builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1449758526.66 results: success (0) buildid: 20151210063037 builduid: c5787a1ebb054b0d9fd55c241af53102 revision: aca5428cbf4627ab41014457b6ea50a624324b27 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:06.658153) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:06.658569) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:06.658874) ========= 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=ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006372 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:06.739256) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:06.739553) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:06.819708) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:06.819961) ========= 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=ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:06.874630) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:06.874895) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:06.875320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:06.875612) ========= 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=ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-10 06:42:06-- 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% 40.1M=0s 2015-12-10 06:42:07 (40.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.337318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:07.226276) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:07.226600) ========= 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=ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015471 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:07.276064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:07.276398) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev aca5428cbf4627ab41014457b6ea50a624324b27 --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 aca5428cbf4627ab41014457b6ea50a624324b27 --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=ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-10 06:42:07,406 truncating revision to first 12 chars 2015-12-10 06:42:07,406 Setting DEBUG logging. 2015-12-10 06:42:07,406 attempt 1/10 2015-12-10 06:42:07,406 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/aca5428cbf46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-10 06:42:07,672 unpacking tar archive at: fx-team-aca5428cbf46/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549103 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:07.838310) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:07.838611) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:07.882359) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:07.882679) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 06:42:07.883082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 57 secs) (at 2015-12-10 06:42:07.883363) ========= /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=ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:42:08 INFO - MultiFileLogger online at 20151210 06:42:08 in /builds/slave/test 06:42:08 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 06:42:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:42:08 INFO - {'append_to_log': False, 06:42:08 INFO - 'base_work_dir': '/builds/slave/test', 06:42:08 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:42:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:42:08 INFO - 'branch': 'Fx-Team-Non-PGO', 06:42:08 INFO - 'buildbot_json_path': 'buildprops.json', 06:42:08 INFO - 'config_files': ('talos/linux_config.py',), 06:42:08 INFO - 'default_actions': ('clobber', 06:42:08 INFO - 'read-buildbot-config', 06:42:08 INFO - 'download-and-extract', 06:42:08 INFO - 'populate-webroot', 06:42:08 INFO - 'create-virtualenv', 06:42:08 INFO - 'install', 06:42:08 INFO - 'run-tests'), 06:42:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:42:08 INFO - 'download_minidump_stackwalk': True, 06:42:08 INFO - 'download_symbols': 'ondemand', 06:42:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:42:08 INFO - 'tooltool.py': '/tools/tooltool.py', 06:42:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:42:08 INFO - '/tools/misc-python/virtualenv.py')}, 06:42:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:42:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:42:08 INFO - 'installer_path': 'installer.exe', 06:42:08 INFO - 'log_level': 'info', 06:42:08 INFO - 'log_name': 'talos', 06:42:08 INFO - 'log_to_console': True, 06:42:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:42:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:42:08 INFO - 'opt_config_files': (), 06:42:08 INFO - 'pip_index': False, 06:42:08 INFO - 'sps_profile': False, 06:42:08 INFO - 'sps_profile_interval': 0, 06:42:08 INFO - 'suite': 'dromaeojs', 06:42:08 INFO - 'system_bits': '64', 06:42:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:42:08 INFO - 'title': 'talos-linux64-ix-021', 06:42:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:42:08 INFO - 'use_talos_json': True, 06:42:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:42:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:42:08 INFO - 'work_dir': 'build'} 06:42:08 INFO - ##### 06:42:08 INFO - ##### Running clobber step. 06:42:08 INFO - ##### 06:42:08 INFO - Running pre-action listener: _resource_record_pre_action 06:42:08 INFO - Running main action method: clobber 06:42:08 INFO - rmtree: /builds/slave/test/build 06:42:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:42:08 INFO - Running post-action listener: _resource_record_post_action 06:42:08 INFO - ##### 06:42:08 INFO - ##### Running read-buildbot-config step. 06:42:08 INFO - ##### 06:42:08 INFO - Running pre-action listener: _resource_record_pre_action 06:42:08 INFO - Running main action method: read_buildbot_config 06:42:08 INFO - Using buildbot properties: 06:42:08 INFO - { 06:42:08 INFO - "properties": { 06:42:08 INFO - "buildnumber": 1188, 06:42:08 INFO - "product": "firefox", 06:42:08 INFO - "script_repo_revision": "production", 06:42:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:42:08 INFO - "repository": "", 06:42:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:42:08 INFO - "buildid": "20151210063037", 06:42:08 INFO - "slavename": "talos-linux64-ix-021", 06:42:08 INFO - "pgo_build": "False", 06:42:08 INFO - "basedir": "/builds/slave/test", 06:42:08 INFO - "project": "", 06:42:08 INFO - "platform": "ubuntu64_hw", 06:42:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:42:08 INFO - "slavebuilddir": "test", 06:42:08 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:42:08 INFO - "branch": "fx-team", 06:42:08 INFO - "repo_path": "integration/fx-team", 06:42:08 INFO - "stage_platform": "linux64", 06:42:08 INFO - "builduid": "c5787a1ebb054b0d9fd55c241af53102", 06:42:08 INFO - "revision": "aca5428cbf4627ab41014457b6ea50a624324b27" 06:42:08 INFO - }, 06:42:08 INFO - "sourcestamp": { 06:42:08 INFO - "repository": "", 06:42:08 INFO - "hasPatch": false, 06:42:08 INFO - "project": "", 06:42:08 INFO - "branch": "fx-team-linux64-talos", 06:42:08 INFO - "changes": [ 06:42:08 INFO - { 06:42:08 INFO - "category": null, 06:42:08 INFO - "files": [ 06:42:08 INFO - { 06:42:08 INFO - "url": null, 06:42:08 INFO - "name": "https://queue.taskcluster.net/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:42:08 INFO - } 06:42:08 INFO - ], 06:42:08 INFO - "repository": "", 06:42:08 INFO - "rev": "aca5428cbf4627ab41014457b6ea50a624324b27", 06:42:08 INFO - "who": "mhammond@skippinet.com.au", 06:42:08 INFO - "when": 1449758448, 06:42:08 INFO - "number": 7246040, 06:42:08 INFO - "comments": "Bug 1231535 - remove sync spinner and add ellipsis to Synced Tabs panel. r=Gijs", 06:42:08 INFO - "project": "", 06:42:08 INFO - "at": "Thu 10 Dec 2015 06:40:48", 06:42:08 INFO - "branch": "fx-team-linux64-talos", 06:42:08 INFO - "revlink": "", 06:42:08 INFO - "properties": [ 06:42:08 INFO - [ 06:42:08 INFO - "buildid", 06:42:08 INFO - "20151210063037", 06:42:08 INFO - "Change" 06:42:08 INFO - ], 06:42:08 INFO - [ 06:42:08 INFO - "builduid", 06:42:08 INFO - "c5787a1ebb054b0d9fd55c241af53102", 06:42:08 INFO - "Change" 06:42:08 INFO - ], 06:42:08 INFO - [ 06:42:08 INFO - "pgo_build", 06:42:08 INFO - "False", 06:42:08 INFO - "Change" 06:42:08 INFO - ] 06:42:08 INFO - ], 06:42:08 INFO - "revision": "aca5428cbf4627ab41014457b6ea50a624324b27" 06:42:08 INFO - } 06:42:08 INFO - ], 06:42:08 INFO - "revision": "aca5428cbf4627ab41014457b6ea50a624324b27" 06:42:08 INFO - } 06:42:08 INFO - } 06:42:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:42:08 INFO - Running post-action listener: _resource_record_post_action 06:42:08 INFO - ##### 06:42:08 INFO - ##### Running download-and-extract step. 06:42:08 INFO - ##### 06:42:08 INFO - Running pre-action listener: _resource_record_pre_action 06:42:08 INFO - Running main action method: download_and_extract 06:42:08 INFO - mkdir: /builds/slave/test/build/tests 06:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:08 INFO - https://queue.taskcluster.net/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:42:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/test_packages.json 06:42:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/test_packages.json 06:42:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:42:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:42:11 INFO - Downloaded 1302 bytes. 06:42:11 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:42:11 INFO - Using the following test package requirements: 06:42:11 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:42:11 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:42:11 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:11 INFO - u'jsshell-linux-x86_64.zip'], 06:42:11 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:42:11 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:42:11 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:42:11 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:42:11 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:42:11 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:42:11 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:42:11 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:11 INFO - https://queue.taskcluster.net/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:42:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:42:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:42:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/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 06:42:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/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 06:42:24 INFO - retry: attempt #1 caught exception: '' 06:42:24 INFO - retry: Failed, sleeping 30 seconds before retrying 06:42:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/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 #2 06:42:58 INFO - Downloaded 21867289 bytes. 06:42:58 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 06:42:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:42:58 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 06:42:59 INFO - Return code: 0 06:42:59 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 06:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:59 INFO - https://queue.taskcluster.net/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:42:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:42:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:42:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/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 06:42:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/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 06:43:00 INFO - Downloaded 21867289 bytes. 06:43:00 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 06:43:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:43:00 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 06:43:01 INFO - Return code: 0 06:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:43:01 INFO - https://queue.taskcluster.net/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:43:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:43:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:43:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/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 06:43:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/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 06:43:02 INFO - Downloaded 11132038 bytes. 06:43:02 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 06:43:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:43:02 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 06:43:02 INFO - Return code: 0 06:43: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')]} 06:43:02 INFO - https://queue.taskcluster.net/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:43:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:43:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:43:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/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 06:43:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lJi4f5tBQEqD-sh2jnIlGw/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 06:43:03 INFO - Downloaded 57730541 bytes. 06:43:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:43:03 INFO - mkdir: /builds/slave/test/properties 06:43:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:43:03 INFO - Writing to file /builds/slave/test/properties/build_url 06:43:03 INFO - Contents: 06:43:03 INFO - build_url:https://queue.taskcluster.net/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:43:03 INFO - Running post-action listener: _resource_record_post_action 06:43:03 INFO - Running post-action listener: set_extra_try_arguments 06:43:03 INFO - ##### 06:43:03 INFO - ##### Running populate-webroot step. 06:43:03 INFO - ##### 06:43:03 INFO - Running pre-action listener: _resource_record_pre_action 06:43:03 INFO - Running main action method: populate_webroot 06:43:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:43:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:43:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:43:03 INFO - '--tppagecycles', 06:43:03 INFO - '7'], 06:43:03 INFO - 'tests': ['tsvgm']}}, 06:43:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:43:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:43:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:43:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:43:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:43:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:43:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:43:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:43:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:43:03 INFO - 'talos_options': ['--e10s'], 06:43:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:43:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:43:03 INFO - 'tests': ['damp', 'tps']}, 06:43:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:43:03 INFO - 'talos_options': ['--e10s'], 06:43:03 INFO - 'tests': ['damp', 'tps']}, 06:43:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:43:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:43:03 INFO - 'other': {'tests': ['a11yr', 06:43:03 INFO - 'ts_paint', 06:43:03 INFO - 'tpaint', 06:43:03 INFO - 'sessionrestore', 06:43:03 INFO - 'sessionrestore_no_auto_restore']}, 06:43:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:43:03 INFO - 'tests': ['a11yr', 06:43:03 INFO - 'ts_paint', 06:43:03 INFO - 'tpaint', 06:43:03 INFO - 'sessionrestore', 06:43:03 INFO - 'sessionrestore_no_auto_restore']}, 06:43:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:43:03 INFO - 'tests': ['a11yr', 06:43:03 INFO - 'ts_paint', 06:43:03 INFO - 'tpaint', 06:43:03 INFO - 'sessionrestore', 06:43:03 INFO - 'sessionrestore_no_auto_restore']}, 06:43:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:43:03 INFO - 'tests': ['a11yr', 06:43:03 INFO - 'ts_paint', 06:43:03 INFO - 'tpaint', 06:43:03 INFO - 'sessionrestore', 06:43:03 INFO - 'sessionrestore_no_auto_restore']}, 06:43:03 INFO - 'other_l64': {'tests': ['a11yr', 06:43:03 INFO - 'ts_paint', 06:43:03 INFO - 'tpaint', 06:43:03 INFO - 'sessionrestore', 06:43:03 INFO - 'sessionrestore_no_auto_restore']}, 06:43:03 INFO - 'other_nol64': {'tests': ['a11yr', 06:43:03 INFO - 'ts_paint', 06:43:03 INFO - 'tpaint', 06:43:03 INFO - 'sessionrestore', 06:43:03 INFO - 'sessionrestore_no_auto_restore']}, 06:43:03 INFO - 'svgr': {'tests': ['tsvgx', 06:43:03 INFO - 'tsvgr_opacity', 06:43:03 INFO - 'tart', 06:43:03 INFO - 'tscrollx', 06:43:03 INFO - 'cart']}, 06:43:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:43:03 INFO - 'tests': ['tsvgx', 06:43:03 INFO - 'tsvgr_opacity', 06:43:03 INFO - 'tart', 06:43:03 INFO - 'tscrollx', 06:43:03 INFO - 'cart']}, 06:43:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:43:03 INFO - 'tests': ['tp5o']}, 06:43:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:43:03 INFO - 'talos_options': ['--e10s'], 06:43:03 INFO - 'tests': ['tp5o']}, 06:43:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:43:03 INFO - 'talos_options': ['--xperf_path', 06:43:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:43:03 INFO - 'tests': ['tp5n']}, 06:43:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:43:03 INFO - 'talos_options': ['--e10s', 06:43:03 INFO - '--xperf_path', 06:43:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:43:03 INFO - 'tests': ['tp5n']}}, 06:43:03 INFO - 'talos.zip': {'path': '', 06:43:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:43:03 INFO - Running post-action listener: _resource_record_post_action 06:43:03 INFO - ##### 06:43:03 INFO - ##### Running create-virtualenv step. 06:43:03 INFO - ##### 06:43:03 INFO - Running pre-action listener: _resource_record_pre_action 06:43:03 INFO - Running main action method: create_virtualenv 06:43:03 INFO - Creating virtualenv /builds/slave/test/build/venv 06:43:03 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 06:43:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:43:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:43:04 INFO - Using real prefix '/usr' 06:43:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:43:04 INFO - Installing distribute.............................................................................................................................................................................................done. 06:43:06 INFO - Installing pip.................done. 06:43:06 INFO - Return code: 0 06:43:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ebf0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf49240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd80b0>, '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 0xfd8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd9440>, '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': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', '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 06:43:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:43:06 INFO - Using env: {'DISPLAY': ':0', 06:43:06 INFO - 'HOME': '/home/cltbld', 06:43:06 INFO - 'LANG': 'en_US.UTF-8', 06:43:06 INFO - 'LANGUAGE': 'en_US:en', 06:43:06 INFO - 'LOGNAME': 'cltbld', 06:43:06 INFO - 'MAIL': '/var/mail/cltbld', 06:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:06 INFO - 'MOZ_NO_REMOTE': '1', 06:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:06 INFO - 'NO_EM_RESTART': '1', 06:43:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:06 INFO - 'PWD': '/builds/slave/test', 06:43:06 INFO - 'SHELL': '/bin/bash', 06:43:06 INFO - 'SHLVL': '1', 06:43:06 INFO - 'TERM': 'linux', 06:43:06 INFO - 'TMOUT': '86400', 06:43:06 INFO - 'USER': 'cltbld', 06:43:06 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', 06:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:06 INFO - '_': '/tools/buildbot/bin/python'} 06:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:07 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 06:43:07 INFO - Cleaning up... 06:43:07 INFO - Return code: 0 06:43:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:43:07 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')]} 06:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:07 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')]} 06:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:07 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 0x7f9ebf0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf49240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd80b0>, '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 0xfd8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd9440>, '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': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', '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 06:43:07 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 06:43:07 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 06:43:07 INFO - Using env: {'DISPLAY': ':0', 06:43:07 INFO - 'HOME': '/home/cltbld', 06:43:07 INFO - 'LANG': 'en_US.UTF-8', 06:43:07 INFO - 'LANGUAGE': 'en_US:en', 06:43:07 INFO - 'LOGNAME': 'cltbld', 06:43:07 INFO - 'MAIL': '/var/mail/cltbld', 06:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:07 INFO - 'MOZ_NO_REMOTE': '1', 06:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:07 INFO - 'NO_EM_RESTART': '1', 06:43:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:07 INFO - 'PWD': '/builds/slave/test', 06:43:07 INFO - 'SHELL': '/bin/bash', 06:43:07 INFO - 'SHLVL': '1', 06:43:07 INFO - 'TERM': 'linux', 06:43:07 INFO - 'TMOUT': '86400', 06:43:07 INFO - 'USER': 'cltbld', 06:43:07 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', 06:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:07 INFO - '_': '/tools/buildbot/bin/python'} 06:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:07 INFO - Downloading/unpacking psutil>=0.7.1 06:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:08 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:43:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:43:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:43:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:43:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:43:09 INFO - Installing collected packages: psutil 06:43:09 INFO - Running setup.py install for psutil 06:43:09 INFO - building 'psutil._psutil_linux' extension 06:43:09 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 06:43:09 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 06:43:09 INFO - building 'psutil._psutil_posix' extension 06:43:09 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 06:43:09 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 06:43:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:43:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:43:09 INFO - Successfully installed psutil 06:43:09 INFO - Cleaning up... 06:43:09 INFO - Return code: 0 06:43:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:09 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 0x7f9ebf0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf49240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd80b0>, '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 0xfd8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd9440>, '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': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', '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 06:43:09 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 06:43:09 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 06:43:09 INFO - Using env: {'DISPLAY': ':0', 06:43:09 INFO - 'HOME': '/home/cltbld', 06:43:09 INFO - 'LANG': 'en_US.UTF-8', 06:43:09 INFO - 'LANGUAGE': 'en_US:en', 06:43:09 INFO - 'LOGNAME': 'cltbld', 06:43:09 INFO - 'MAIL': '/var/mail/cltbld', 06:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:09 INFO - 'MOZ_NO_REMOTE': '1', 06:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:09 INFO - 'NO_EM_RESTART': '1', 06:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:09 INFO - 'PWD': '/builds/slave/test', 06:43:09 INFO - 'SHELL': '/bin/bash', 06:43:09 INFO - 'SHLVL': '1', 06:43:09 INFO - 'TERM': 'linux', 06:43:09 INFO - 'TMOUT': '86400', 06:43:09 INFO - 'USER': 'cltbld', 06:43:09 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', 06:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:09 INFO - '_': '/tools/buildbot/bin/python'} 06:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:43:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:43:11 INFO - Installing collected packages: mozsystemmonitor 06:43:11 INFO - Running setup.py install for mozsystemmonitor 06:43:11 INFO - Successfully installed mozsystemmonitor 06:43:11 INFO - Cleaning up... 06:43:11 INFO - Return code: 0 06:43:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9ebf0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf49240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd80b0>, '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 0xfd8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd9440>, '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': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', '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 06:43:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:43:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:43:11 INFO - Using env: {'DISPLAY': ':0', 06:43:11 INFO - 'HOME': '/home/cltbld', 06:43:11 INFO - 'LANG': 'en_US.UTF-8', 06:43:11 INFO - 'LANGUAGE': 'en_US:en', 06:43:11 INFO - 'LOGNAME': 'cltbld', 06:43:11 INFO - 'MAIL': '/var/mail/cltbld', 06:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:11 INFO - 'MOZ_NO_REMOTE': '1', 06:43:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:11 INFO - 'NO_EM_RESTART': '1', 06:43:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:11 INFO - 'PWD': '/builds/slave/test', 06:43:11 INFO - 'SHELL': '/bin/bash', 06:43:11 INFO - 'SHLVL': '1', 06:43:11 INFO - 'TERM': 'linux', 06:43:11 INFO - 'TMOUT': '86400', 06:43:11 INFO - 'USER': 'cltbld', 06:43:11 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', 06:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:11 INFO - '_': '/tools/buildbot/bin/python'} 06:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:11 INFO - Downloading/unpacking blobuploader==1.2.4 06:43:11 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 06:43:11 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 06:43:11 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 06:43:11 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 06:43:11 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 06:43:11 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 06:43:13 INFO - Downloading blobuploader-1.2.4.tar.gz 06:43:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:43:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:43:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:14 INFO - Downloading docopt-0.6.1.tar.gz 06:43:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:43:14 INFO - Installing collected packages: blobuploader, requests, docopt 06:43:14 INFO - Running setup.py install for blobuploader 06:43:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:43:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:43:14 INFO - Running setup.py install for requests 06:43:14 INFO - Running setup.py install for docopt 06:43:15 INFO - Successfully installed blobuploader requests docopt 06:43:15 INFO - Cleaning up... 06:43:16 INFO - Return code: 0 06:43:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:16 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 0x7f9ebf0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf49240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd80b0>, '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 0xfd8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd9440>, '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': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', '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 06:43:16 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 06:43:16 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 06:43:16 INFO - Using env: {'DISPLAY': ':0', 06:43:16 INFO - 'HOME': '/home/cltbld', 06:43:16 INFO - 'LANG': 'en_US.UTF-8', 06:43:16 INFO - 'LANGUAGE': 'en_US:en', 06:43:16 INFO - 'LOGNAME': 'cltbld', 06:43:16 INFO - 'MAIL': '/var/mail/cltbld', 06:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:16 INFO - 'MOZ_NO_REMOTE': '1', 06:43:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:16 INFO - 'NO_EM_RESTART': '1', 06:43:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:16 INFO - 'PWD': '/builds/slave/test', 06:43:16 INFO - 'SHELL': '/bin/bash', 06:43:16 INFO - 'SHLVL': '1', 06:43:16 INFO - 'TERM': 'linux', 06:43:16 INFO - 'TMOUT': '86400', 06:43:16 INFO - 'USER': 'cltbld', 06:43:16 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', 06:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:16 INFO - '_': '/tools/buildbot/bin/python'} 06:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:43:17 INFO - Running setup.py (path:/tmp/pip-iOqlhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:43:17 INFO - Running setup.py (path:/tmp/pip-7SEg0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:43:17 INFO - Running setup.py (path:/tmp/pip-Wgk096-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:43:17 INFO - Running setup.py (path:/tmp/pip-3LAnUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:43:17 INFO - Running setup.py (path:/tmp/pip-q6lelV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:43:17 INFO - Running setup.py (path:/tmp/pip-YCdKGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:43:17 INFO - Running setup.py (path:/tmp/pip-yZmDo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:43:17 INFO - Running setup.py (path:/tmp/pip-zah2dF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:43:17 INFO - Running setup.py (path:/tmp/pip-zFQ_Ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:43:17 INFO - Running setup.py (path:/tmp/pip-uym0XG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:43:17 INFO - Running setup.py (path:/tmp/pip-j0pp5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:43:17 INFO - Running setup.py (path:/tmp/pip-IJA7DK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:43:17 INFO - Running setup.py (path:/tmp/pip-QySMBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:43:17 INFO - Running setup.py (path:/tmp/pip-sWqh5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:18 INFO - Running setup.py (path:/tmp/pip-BdPuLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:43:18 INFO - Running setup.py (path:/tmp/pip-1t13fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:43:18 INFO - Running setup.py (path:/tmp/pip-c27Dhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:43:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:43:18 INFO - Running setup.py install for manifestparser 06:43:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:43:18 INFO - Running setup.py install for mozcrash 06:43:18 INFO - Running setup.py install for mozdebug 06:43:18 INFO - Running setup.py install for mozdevice 06:43:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:43:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:43:18 INFO - Running setup.py install for mozfile 06:43:18 INFO - Running setup.py install for mozhttpd 06:43:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:43:18 INFO - Running setup.py install for mozinfo 06:43:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:43:18 INFO - Running setup.py install for mozInstall 06:43:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:43:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:43:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:43:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:43:19 INFO - Running setup.py install for mozleak 06:43:19 INFO - Running setup.py install for mozlog 06:43:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:43:19 INFO - Running setup.py install for moznetwork 06:43:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:43:19 INFO - Running setup.py install for mozprocess 06:43:19 INFO - Running setup.py install for mozprofile 06:43:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:43:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:43:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:43:19 INFO - Running setup.py install for mozrunner 06:43:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:43:19 INFO - Running setup.py install for mozscreenshot 06:43:19 INFO - Running setup.py install for moztest 06:43:19 INFO - Running setup.py install for mozversion 06:43:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:43:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:43:19 INFO - Cleaning up... 06:43:19 INFO - Return code: 0 06:43:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f9ebf0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf49240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd80b0>, '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 0xfd8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd9440>, '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': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', '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 06:43:20 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 06:43:20 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 06:43:20 INFO - Using env: {'DISPLAY': ':0', 06:43:20 INFO - 'HOME': '/home/cltbld', 06:43:20 INFO - 'LANG': 'en_US.UTF-8', 06:43:20 INFO - 'LANGUAGE': 'en_US:en', 06:43:20 INFO - 'LOGNAME': 'cltbld', 06:43:20 INFO - 'MAIL': '/var/mail/cltbld', 06:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:20 INFO - 'MOZ_NO_REMOTE': '1', 06:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:20 INFO - 'NO_EM_RESTART': '1', 06:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:20 INFO - 'PWD': '/builds/slave/test', 06:43:20 INFO - 'SHELL': '/bin/bash', 06:43:20 INFO - 'SHLVL': '1', 06:43:20 INFO - 'TERM': 'linux', 06:43:20 INFO - 'TMOUT': '86400', 06:43:20 INFO - 'USER': 'cltbld', 06:43:20 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', 06:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:20 INFO - '_': '/tools/buildbot/bin/python'} 06:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:43:20 INFO - Running setup.py (path:/tmp/pip-CWCo6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:43:20 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)) 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:43:20 INFO - Running setup.py (path:/tmp/pip-Bayj9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:43:20 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)) 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:43:20 INFO - Running setup.py (path:/tmp/pip-14FkrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:43:20 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)) 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:43:20 INFO - Running setup.py (path:/tmp/pip-vLQX6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:43:20 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)) 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:43:20 INFO - Running setup.py (path:/tmp/pip-TSagwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:43:20 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)) 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:43:20 INFO - Running setup.py (path:/tmp/pip-lGHkD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:43:20 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)) 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:43:20 INFO - Running setup.py (path:/tmp/pip-uiPLG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:43:20 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)) 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:43:20 INFO - Running setup.py (path:/tmp/pip-_7adqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:43:20 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)) 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:43:20 INFO - Running setup.py (path:/tmp/pip-s0OJTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:43:20 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)) 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:43:20 INFO - Running setup.py (path:/tmp/pip-_2UGft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:43:20 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)) 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:43:20 INFO - Running setup.py (path:/tmp/pip-HajDUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:43:21 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)) 06:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:43:21 INFO - Running setup.py (path:/tmp/pip-tmviNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:43:21 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)) 06:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:43:21 INFO - Running setup.py (path:/tmp/pip-s440k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:43:21 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)) 06:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:43:21 INFO - Running setup.py (path:/tmp/pip-x3VOGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:43:21 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)) 06:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:21 INFO - Running setup.py (path:/tmp/pip-tQtHOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:21 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)) 06:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:43:21 INFO - Running setup.py (path:/tmp/pip-hKw1Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:43:21 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)) 06:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:43:21 INFO - Running setup.py (path:/tmp/pip-A4_XVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:43:21 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)) 06:43:21 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)) 06:43:21 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)) 06:43:21 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)) 06:43:21 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)) 06:43:21 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)) 06:43:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:23 INFO - Downloading blessings-1.5.1.tar.gz 06:43:23 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 06:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:43:23 INFO - Installing collected packages: blessings 06:43:23 INFO - Running setup.py install for blessings 06:43:23 INFO - Successfully installed blessings 06:43:23 INFO - Cleaning up... 06:43:23 INFO - Return code: 0 06:43:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:43:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:43:23 INFO - Reading from file tmpfile_stdout 06:43:23 INFO - Current package versions: 06:43:23 INFO - argparse == 1.2.1 06:43:23 INFO - blessings == 1.5.1 06:43:23 INFO - blobuploader == 1.2.4 06:43:23 INFO - docopt == 0.6.1 06:43:23 INFO - manifestparser == 1.1 06:43:23 INFO - mozInstall == 1.12 06:43:23 INFO - mozcrash == 0.16 06:43:23 INFO - mozdebug == 0.1 06:43:23 INFO - mozdevice == 0.47 06:43:23 INFO - mozfile == 1.2 06:43:23 INFO - mozhttpd == 0.7 06:43:23 INFO - mozinfo == 0.9 06:43:23 INFO - mozleak == 0.1 06:43:23 INFO - mozlog == 3.1 06:43:23 INFO - moznetwork == 0.27 06:43:23 INFO - mozprocess == 0.22 06:43:23 INFO - mozprofile == 0.27 06:43:23 INFO - mozrunner == 6.11 06:43:23 INFO - mozscreenshot == 0.1 06:43:23 INFO - mozsystemmonitor == 0.0 06:43:23 INFO - moztest == 0.7 06:43:23 INFO - mozversion == 1.4 06:43:23 INFO - psutil == 3.1.1 06:43:23 INFO - requests == 1.2.3 06:43:23 INFO - wsgiref == 0.1.2 06:43:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:43:23 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')]} 06:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:23 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')]} 06:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:23 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 0x7f9ebf0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf49240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd80b0>, '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 0xfd8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd9440>, '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': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', '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 06:43:23 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 06:43:23 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 06:43:23 INFO - Using env: {'DISPLAY': ':0', 06:43:23 INFO - 'HOME': '/home/cltbld', 06:43:23 INFO - 'LANG': 'en_US.UTF-8', 06:43:23 INFO - 'LANGUAGE': 'en_US:en', 06:43:23 INFO - 'LOGNAME': 'cltbld', 06:43:23 INFO - 'MAIL': '/var/mail/cltbld', 06:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:23 INFO - 'MOZ_NO_REMOTE': '1', 06:43:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:23 INFO - 'NO_EM_RESTART': '1', 06:43:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:23 INFO - 'PWD': '/builds/slave/test', 06:43:23 INFO - 'SHELL': '/bin/bash', 06:43:23 INFO - 'SHLVL': '1', 06:43:23 INFO - 'TERM': 'linux', 06:43:23 INFO - 'TMOUT': '86400', 06:43:23 INFO - 'USER': 'cltbld', 06:43:23 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', 06:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:23 INFO - '_': '/tools/buildbot/bin/python'} 06:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:23 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)) 06:43:23 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)) 06:43:23 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)) 06:43:23 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)) 06:43:23 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)) 06:43:23 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)) 06:43:23 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)) 06:43:23 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)) 06:43:23 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)) 06:43:23 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)) 06:43:23 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)) 06:43:23 INFO - Cleaning up... 06:43:23 INFO - Return code: 0 06:43:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:43:23 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')]} 06:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:23 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')]} 06:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:23 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 0x7f9ebf0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf49240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd80b0>, '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 0xfd8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd9440>, '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': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', '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 06:43:23 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 06:43:23 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 06:43:23 INFO - Using env: {'DISPLAY': ':0', 06:43:23 INFO - 'HOME': '/home/cltbld', 06:43:23 INFO - 'LANG': 'en_US.UTF-8', 06:43:23 INFO - 'LANGUAGE': 'en_US:en', 06:43:23 INFO - 'LOGNAME': 'cltbld', 06:43:23 INFO - 'MAIL': '/var/mail/cltbld', 06:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:23 INFO - 'MOZ_NO_REMOTE': '1', 06:43:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:23 INFO - 'NO_EM_RESTART': '1', 06:43:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:23 INFO - 'PWD': '/builds/slave/test', 06:43:23 INFO - 'SHELL': '/bin/bash', 06:43:23 INFO - 'SHLVL': '1', 06:43:23 INFO - 'TERM': 'linux', 06:43:23 INFO - 'TMOUT': '86400', 06:43:23 INFO - 'USER': 'cltbld', 06:43:23 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', 06:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:23 INFO - '_': '/tools/buildbot/bin/python'} 06:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:24 INFO - Downloading/unpacking jsonschema 06:43:24 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 06:43:24 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 06:43:24 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 06:43:24 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 06:43:24 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 06:43:24 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 06:43:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:43:25 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 06:43:25 INFO - Downloading/unpacking functools32 (from jsonschema) 06:43:25 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 06:43:25 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 06:43:25 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 06:43:25 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 06:43:25 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 06:43:25 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 06:43:25 INFO - Downloading functools32-3.2.3-2.tar.gz 06:43:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:43:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:43:25 INFO - warning: no files found matching '*.txt' 06:43:25 INFO - no previously-included directories found matching 'build' 06:43:25 INFO - no previously-included directories found matching 'dist' 06:43:25 INFO - no previously-included directories found matching '.git*' 06:43:25 INFO - Installing collected packages: jsonschema, functools32 06:43:26 INFO - Running setup.py install for functools32 06:43:26 INFO - warning: no files found matching '*.txt' 06:43:26 INFO - no previously-included directories found matching 'build' 06:43:26 INFO - no previously-included directories found matching 'dist' 06:43:26 INFO - no previously-included directories found matching '.git*' 06:43:26 INFO - Successfully installed jsonschema functools32 06:43:26 INFO - Cleaning up... 06:43:26 INFO - Return code: 0 06:43:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:43:26 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')]} 06:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:26 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')]} 06:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:26 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 0x7f9ebf0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf49240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd80b0>, '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 0xfd8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd9440>, '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': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', '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 06:43:26 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 06:43:26 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 06:43:26 INFO - Using env: {'DISPLAY': ':0', 06:43:26 INFO - 'HOME': '/home/cltbld', 06:43:26 INFO - 'LANG': 'en_US.UTF-8', 06:43:26 INFO - 'LANGUAGE': 'en_US:en', 06:43:26 INFO - 'LOGNAME': 'cltbld', 06:43:26 INFO - 'MAIL': '/var/mail/cltbld', 06:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:26 INFO - 'MOZ_NO_REMOTE': '1', 06:43:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:26 INFO - 'NO_EM_RESTART': '1', 06:43:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:26 INFO - 'PWD': '/builds/slave/test', 06:43:26 INFO - 'SHELL': '/bin/bash', 06:43:26 INFO - 'SHLVL': '1', 06:43:26 INFO - 'TERM': 'linux', 06:43:26 INFO - 'TMOUT': '86400', 06:43:26 INFO - 'USER': 'cltbld', 06:43:26 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', 06:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:26 INFO - '_': '/tools/buildbot/bin/python'} 06:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:26 INFO - Downloading/unpacking flake8 06:43:26 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 06:43:26 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 06:43:26 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 06:43:26 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 06:43:26 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 06:43:26 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 06:43:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:43:28 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 06:43:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:43:28 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 06:43:28 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 06:43:28 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 06:43:28 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 06:43:28 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 06:43:28 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 06:43:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:43:28 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 06:43:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:43:28 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 06:43:28 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 06:43:28 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 06:43:28 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 06:43:28 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 06:43:28 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 06:43:28 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 06:43:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:43:28 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 06:43:28 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 06:43:28 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 06:43:28 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 06:43:28 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 06:43:28 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 06:43:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:43:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:43:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:43:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:43:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:43:28 INFO - no previously-included directories found matching 'docs/_build' 06:43:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:43:28 INFO - Running setup.py install for pep8 06:43:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:43:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:43:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:43:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:43:28 INFO - no previously-included directories found matching 'docs/_build' 06:43:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:43:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:43:28 INFO - Cleaning up... 06:43:28 INFO - Return code: 0 06:43:28 INFO - Running post-action listener: _resource_record_post_action 06:43:28 INFO - Running post-action listener: _start_resource_monitoring 06:43:28 INFO - Starting resource monitoring. 06:43:28 INFO - ##### 06:43:28 INFO - ##### Running install step. 06:43:28 INFO - ##### 06:43:28 INFO - Running pre-action listener: _resource_record_pre_action 06:43:28 INFO - Running main action method: install 06:43:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:43:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:43:29 INFO - Reading from file tmpfile_stdout 06:43:29 INFO - Detecting whether we're running mozinstall >=1.0... 06:43:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:43:29 INFO - Reading from file tmpfile_stdout 06:43:29 INFO - Output received: 06:43:29 INFO - Usage: mozinstall [options] installer 06:43:29 INFO - Options: 06:43:29 INFO - -h, --help show this help message and exit 06:43:29 INFO - -d DEST, --destination=DEST 06:43:29 INFO - Directory to install application into. [default: 06:43:29 INFO - "/builds/slave/test"] 06:43:29 INFO - --app=APP Application being installed. [default: firefox] 06:43:29 INFO - mkdir: /builds/slave/test/build/application 06:43:29 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'] 06:43:29 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 06:43:43 INFO - Reading from file tmpfile_stdout 06:43:43 INFO - Output received: 06:43:43 INFO - /builds/slave/test/build/application/firefox/firefox 06:43:43 INFO - Running post-action listener: _resource_record_post_action 06:43:43 INFO - ##### 06:43:43 INFO - ##### Running run-tests step. 06:43:43 INFO - ##### 06:43:43 INFO - Running pre-action listener: _resource_record_pre_action 06:43:43 INFO - Running main action method: run_tests 06:43:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:43:43 INFO - Python 2.7.3 06:43:43 INFO - Return code: 0 06:43:43 INFO - grabbing minidump binary from tooltool 06:43: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')]} 06:43:43 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 0xfd80b0>, '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 0xfd8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd9440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:43:43 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 06:43:43 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 06:43:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:43:43 INFO - Return code: 0 06:43:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:43:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:43:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:43:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:43:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:43:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:43:44 INFO - Return code: 0 06:43:44 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/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost'] in /builds/slave/test/build 06:43:44 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/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost 06:43:44 INFO - Using env: {'DISPLAY': ':0', 06:43:44 INFO - 'HOME': '/home/cltbld', 06:43:44 INFO - 'LANG': 'en_US.UTF-8', 06:43:44 INFO - 'LANGUAGE': 'en_US:en', 06:43:44 INFO - 'LOGNAME': 'cltbld', 06:43:44 INFO - 'MAIL': '/var/mail/cltbld', 06:43:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:43:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:44 INFO - 'MOZ_NO_REMOTE': '1', 06:43:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:44 INFO - 'NO_EM_RESTART': '1', 06:43:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:44 INFO - 'PWD': '/builds/slave/test', 06:43:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:43:44 INFO - 'SHELL': '/bin/bash', 06:43:44 INFO - 'SHLVL': '1', 06:43:44 INFO - 'TERM': 'linux', 06:43:44 INFO - 'TMOUT': '86400', 06:43:44 INFO - 'USER': 'cltbld', 06:43:44 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109', 06:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:44 INFO - '_': '/tools/buildbot/bin/python'} 06:43:44 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/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost'] with output_timeout 3600 06:43:45 INFO - mozversion INFO | application_buildid: 20151210063037 06:43:45 INFO - mozversion INFO | application_changeset: aca5428cbf4627ab41014457b6ea50a624324b27 06:43:45 INFO - mozversion INFO | application_display_name: Nightly 06:43:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:43:45 INFO - mozversion INFO | application_name: Firefox 06:43:45 INFO - mozversion INFO | application_remotingname: firefox 06:43:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 06:43:45 INFO - mozversion INFO | application_vendor: Mozilla 06:43:45 INFO - mozversion INFO | application_version: 45.0a1 06:43:45 INFO - mozversion INFO | platform_buildid: 20151210063037 06:43:45 INFO - mozversion INFO | platform_changeset: aca5428cbf4627ab41014457b6ea50a624324b27 06:43:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 06:43:45 INFO - mozversion INFO | platform_version: 45.0a1 06:43:45 INFO - 2015-12-10 06:43:45,007 DEBUG : using testdate: 1449758625 06:43:45 INFO - 2015-12-10 06:43:45,007 DEBUG : actual date: 1449758625 06:43:45 INFO - 2015-12-10 06:43:45,016 INFO : starting webserver on 'localhost:58196' 06:43:45 INFO - 2015-12-10 06:43:45,017 INFO : Starting test suite talos-linux64-ix-021 06:43:45 INFO - 2015-12-10 06:43:45,017 INFO : Starting test dromaeo_css 06:43:45 INFO - 2015-12-10 06:43:45,017 DEBUG : operating with platform_type : linux_ 06:43:45 INFO - 2015-12-10 06:43:45,018 INFO : Initialising browser for dromaeo_css test... 06:43:45 INFO - 2015-12-10 06:43:45,031 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0ezYhi/profile http://localhost:58196/getInfo.html 06:43:49 INFO - 2015-12-10 06:43:49,995 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:43:49 INFO - 2015-12-10 06:43:49,995 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:43:49 INFO - 2015-12-10 06:43:49,995 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:43:49 INFO - 2015-12-10 06:43:49,995 DEBUG : BROWSER_OUTPUT: __metrics 06:43:50 INFO - 2015-12-10 06:43:50,758 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:43:50 INFO - 2015-12-10 06:43:50,814 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] 06:43:52 INFO - 2015-12-10 06:43:52,451 INFO : Browser initialized. 06:43:52 INFO - 2015-12-10 06:43:52,451 INFO : Running cycle 1/1 for dromaeo_css test... 06:43:52 INFO - 2015-12-10 06:43:52,451 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0ezYhi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:44:04 INFO - 2015-12-10 06:44:04,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 142770176 06:44:04 INFO - 2015-12-10 06:44:04,484 DEBUG : BROWSER_OUTPUT: 06:44:55 INFO - 2015-12-10 06:44:55,738 DEBUG : BROWSER_OUTPUT: 1449758695736 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] 06:47:07 INFO - 2015-12-10 06:47:07,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58196/tests/dromaeo/cssquery-ext.html) 06:47:09 INFO - 2015-12-10 06:47:09,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 245239808 06:47:09 INFO - 2015-12-10 06:47:09,116 DEBUG : BROWSER_OUTPUT: 06:50:11 INFO - 2015-12-10 06:50:11,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/dromaeo/cssquery-ext.html (next: http://localhost:58196/tests/dromaeo/cssquery-jquery.html) 06:50:12 INFO - 2015-12-10 06:50:12,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 229572608 06:50:12 INFO - 2015-12-10 06:50:12,428 DEBUG : BROWSER_OUTPUT: 06:53:14 INFO - 2015-12-10 06:53:14,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58196/tests/dromaeo/cssquery-mootools.html) 06:53:15 INFO - 2015-12-10 06:53:15,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 225099776 06:53:15 INFO - 2015-12-10 06:53:15,125 DEBUG : BROWSER_OUTPUT: 06:56:17 INFO - 2015-12-10 06:56:17,079 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58196/tests/dromaeo/cssquery-prototype.html) 06:56:17 INFO - 2015-12-10 06:56:17,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 204816384 06:56:17 INFO - 2015-12-10 06:56:17,645 DEBUG : BROWSER_OUTPUT: 06:59:20 INFO - 2015-12-10 06:59:20,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58196/tests/dromaeo/cssquery-yui.html) 06:59:21 INFO - 2015-12-10 06:59:21,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 210333696 06:59:21 INFO - 2015-12-10 06:59:21,050 DEBUG : BROWSER_OUTPUT: 07:02:23 INFO - 2015-12-10 07:02:23,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/dromaeo/cssquery-yui.html (next: http://localhost:58196/tests/dromaeo/cssquery-dojo.html) 07:02:23 INFO - 2015-12-10 07:02:23,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 250552320 07:02:23 INFO - 2015-12-10 07:02:23,850 DEBUG : BROWSER_OUTPUT: 07:02:23 INFO - 2015-12-10 07:02:23,851 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:02:23 INFO - 2015-12-10 07:02:23,851 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:02:23 INFO - 2015-12-10 07:02:23,851 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:02:23 INFO - 2015-12-10 07:02:23,852 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:02:23 INFO - 2015-12-10 07:02:23,855 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2599.753023462771;2651.1648830618365;2660.813743037988;2674.7860171186308;2697.1234348836633;4337.327714204295;4494.865154045384;4553.749543775091;4582.656300777442;4624.121416930785;4513.097380523892;4536.455625324966;4579.404677391943;4587.632989360852;4641.443026836776;4233.767142807144;4279.893002674935;4287.506936702288;4379.058502421979;4405.713628614146;4040.353543433051;4310.159518893801;4333.60997510224;4408.537103604123;4423.823047078129;4148.004478925066;4226.788660566959;4230.428892099558;4244.469441319835;4252.064545799919;4267.530571637118;4271.252530807127;4279.807408666617;4292.399064131024;4316.913661726748;4092.815823287959;4262.019735460862;4283.7858107094835;4284.700070995032;4331.155424692186;4490.438695163105;4492.7528985905765;4503.527129651372;4542.04617030424;4596.310553416981;4959.057779021974;4965.106280869442;4966.081274964107;4969.031038947407;5008.524190201925;4853.660243782937;4996.700197988096;5010.0981823271795;5010.473900240495;5013.6490445668815;4516.119356725407;4570.794314255866;4586.518415566385;4586.88532786683;4606;5078.111330517145;5083.8983220335385;5084.694918304914;5085.694858308513;5101.51535604117;4876.878078048077;4877.146499362669;4895.73073480962;4898.559129678346;4935.703857768545;4773.188557945157;4841.104395686739;4899.191633380524;4901.852944411673;4975.825846095369;4960.751962401865;4962.057209130254;4965.205567109245;4966.180580204298;4967.230079337636;4960.727160006234;4964.05682920244;4964.975175124101;4966.255061740696;4996.90006199874;3923.5487918889694;4015.377616469452;4075.225707115698;4075.918481630351;4181.435506206623;3609.6931760800103;3623.221007483404;3629.927401451956;3639.94540081899;3659.341318562684;4339.218940590724;4340.370646256275;4344.522102568715;4345.67407444443;4383.7588932609015;4745.193317136095;4847.200211965057;4853.272009198648;4961.5286547777905;5022.74886255693;4321.438213032286;4325.740455572675;4328;4339.63113135387;4343.283358245854;4421.027373977719;4426.933595996063;4430.224710675619;4436.534163912807;4478.48497422794;4583.793729282257;4698.130845793539;4710.8351207707565;4717.386739723814;4803.207470767354;4849.248366503198;4940.604751619933;4957.851264462072;4973.104841128632;4975.154223782039;4687.554682305175;4730.361401210793;4731.384919960383;4732.52674732524;4791.233402655558;4743.573078422958;4866.367372241586;4867.415910090812;4882.755862206946;4928.556429921325;4835.540623640749;4884.5603895649565;4904.803807847647;4905.8037678492465;4940.580050695731;4821.54195351441;4836.492168322417;4842.394700662418;4842.661013729005;4885;4688.179568575554;4808.110499557593;4821.276808478756;4843.612510999041;4897.9020419592125;4621.976890115662;4655.464621568563;4688.109259240733;4689.859304220879;4740.051989602024;4889.559939605452;4893.535114164149;4895.290182923527;4910.631702622246;4942.975285123552;4514.7291162530355;4746.406699162605;4746.881327966828;4753.263244197155;4774.21225497789 07:02:23 INFO - 2015-12-10 07:02:23,857 DEBUG : BROWSER_OUTPUT: |1;ext.html;572.1960645293364;580.8702074465165;584.5382148102999;585.616421244085;599.9130126131711;27182.592261116075;27714.861425692845;27731.168064958034;32790;33189.17027074324;39098.413523797164;39703.80148099255;39805.60194398055;39855.80072099643;39863.40204896922;7890.289873911362;8056.959715201416;8058.073321568007;8066.4353495255355;8069.757907262791;7180.389666878295;7325.926740732578;10027.74930626733;10292.948535257314;10309.742256443611;9876.604935802596;9985.450800205987;9985.700428987142;9986.600535978552;10060.044295791888;7142.21435642079;7369.22623124575;10046;10164.796704065915;10172.44051577163;7086.68109935049;10145.594176233015;10432.843507347396;10440.738981525523;10453.68638940833;36879.26241475155;37397.81301093477;37405.31676074556;37405.81297093524;37466.43800342997;2106.083853523722;2733.139061195717;2750.714631902745;2967.792254542183;3521.190126270972;25893.611595826078;26269.080582179722;26740.86629566859;26984.325391865164;27130.050448234415;3026.6670666226696;3037.3014206732573;3064.310530130725;3107.471729805916;3119.391718614871;183796;184259;184543;185111;185348;50694.49305506972;51701.48298516967;51719.482805171465;51729.482705172464;51747;60499;61809.38190618126;61824.07263891045;61837.69081154565;61861.69069154625;12515.937420312841;12565.497380104876;12827.551035713705;12843.422046007952;12861.54984575554;8882.15619516145;8887.244584210286;8961.4175078621;8987.370884038186;8991.505467199237;17712.46862594124;17881.910590446965;17926.28294868217;17971.191296391695;18009.819901801075;7360.374368178765;7569.091708994956;7591.127020392615;7633.5419874807685;7709.575973321409;800.2877439079224;822.6421506644629;835.853725598018;874.8206617643368;1048.9737756555994;25792.226233213034;26122.216333510027;26332.210033698637;26670.19989400321;26681.33296667599;917.9541022948825;923.3259720404143;923.6859467780853;1014.2342531388754;1077.3374374759467;12436.253824770543;12581.93709031449;12625.810612840814;12688.492460301484;12696;263406;268972;269425;269450;269654;42824;42891;43122;43150;43447;1075.9462026898623;1086.0171544751854;1186.8931796138215;1198.796204645195;1205.75884823034;23247.767522325237;24576.401916827894;25164.622530662422;25207.109466789698;25215.747842522072;35125.64874351224;35309.823450882584;35333.1166720834;35414.82292588521;35429.29141417209;180450;226534;232858;321895;334391;27297.181084567495;27359;27381;27403.725962740118;27568.862155689094;37269.6273037277;37749.05627359228;38108.61891381162;38165.618343816204;38641.42037869491;32018.633385148867;32698.182545436553;32764;33071.031476223005;33475.83262083771;31322.21694457657;32636.184095396857;32958;33190.66809331972;33501.832490838366;30218.84890575621;30522.694773052874;30540.418937159604;32888.835555822065;33240.66759332376;27290.590641140003;28985.130446086652;29332.706672932996;29796.553051704675;30270.243243919078;22644.28195144848;23165.768342317035;23223.187188448323;23226.65160022635;23340.416489587897 07:02:23 INFO - 2015-12-10 07:02:23,860 DEBUG : BROWSER_OUTPUT: |2;jquery.html;339.7265201512781;342.59231514497753;343.4127641732637;344.0692925636154;345.93773120838244;12381.195222310544;12772.616821495347;15060;15062.924685376585;15855.048697078184;10607.045365917065;10614.203934704889;10640.840387394195;15212.619684507865;15292.235388230572;4809.326694262789;4867.221244600864;4999.975000124994;5024.296598476216;5032;3749.9437508437395;3862.7489213201193;4935.605151587864;5476.096444086741;5664.037113690682;5543.251661025771;5556.777728890839;5575.275214222145;5613.775448982035;5614.29821272341;4888.608911287106;4968.850934471971;5000.324956130912;5002.59979201663;5568.7215639217875;4686.484486706459;4799.256115302133;4817.85546433604;4823.879403014917;4827.8551643450755;11331.150163737753;11573.53705851765;11720.413979301002;11724.120690948213;19492.512687182792;1655.9503214903573;1801.8107404191987;1810.8913465192131;1829.679806033952;1851.0652120679106;12635.557755478514;12646.557370491988;12647.17793343439;12983.415746291439;13038.934805325913;1745.450183192303;1751.1944505527472;1775.3874913154941;1791.4177892184962;1830.3227805711838;49966.25050624244;50843.983120337754;56574.15138772922;58026.7098664504;58302.125468118014;9181.265498760084;9562.95218523903;9769.951150244204;9808.558614862348;9934.254930880214;12355.073369497144;12446.06654500916;12452;12452.75094498105;12470.376481175905;6774;6791.2869148739655;6829.6585170742255;6834.350736680008;6847.109875716125;6422.325655806167;6446.033095035782;6502.674866256668;6508.479321654257;6523.054157147187;4127.33962565988;4172.77049762266;4195.58044195578;4196.055887425305;4236.9364459533135;1611.3554578168591;1649.158928946222;1665.991670041642;1692.2723229011642;1704.9573760655835;825.8719898415756;829.6349606173264;854.9868405938857;894.7539426657592;920.3143657974717;12351.876481235253;14036.29818509091;15071.4724984625;15133.697326053638;15163.469278575198;790.6165509727778;809.3242142810819;830.0993422137049;855.2601999270711;879.3976126353468;8854.86717699235;8968.417052891671;9126.543672816333;9177;9521.857172142423;494410;507081;507726;508053;515573;68873.65563172252;70168.64915675389;72514.63742681252;73487;74073.25926740772;1031.886492485826;1037.4501514197486;1039.6101461951769;1064.6007747094839;1064.6380230721593;13887.236202008582;13953.790693139814;14000.43998240059;14121.929390353393;14179.361928713026;32590.83704581462;32963.505547417284;33286;33441.163970900925;33548.496772547944;43384.566154338056;44115.338269925334;44205.77897110494;44616.55383446124;47088;8180.631871565674;8386.32909367237;8438.113998030118;8443.620037098468;8447.95776021116;9833.70498885006;9905;12401.93799030999;14811.925940370229;15584;13109.934450327688;13218.537351192663;13237.470501179845;13286.734265314833;13487.460501580219;12876.613701588967;13007.544735934196;13441.126326788728;13584.388702508213;13736.93131534336;12927.030472714772;12936.870631293566;13334.866651333363;13463.528776492776;13487.190768553919;8454.619542120496;8672.609732561923;8772.429792063751;8779.20987111163;8793.076726943835;12325.383730813244;12339.383030848601;12398.81401778956;13052.54316098932;13423.932880335537 07:02:23 INFO - 2015-12-10 07:02:23,861 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1227.300438749913;1597.0896588944304;1659.9170041497923;1682.59617691754;1720.6902757503644;6022.7590896364145;6801.217859946108;6977.162740471138;6988.196357418892;7003.404710599592;6818.318168183179;6954.5479543829615;6984.1619005719385;6987.825304367393;6996.965015174917;1747.7116275814476;1765.37329248117;1999.4401567561033;2036.409441262036;2065.834733221346;2039.4289598912253;2044.7955204479508;2045.7851925547827;2047.3448496481133;2048.3752455501067;2014.8287395571322;2023.2817349840816;2067.7105205271273;2071.1508281604547;2072.5025993761465;2004.9699254511195;2011.979880201194;2030.3604364625169;2034.410021093881;2050.149188086942;2018.485286252011;2037.898105094754;2040.9081591328427;2042.1423002338904;2046.3553980496097;6912.619805910673;6982.755603553851;6985.196702379189;6986.790396288119;6989.89515157273;4031.9193616127804;4073.1853629274265;4086.12148388095;4102.3026085565225;4102.425660407545;2547.8598677072755;2604.1406335909105;2621.3839747659285;2631.63157157998;2641.4585010072888;816.7590560784582;855.2901092093548;860.6987554355987;861.1947828780111;871.5163084488106;9189.954050229773;9257.814843703156;9272.768180795467;9284.210842078432;9289.581968811419;3674.761140525911;3748.9437658435145;3756.4740936268945;3762.6801721853403;3778.5843557209237;8054.919450805534;8071;8073.555954422446;8078.474899131537;8085.83828323442;4148.668106551469;4162.937555936664;4181.477315335583;4181.937270940938;4183.39340795589;3774.8112594370173;3788.204477059848;3788.4885540452237;3793.203427280302;3797.2025874566098;2928.4582352264897;3056.938861222763;3058.525928481089;3095;3413.6586341365664;1087.7498175419698;1095.2606990281529;1099.1646348774989;1109.8668159820872;1110.4836251143095;898.6854600889636;898.9955050224838;960.7646126698863;1035.637526865606;1177.746784441332;6527.575707579087;6565.868682626417;6573.868522629521;6585.604863708193;6589.472842172615;933.7478880702172;941.5245301122889;956.5265193729149;959.7072892767773;986.8322385194534;4908.460069392364;4991.975040124777;4996.925046124311;5005.874853128701;5007.874803129951;8129.4715843469985;8228.0126384833;8535.445196062235;8541.273991710774;8561.700340488052;8322.958385208156;8411.957940210383;8415.452995555392;8428.199321064489;8444.071152173256;6177.722002509898;6370.681465926685;6507.7071531781185;6556.27880933097;6592.406683398517;6667.366600172976;6700.765473208415;6716.227633822173;6727.461803055841;6735;7313.561186328838;7368.115826100902;7523.022007139256;7615.352695020985;7673.693052277847;7574.166841647525;7737.690492380467;7827;7842;7852.254035866584;6108.053251745987;6158.476529495043;6176.567640265138;6185.010398336244;6191.25704915413;5849.415058494116;5986.2217911671205;6128.693565321805;6368.4586810121655;6594.043863639841;6227.283862355887;6272.686365681789;6344.984802431589;6430.164078669743;6432.903506447314;6042.848928776816;6056.697165141637;6134.723937422737;6145.9692701538;6176.969115154396;5804.912926306024;5901.7639294427745;5928.258967629046;6145.84635384119;6174.845628859314;5961.791337303173;5976.372480889444;5986.191864098465;5992.64044157352;5998.520118390431;5802.767889284381;5803.7968671096305;5805.76776928935;5806.071028635398;5818.4763371296785 07:02:23 INFO - 2015-12-10 07:02:23,863 DEBUG : BROWSER_OUTPUT: |4;prototype.html;306.8266429467351;312.44384994709424;314.95275708643703;314.97165255127044;319.86885376995434;5223.216517522374;5226.817061402851;5230.21546767985;5233.84298471046;5277.498637629428;5205.219217117435;5206.505381988714;5214.921776173351;5215.061288967984;5218.112920803463;4097.487814023247;4100.405441211023;4101.220768054068;4104.13813099248;4108.712390132692;3877.1664092220167;4002.9599704003026;4101.384792281152;4108.52751933527;4111.075008123178;3926.450296958428;3931.960680393188;3953.169834334793;3978.622030907059;3979.621935916083;4058.5129784425912;4079.653229475498;4079.837246384796;4088.3049881520215;4089.161721847044;3613;3613.1509095362567;3620.4931309616672;3627.4740162676526;3633.0372451300163;4756.3816703828625;4842.2736589511505;4912.336834527328;4954.2568614707725;5004.874878128039;4632.791524381411;4642.907141857144;4643.512431194709;4643.674942754009;4644.117617652635;5472.370677372113;5483.917741233885;5484;5490.423505531941;5490.780368785244;3871.6709079728257;3875.147467557133;3876.030992251937;3878.7866667333287;3879.4374815651854;5584.581156413245;5748.741306641211;5753.626014309057;5756.050251708463;5769.8557536061935;3914.9804250978564;3939.9212015759526;3940.133170702441;3942.2903877301787;3946.4474973503734;3780.9432858507143;3886.941695874564;3892.708046896494;3955.406688996616;3993.4608827807874;4539.8662628564525;4563.475200351935;4574.565416285448;4579.244424669959;4584.88537786558;5458.536024437967;5467.617266791286;5467.753951072212;5467.917981230285;5480.588955828329;1392.3455975691409;1414.2716501001992;1414.8868090552937;1415.2640626873967;1415.7522433574084;953.1755031897359;961.3318743473219;963.1812958984807;980.597954838527;984.2962281968283;4798.992211635526;4832.371791667061;4838.443578988461;4841.1285968526;4843.8304659337455;5646.209530665628;5654.604177707603;5658.7170641467765;5670.291213598301;5671.262735844314;4824.662273640882;4827.179379505493;4830.203016502308;4830.372051633265;4830.855074347775;2962.5852380666724;3009.8344591047703;3028.2732144285214;3031.3937212557576;3036.362363903561;5396.946030539723;5402.540784033323;5406.783728650888;5409.810656627078;5417.133258678593;5795.913061304;5797.043487824461;5805.477507024304;5807.941920580824;5811.041178205549;5404.243405923174;5418.051840927822;5423;5424.05079111154;5427.782888684408;5517.5585953124455;5655.349634792052;5668;5672.829815105553;5675.574331925205;5544.473275038865;5551.666899986014;5554.666719996813;5555.30558680165;5561.944380556142;5353.732313384237;5411.485908838654;5413.133898576209;5413.729313534386;5415.756290966995;3950.822213000364;3970.821313040862;3973.2252210818615;3976.6619837312996;3977.940330895097;5502.697351645698;5505.889882202414;5628.212050313042;5655.462731040545;5659.462351076806;5373.677579345252;5484.2596249505805;5499.477549632778;5499.862503437446;5507.981023510663;5437.782488700408;5477.04151773446;5492.231087647652;5500.862478438071;5502.8349149525575;5294.073537130909;5385.623006389672;5397.217403476552;5398.163284690879;5407.918881216863;5501.5323697486165;5536.446355364431;5544.750486228048;5546.556275498031;5550.195221692751;5412.810551630674;5414.485623865727;5417.783288668409;5417.945820541744;5425.213344065168 07:02:23 INFO - 2015-12-10 07:02:23,864 DEBUG : BROWSER_OUTPUT: |5;yui.html;700.3766647683561;741.5995362504248;751.1361933776157;757.2957149850637;800.683729926679;11922.046236301097;12234.938825305884;12236.143469957095;12246.387680615968;12250.754984900297;11386.886131138686;11468.426578671055;11469.59856405026;11473.655790326282;11497.310161390322;619.4889216396468;635.5297080160694;810.5703976892227;819.7663665855232;821.6754382019129;815.2011029191395;820.1962077164383;825.7646570727344;826.4545400035978;826.6032304493847;659.1990731261516;672.6771149848051;849.5285116760195;855.7903313688124;856.6316483911916;839.4082172068707;854.5129276312505;855.8930133733284;857.7941294089436;858.3733874271785;634.1945728924286;636.4335741190345;637.579197729501;637.9043143528462;638.5721566550422;12094.153409261355;12258.81611775824;12268.693282667915;12278.815817762741;12285.262884226975;10979.670609881716;11179.888201118047;11212.495437705242;11322.490487928064;11388.316700997966;8566;8680.435771674822;8759.34304927133;8767.079456657022;8768.079351668046;3159.636641786201;3172.349668317989;3207.246297120175;3221.7596225453135;3261.4781634938295;40194.19611607781;40334.79832600818;40392.596074039175;40432.191356173;40904.79547602243;8701.738947831574;8723.171298726611;8821.647134114564;8839.469631821983;8839.823203535892;16482;16818.747718784227;16845.32618695263;16902.661946761244;16922.576935576464;6189.102580125857;6252.196684306065;6309.873802523924;6346.079818426302;6382.106505089291;3531.911702207465;3544.7518673692593;3548.2903419315726;3584.6415358464465;3643.6356364363883;2734.125079974429;2767.045369347572;2776.6529183852017;2777.375090604638;2783.192874066498;490.2694984473109;492.97042177469467;503.67009608706354;506.60231718101113;506.90875642383986;370.88687950175455;383.7831625131847;384.2181161336666;416.07008336368193;416.79160419790105;6925.861482770317;7115.217326094125;7300.160481544584;7366.263373662591;7992.720254791055;366.5637890909809;399.5664703796355;434.3311300597108;473.93838800955655;519.3093186062528;3705.184859330943;3776.263628592398;3814.1990182062077;3822.2737679840743;3866.574676785551;43989.12021759547;49078.7730306738;49143;49231.50768492341;49322.753386233555;38446.615533844866;38663.42004869929;38703.80648096742;39412.605873941466;39507.802460987514;39837.203255935296;40381.59618403837;40558.52459917932;41632;41698.791506042275;7380.520266182681;7563.432742544222;7733;7773.572453514885;8078.474899131537;31538.369232615678;31664.20839478939;31948.840255798572;32192;32216.36213662553;39992.2001559973;40737.38893916653;40989.38515922204;40991.795041024605;41301.173976520906;9484.867582038498;9557.378770379903;9593.42439453635;9777.804443911224;9895;9882.50587470638;10047.799044019224;11017.83473247886;11022.944885275523;11099;10028.799424011333;10277.486125693536;10282.794344112926;10512.26414151002;10721.517531710935;10277.794444110927;10415.895841041493;10590.046895779416;10592.629257975934;10957.01386875185;7566.772996810105;9165.391907880774;9648.469334186406;9683;9684.08001239881;8208.09710931785;8221.424500284922;8702.782430439289;8995.550222488719;9294.72115836526;8810.823783524422;8820.470771753715;8982.191602755784;9050.954745226232;9231.58457869384 07:02:23 INFO - 2015-12-10 07:02:23,864 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:02:23 INFO - 2015-12-10 07:02:23,864 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:02:23 INFO - 2015-12-10 07:02:23,864 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,925 07:02:23 INFO - 2015-12-10 07:02:23,864 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:02:23 INFO - 2015-12-10 07:02:23,864 DEBUG : BROWSER_OUTPUT: __startTimestamp1449759743850__endTimestamp 07:02:23 INFO - 2015-12-10 07:02:23,865 DEBUG : BROWSER_OUTPUT: 07:02:23 INFO - 2015-12-10 07:02:23,865 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:02:23 INFO - 2015-12-10 07:02:23,866 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:02:23 INFO - 2015-12-10 07:02:23,866 DEBUG : BROWSER_OUTPUT: 07:02:23 INFO - 2015-12-10 07:02:23,866 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4567.93 Median:4689.86 stddev:472.95 (10.1%) stddev-sans-first:448.49 07:02:23 INFO - 2015-12-10 07:02:23,866 DEBUG : BROWSER_OUTPUT: Values: 2599.8 2651.2 2660.8 2674.8 2697.1 4337.3 4494.9 4553.7 4582.7 4624.1 4513.1 4536.5 4579.4 4587.6 4641.4 4233.8 4279.9 4287.5 4379.1 4405.7 4040.4 4310.2 4333.6 4408.5 4423.8 4148.0 4226.8 4230.4 4244.5 4252.1 4267.5 4271.3 4279.8 4292.4 4316.9 4092.8 4262.0 4283.8 4284.7 4331.2 4490.4 4492.8 4503.5 4542.0 4596.3 4959.1 4965.1 4966.1 4969.0 5008.5 4853.7 4996.7 5010.1 5010.5 5013.6 4516.1 4570.8 4586.5 4586.9 4606.0 5078.1 5083.9 5084.7 5085.7 5101.5 4876.9 4877.1 4895.7 4898.6 4935.7 4773.2 4841.1 4899.2 4901.9 4975.8 4960.8 4962.1 4965.2 4966.2 4967.2 4960.7 4964.1 4965.0 4966.3 4996.9 3923.5 4015.4 4075.2 4075.9 4181.4 3609.7 3623.2 3629.9 3639.9 3659.3 4339.2 4340.4 4344.5 4345.7 4383.8 4745.2 4847.2 4853.3 4961.5 5022.7 4321.4 4325.7 4328.0 4339.6 4343.3 4421.0 4426.9 4430.2 4436.5 4478.5 4583.8 4698.1 4710.8 4717.4 4803.2 4849.2 4940.6 4957.9 4973.1 4975.2 4687.6 4730.4 4731.4 4732.5 4791.2 4743.6 4866.4 4867.4 4882.8 4928.6 4835.5 4884.6 4904.8 4905.8 4940.6 4821.5 4836.5 4842.4 4842.7 4885.0 4688.2 4808.1 4821.3 4843.6 4897.9 4622.0 4655.5 4688.1 4689.9 4740.1 4889.6 4893.5 4895.3 4910.6 4943.0 4514.7 4746.4 4746.9 4753.3 4774.2 07:02:23 INFO - 2015-12-10 07:02:23,866 DEBUG : BROWSER_OUTPUT: 07:02:23 INFO - 2015-12-10 07:02:23,867 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39372.45 Median:3113.43 stddev:63481.41 (2039.0%) stddev-sans-first:63592.64 07:02:23 INFO - 2015-12-10 07:02:23,867 DEBUG : BROWSER_OUTPUT: Values: 572.2 580.9 584.5 585.6 599.9 27182.6 27714.9 27731.2 32790.0 33189.2 39098.4 39703.8 39805.6 39855.8 39863.4 7890.3 8057.0 8058.1 8066.4 8069.8 7180.4 7325.9 10027.7 10292.9 10309.7 9876.6 9985.5 9985.7 9986.6 10060.0 7142.2 7369.2 10046.0 10164.8 10172.4 7086.7 10145.6 10432.8 10440.7 10453.7 36879.3 37397.8 37405.3 37405.8 37466.4 2106.1 2733.1 2750.7 2967.8 3521.2 25893.6 26269.1 26740.9 26984.3 27130.1 3026.7 3037.3 3064.3 3107.5 3119.4 183796.0 184259.0 184543.0 185111.0 185348.0 50694.5 51701.5 51719.5 51729.5 51747.0 60499.0 61809.4 61824.1 61837.7 61861.7 12515.9 12565.5 12827.6 12843.4 12861.5 8882.2 8887.2 8961.4 8987.4 8991.5 17712.5 17881.9 17926.3 17971.2 18009.8 7360.4 7569.1 7591.1 7633.5 7709.6 800.3 822.6 835.9 874.8 1049.0 25792.2 26122.2 26332.2 26670.2 26681.3 918.0 923.3 923.7 1014.2 1077.3 12436.3 12581.9 12625.8 12688.5 12696.0 263406.0 268972.0 269425.0 269450.0 269654.0 42824.0 42891.0 43122.0 43150.0 43447.0 1075.9 1086.0 1186.9 1198.8 1205.8 23247.8 24576.4 25164.6 25207.1 25215.7 35125.6 35309.8 35333.1 35414.8 35429.3 180450.0 226534.0 232858.0 321895.0 334391.0 27297.2 27359.0 27381.0 27403.7 27568.9 37269.6 37749.1 38108.6 38165.6 38641.4 32018.6 32698.2 32764.0 33071.0 33475.8 31322.2 32636.2 32958.0 33190.7 33501.8 30218.8 30522.7 30540.4 32888.8 33240.7 27290.6 28985.1 29332.7 29796.6 30270.2 22644.3 23165.8 23223.2 23226.7 23340.4 07:02:23 INFO - 2015-12-10 07:02:23,867 DEBUG : BROWSER_OUTPUT: 07:02:23 INFO - 2015-12-10 07:02:23,867 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26563.87 Median:4150.06 stddev:82762.54 (1994.3%) stddev-sans-first:82971.28 07:02:23 INFO - 2015-12-10 07:02:23,868 DEBUG : BROWSER_OUTPUT: Values: 339.7 342.6 343.4 344.1 345.9 12381.2 12772.6 15060.0 15062.9 15855.0 10607.0 10614.2 10640.8 15212.6 15292.2 4809.3 4867.2 5000.0 5024.3 5032.0 3749.9 3862.7 4935.6 5476.1 5664.0 5543.3 5556.8 5575.3 5613.8 5614.3 4888.6 4968.9 5000.3 5002.6 5568.7 4686.5 4799.3 4817.9 4823.9 4827.9 11331.2 11573.5 11720.4 11724.1 19492.5 1656.0 1801.8 1810.9 1829.7 1851.1 12635.6 12646.6 12647.2 12983.4 13038.9 1745.5 1751.2 1775.4 1791.4 1830.3 49966.3 50844.0 56574.2 58026.7 58302.1 9181.3 9563.0 9770.0 9808.6 9934.3 12355.1 12446.1 12452.0 12452.8 12470.4 6774.0 6791.3 6829.7 6834.4 6847.1 6422.3 6446.0 6502.7 6508.5 6523.1 4127.3 4172.8 4195.6 4196.1 4236.9 1611.4 1649.2 1666.0 1692.3 1705.0 825.9 829.6 855.0 894.8 920.3 12351.9 14036.3 15071.5 15133.7 15163.5 790.6 809.3 830.1 855.3 879.4 8854.9 8968.4 9126.5 9177.0 9521.9 494410.0 507081.0 507726.0 508053.0 515573.0 68873.7 70168.6 72514.6 73487.0 74073.3 1031.9 1037.5 1039.6 1064.6 1064.6 13887.2 13953.8 14000.4 14121.9 14179.4 32590.8 32963.5 33286.0 33441.2 33548.5 43384.6 44115.3 44205.8 44616.6 47088.0 8180.6 8386.3 8438.1 8443.6 8448.0 9833.7 9905.0 12401.9 14811.9 15584.0 13109.9 13218.5 13237.5 13286.7 13487.5 12876.6 13007.5 13441.1 13584.4 13736.9 12927.0 12936.9 13334.9 13463.5 13487.2 8454.6 8672.6 8772.4 8779.2 8793.1 12325.4 12339.4 12398.8 13052.5 13423.9 07:02:23 INFO - 2015-12-10 07:02:23,868 DEBUG : BROWSER_OUTPUT: 07:02:23 INFO - 2015-12-10 07:02:23,868 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4845.28 Median:6118.37 stddev:2511.04 (41.0%) stddev-sans-first:2503.36 07:02:23 INFO - 2015-12-10 07:02:23,869 DEBUG : BROWSER_OUTPUT: Values: 1227.3 1597.1 1659.9 1682.6 1720.7 6022.8 6801.2 6977.2 6988.2 7003.4 6818.3 6954.5 6984.2 6987.8 6997.0 1747.7 1765.4 1999.4 2036.4 2065.8 2039.4 2044.8 2045.8 2047.3 2048.4 2014.8 2023.3 2067.7 2071.2 2072.5 2005.0 2012.0 2030.4 2034.4 2050.1 2018.5 2037.9 2040.9 2042.1 2046.4 6912.6 6982.8 6985.2 6986.8 6989.9 4031.9 4073.2 4086.1 4102.3 4102.4 2547.9 2604.1 2621.4 2631.6 2641.5 816.8 855.3 860.7 861.2 871.5 9190.0 9257.8 9272.8 9284.2 9289.6 3674.8 3748.9 3756.5 3762.7 3778.6 8054.9 8071.0 8073.6 8078.5 8085.8 4148.7 4162.9 4181.5 4181.9 4183.4 3774.8 3788.2 3788.5 3793.2 3797.2 2928.5 3056.9 3058.5 3095.0 3413.7 1087.7 1095.3 1099.2 1109.9 1110.5 898.7 899.0 960.8 1035.6 1177.7 6527.6 6565.9 6573.9 6585.6 6589.5 933.7 941.5 956.5 959.7 986.8 4908.5 4992.0 4996.9 5005.9 5007.9 8129.5 8228.0 8535.4 8541.3 8561.7 8323.0 8412.0 8415.5 8428.2 8444.1 6177.7 6370.7 6507.7 6556.3 6592.4 6667.4 6700.8 6716.2 6727.5 6735.0 7313.6 7368.1 7523.0 7615.4 7673.7 7574.2 7737.7 7827.0 7842.0 7852.3 6108.1 6158.5 6176.6 6185.0 6191.3 5849.4 5986.2 6128.7 6368.5 6594.0 6227.3 6272.7 6345.0 6430.2 6432.9 6042.8 6056.7 6134.7 6146.0 6177.0 5804.9 5901.8 5928.3 6145.8 6174.8 5961.8 5976.4 5986.2 5992.6 5998.5 5802.8 5803.8 5805.8 5806.1 5818.5 07:02:23 INFO - 2015-12-10 07:02:23,869 DEBUG : BROWSER_OUTPUT: 07:02:23 INFO - 2015-12-10 07:02:23,869 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4551.00 Median:5225.02 stddev:1328.95 (25.4%) stddev-sans-first:1293.93 07:02:23 INFO - 2015-12-10 07:02:23,870 DEBUG : BROWSER_OUTPUT: Values: 306.8 312.4 315.0 315.0 319.9 5223.2 5226.8 5230.2 5233.8 5277.5 5205.2 5206.5 5214.9 5215.1 5218.1 4097.5 4100.4 4101.2 4104.1 4108.7 3877.2 4003.0 4101.4 4108.5 4111.1 3926.5 3932.0 3953.2 3978.6 3979.6 4058.5 4079.7 4079.8 4088.3 4089.2 3613.0 3613.2 3620.5 3627.5 3633.0 4756.4 4842.3 4912.3 4954.3 5004.9 4632.8 4642.9 4643.5 4643.7 4644.1 5472.4 5483.9 5484.0 5490.4 5490.8 3871.7 3875.1 3876.0 3878.8 3879.4 5584.6 5748.7 5753.6 5756.1 5769.9 3915.0 3939.9 3940.1 3942.3 3946.4 3780.9 3886.9 3892.7 3955.4 3993.5 4539.9 4563.5 4574.6 4579.2 4584.9 5458.5 5467.6 5467.8 5467.9 5480.6 1392.3 1414.3 1414.9 1415.3 1415.8 953.2 961.3 963.2 980.6 984.3 4799.0 4832.4 4838.4 4841.1 4843.8 5646.2 5654.6 5658.7 5670.3 5671.3 4824.7 4827.2 4830.2 4830.4 4830.9 2962.6 3009.8 3028.3 3031.4 3036.4 5396.9 5402.5 5406.8 5409.8 5417.1 5795.9 5797.0 5805.5 5807.9 5811.0 5404.2 5418.1 5423.0 5424.1 5427.8 5517.6 5655.3 5668.0 5672.8 5675.6 5544.5 5551.7 5554.7 5555.3 5561.9 5353.7 5411.5 5413.1 5413.7 5415.8 3950.8 3970.8 3973.2 3976.7 3977.9 5502.7 5505.9 5628.2 5655.5 5659.5 5373.7 5484.3 5499.5 5499.9 5508.0 5437.8 5477.0 5492.2 5500.9 5502.8 5294.1 5385.6 5397.2 5398.2 5407.9 5501.5 5536.4 5544.8 5546.6 5550.2 5412.8 5414.5 5417.8 5417.9 5425.2 07:02:23 INFO - 2015-12-10 07:02:23,870 DEBUG : BROWSER_OUTPUT: 07:02:23 INFO - 2015-12-10 07:02:23,870 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11974.56 Median:21066.56 stddev:13499.06 (64.1%) stddev-sans-first:13510.38 07:02:23 INFO - 2015-12-10 07:02:23,871 DEBUG : BROWSER_OUTPUT: Values: 700.4 741.6 751.1 757.3 800.7 11922.0 12234.9 12236.1 12246.4 12250.8 11386.9 11468.4 11469.6 11473.7 11497.3 619.5 635.5 810.6 819.8 821.7 815.2 820.2 825.8 826.5 826.6 659.2 672.7 849.5 855.8 856.6 839.4 854.5 855.9 857.8 858.4 634.2 636.4 637.6 637.9 638.6 12094.2 12258.8 12268.7 12278.8 12285.3 10979.7 11179.9 11212.5 11322.5 11388.3 8566.0 8680.4 8759.3 8767.1 8768.1 3159.6 3172.3 3207.2 3221.8 3261.5 40194.2 40334.8 40392.6 40432.2 40904.8 8701.7 8723.2 8821.6 8839.5 8839.8 16482.0 16818.7 16845.3 16902.7 16922.6 6189.1 6252.2 6309.9 6346.1 6382.1 3531.9 3544.8 3548.3 3584.6 3643.6 2734.1 2767.0 2776.7 2777.4 2783.2 490.3 493.0 503.7 506.6 506.9 370.9 383.8 384.2 416.1 416.8 6925.9 7115.2 7300.2 7366.3 7992.7 366.6 399.6 434.3 473.9 519.3 3705.2 3776.3 3814.2 3822.3 3866.6 43989.1 49078.8 49143.0 49231.5 49322.8 38446.6 38663.4 38703.8 39412.6 39507.8 39837.2 40381.6 40558.5 41632.0 41698.8 7380.5 7563.4 7733.0 7773.6 8078.5 31538.4 31664.2 31948.8 32192.0 32216.4 39992.2 40737.4 40989.4 40991.8 41301.2 9484.9 9557.4 9593.4 9777.8 9895.0 9882.5 10047.8 11017.8 11022.9 11099.0 10028.8 10277.5 10282.8 10512.3 10721.5 10277.8 10415.9 10590.0 10592.6 10957.0 7566.8 9165.4 9648.5 9683.0 9684.1 8208.1 8221.4 8702.8 8995.6 9294.7 8810.8 8820.5 8982.2 9051.0 9231.6 07:02:23 INFO - 2015-12-10 07:02:23,871 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:02:23 INFO - 2015-12-10 07:02:23,871 DEBUG : BROWSER_OUTPUT: 07:02:24 INFO - 2015-12-10 07:02:24,705 INFO : Browser exited with error code: 0 07:02:24 INFO - 2015-12-10 07:02:24,721 INFO : Completed test dromaeo_css (00:18:39) 07:02:24 INFO - 2015-12-10 07:02:24,722 INFO : Starting test kraken 07:02:24 INFO - 2015-12-10 07:02:24,722 DEBUG : operating with platform_type : linux_ 07:02:24 INFO - 2015-12-10 07:02:24,722 INFO : Initialising browser for kraken test... 07:02:24 INFO - 2015-12-10 07:02:24,728 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxaKEYk/profile http://localhost:58196/getInfo.html 07:02:29 INFO - 2015-12-10 07:02:29,748 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:02:29 INFO - 2015-12-10 07:02:29,748 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:02:29 INFO - 2015-12-10 07:02:29,748 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:02:29 INFO - 2015-12-10 07:02:29,748 DEBUG : BROWSER_OUTPUT: __metrics 07:02:29 INFO - 2015-12-10 07:02:29,954 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:02:30 INFO - 2015-12-10 07:02:30,036 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] 07:02:31 INFO - 2015-12-10 07:02:31,398 INFO : Browser initialized. 07:02:31 INFO - 2015-12-10 07:02:31,398 INFO : Running cycle 1/1 for kraken test... 07:02:31 INFO - 2015-12-10 07:02:31,399 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxaKEYk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:02:43 INFO - 2015-12-10 07:02:43,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 143114240 07:02:43 INFO - 2015-12-10 07:02:43,454 DEBUG : BROWSER_OUTPUT: 07:02:46 INFO - 2015-12-10 07:02:46,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58196/tests/kraken/driver.html?testName=audio-beat-detection) 07:02:46 INFO - 2015-12-10 07:02:46,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 178102272 07:02:46 INFO - 2015-12-10 07:02:46,638 DEBUG : BROWSER_OUTPUT: 07:02:49 INFO - 2015-12-10 07:02:49,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58196/tests/kraken/driver.html?testName=audio-dft) 07:02:49 INFO - 2015-12-10 07:02:49,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 165629952 07:02:49 INFO - 2015-12-10 07:02:49,962 DEBUG : BROWSER_OUTPUT: 07:02:52 INFO - 2015-12-10 07:02:52,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58196/tests/kraken/driver.html?testName=audio-fft) 07:02:53 INFO - 2015-12-10 07:02:53,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 154791936 07:02:53 INFO - 2015-12-10 07:02:53,529 DEBUG : BROWSER_OUTPUT: 07:02:55 INFO - 2015-12-10 07:02:55,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58196/tests/kraken/driver.html?testName=audio-oscillator) 07:02:56 INFO - 2015-12-10 07:02:56,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 157097984 07:02:56 INFO - 2015-12-10 07:02:56,167 DEBUG : BROWSER_OUTPUT: 07:02:58 INFO - 2015-12-10 07:02:58,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58196/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:02:58 INFO - 2015-12-10 07:02:58,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 158560256 07:02:58 INFO - 2015-12-10 07:02:58,958 DEBUG : BROWSER_OUTPUT: 07:03:01 INFO - 2015-12-10 07:03:01,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58196/tests/kraken/driver.html?testName=imaging-darkroom) 07:03:02 INFO - 2015-12-10 07:03:02,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 158556160 07:03:02 INFO - 2015-12-10 07:03:02,546 DEBUG : BROWSER_OUTPUT: 07:03:05 INFO - 2015-12-10 07:03:05,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58196/tests/kraken/driver.html?testName=imaging-desaturate) 07:03:06 INFO - 2015-12-10 07:03:06,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 157818880 07:03:06 INFO - 2015-12-10 07:03:06,542 DEBUG : BROWSER_OUTPUT: 07:03:09 INFO - 2015-12-10 07:03:09,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58196/tests/kraken/driver.html?testName=json-parse-financial) 07:03:09 INFO - 2015-12-10 07:03:09,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 159473664 07:03:09 INFO - 2015-12-10 07:03:09,978 DEBUG : BROWSER_OUTPUT: 07:03:11 INFO - 2015-12-10 07:03:11,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58196/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:03:12 INFO - 2015-12-10 07:03:12,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 168243200 07:03:12 INFO - 2015-12-10 07:03:12,327 DEBUG : BROWSER_OUTPUT: 07:03:14 INFO - 2015-12-10 07:03:14,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58196/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:03:14 INFO - 2015-12-10 07:03:14,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 168296448 07:03:14 INFO - 2015-12-10 07:03:14,795 DEBUG : BROWSER_OUTPUT: 07:03:16 INFO - 2015-12-10 07:03:16,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58196/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:03:17 INFO - 2015-12-10 07:03:17,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 180047872 07:03:17 INFO - 2015-12-10 07:03:17,549 DEBUG : BROWSER_OUTPUT: 07:03:20 INFO - 2015-12-10 07:03:20,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58196/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:03:20 INFO - 2015-12-10 07:03:20,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 185049088 07:03:20 INFO - 2015-12-10 07:03:20,651 DEBUG : BROWSER_OUTPUT: 07:03:23 INFO - 2015-12-10 07:03:23,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58196/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:03:23 INFO - 2015-12-10 07:03:23,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 182583296 07:03:23 INFO - 2015-12-10 07:03:23,799 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58196/tests/kraken/driver.html?testName=ai-astar) 07:03:25 INFO - 2015-12-10 07:03:25,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 240734208 07:03:25 INFO - 2015-12-10 07:03:25,826 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,827 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:03:25 INFO - 2015-12-10 07:03:25,827 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:03:25 INFO - 2015-12-10 07:03:25,827 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:03:25 INFO - 2015-12-10 07:03:25,827 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:03:25 INFO - 2015-12-10 07:03:25,827 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;111;112;111;113;102;111;111;102 07:03:25 INFO - 2015-12-10 07:03:25,827 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;133;175;164;129;159;158;129;171;129 07:03:25 INFO - 2015-12-10 07:03:25,828 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;161;162;162;162;161;161;161;162 07:03:25 INFO - 2015-12-10 07:03:25,828 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;83;93;70;78;72;111;101;71 07:03:25 INFO - 2015-12-10 07:03:25,828 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;94;140;95;94;94;127;96;95;134 07:03:25 INFO - 2015-12-10 07:03:25,828 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;109;109;109;110;109;109;109;109 07:03:25 INFO - 2015-12-10 07:03:25,828 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;148;146;145;146;146;146;146;146;146 07:03:25 INFO - 2015-12-10 07:03:25,828 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;95 07:03:25 INFO - 2015-12-10 07:03:25,828 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;70;72;71;73;70;71;83;67;68 07:03:25 INFO - 2015-12-10 07:03:25,828 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;67;68;69;69;69;68;68;69 07:03:25 INFO - 2015-12-10 07:03:25,829 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;92;85;84;83;84;83;86;85;84 07:03:25 INFO - 2015-12-10 07:03:25,829 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;127;118;118;123;118;127;119;119;128 07:03:25 INFO - 2015-12-10 07:03:25,829 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;139;151;144;146;135;140;140;144;134 07:03:25 INFO - 2015-12-10 07:03:25,829 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;72;71;69;68;68;68;69;69;69 07:03:25 INFO - 2015-12-10 07:03:25,829 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:03:25 INFO - 2015-12-10 07:03:25,829 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:03:25 INFO - 2015-12-10 07:03:25,829 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,980 07:03:25 INFO - 2015-12-10 07:03:25,829 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:03:25 INFO - 2015-12-10 07:03:25,829 DEBUG : BROWSER_OUTPUT: __startTimestamp1449759805821__endTimestamp 07:03:25 INFO - 2015-12-10 07:03:25,829 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,830 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:03:25 INFO - 2015-12-10 07:03:25,831 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:03:25 INFO - 2015-12-10 07:03:25,831 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,831 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:4.14 (3.7%) stddev-sans-first:4.36 07:03:25 INFO - 2015-12-10 07:03:25,831 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 111.0 112.0 111.0 113.0 102.0 111.0 111.0 102.0 07:03:25 INFO - 2015-12-10 07:03:25,831 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,831 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.20 Median:158.50 stddev:18.39 (11.6%) stddev-sans-first:19.42 07:03:25 INFO - 2015-12-10 07:03:25,831 DEBUG : BROWSER_OUTPUT: Values: 155.0 133.0 175.0 164.0 129.0 159.0 158.0 129.0 171.0 129.0 07:03:25 INFO - 2015-12-10 07:03:25,831 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,831 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 07:03:25 INFO - 2015-12-10 07:03:25,831 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 161.0 162.0 162.0 162.0 161.0 161.0 161.0 162.0 07:03:25 INFO - 2015-12-10 07:03:25,831 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,831 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.30 Median:72.00 stddev:14.55 (20.2%) stddev-sans-first:14.94 07:03:25 INFO - 2015-12-10 07:03:25,831 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 83.0 93.0 70.0 78.0 72.0 111.0 101.0 71.0 07:03:25 INFO - 2015-12-10 07:03:25,831 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,831 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:94.50 stddev:19.01 (20.1%) stddev-sans-first:19.78 07:03:25 INFO - 2015-12-10 07:03:25,831 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 140.0 95.0 94.0 94.0 127.0 96.0 95.0 134.0 07:03:25 INFO - 2015-12-10 07:03:25,832 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,832 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.00 stddev:0.70 (0.6%) stddev-sans-first:0.44 07:03:25 INFO - 2015-12-10 07:03:25,832 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 07:03:25 INFO - 2015-12-10 07:03:25,832 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,832 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 07:03:25 INFO - 2015-12-10 07:03:25,832 DEBUG : BROWSER_OUTPUT: Values: 146.0 148.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 07:03:25 INFO - 2015-12-10 07:03:25,832 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,832 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:03:25 INFO - 2015-12-10 07:03:25,832 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 07:03:25 INFO - 2015-12-10 07:03:25,832 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,832 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.80 Median:71.50 stddev:4.39 (6.1%) stddev-sans-first:4.64 07:03:25 INFO - 2015-12-10 07:03:25,832 DEBUG : BROWSER_OUTPUT: Values: 73.0 70.0 72.0 71.0 73.0 70.0 71.0 83.0 67.0 68.0 07:03:25 INFO - 2015-12-10 07:03:25,832 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,832 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 07:03:25 INFO - 2015-12-10 07:03:25,832 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 67.0 68.0 69.0 69.0 69.0 68.0 68.0 69.0 07:03:25 INFO - 2015-12-10 07:03:25,832 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,833 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.50 stddev:2.62 (3.1%) stddev-sans-first:2.76 07:03:25 INFO - 2015-12-10 07:03:25,833 DEBUG : BROWSER_OUTPUT: Values: 84.0 92.0 85.0 84.0 83.0 84.0 83.0 86.0 85.0 84.0 07:03:25 INFO - 2015-12-10 07:03:25,833 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,833 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:121.00 stddev:4.40 (3.6%) stddev-sans-first:4.37 07:03:25 INFO - 2015-12-10 07:03:25,833 DEBUG : BROWSER_OUTPUT: Values: 117.0 127.0 118.0 118.0 123.0 118.0 127.0 119.0 119.0 128.0 07:03:25 INFO - 2015-12-10 07:03:25,833 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,833 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.80 Median:142.00 stddev:5.47 (3.9%) stddev-sans-first:5.39 07:03:25 INFO - 2015-12-10 07:03:25,833 DEBUG : BROWSER_OUTPUT: Values: 135.0 139.0 151.0 144.0 146.0 135.0 140.0 140.0 144.0 134.0 07:03:25 INFO - 2015-12-10 07:03:25,834 DEBUG : BROWSER_OUTPUT: 07:03:25 INFO - 2015-12-10 07:03:25,834 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.00 stddev:1.43 (2.1%) stddev-sans-first:1.39 07:03:25 INFO - 2015-12-10 07:03:25,834 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 71.0 69.0 68.0 68.0 68.0 69.0 69.0 69.0 07:03:25 INFO - 2015-12-10 07:03:25,834 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:03:25 INFO - 2015-12-10 07:03:25,834 DEBUG : BROWSER_OUTPUT: 07:03:26 INFO - 2015-12-10 07:03:26,721 INFO : Browser exited with error code: 0 07:03:26 INFO - 2015-12-10 07:03:26,769 INFO : Completed test kraken (00:01:02) 07:03:26 INFO - 2015-12-10 07:03:26,769 INFO : Starting test v8_7 07:03:26 INFO - 2015-12-10 07:03:26,769 DEBUG : operating with platform_type : linux_ 07:03:26 INFO - 2015-12-10 07:03:26,769 INFO : Initialising browser for v8_7 test... 07:03:26 INFO - 2015-12-10 07:03:26,775 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT9d6IK/profile http://localhost:58196/getInfo.html 07:03:32 INFO - 2015-12-10 07:03:32,033 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:03:32 INFO - 2015-12-10 07:03:32,033 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:03:32 INFO - 2015-12-10 07:03:32,033 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:03:32 INFO - 2015-12-10 07:03:32,033 DEBUG : BROWSER_OUTPUT: __metrics 07:03:32 INFO - 2015-12-10 07:03:32,235 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:03:32 INFO - 2015-12-10 07:03:32,291 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] 07:03:33 INFO - 2015-12-10 07:03:33,812 INFO : Browser initialized. 07:03:33 INFO - 2015-12-10 07:03:33,813 INFO : Running cycle 1/1 for v8_7 test... 07:03:33 INFO - 2015-12-10 07:03:33,813 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT9d6IK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:03:45 INFO - 2015-12-10 07:03:45,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 143101952 07:03:45 INFO - 2015-12-10 07:03:45,790 DEBUG : BROWSER_OUTPUT: 07:04:07 INFO - 2015-12-10 07:04:07,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58196/tests/v8_7/run.html (next: http://localhost:58196/tests/v8_7/run.html) 07:04:07 INFO - 2015-12-10 07:04:07,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 437608448 07:04:07 INFO - 2015-12-10 07:04:07,523 DEBUG : BROWSER_OUTPUT: 07:04:07 INFO - 2015-12-10 07:04:07,523 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:04:07 INFO - 2015-12-10 07:04:07,523 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:04:07 INFO - 2015-12-10 07:04:07,523 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:04:07 INFO - 2015-12-10 07:04:07,523 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:04:07 INFO - 2015-12-10 07:04:07,523 DEBUG : BROWSER_OUTPUT: |0;Richards;165.39861065167054 07:04:07 INFO - 2015-12-10 07:04:07,523 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.6019779809666 07:04:07 INFO - 2015-12-10 07:04:07,524 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 07:04:07 INFO - 2015-12-10 07:04:07,524 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 07:04:07 INFO - 2015-12-10 07:04:07,524 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1992.03187250996 07:04:07 INFO - 2015-12-10 07:04:07,524 DEBUG : BROWSER_OUTPUT: |5;Earley;809.7165991902834 07:04:07 INFO - 2015-12-10 07:04:07,524 DEBUG : BROWSER_OUTPUT: |6;Boyer;12083.333333333334 07:04:07 INFO - 2015-12-10 07:04:07,524 DEBUG : BROWSER_OUTPUT: |7;RegExp;27324.324324324323 07:04:07 INFO - 2015-12-10 07:04:07,524 DEBUG : BROWSER_OUTPUT: |8;Splay;596.688350088705 07:04:07 INFO - 2015-12-10 07:04:07,525 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 07:04:07 INFO - 2015-12-10 07:04:07,525 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:04:07 INFO - 2015-12-10 07:04:07,525 DEBUG : BROWSER_OUTPUT: __startTimestamp1449759847515__endTimestamp 07:04:07 INFO - 2015-12-10 07:04:07,525 DEBUG : BROWSER_OUTPUT: 07:04:07 INFO - 2015-12-10 07:04:07,525 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:04:07 INFO - 2015-12-10 07:04:07,525 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:04:07 INFO - 2015-12-10 07:04:07,525 DEBUG : BROWSER_OUTPUT: 07:04:07 INFO - 2015-12-10 07:04:07,526 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.40 Median:165.40 stddev:0.00 (0.0%) 07:04:07 INFO - 2015-12-10 07:04:07,526 DEBUG : BROWSER_OUTPUT: Values: 165.4 07:04:07 INFO - 2015-12-10 07:04:07,526 DEBUG : BROWSER_OUTPUT: 07:04:07 INFO - 2015-12-10 07:04:07,526 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.60 Median:186.60 stddev:0.00 (0.0%) 07:04:07 INFO - 2015-12-10 07:04:07,526 DEBUG : BROWSER_OUTPUT: Values: 186.6 07:04:07 INFO - 2015-12-10 07:04:07,526 DEBUG : BROWSER_OUTPUT: 07:04:07 INFO - 2015-12-10 07:04:07,526 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 07:04:07 INFO - 2015-12-10 07:04:07,526 DEBUG : BROWSER_OUTPUT: Values: 278.3 07:04:07 INFO - 2015-12-10 07:04:07,527 DEBUG : BROWSER_OUTPUT: 07:04:07 INFO - 2015-12-10 07:04:07,527 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 07:04:07 INFO - 2015-12-10 07:04:07,527 DEBUG : BROWSER_OUTPUT: Values: 5148.7 07:04:07 INFO - 2015-12-10 07:04:07,527 DEBUG : BROWSER_OUTPUT: 07:04:07 INFO - 2015-12-10 07:04:07,527 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 07:04:07 INFO - 2015-12-10 07:04:07,527 DEBUG : BROWSER_OUTPUT: Values: 1992.0 07:04:07 INFO - 2015-12-10 07:04:07,527 DEBUG : BROWSER_OUTPUT: 07:04:07 INFO - 2015-12-10 07:04:07,528 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:809.72 Median:809.72 stddev:0.00 (0.0%) 07:04:07 INFO - 2015-12-10 07:04:07,528 DEBUG : BROWSER_OUTPUT: Values: 809.7 07:04:07 INFO - 2015-12-10 07:04:07,528 DEBUG : BROWSER_OUTPUT: 07:04:07 INFO - 2015-12-10 07:04:07,528 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12083.33 Median:12083.33 stddev:0.00 (0.0%) 07:04:07 INFO - 2015-12-10 07:04:07,528 DEBUG : BROWSER_OUTPUT: Values: 12083.3 07:04:07 INFO - 2015-12-10 07:04:07,528 DEBUG : BROWSER_OUTPUT: 07:04:07 INFO - 2015-12-10 07:04:07,528 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27324.32 Median:27324.32 stddev:0.00 (0.0%) 07:04:07 INFO - 2015-12-10 07:04:07,528 DEBUG : BROWSER_OUTPUT: Values: 27324.3 07:04:07 INFO - 2015-12-10 07:04:07,529 DEBUG : BROWSER_OUTPUT: 07:04:07 INFO - 2015-12-10 07:04:07,529 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:596.69 Median:596.69 stddev:0.00 (0.0%) 07:04:07 INFO - 2015-12-10 07:04:07,529 DEBUG : BROWSER_OUTPUT: Values: 596.7 07:04:07 INFO - 2015-12-10 07:04:07,529 DEBUG : BROWSER_OUTPUT: 07:04:07 INFO - 2015-12-10 07:04:07,529 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 07:04:07 INFO - 2015-12-10 07:04:07,529 DEBUG : BROWSER_OUTPUT: Values: 4822.1 07:04:07 INFO - 2015-12-10 07:04:07,529 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:04:07 INFO - 2015-12-10 07:04:07,529 DEBUG : BROWSER_OUTPUT: 07:04:08 INFO - 2015-12-10 07:04:08,517 INFO : Browser exited with error code: 0 07:04:08 INFO - 2015-12-10 07:04:08,529 INFO : Completed test v8_7 (00:00:41) 07:04:08 INFO - 2015-12-10 07:04:08,993 INFO : Completed test suite (00:20:23) 07:04:08 INFO - 2015-12-10 07:04:08,993 DEBUG : Working with test: dromaeo_css 07:04:08 INFO - 2015-12-10 07:04:08,993 DEBUG : Generating results file: dromaeo_css 07:04:08 INFO - 2015-12-10 07:04:08,995 DEBUG : Working with test: kraken 07:04:08 INFO - 2015-12-10 07:04:08,995 DEBUG : Generating results file: kraken 07:04:08 INFO - 2015-12-10 07:04:08,995 INFO : javascript benchmark 07:04:08 INFO - 2015-12-10 07:04:08,995 DEBUG : Working with test: v8_7 07:04:08 INFO - 2015-12-10 07:04:08,995 DEBUG : Generating results file: v8_7 07:04:08 INFO - 2015-12-10 07:04:08,996 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:04:09 INFO - 2015-12-10 07:04:09,059 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 07:04:09 INFO - 2015-12-10 07:04:09,059 DEBUG : process_Request line: dromaeo_css 6166.87 graph.html#tests=[[72,132,35]] 07:04:09 INFO - 2015-12-10 07:04:09,059 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:04:09 INFO - 2015-12-10 07:04:09,167 DEBUG : process_Request line: kraken 1517.40 graph.html#tests=[[232,132,35]] 07:04:09 INFO - 2015-12-10 07:04:09,167 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:04:09 INFO - 2015-12-10 07:04:09,211 DEBUG : process_Request line: v8_7 19784.76 graph.html#tests=[[230,132,35]] 07:04:09 INFO - 2015-12-10 07:04:09,212 INFO : javascript benchmark 07:04:09 INFO - 2015-12-10 07:04:09,216 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2599.753023462771, 2651.1648830618365, 2660.813743037988, 2674.7860171186308, 2697.1234348836633, 4337.327714204295, 4494.865154045384, 4553.749543775091, 4582.656300777442, 4624.121416930785, 4513.097380523892, 4536.455625324966, 4579.404677391943, 4587.632989360852, 4641.443026836776, 4233.767142807144, 4279.893002674935, 4287.506936702288, 4379.058502421979, 4405.713628614146, 4040.353543433051, 4310.159518893801, 4333.60997510224, 4408.537103604123, 4423.823047078129, 4148.004478925066, 4226.788660566959, 4230.428892099558, 4244.469441319835, 4252.064545799919, 4267.530571637118, 4271.252530807127, 4279.807408666617, 4292.399064131024, 4316.913661726748, 4092.815823287959, 4262.019735460862, 4283.7858107094835, 4284.700070995032, 4331.155424692186, 4490.438695163105, 4492.7528985905765, 4503.527129651372, 4542.04617030424, 4596.310553416981, 4959.057779021974, 4965.106280869442, 4966.081274964107, 4969.031038947407, 5008.524190201925, 4853.660243782937, 4996.700197988096, 5010.0981823271795, 5010.473900240495, 5013.6490445668815, 4516.119356725407, 4570.794314255866, 4586.518415566385, 4586.88532786683, 4606.0, 5078.111330517145, 5083.8983220335385, 5084.694918304914, 5085.694858308513, 5101.51535604117, 4876.878078048077, 4877.146499362669, 4895.73073480962, 4898.559129678346, 4935.703857768545, 4773.188557945157, 4841.104395686739, 4899.191633380524, 4901.852944411673, 4975.825846095369, 4960.751962401865, 4962.057209130254, 4965.205567109245, 4966.180580204298, 4967.230079337636, 4960.727160006234, 4964.05682920244, 4964.975175124101, 4966.255061740696, 4996.90006199874, 3923.5487918889694, 4015.377616469452, 4075.225707115698, 4075.918481630351, 4181.435506206623, 3609.6931760800103, 3623.221007483404, 3629.927401451956, 3639.94540081899, 3659.341318562684, 4339.218940590724, 4340.370646256275, 4344.522102568715, 4345.67407444443, 4383.7588932609015, 4745.193317136095, 4847.200211965057, 4853.272009198648, 4961.5286547777905, 5022.74886255693, 4321.438213032286, 4325.740455572675, 4328.0, 4339.63113135387, 4343.283358245854, 4421.027373977719, 4426.933595996063, 4430.224710675619, 4436.534163912807, 4478.48497422794, 4583.793729282257, 4698.130845793539, 4710.8351207707565, 4717.386739723814, 4803.207470767354, 4849.248366503198, 4940.604751619933, 4957.851264462072, 4973.104841128632, 4975.154223782039, 4687.554682305175, 4730.361401210793, 4731.384919960383, 4732.52674732524, 4791.233402655558, 4743.573078422958, 4866.367372241586, 4867.415910090812, 4882.755862206946, 4928.556429921325, 4835.540623640749, 4884.5603895649565, 4904.803807847647, 4905.8037678492465, 4940.580050695731, 4821.54195351441, 4836.492168322417, 4842.394700662418, 4842.661013729005, 4885.0, 4688.179568575554, 4808.110499557593, 4821.276808478756, 4843.612510999041, 4897.9020419592125, 4621.976890115662, 4655.464621568563, 4688.109259240733, 4689.859304220879, 4740.051989602024, 4889.559939605452, 4893.535114164149, 4895.290182923527, 4910.631702622246, 4942.975285123552, 4514.7291162530355, 4746.406699162605, 4746.881327966828, 4753.263244197155, 4774.21225497789], "unit": "ms", "name": "dojo.html", "value": 4538.752383802581}, {"lowerIsBetter": false, "replicates": [572.1960645293364, 580.8702074465165, 584.5382148102999, 585.616421244085, 599.9130126131711, 27182.592261116075, 27714.861425692845, 27731.168064958034, 32790.0, 33189.17027074324, 39098.413523797164, 39703.80148099255, 39805.60194398055, 39855.80072099643, 39863.40204896922, 7890.289873911362, 8056.959715201416, 8058.073321568007, 8066.4353495255355, 8069.757907262791, 7180.389666878295, 7325.926740732578, 10027.74930626733, 10292.948535257314, 10309.742256443611, 9876.604935802596, 9985.450800205987, 9985.700428987142, 9986.600535978552, 10060.044295791888, 7142.21435642079, 7369.22623124575, 10046.0, 10164.796704065915, 10172.44051577163, 7086.68109935049, 10145.594176233015, 10432.843507347396, 10440.738981525523, 10453.68638940833, 36879.26241475155, 37397.81301093477, 37405.31676074556, 37405.81297093524, 37466.43800342997, 2106.083853523722, 2733.139061195717, 2750.714631902745, 2967.792254542183, 3521.190126270972, 25893.611595826078, 26269.080582179722, 26740.86629566859, 26984.325391865164, 27130.050448234415, 3026.6670666226696, 3037.3014206732573, 3064.310530130725, 3107.471729805916, 3119.391718614871, 183796.0, 184259.0, 184543.0, 185111.0, 185348.0, 50694.49305506972, 51701.48298516967, 51719.482805171465, 51729.482705172464, 51747.0, 60499.0, 61809.38190618126, 61824.07263891045, 61837.69081154565, 61861.69069154625, 12515.937420312841, 12565.497380104876, 12827.551035713705, 12843.422046007952, 12861.54984575554, 8882.15619516145, 8887.244584210286, 8961.4175078621, 8987.370884038186, 8991.505467199237, 17712.46862594124, 17881.910590446965, 17926.28294868217, 17971.191296391695, 18009.819901801075, 7360.374368178765, 7569.091708994956, 7591.127020392615, 7633.5419874807685, 7709.575973321409, 800.2877439079224, 822.6421506644629, 835.853725598018, 874.8206617643368, 1048.9737756555994, 25792.226233213034, 26122.216333510027, 26332.210033698637, 26670.19989400321, 26681.33296667599, 917.9541022948825, 923.3259720404143, 923.6859467780853, 1014.2342531388754, 1077.3374374759467, 12436.253824770543, 12581.93709031449, 12625.810612840814, 12688.492460301484, 12696.0, 263406.0, 268972.0, 269425.0, 269450.0, 269654.0, 42824.0, 42891.0, 43122.0, 43150.0, 43447.0, 1075.9462026898623, 1086.0171544751854, 1186.8931796138215, 1198.796204645195, 1205.75884823034, 23247.767522325237, 24576.401916827894, 25164.622530662422, 25207.109466789698, 25215.747842522072, 35125.64874351224, 35309.823450882584, 35333.1166720834, 35414.82292588521, 35429.29141417209, 180450.0, 226534.0, 232858.0, 321895.0, 334391.0, 27297.181084567495, 27359.0, 27381.0, 27403.725962740118, 27568.862155689094, 37269.6273037277, 37749.05627359228, 38108.61891381162, 38165.618343816204, 38641.42037869491, 32018.633385148867, 32698.182545436553, 32764.0, 33071.031476223005, 33475.83262083771, 31322.21694457657, 32636.184095396857, 32958.0, 33190.66809331972, 33501.832490838366, 30218.84890575621, 30522.694773052874, 30540.418937159604, 32888.835555822065, 33240.66759332376, 27290.590641140003, 28985.130446086652, 29332.706672932996, 29796.553051704675, 30270.243243919078, 22644.28195144848, 23165.768342317035, 23223.187188448323, 23226.65160022635, 23340.416489587897], "unit": "ms", "name": "ext.html", "value": 16503.847430892987}, {"lowerIsBetter": false, "replicates": [339.7265201512781, 342.59231514497753, 343.4127641732637, 344.0692925636154, 345.93773120838244, 12381.195222310544, 12772.616821495347, 15060.0, 15062.924685376585, 15855.048697078184, 10607.045365917065, 10614.203934704889, 10640.840387394195, 15212.619684507865, 15292.235388230572, 4809.326694262789, 4867.221244600864, 4999.975000124994, 5024.296598476216, 5032.0, 3749.9437508437395, 3862.7489213201193, 4935.605151587864, 5476.096444086741, 5664.037113690682, 5543.251661025771, 5556.777728890839, 5575.275214222145, 5613.775448982035, 5614.29821272341, 4888.608911287106, 4968.850934471971, 5000.324956130912, 5002.59979201663, 5568.7215639217875, 4686.484486706459, 4799.256115302133, 4817.85546433604, 4823.879403014917, 4827.8551643450755, 11331.150163737753, 11573.53705851765, 11720.413979301002, 11724.120690948213, 19492.512687182792, 1655.9503214903573, 1801.8107404191987, 1810.8913465192131, 1829.679806033952, 1851.0652120679106, 12635.557755478514, 12646.557370491988, 12647.17793343439, 12983.415746291439, 13038.934805325913, 1745.450183192303, 1751.1944505527472, 1775.3874913154941, 1791.4177892184962, 1830.3227805711838, 49966.25050624244, 50843.983120337754, 56574.15138772922, 58026.7098664504, 58302.125468118014, 9181.265498760084, 9562.95218523903, 9769.951150244204, 9808.558614862348, 9934.254930880214, 12355.073369497144, 12446.06654500916, 12452.0, 12452.75094498105, 12470.376481175905, 6774.0, 6791.2869148739655, 6829.6585170742255, 6834.350736680008, 6847.109875716125, 6422.325655806167, 6446.033095035782, 6502.674866256668, 6508.479321654257, 6523.054157147187, 4127.33962565988, 4172.77049762266, 4195.58044195578, 4196.055887425305, 4236.9364459533135, 1611.3554578168591, 1649.158928946222, 1665.991670041642, 1692.2723229011642, 1704.9573760655835, 825.8719898415756, 829.6349606173264, 854.9868405938857, 894.7539426657592, 920.3143657974717, 12351.876481235253, 14036.29818509091, 15071.4724984625, 15133.697326053638, 15163.469278575198, 790.6165509727778, 809.3242142810819, 830.0993422137049, 855.2601999270711, 879.3976126353468, 8854.86717699235, 8968.417052891671, 9126.543672816333, 9177.0, 9521.857172142423, 494410.0, 507081.0, 507726.0, 508053.0, 515573.0, 68873.65563172252, 70168.64915675389, 72514.63742681252, 73487.0, 74073.25926740772, 1031.886492485826, 1037.4501514197486, 1039.6101461951769, 1064.6007747094839, 1064.6380230721593, 13887.236202008582, 13953.790693139814, 14000.43998240059, 14121.929390353393, 14179.361928713026, 32590.83704581462, 32963.505547417284, 33286.0, 33441.163970900925, 33548.496772547944, 43384.566154338056, 44115.338269925334, 44205.77897110494, 44616.55383446124, 47088.0, 8180.631871565674, 8386.32909367237, 8438.113998030118, 8443.620037098468, 8447.95776021116, 9833.70498885006, 9905.0, 12401.93799030999, 14811.925940370229, 15584.0, 13109.934450327688, 13218.537351192663, 13237.470501179845, 13286.734265314833, 13487.460501580219, 12876.613701588967, 13007.544735934196, 13441.126326788728, 13584.388702508213, 13736.93131534336, 12927.030472714772, 12936.870631293566, 13334.866651333363, 13463.528776492776, 13487.190768553919, 8454.619542120496, 8672.609732561923, 8772.429792063751, 8779.20987111163, 8793.076726943835, 12325.383730813244, 12339.383030848601, 12398.81401778956, 13052.54316098932, 13423.932880335537], "unit": "ms", "name": "jquery.html", "value": 8062.393248772656}, {"lowerIsBetter": false, "replicates": [1227.300438749913, 1597.0896588944304, 1659.9170041497923, 1682.59617691754, 1720.6902757503644, 6022.7590896364145, 6801.217859946108, 6977.162740471138, 6988.196357418892, 7003.404710599592, 6818.318168183179, 6954.5479543829615, 6984.1619005719385, 6987.825304367393, 6996.965015174917, 1747.7116275814476, 1765.37329248117, 1999.4401567561033, 2036.409441262036, 2065.834733221346, 2039.4289598912253, 2044.7955204479508, 2045.7851925547827, 2047.3448496481133, 2048.3752455501067, 2014.8287395571322, 2023.2817349840816, 2067.7105205271273, 2071.1508281604547, 2072.5025993761465, 2004.9699254511195, 2011.979880201194, 2030.3604364625169, 2034.410021093881, 2050.149188086942, 2018.485286252011, 2037.898105094754, 2040.9081591328427, 2042.1423002338904, 2046.3553980496097, 6912.619805910673, 6982.755603553851, 6985.196702379189, 6986.790396288119, 6989.89515157273, 4031.9193616127804, 4073.1853629274265, 4086.12148388095, 4102.3026085565225, 4102.425660407545, 2547.8598677072755, 2604.1406335909105, 2621.3839747659285, 2631.63157157998, 2641.4585010072888, 816.7590560784582, 855.2901092093548, 860.6987554355987, 861.1947828780111, 871.5163084488106, 9189.954050229773, 9257.814843703156, 9272.768180795467, 9284.210842078432, 9289.581968811419, 3674.761140525911, 3748.9437658435145, 3756.4740936268945, 3762.6801721853403, 3778.5843557209237, 8054.919450805534, 8071.0, 8073.555954422446, 8078.474899131537, 8085.83828323442, 4148.668106551469, 4162.937555936664, 4181.477315335583, 4181.937270940938, 4183.39340795589, 3774.8112594370173, 3788.204477059848, 3788.4885540452237, 3793.203427280302, 3797.2025874566098, 2928.4582352264897, 3056.938861222763, 3058.525928481089, 3095.0, 3413.6586341365664, 1087.7498175419698, 1095.2606990281529, 1099.1646348774989, 1109.8668159820872, 1110.4836251143095, 898.6854600889636, 898.9955050224838, 960.7646126698863, 1035.637526865606, 1177.746784441332, 6527.575707579087, 6565.868682626417, 6573.868522629521, 6585.604863708193, 6589.472842172615, 933.7478880702172, 941.5245301122889, 956.5265193729149, 959.7072892767773, 986.8322385194534, 4908.460069392364, 4991.975040124777, 4996.925046124311, 5005.874853128701, 5007.874803129951, 8129.4715843469985, 8228.0126384833, 8535.445196062235, 8541.273991710774, 8561.700340488052, 8322.958385208156, 8411.957940210383, 8415.452995555392, 8428.199321064489, 8444.071152173256, 6177.722002509898, 6370.681465926685, 6507.7071531781185, 6556.27880933097, 6592.406683398517, 6667.366600172976, 6700.765473208415, 6716.227633822173, 6727.461803055841, 6735.0, 7313.561186328838, 7368.115826100902, 7523.022007139256, 7615.352695020985, 7673.693052277847, 7574.166841647525, 7737.690492380467, 7827.0, 7842.0, 7852.254035866584, 6108.053251745987, 6158.476529495043, 6176.567640265138, 6185.010398336244, 6191.25704915413, 5849.415058494116, 5986.2217911671205, 6128.693565321805, 6368.4586810121655, 6594.043863639841, 6227.283862355887, 6272.686365681789, 6344.984802431589, 6430.164078669743, 6432.903506447314, 6042.848928776816, 6056.697165141637, 6134.723937422737, 6145.9692701538, 6176.969115154396, 5804.912926306024, 5901.7639294427745, 5928.258967629046, 6145.84635384119, 6174.845628859314, 5961.791337303173, 5976.372480889444, 5986.191864098465, 5992.64044157352, 5998.520118390431, 5802.767889284381, 5803.7968671096305, 5805.76776928935, 5806.071028635398, 5818.4763371296785], "unit": "ms", "name": "mootools.html", "value": 3982.349108064595}, {"lowerIsBetter": false, "replicates": [306.8266429467351, 312.44384994709424, 314.95275708643703, 314.97165255127044, 319.86885376995434, 5223.216517522374, 5226.817061402851, 5230.21546767985, 5233.84298471046, 5277.498637629428, 5205.219217117435, 5206.505381988714, 5214.921776173351, 5215.061288967984, 5218.112920803463, 4097.487814023247, 4100.405441211023, 4101.220768054068, 4104.13813099248, 4108.712390132692, 3877.1664092220167, 4002.9599704003026, 4101.384792281152, 4108.52751933527, 4111.075008123178, 3926.450296958428, 3931.960680393188, 3953.169834334793, 3978.622030907059, 3979.621935916083, 4058.5129784425912, 4079.653229475498, 4079.837246384796, 4088.3049881520215, 4089.161721847044, 3613.0, 3613.1509095362567, 3620.4931309616672, 3627.4740162676526, 3633.0372451300163, 4756.3816703828625, 4842.2736589511505, 4912.336834527328, 4954.2568614707725, 5004.874878128039, 4632.791524381411, 4642.907141857144, 4643.512431194709, 4643.674942754009, 4644.117617652635, 5472.370677372113, 5483.917741233885, 5484.0, 5490.423505531941, 5490.780368785244, 3871.6709079728257, 3875.147467557133, 3876.030992251937, 3878.7866667333287, 3879.4374815651854, 5584.581156413245, 5748.741306641211, 5753.626014309057, 5756.050251708463, 5769.8557536061935, 3914.9804250978564, 3939.9212015759526, 3940.133170702441, 3942.2903877301787, 3946.4474973503734, 3780.9432858507143, 3886.941695874564, 3892.708046896494, 3955.406688996616, 3993.4608827807874, 4539.8662628564525, 4563.475200351935, 4574.565416285448, 4579.244424669959, 4584.88537786558, 5458.536024437967, 5467.617266791286, 5467.753951072212, 5467.917981230285, 5480.588955828329, 1392.3455975691409, 1414.2716501001992, 1414.8868090552937, 1415.2640626873967, 1415.7522433574084, 953.1755031897359, 961.3318743473219, 963.1812958984807, 980.597954838527, 984.2962281968283, 4798.992211635526, 4832.371791667061, 4838.443578988461, 4841.1285968526, 4843.8304659337455, 5646.209530665628, 5654.604177707603, 5658.7170641467765, 5670.291213598301, 5671.262735844314, 4824.662273640882, 4827.179379505493, 4830.203016502308, 4830.372051633265, 4830.855074347775, 2962.5852380666724, 3009.8344591047703, 3028.2732144285214, 3031.3937212557576, 3036.362363903561, 5396.946030539723, 5402.540784033323, 5406.783728650888, 5409.810656627078, 5417.133258678593, 5795.913061304, 5797.043487824461, 5805.477507024304, 5807.941920580824, 5811.041178205549, 5404.243405923174, 5418.051840927822, 5423.0, 5424.05079111154, 5427.782888684408, 5517.5585953124455, 5655.349634792052, 5668.0, 5672.829815105553, 5675.574331925205, 5544.473275038865, 5551.666899986014, 5554.666719996813, 5555.30558680165, 5561.944380556142, 5353.732313384237, 5411.485908838654, 5413.133898576209, 5413.729313534386, 5415.756290966995, 3950.822213000364, 3970.821313040862, 3973.2252210818615, 3976.6619837312996, 3977.940330895097, 5502.697351645698, 5505.889882202414, 5628.212050313042, 5655.462731040545, 5659.462351076806, 5373.677579345252, 5484.2596249505805, 5499.477549632778, 5499.862503437446, 5507.981023510663, 5437.782488700408, 5477.04151773446, 5492.231087647652, 5500.862478438071, 5502.8349149525575, 5294.073537130909, 5385.623006389672, 5397.217403476552, 5398.163284690879, 5407.918881216863, 5501.5323697486165, 5536.446355364431, 5544.750486228048, 5546.556275498031, 5550.195221692751, 5412.810551630674, 5414.485623865727, 5417.783288668409, 5417.945820541744, 5425.213344065168], "unit": "ms", "name": "prototype.html", "value": 4129.045740719337}, {"lowerIsBetter": false, "replicates": [700.3766647683561, 741.5995362504248, 751.1361933776157, 757.2957149850637, 800.683729926679, 11922.046236301097, 12234.938825305884, 12236.143469957095, 12246.387680615968, 12250.754984900297, 11386.886131138686, 11468.426578671055, 11469.59856405026, 11473.655790326282, 11497.310161390322, 619.4889216396468, 635.5297080160694, 810.5703976892227, 819.7663665855232, 821.6754382019129, 815.2011029191395, 820.1962077164383, 825.7646570727344, 826.4545400035978, 826.6032304493847, 659.1990731261516, 672.6771149848051, 849.5285116760195, 855.7903313688124, 856.6316483911916, 839.4082172068707, 854.5129276312505, 855.8930133733284, 857.7941294089436, 858.3733874271785, 634.1945728924286, 636.4335741190345, 637.579197729501, 637.9043143528462, 638.5721566550422, 12094.153409261355, 12258.81611775824, 12268.693282667915, 12278.815817762741, 12285.262884226975, 10979.670609881716, 11179.888201118047, 11212.495437705242, 11322.490487928064, 11388.316700997966, 8566.0, 8680.435771674822, 8759.34304927133, 8767.079456657022, 8768.079351668046, 3159.636641786201, 3172.349668317989, 3207.246297120175, 3221.7596225453135, 3261.4781634938295, 40194.19611607781, 40334.79832600818, 40392.596074039175, 40432.191356173, 40904.79547602243, 8701.738947831574, 8723.171298726611, 8821.647134114564, 8839.469631821983, 8839.823203535892, 16482.0, 16818.747718784227, 16845.32618695263, 16902.661946761244, 16922.576935576464, 6189.102580125857, 6252.196684306065, 6309.873802523924, 6346.079818426302, 6382.106505089291, 3531.911702207465, 3544.7518673692593, 3548.2903419315726, 3584.6415358464465, 3643.6356364363883, 2734.125079974429, 2767.045369347572, 2776.6529183852017, 2777.375090604638, 2783.192874066498, 490.2694984473109, 492.97042177469467, 503.67009608706354, 506.60231718101113, 506.90875642383986, 370.88687950175455, 383.7831625131847, 384.2181161336666, 416.07008336368193, 416.79160419790105, 6925.861482770317, 7115.217326094125, 7300.160481544584, 7366.263373662591, 7992.720254791055, 366.5637890909809, 399.5664703796355, 434.3311300597108, 473.93838800955655, 519.3093186062528, 3705.184859330943, 3776.263628592398, 3814.1990182062077, 3822.2737679840743, 3866.574676785551, 43989.12021759547, 49078.7730306738, 49143.0, 49231.50768492341, 49322.753386233555, 38446.615533844866, 38663.42004869929, 38703.80648096742, 39412.605873941466, 39507.802460987514, 39837.203255935296, 40381.59618403837, 40558.52459917932, 41632.0, 41698.791506042275, 7380.520266182681, 7563.432742544222, 7733.0, 7773.572453514885, 8078.474899131537, 31538.369232615678, 31664.20839478939, 31948.840255798572, 32192.0, 32216.36213662553, 39992.2001559973, 40737.38893916653, 40989.38515922204, 40991.795041024605, 41301.173976520906, 9484.867582038498, 9557.378770379903, 9593.42439453635, 9777.804443911224, 9895.0, 9882.50587470638, 10047.799044019224, 11017.83473247886, 11022.944885275523, 11099.0, 10028.799424011333, 10277.486125693536, 10282.794344112926, 10512.26414151002, 10721.517531710935, 10277.794444110927, 10415.895841041493, 10590.046895779416, 10592.629257975934, 10957.01386875185, 7566.772996810105, 9165.391907880774, 9648.469334186406, 9683.0, 9684.08001239881, 8208.09710931785, 8221.424500284922, 8702.782430439289, 8995.550222488719, 9294.72115836526, 8810.823783524422, 8820.470771753715, 8982.191602755784, 9050.954745226232, 9231.58457869384], "unit": "ms", "name": "yui.html", "value": 5538.205866473263}], "name": "dromaeo_css", "value": 6166.872341281757}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 111.0, 112.0, 111.0, 113.0, 102.0, 111.0, 111.0, 102.0], "unit": "ms", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [155.0, 133.0, 175.0, 164.0, 129.0, 159.0, 158.0, 129.0, 171.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.2}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 83.0, 93.0, 70.0, 78.0, 72.0, 111.0, 101.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 82.3}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 140.0, 95.0, 94.0, 94.0, 127.0, 96.0, 95.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [73.0, 70.0, 72.0, 71.0, 73.0, 70.0, 71.0, 83.0, 67.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.8}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [84.0, 92.0, 85.0, 84.0, 83.0, 84.0, 83.0, 86.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [117.0, 127.0, 118.0, 118.0, 123.0, 118.0, 127.0, 119.0, 119.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.4}, {"lowerIsBetter": true, "replicates": [135.0, 139.0, 151.0, 144.0, 146.0, 135.0, 140.0, 140.0, 144.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.8}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1517.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.39861065167054], "unit": "score", "name": "Richards", "value": 213.43589200000002}, {"lowerIsBetter": false, "replicates": [186.6019779809666], "unit": "score", "name": "DeltaBlue", "value": 354.3263619999999}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [809.7165991902834], "unit": "score", "name": "Earley", "value": 823.0818049999997}, {"lowerIsBetter": false, "replicates": [12083.333333333334], "unit": "score", "name": "Boyer", "value": 55.155558620689625}, {"lowerIsBetter": false, "replicates": [27324.324324324323], "unit": "score", "name": "RegExp", "value": 33.33970820969339}, {"lowerIsBetter": false, "replicates": [596.688350088705], "unit": "score", "name": "Splay", "value": 136.5721318136769}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19784.7583656777}]} 07:04:09 INFO - RETURN: dromaeo_css: 6166.87 07:04:09 INFO - RETURN: kraken: 1517.40 07:04:09 INFO - RETURN: v8_7: 19784.76 07:04:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19784.76"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1517.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6166.87"}}} 07:04:09 INFO - Return code: 0 07:04:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:04:09 INFO - # TBPL SUCCESS # 07:04:09 INFO - Running post-action listener: _resource_record_post_action 07:04:09 INFO - Running post-run listener: _resource_record_post_run 07:04:10 INFO - Total resource usage - Wall time: 1240s; CPU: 13.0%; Read bytes: 438272; Write bytes: 270196736; Read time: 792; Write time: 511688 07:04:10 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 1392640; Read time: 0; Write time: 160 07:04:10 INFO - run-tests - Wall time: 1226s; CPU: 13.0%; Read bytes: 438272; Write bytes: 268804096; Read time: 792; Write time: 511528 07:04:10 INFO - Running post-run listener: _upload_blobber_files 07:04:10 INFO - Blob upload gear active. 07:04:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:04:10 INFO - Copying logs to upload dir... 07:04:10 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1322.536489 ========= master_lag: 54.97 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 57 secs) (at 2015-12-10 07:05:05.384950) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 07:05:05.392965) ========= 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=ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010183 build_url: 'https://queue.taskcluster.net/v1/task/lJi4f5tBQEqD-sh2jnIlGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.23 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 07:05:05.634527) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 07:05:05.635092) ========= 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=ccb4611811c763f2fad71465000001de-1449757762.879834-1112609109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 07:05:05.652172) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 07:05:05.652504) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 07:05:05.652801) ========= ========= Total master_lag: 55.39 =========