builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1449260084.49 results: success (0) buildid: 20151204113611 builduid: ce3f0cc682994afab06fa7ec9be424c4 revision: 3d8926eef121ba1b6b003011e2cac09c00782657 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:44.495185) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:44.495675) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:44.495964) ========= 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=7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006230 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:44.518823) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:44.519126) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:44.532284) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:44.532637) ========= 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=7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:44.585080) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:44.585395) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:44.585772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:44.586052) ========= 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=7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-04 12:14:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2015-12-04 12:14:45 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106424 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:44.704833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:44.705178) ========= 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=7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021124 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:44.754414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:44.754785) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3d8926eef121ba1b6b003011e2cac09c00782657 --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 3d8926eef121ba1b6b003011e2cac09c00782657 --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=7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-04 12:14:45,255 truncating revision to first 12 chars 2015-12-04 12:14:45,255 Setting DEBUG logging. 2015-12-04 12:14:45,255 attempt 1/10 2015-12-04 12:14:45,255 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3d8926eef121?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-04 12:14:45,522 unpacking tar archive at: fx-team-3d8926eef121/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548325 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:45.319087) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:45.319686) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:45.330063) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:45.330406) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 12:14:45.330806) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-04 12:14:45.331091) ========= /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=7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:14:45 INFO - MultiFileLogger online at 20151204 12:14:45 in /builds/slave/test 12:14:45 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 12:14:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:14:45 INFO - {'append_to_log': False, 12:14:45 INFO - 'base_work_dir': '/builds/slave/test', 12:14:45 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:14:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:14:45 INFO - 'branch': 'Fx-Team-Non-PGO', 12:14:45 INFO - 'buildbot_json_path': 'buildprops.json', 12:14:45 INFO - 'config_files': ('talos/linux_config.py',), 12:14:45 INFO - 'default_actions': ('clobber', 12:14:45 INFO - 'read-buildbot-config', 12:14:45 INFO - 'download-and-extract', 12:14:45 INFO - 'populate-webroot', 12:14:45 INFO - 'create-virtualenv', 12:14:45 INFO - 'install', 12:14:45 INFO - 'run-tests'), 12:14:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:14:45 INFO - 'download_minidump_stackwalk': True, 12:14:45 INFO - 'download_symbols': 'ondemand', 12:14:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:14:45 INFO - 'tooltool.py': '/tools/tooltool.py', 12:14:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:14:45 INFO - '/tools/misc-python/virtualenv.py')}, 12:14:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:14:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:14:45 INFO - 'installer_path': 'installer.exe', 12:14:45 INFO - 'log_level': 'info', 12:14:45 INFO - 'log_name': 'talos', 12:14:45 INFO - 'log_to_console': True, 12:14:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:14:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:14:45 INFO - 'opt_config_files': (), 12:14:45 INFO - 'pip_index': False, 12:14:45 INFO - 'sps_profile': False, 12:14:45 INFO - 'sps_profile_interval': 0, 12:14:45 INFO - 'suite': 'dromaeojs', 12:14:45 INFO - 'system_bits': '64', 12:14:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:14:45 INFO - 'title': 'talos-linux64-ix-041', 12:14:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:14:45 INFO - 'use_talos_json': True, 12:14:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:14:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:14:45 INFO - 'work_dir': 'build'} 12:14:45 INFO - ##### 12:14:45 INFO - ##### Running clobber step. 12:14:45 INFO - ##### 12:14:45 INFO - Running pre-action listener: _resource_record_pre_action 12:14:45 INFO - Running main action method: clobber 12:14:45 INFO - rmtree: /builds/slave/test/build 12:14:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:14:46 INFO - Running post-action listener: _resource_record_post_action 12:14:46 INFO - ##### 12:14:46 INFO - ##### Running read-buildbot-config step. 12:14:46 INFO - ##### 12:14:46 INFO - Running pre-action listener: _resource_record_pre_action 12:14:46 INFO - Running main action method: read_buildbot_config 12:14:46 INFO - Using buildbot properties: 12:14:46 INFO - { 12:14:46 INFO - "properties": { 12:14:46 INFO - "buildnumber": 1171, 12:14:46 INFO - "product": "firefox", 12:14:46 INFO - "script_repo_revision": "production", 12:14:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:14:46 INFO - "repository": "", 12:14:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:14:46 INFO - "buildid": "20151204113611", 12:14:46 INFO - "slavename": "talos-linux64-ix-041", 12:14:46 INFO - "pgo_build": "False", 12:14:46 INFO - "basedir": "/builds/slave/test", 12:14:46 INFO - "project": "", 12:14:46 INFO - "platform": "ubuntu64_hw", 12:14:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:14:46 INFO - "slavebuilddir": "test", 12:14:46 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:14:46 INFO - "branch": "fx-team", 12:14:46 INFO - "repo_path": "integration/fx-team", 12:14:46 INFO - "stage_platform": "linux64", 12:14:46 INFO - "builduid": "ce3f0cc682994afab06fa7ec9be424c4", 12:14:46 INFO - "revision": "3d8926eef121ba1b6b003011e2cac09c00782657" 12:14:46 INFO - }, 12:14:46 INFO - "sourcestamp": { 12:14:46 INFO - "repository": "", 12:14:46 INFO - "hasPatch": false, 12:14:46 INFO - "project": "", 12:14:46 INFO - "branch": "fx-team-linux64-talos", 12:14:46 INFO - "changes": [ 12:14:46 INFO - { 12:14:46 INFO - "category": null, 12:14:46 INFO - "files": [ 12:14:46 INFO - { 12:14:46 INFO - "url": null, 12:14:46 INFO - "name": "https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:14:46 INFO - } 12:14:46 INFO - ], 12:14:46 INFO - "repository": "", 12:14:46 INFO - "rev": "3d8926eef121ba1b6b003011e2cac09c00782657", 12:14:46 INFO - "who": "mconley@mozilla.com", 12:14:46 INFO - "when": 1449259442, 12:14:46 INFO - "number": 6745749, 12:14:46 INFO - "comments": "Bug 1225921 - Have SessionStore keep a list of window data that might be saved during a flush. r=billm\n\nThis helps us keep track of what windows we've chosen to forget, and helps\nus avoid the problem of accidentally saving a window we've chosen to forget.", 12:14:46 INFO - "project": "", 12:14:46 INFO - "at": "Fri 04 Dec 2015 12:04:02", 12:14:46 INFO - "branch": "fx-team-linux64-talos", 12:14:46 INFO - "revlink": "", 12:14:46 INFO - "properties": [ 12:14:46 INFO - [ 12:14:46 INFO - "buildid", 12:14:46 INFO - "20151204113611", 12:14:46 INFO - "Change" 12:14:46 INFO - ], 12:14:46 INFO - [ 12:14:46 INFO - "builduid", 12:14:46 INFO - "ce3f0cc682994afab06fa7ec9be424c4", 12:14:46 INFO - "Change" 12:14:46 INFO - ], 12:14:46 INFO - [ 12:14:46 INFO - "pgo_build", 12:14:46 INFO - "False", 12:14:46 INFO - "Change" 12:14:46 INFO - ] 12:14:46 INFO - ], 12:14:46 INFO - "revision": "3d8926eef121ba1b6b003011e2cac09c00782657" 12:14:46 INFO - } 12:14:46 INFO - ], 12:14:46 INFO - "revision": "3d8926eef121ba1b6b003011e2cac09c00782657" 12:14:46 INFO - } 12:14:46 INFO - } 12:14:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:14:46 INFO - Running post-action listener: _resource_record_post_action 12:14:46 INFO - ##### 12:14:46 INFO - ##### Running download-and-extract step. 12:14:46 INFO - ##### 12:14:46 INFO - Running pre-action listener: _resource_record_pre_action 12:14:46 INFO - Running main action method: download_and_extract 12:14:46 INFO - mkdir: /builds/slave/test/build/tests 12:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:46 INFO - https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:14:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/test_packages.json 12:14:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/test_packages.json 12:14:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:14:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:14:47 INFO - Downloaded 1302 bytes. 12:14:47 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:14:47 INFO - Using the following test package requirements: 12:14:47 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:14:47 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:14:47 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:47 INFO - u'jsshell-linux-x86_64.zip'], 12:14:47 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:14:47 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:14:47 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:14:47 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:14:47 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:14:47 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:14:47 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:14:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:47 INFO - https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:14:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:14:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:14:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/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 12:14:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/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 12:14:48 INFO - Downloaded 21849117 bytes. 12:14:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 12:14:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:14:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:14:49 INFO - Return code: 0 12:14:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:49 INFO - https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:14:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:14:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:14:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/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 12:14:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/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 12:14:51 INFO - Downloaded 21849117 bytes. 12:14:51 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 12:14:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:14:51 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 12:14:52 INFO - Return code: 0 12:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:52 INFO - https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:14:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:14:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:14:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/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 12:14:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/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 12:14:54 INFO - Downloaded 11132001 bytes. 12:14:54 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 12:14:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:14:54 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 12:14:54 INFO - Return code: 0 12:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:54 INFO - https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:14:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:14:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:14:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/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 12:14:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/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 12:14:56 INFO - Downloaded 57704536 bytes. 12:14:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:14:56 INFO - mkdir: /builds/slave/test/properties 12:14:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:14:56 INFO - Writing to file /builds/slave/test/properties/build_url 12:14:56 INFO - Contents: 12:14:56 INFO - build_url:https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:14:56 INFO - Running post-action listener: _resource_record_post_action 12:14:56 INFO - Running post-action listener: set_extra_try_arguments 12:14:56 INFO - ##### 12:14:56 INFO - ##### Running populate-webroot step. 12:14:56 INFO - ##### 12:14:56 INFO - Running pre-action listener: _resource_record_pre_action 12:14:56 INFO - Running main action method: populate_webroot 12:14:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:14:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:14:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:14:56 INFO - '../fennec_ids.txt'], 12:14:56 INFO - 'tests': ['tcheck2']}, 12:14:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:14:56 INFO - '--tppagecycles', 12:14:56 INFO - '7'], 12:14:56 INFO - 'tests': ['tsvgm']}}, 12:14:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:14:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:14:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:14:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:14:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:14:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:14:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:56 INFO - 'talos_options': ['--e10s'], 12:14:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:56 INFO - 'tests': ['damp', 'tps']}, 12:14:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:56 INFO - 'talos_options': ['--e10s'], 12:14:56 INFO - 'tests': ['damp', 'tps']}, 12:14:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:14:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:14:56 INFO - 'other': {'tests': ['a11yr', 12:14:56 INFO - 'ts_paint', 12:14:56 INFO - 'tpaint', 12:14:56 INFO - 'sessionrestore', 12:14:56 INFO - 'sessionrestore_no_auto_restore']}, 12:14:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:14:56 INFO - 'tests': ['a11yr', 12:14:56 INFO - 'ts_paint', 12:14:56 INFO - 'tpaint', 12:14:56 INFO - 'sessionrestore', 12:14:56 INFO - 'sessionrestore_no_auto_restore']}, 12:14:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:14:56 INFO - 'tests': ['a11yr', 12:14:56 INFO - 'ts_paint', 12:14:56 INFO - 'tpaint', 12:14:56 INFO - 'sessionrestore', 12:14:56 INFO - 'sessionrestore_no_auto_restore']}, 12:14:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:14:56 INFO - 'tests': ['a11yr', 12:14:56 INFO - 'ts_paint', 12:14:56 INFO - 'tpaint', 12:14:56 INFO - 'sessionrestore', 12:14:56 INFO - 'sessionrestore_no_auto_restore']}, 12:14:56 INFO - 'other_l64': {'tests': ['a11yr', 12:14:56 INFO - 'ts_paint', 12:14:56 INFO - 'tpaint', 12:14:56 INFO - 'sessionrestore', 12:14:56 INFO - 'sessionrestore_no_auto_restore']}, 12:14:56 INFO - 'other_nol64': {'tests': ['a11yr', 12:14:56 INFO - 'ts_paint', 12:14:56 INFO - 'tpaint', 12:14:56 INFO - 'sessionrestore', 12:14:56 INFO - 'sessionrestore_no_auto_restore']}, 12:14:56 INFO - 'svgr': {'tests': ['tsvgx', 12:14:56 INFO - 'tsvgr_opacity', 12:14:56 INFO - 'tart', 12:14:56 INFO - 'tscrollx', 12:14:56 INFO - 'cart']}, 12:14:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:14:56 INFO - 'tests': ['tsvgx', 12:14:56 INFO - 'tsvgr_opacity', 12:14:56 INFO - 'tart', 12:14:56 INFO - 'tscrollx', 12:14:56 INFO - 'cart']}, 12:14:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:56 INFO - 'tests': ['tp5o']}, 12:14:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:56 INFO - 'talos_options': ['--e10s'], 12:14:56 INFO - 'tests': ['tp5o']}, 12:14:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:56 INFO - 'talos_options': ['--xperf_path', 12:14:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:56 INFO - 'tests': ['tp5n']}, 12:14:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:56 INFO - 'talos_options': ['--e10s', 12:14:56 INFO - '--xperf_path', 12:14:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:56 INFO - 'tests': ['tp5n']}}, 12:14:56 INFO - 'talos.zip': {'path': '', 12:14:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:14:56 INFO - Running post-action listener: _resource_record_post_action 12:14:56 INFO - ##### 12:14:56 INFO - ##### Running create-virtualenv step. 12:14:56 INFO - ##### 12:14:56 INFO - Running pre-action listener: _resource_record_pre_action 12:14:56 INFO - Running main action method: create_virtualenv 12:14:56 INFO - Creating virtualenv /builds/slave/test/build/venv 12:14:56 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 12:14:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:14:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:14:56 INFO - Using real prefix '/usr' 12:14:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:14:57 INFO - Installing distribute.............................................................................................................................................................................................done. 12:14:59 INFO - Installing pip.................done. 12:14:59 INFO - Return code: 0 12:14:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:14: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')]} 12:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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')]} 12:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb795baff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe90b0>, '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 0x1fe9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', '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 12:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:14:59 INFO - Using env: {'DISPLAY': ':0', 12:14:59 INFO - 'HOME': '/home/cltbld', 12:14:59 INFO - 'LANG': 'en_US.UTF-8', 12:14:59 INFO - 'LANGUAGE': 'en_US:en', 12:14:59 INFO - 'LOGNAME': 'cltbld', 12:14:59 INFO - 'MAIL': '/var/mail/cltbld', 12:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:59 INFO - 'MOZ_NO_REMOTE': '1', 12:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:59 INFO - 'NO_EM_RESTART': '1', 12:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:59 INFO - 'PWD': '/builds/slave/test', 12:14:59 INFO - 'SHELL': '/bin/bash', 12:14:59 INFO - 'SHLVL': '1', 12:14:59 INFO - 'TERM': 'linux', 12:14:59 INFO - 'TMOUT': '86400', 12:14:59 INFO - 'USER': 'cltbld', 12:14:59 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', 12:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:59 INFO - '_': '/tools/buildbot/bin/python'} 12:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:59 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 12:14:59 INFO - Cleaning up... 12:14:59 INFO - Return code: 0 12:14:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:14: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')]} 12:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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')]} 12:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb795baff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe90b0>, '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 0x1fe9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', '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 12:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:14:59 INFO - Using env: {'DISPLAY': ':0', 12:14:59 INFO - 'HOME': '/home/cltbld', 12:14:59 INFO - 'LANG': 'en_US.UTF-8', 12:14:59 INFO - 'LANGUAGE': 'en_US:en', 12:14:59 INFO - 'LOGNAME': 'cltbld', 12:14:59 INFO - 'MAIL': '/var/mail/cltbld', 12:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:59 INFO - 'MOZ_NO_REMOTE': '1', 12:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:59 INFO - 'NO_EM_RESTART': '1', 12:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:59 INFO - 'PWD': '/builds/slave/test', 12:14:59 INFO - 'SHELL': '/bin/bash', 12:14:59 INFO - 'SHLVL': '1', 12:14:59 INFO - 'TERM': 'linux', 12:14:59 INFO - 'TMOUT': '86400', 12:14:59 INFO - 'USER': 'cltbld', 12:14:59 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', 12:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:59 INFO - '_': '/tools/buildbot/bin/python'} 12:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:59 INFO - Downloading/unpacking psutil>=0.7.1 12:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:15:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:15:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:01 INFO - Installing collected packages: psutil 12:15:01 INFO - Running setup.py install for psutil 12:15:01 INFO - building 'psutil._psutil_linux' extension 12:15:01 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 12:15:01 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 12:15:01 INFO - building 'psutil._psutil_posix' extension 12:15:01 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 12:15:01 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 12:15:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:01 INFO - Successfully installed psutil 12:15:01 INFO - Cleaning up... 12:15:01 INFO - Return code: 0 12:15:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb795baff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe90b0>, '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 0x1fe9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', '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 12:15:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:15:01 INFO - Using env: {'DISPLAY': ':0', 12:15:01 INFO - 'HOME': '/home/cltbld', 12:15:01 INFO - 'LANG': 'en_US.UTF-8', 12:15:01 INFO - 'LANGUAGE': 'en_US:en', 12:15:01 INFO - 'LOGNAME': 'cltbld', 12:15:01 INFO - 'MAIL': '/var/mail/cltbld', 12:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:01 INFO - 'MOZ_NO_REMOTE': '1', 12:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:01 INFO - 'NO_EM_RESTART': '1', 12:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:01 INFO - 'PWD': '/builds/slave/test', 12:15:01 INFO - 'SHELL': '/bin/bash', 12:15:01 INFO - 'SHLVL': '1', 12:15:01 INFO - 'TERM': 'linux', 12:15:01 INFO - 'TMOUT': '86400', 12:15:01 INFO - 'USER': 'cltbld', 12:15:01 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', 12:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:01 INFO - '_': '/tools/buildbot/bin/python'} 12:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:15:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:15:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:15:03 INFO - Installing collected packages: mozsystemmonitor 12:15:03 INFO - Running setup.py install for mozsystemmonitor 12:15:03 INFO - Successfully installed mozsystemmonitor 12:15:03 INFO - Cleaning up... 12:15:04 INFO - Return code: 0 12:15:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb795baff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe90b0>, '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 0x1fe9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', '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 12:15:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:15:04 INFO - Using env: {'DISPLAY': ':0', 12:15:04 INFO - 'HOME': '/home/cltbld', 12:15:04 INFO - 'LANG': 'en_US.UTF-8', 12:15:04 INFO - 'LANGUAGE': 'en_US:en', 12:15:04 INFO - 'LOGNAME': 'cltbld', 12:15:04 INFO - 'MAIL': '/var/mail/cltbld', 12:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:04 INFO - 'MOZ_NO_REMOTE': '1', 12:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:04 INFO - 'NO_EM_RESTART': '1', 12:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:04 INFO - 'PWD': '/builds/slave/test', 12:15:04 INFO - 'SHELL': '/bin/bash', 12:15:04 INFO - 'SHLVL': '1', 12:15:04 INFO - 'TERM': 'linux', 12:15:04 INFO - 'TMOUT': '86400', 12:15:04 INFO - 'USER': 'cltbld', 12:15:04 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', 12:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:04 INFO - '_': '/tools/buildbot/bin/python'} 12:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:04 INFO - Downloading/unpacking blobuploader==1.2.4 12:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:05 INFO - Downloading blobuploader-1.2.4.tar.gz 12:15:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:15:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:15:05 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 12:15:05 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 12:15:05 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 12:15:05 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 12:15:05 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 12:15:05 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 12:15:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:15:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:06 INFO - Downloading docopt-0.6.1.tar.gz 12:15:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:15:06 INFO - Installing collected packages: blobuploader, requests, docopt 12:15:06 INFO - Running setup.py install for blobuploader 12:15:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:15:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:15:06 INFO - Running setup.py install for requests 12:15:07 INFO - Running setup.py install for docopt 12:15:07 INFO - Successfully installed blobuploader requests docopt 12:15:07 INFO - Cleaning up... 12:15:07 INFO - Return code: 0 12:15:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:07 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 0x7fb795baff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe90b0>, '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 0x1fe9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', '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 12:15:07 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 12:15:07 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 12:15:07 INFO - Using env: {'DISPLAY': ':0', 12:15:07 INFO - 'HOME': '/home/cltbld', 12:15:07 INFO - 'LANG': 'en_US.UTF-8', 12:15:07 INFO - 'LANGUAGE': 'en_US:en', 12:15:07 INFO - 'LOGNAME': 'cltbld', 12:15:07 INFO - 'MAIL': '/var/mail/cltbld', 12:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:07 INFO - 'MOZ_NO_REMOTE': '1', 12:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:07 INFO - 'NO_EM_RESTART': '1', 12:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:07 INFO - 'PWD': '/builds/slave/test', 12:15:07 INFO - 'SHELL': '/bin/bash', 12:15:07 INFO - 'SHLVL': '1', 12:15:07 INFO - 'TERM': 'linux', 12:15:07 INFO - 'TMOUT': '86400', 12:15:07 INFO - 'USER': 'cltbld', 12:15:07 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', 12:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:07 INFO - '_': '/tools/buildbot/bin/python'} 12:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:07 INFO - Running setup.py (path:/tmp/pip-g50tyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:07 INFO - Running setup.py (path:/tmp/pip-w6m4Wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:07 INFO - Running setup.py (path:/tmp/pip-QnH35f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:07 INFO - Running setup.py (path:/tmp/pip-A7mxz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:07 INFO - Running setup.py (path:/tmp/pip-mRyqYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:07 INFO - Running setup.py (path:/tmp/pip-zislYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:07 INFO - Running setup.py (path:/tmp/pip-D6X25q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:07 INFO - Running setup.py (path:/tmp/pip-3xQ5Gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:08 INFO - Running setup.py (path:/tmp/pip-CSNsvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:08 INFO - Running setup.py (path:/tmp/pip-zBtnId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:08 INFO - Running setup.py (path:/tmp/pip-FZSeLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:08 INFO - Running setup.py (path:/tmp/pip-QJGfqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:08 INFO - Running setup.py (path:/tmp/pip-gGU4Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:08 INFO - Running setup.py (path:/tmp/pip-mbQurH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:08 INFO - Running setup.py (path:/tmp/pip-hKDXJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:08 INFO - Running setup.py (path:/tmp/pip-O5H19s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:08 INFO - Running setup.py (path:/tmp/pip-iQbNbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:15:08 INFO - Running setup.py install for manifestparser 12:15:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:15:08 INFO - Running setup.py install for mozcrash 12:15:08 INFO - Running setup.py install for mozdebug 12:15:09 INFO - Running setup.py install for mozdevice 12:15:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:15:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:15:09 INFO - Running setup.py install for mozfile 12:15:09 INFO - Running setup.py install for mozhttpd 12:15:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:15:09 INFO - Running setup.py install for mozinfo 12:15:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:15:09 INFO - Running setup.py install for mozInstall 12:15:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:15:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:15:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:15:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:15:09 INFO - Running setup.py install for mozleak 12:15:09 INFO - Running setup.py install for mozlog 12:15:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:15:09 INFO - Running setup.py install for moznetwork 12:15:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:15:09 INFO - Running setup.py install for mozprocess 12:15:09 INFO - Running setup.py install for mozprofile 12:15:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:15:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:15:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:15:10 INFO - Running setup.py install for mozrunner 12:15:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:15:10 INFO - Running setup.py install for mozscreenshot 12:15:10 INFO - Running setup.py install for moztest 12:15:10 INFO - Running setup.py install for mozversion 12:15:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:15:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:15:10 INFO - Cleaning up... 12:15:10 INFO - Return code: 0 12:15:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7fb795baff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe90b0>, '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 0x1fe9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', '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 12:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 12:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 12:15:10 INFO - Using env: {'DISPLAY': ':0', 12:15:10 INFO - 'HOME': '/home/cltbld', 12:15:10 INFO - 'LANG': 'en_US.UTF-8', 12:15:10 INFO - 'LANGUAGE': 'en_US:en', 12:15:10 INFO - 'LOGNAME': 'cltbld', 12:15:10 INFO - 'MAIL': '/var/mail/cltbld', 12:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:10 INFO - 'MOZ_NO_REMOTE': '1', 12:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:10 INFO - 'NO_EM_RESTART': '1', 12:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:10 INFO - 'PWD': '/builds/slave/test', 12:15:10 INFO - 'SHELL': '/bin/bash', 12:15:10 INFO - 'SHLVL': '1', 12:15:10 INFO - 'TERM': 'linux', 12:15:10 INFO - 'TMOUT': '86400', 12:15:10 INFO - 'USER': 'cltbld', 12:15:10 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', 12:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:10 INFO - '_': '/tools/buildbot/bin/python'} 12:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:10 INFO - Running setup.py (path:/tmp/pip-iWwSTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:10 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)) 12:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:10 INFO - Running setup.py (path:/tmp/pip-Rq8JVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:10 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)) 12:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:10 INFO - Running setup.py (path:/tmp/pip-kghIho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:10 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)) 12:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:10 INFO - Running setup.py (path:/tmp/pip-kIlvIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:10 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)) 12:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:10 INFO - Running setup.py (path:/tmp/pip-eCr_Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:11 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)) 12:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:11 INFO - Running setup.py (path:/tmp/pip-EcNBG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:11 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)) 12:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:11 INFO - Running setup.py (path:/tmp/pip-SkWJLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:11 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)) 12:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:11 INFO - Running setup.py (path:/tmp/pip-60RL2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:11 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)) 12:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:11 INFO - Running setup.py (path:/tmp/pip-I42fdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:11 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)) 12:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:11 INFO - Running setup.py (path:/tmp/pip-6ITgNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:11 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)) 12:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:11 INFO - Running setup.py (path:/tmp/pip-9h_X_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:11 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)) 12:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:11 INFO - Running setup.py (path:/tmp/pip-HZOP8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:11 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)) 12:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:11 INFO - Running setup.py (path:/tmp/pip-DifLfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:11 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)) 12:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:11 INFO - Running setup.py (path:/tmp/pip-mx9CxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:11 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)) 12:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:11 INFO - Running setup.py (path:/tmp/pip-cvgd6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:11 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)) 12:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:11 INFO - Running setup.py (path:/tmp/pip-sBO4A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:11 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)) 12:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:11 INFO - Running setup.py (path:/tmp/pip-suB6BX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:11 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)) 12:15:11 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)) 12:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:15:11 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)) 12:15:11 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)) 12:15:11 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)) 12:15:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:13 INFO - Downloading blessings-1.5.1.tar.gz 12:15:13 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 12:15:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:15:13 INFO - Installing collected packages: blessings 12:15:13 INFO - Running setup.py install for blessings 12:15:13 INFO - Successfully installed blessings 12:15:13 INFO - Cleaning up... 12:15:13 INFO - Return code: 0 12:15:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:14 INFO - Reading from file tmpfile_stdout 12:15:14 INFO - Current package versions: 12:15:14 INFO - argparse == 1.2.1 12:15:14 INFO - blessings == 1.5.1 12:15:14 INFO - blobuploader == 1.2.4 12:15:14 INFO - docopt == 0.6.1 12:15:14 INFO - manifestparser == 1.1 12:15:14 INFO - mozInstall == 1.12 12:15:14 INFO - mozcrash == 0.16 12:15:14 INFO - mozdebug == 0.1 12:15:14 INFO - mozdevice == 0.47 12:15:14 INFO - mozfile == 1.2 12:15:14 INFO - mozhttpd == 0.7 12:15:14 INFO - mozinfo == 0.9 12:15:14 INFO - mozleak == 0.1 12:15:14 INFO - mozlog == 3.1 12:15:14 INFO - moznetwork == 0.27 12:15:14 INFO - mozprocess == 0.22 12:15:14 INFO - mozprofile == 0.27 12:15:14 INFO - mozrunner == 6.11 12:15:14 INFO - mozscreenshot == 0.1 12:15:14 INFO - mozsystemmonitor == 0.0 12:15:14 INFO - moztest == 0.7 12:15:14 INFO - mozversion == 1.4 12:15:14 INFO - psutil == 3.1.1 12:15:14 INFO - requests == 1.2.3 12:15:14 INFO - wsgiref == 0.1.2 12:15:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fb795baff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe90b0>, '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 0x1fe9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', '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 12:15:14 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 12:15:14 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 12:15:14 INFO - Using env: {'DISPLAY': ':0', 12:15:14 INFO - 'HOME': '/home/cltbld', 12:15:14 INFO - 'LANG': 'en_US.UTF-8', 12:15:14 INFO - 'LANGUAGE': 'en_US:en', 12:15:14 INFO - 'LOGNAME': 'cltbld', 12:15:14 INFO - 'MAIL': '/var/mail/cltbld', 12:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:14 INFO - 'MOZ_NO_REMOTE': '1', 12:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:14 INFO - 'NO_EM_RESTART': '1', 12:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:14 INFO - 'PWD': '/builds/slave/test', 12:15:14 INFO - 'SHELL': '/bin/bash', 12:15:14 INFO - 'SHLVL': '1', 12:15:14 INFO - 'TERM': 'linux', 12:15:14 INFO - 'TMOUT': '86400', 12:15:14 INFO - 'USER': 'cltbld', 12:15:14 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', 12:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:14 INFO - '_': '/tools/buildbot/bin/python'} 12:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:14 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)) 12:15:14 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)) 12:15:14 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)) 12:15:14 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)) 12:15:14 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)) 12:15:14 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)) 12:15:14 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)) 12:15:14 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)) 12:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:15:14 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)) 12:15:14 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)) 12:15:14 INFO - Cleaning up... 12:15:14 INFO - Return code: 0 12:15:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb795baff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe90b0>, '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 0x1fe9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', '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 12:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:15:14 INFO - Using env: {'DISPLAY': ':0', 12:15:14 INFO - 'HOME': '/home/cltbld', 12:15:14 INFO - 'LANG': 'en_US.UTF-8', 12:15:14 INFO - 'LANGUAGE': 'en_US:en', 12:15:14 INFO - 'LOGNAME': 'cltbld', 12:15:14 INFO - 'MAIL': '/var/mail/cltbld', 12:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:14 INFO - 'MOZ_NO_REMOTE': '1', 12:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:14 INFO - 'NO_EM_RESTART': '1', 12:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:14 INFO - 'PWD': '/builds/slave/test', 12:15:14 INFO - 'SHELL': '/bin/bash', 12:15:14 INFO - 'SHLVL': '1', 12:15:14 INFO - 'TERM': 'linux', 12:15:14 INFO - 'TMOUT': '86400', 12:15:14 INFO - 'USER': 'cltbld', 12:15:14 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', 12:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:14 INFO - '_': '/tools/buildbot/bin/python'} 12:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:14 INFO - Downloading/unpacking jsonschema 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:15:16 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 12:15:16 INFO - Downloading/unpacking functools32 (from jsonschema) 12:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:16 INFO - Downloading functools32-3.2.3-2.tar.gz 12:15:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:15:16 INFO - warning: no files found matching '*.txt' 12:15:16 INFO - no previously-included directories found matching 'build' 12:15:16 INFO - no previously-included directories found matching 'dist' 12:15:16 INFO - no previously-included directories found matching '.git*' 12:15:16 INFO - Installing collected packages: jsonschema, functools32 12:15:16 INFO - Running setup.py install for functools32 12:15:16 INFO - warning: no files found matching '*.txt' 12:15:16 INFO - no previously-included directories found matching 'build' 12:15:16 INFO - no previously-included directories found matching 'dist' 12:15:16 INFO - no previously-included directories found matching '.git*' 12:15:16 INFO - Successfully installed jsonschema functools32 12:15:16 INFO - Cleaning up... 12:15:16 INFO - Return code: 0 12:15:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb795baff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe90b0>, '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 0x1fe9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', '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 12:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:15:16 INFO - Using env: {'DISPLAY': ':0', 12:15:16 INFO - 'HOME': '/home/cltbld', 12:15:16 INFO - 'LANG': 'en_US.UTF-8', 12:15:16 INFO - 'LANGUAGE': 'en_US:en', 12:15:16 INFO - 'LOGNAME': 'cltbld', 12:15:16 INFO - 'MAIL': '/var/mail/cltbld', 12:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:16 INFO - 'MOZ_NO_REMOTE': '1', 12:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:16 INFO - 'NO_EM_RESTART': '1', 12:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:16 INFO - 'PWD': '/builds/slave/test', 12:15:16 INFO - 'SHELL': '/bin/bash', 12:15:16 INFO - 'SHLVL': '1', 12:15:16 INFO - 'TERM': 'linux', 12:15:16 INFO - 'TMOUT': '86400', 12:15:16 INFO - 'USER': 'cltbld', 12:15:16 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', 12:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:16 INFO - '_': '/tools/buildbot/bin/python'} 12:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:16 INFO - Downloading/unpacking flake8 12:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:15:18 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 12:15:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:15:18 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 12:15:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:18 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 12:15:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:15:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:15:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:15:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:15:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:15:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:15:19 INFO - no previously-included directories found matching 'docs/_build' 12:15:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:15:19 INFO - Running setup.py install for pep8 12:15:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:15:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:15:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:15:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:15:19 INFO - no previously-included directories found matching 'docs/_build' 12:15:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:15:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:15:19 INFO - Cleaning up... 12:15:19 INFO - Return code: 0 12:15:19 INFO - Running post-action listener: _resource_record_post_action 12:15:19 INFO - Running post-action listener: _start_resource_monitoring 12:15:19 INFO - Starting resource monitoring. 12:15:19 INFO - ##### 12:15:19 INFO - ##### Running install step. 12:15:19 INFO - ##### 12:15:19 INFO - Running pre-action listener: _resource_record_pre_action 12:15:19 INFO - Running main action method: install 12:15:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:19 INFO - Reading from file tmpfile_stdout 12:15:19 INFO - Detecting whether we're running mozinstall >=1.0... 12:15:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:15:19 INFO - Reading from file tmpfile_stdout 12:15:19 INFO - Output received: 12:15:19 INFO - Usage: mozinstall [options] installer 12:15:19 INFO - Options: 12:15:19 INFO - -h, --help show this help message and exit 12:15:19 INFO - -d DEST, --destination=DEST 12:15:19 INFO - Directory to install application into. [default: 12:15:19 INFO - "/builds/slave/test"] 12:15:19 INFO - --app=APP Application being installed. [default: firefox] 12:15:19 INFO - mkdir: /builds/slave/test/build/application 12:15:19 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'] 12:15:19 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 12:15:34 INFO - Reading from file tmpfile_stdout 12:15:34 INFO - Output received: 12:15:34 INFO - /builds/slave/test/build/application/firefox/firefox 12:15:34 INFO - Running post-action listener: _resource_record_post_action 12:15:34 INFO - ##### 12:15:34 INFO - ##### Running run-tests step. 12:15:34 INFO - ##### 12:15:34 INFO - Running pre-action listener: _resource_record_pre_action 12:15:34 INFO - Running main action method: run_tests 12:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:15:34 INFO - Python 2.7.3 12:15:34 INFO - Return code: 0 12:15:34 INFO - grabbing minidump binary from tooltool 12:15:34 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')]} 12:15:34 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 0x1fe90b0>, '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 0x1fe9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:15:34 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 12:15:34 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 12:15:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:15:34 INFO - Return code: 0 12:15:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:15:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:15:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:15:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:15:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:15:35 INFO - Return code: 0 12:15:35 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/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] in /builds/slave/test/build 12:15:35 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/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost 12:15:35 INFO - Using env: {'DISPLAY': ':0', 12:15:35 INFO - 'HOME': '/home/cltbld', 12:15:35 INFO - 'LANG': 'en_US.UTF-8', 12:15:35 INFO - 'LANGUAGE': 'en_US:en', 12:15:35 INFO - 'LOGNAME': 'cltbld', 12:15:35 INFO - 'MAIL': '/var/mail/cltbld', 12:15:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:15:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:35 INFO - 'MOZ_NO_REMOTE': '1', 12:15:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:35 INFO - 'NO_EM_RESTART': '1', 12:15:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:35 INFO - 'PWD': '/builds/slave/test', 12:15:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:15:35 INFO - 'SHELL': '/bin/bash', 12:15:35 INFO - 'SHLVL': '1', 12:15:35 INFO - 'TERM': 'linux', 12:15:35 INFO - 'TMOUT': '86400', 12:15:35 INFO - 'USER': 'cltbld', 12:15:35 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765', 12:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:35 INFO - '_': '/tools/buildbot/bin/python'} 12:15:35 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/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] with output_timeout 3600 12:15:35 INFO - mozversion INFO | application_buildid: 20151204113611 12:15:35 INFO - mozversion INFO | application_changeset: 3d8926eef121ba1b6b003011e2cac09c00782657 12:15:35 INFO - mozversion INFO | application_display_name: Nightly 12:15:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:15:35 INFO - mozversion INFO | application_name: Firefox 12:15:35 INFO - mozversion INFO | application_remotingname: firefox 12:15:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:15:35 INFO - mozversion INFO | application_vendor: Mozilla 12:15:35 INFO - mozversion INFO | application_version: 45.0a1 12:15:35 INFO - mozversion INFO | platform_buildid: 20151204113611 12:15:35 INFO - mozversion INFO | platform_changeset: 3d8926eef121ba1b6b003011e2cac09c00782657 12:15:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:15:35 INFO - mozversion INFO | platform_version: 45.0a1 12:15:35 INFO - 2015-12-04 12:15:35,446 DEBUG : using testdate: 1449260135 12:15:35 INFO - 2015-12-04 12:15:35,446 DEBUG : actual date: 1449260135 12:15:35 INFO - 2015-12-04 12:15:35,453 INFO : starting webserver on 'localhost:59185' 12:15:35 INFO - 2015-12-04 12:15:35,454 INFO : Starting test suite talos-linux64-ix-041 12:15:35 INFO - 2015-12-04 12:15:35,454 INFO : Starting test dromaeo_css 12:15:35 INFO - 2015-12-04 12:15:35,454 DEBUG : operating with platform_type : linux_ 12:15:35 INFO - 2015-12-04 12:15:35,454 INFO : Initialising browser for dromaeo_css test... 12:15:35 INFO - 2015-12-04 12:15:35,465 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRFFu6h/profile http://localhost:59185/getInfo.html 12:15:39 INFO - 2015-12-04 12:15:39,950 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:15:39 INFO - 2015-12-04 12:15:39,951 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:15:39 INFO - 2015-12-04 12:15:39,951 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:15:39 INFO - 2015-12-04 12:15:39,951 DEBUG : BROWSER_OUTPUT: __metrics 12:15:40 INFO - 2015-12-04 12:15:40,107 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] 12:15:40 INFO - 2015-12-04 12:15:40,168 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] 12:15:41 INFO - 2015-12-04 12:15:41,435 INFO : Browser initialized. 12:15:41 INFO - 2015-12-04 12:15:41,436 INFO : Running cycle 1/1 for dromaeo_css test... 12:15:41 INFO - 2015-12-04 12:15:41,436 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRFFu6h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:15:53 INFO - 2015-12-04 12:15:53,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 143835136 12:15:53 INFO - 2015-12-04 12:15:53,436 DEBUG : BROWSER_OUTPUT: 12:16:44 INFO - 2015-12-04 12:16:44,174 DEBUG : BROWSER_OUTPUT: 1449260204168 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] 12:18:57 INFO - 2015-12-04 12:18:57,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59185/tests/dromaeo/cssquery-ext.html) 12:18:58 INFO - 2015-12-04 12:18:58,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 262049792 12:18:58 INFO - 2015-12-04 12:18:58,944 DEBUG : BROWSER_OUTPUT: 12:22:01 INFO - 2015-12-04 12:22:01,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/dromaeo/cssquery-ext.html (next: http://localhost:59185/tests/dromaeo/cssquery-jquery.html) 12:22:01 INFO - 2015-12-04 12:22:01,888 DEBUG : BROWSER_OUTPUT: RSS: Main: 230486016 12:22:01 INFO - 2015-12-04 12:22:01,888 DEBUG : BROWSER_OUTPUT: 12:25:03 INFO - 2015-12-04 12:25:03,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59185/tests/dromaeo/cssquery-mootools.html) 12:25:04 INFO - 2015-12-04 12:25:04,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 217542656 12:25:04 INFO - 2015-12-04 12:25:04,492 DEBUG : BROWSER_OUTPUT: 12:28:06 INFO - 2015-12-04 12:28:06,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59185/tests/dromaeo/cssquery-prototype.html) 12:28:06 INFO - 2015-12-04 12:28:06,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 201383936 12:28:06 INFO - 2015-12-04 12:28:06,945 DEBUG : BROWSER_OUTPUT: 12:31:09 INFO - 2015-12-04 12:31:09,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59185/tests/dromaeo/cssquery-yui.html) 12:31:10 INFO - 2015-12-04 12:31:10,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 207925248 12:31:10 INFO - 2015-12-04 12:31:10,280 DEBUG : BROWSER_OUTPUT: 12:34:12 INFO - 2015-12-04 12:34:12,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/dromaeo/cssquery-yui.html (next: http://localhost:59185/tests/dromaeo/cssquery-dojo.html) 12:34:13 INFO - 2015-12-04 12:34:13,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 250736640 12:34:13 INFO - 2015-12-04 12:34:13,053 DEBUG : BROWSER_OUTPUT: 12:34:13 INFO - 2015-12-04 12:34:13,053 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:34:13 INFO - 2015-12-04 12:34:13,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:34:13 INFO - 2015-12-04 12:34:13,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:34:13 INFO - 2015-12-04 12:34:13,054 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:34:13 INFO - 2015-12-04 12:34:13,057 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2629.618705287733;2728.467948749992;2732.289604702778;2752.710965348638;2763.8894444222224;4577.404937358147;4701.952980470194;4798.304245884345;4837.226043832992;4863.537963893429;4647.395838540993;4723.456802467717;4738.312944623036;4749.168895443301;4878.804847806093;4343.847965321206;4347.13057388522;4401.987542865143;4470.329450582406;4482.5069242383315;4405.80173892174;4467.664925130595;4470.441194850644;4475.70907890986;4516.074204788027;4258.446401967724;4292.935605965913;4385.386045953569;4391.6486681065435;4398.34024896265;4398.64810815134;4427.822887084512;4440.422745043156;4440.933385999213;4451.643868490513;4347.956520434786;4373.868783936487;4386.868393948187;4392.1874453226255;4442.444694413199;4489.528599497071;4600.033992861503;4610.884727881797;4754.857354279377;4772.475027746945;5005.174146265862;5107.923381149286;5114.181730923035;5123.436421993578;5163.277141200235;5147.819826306061;5160.148575485078;5168.638195326329;5170.069387510247;5209.635325527214;4594.977025114853;4717.174494463524;4741.407324084489;4776.426828780499;4779.999999999965;5114.948850511447;5196.58427325813;5242.16125419931;5253.816116435906;5254.474552544715;5012.649114562018;5063.063333283354;5064.544191022752;5074.08666440037;5117.462666420047;4871.488493708181;4973.776180071905;4988.326575912278;5136.2295655651205;5149.304843846033;4939.876503087452;4962.851114466572;5030.673006254582;5035.194368900959;5064.772085256099;5043.36957880265;5064.468230835783;5080.69515829044;5083;5127.461616530285;4061.431399604058;4247.341662042389;4253.63844073251;4266.52882292712;4271.359296105609;3619.8009109498703;3666.431703086026;3701.5002974598624;3718.9070273242846;3730.160713839419;4426.136903303889;4433.024734558392;4447.110577884436;4447.977760111179;4475.932861007088;4863.975680121647;5173.741312934339;5179.8446046618665;5181.715005674649;5185.844424667266;4268.9786551067045;4358.891027724332;4390.604845563915;4394.428724265825;4395.428594282786;4492.618127459137;4504.054148628759;4510.932336014962;4553.33976573395;4560.749158796231;4838.830640927551;4853.80584776605;4857.805687772591;4863.562279394871;4906.55840974314;4867.488913664014;4980.576650984707;4994.425641051325;5088.262201980766;5103.387593488805;4765.428148622187;4786.95213047865;4812.975935120302;4821.855344339676;4828.903421931612;4892.363992681071;4951.801927922987;4965;4984.127777638972;5016.247562865454;5116.9232461512365;5159.329287192641;5162.199859021857;5166.535011848951;5200.115980283285;4697;4952.207646776498;4998.775055122601;4999.925001124913;5002.949970500394;4861.513848615252;4896.2410826321975;4906.656534042726;5021.07110184617;5057.949420505748;4806.49531799156;4830.178869592108;4833.903321933612;4837.032593481247;4866.416030076413;4932.753362331798;4945.1346014448045;4949.430815456125;4953.554180123806;4990.80036798524;4698.812047518061;4775.6657034007285;4782.856514304576;4828.130936431476;4833.299171620166 12:34:13 INFO - 2015-12-04 12:34:13,059 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.1110134885531;564.5483613109511;573.2576313673793;578.0462237308443;590.6780804461569;27744;28305.716942830564;37098.81450592747;37657.811710941474;37695.81152094243;39554.80222598883;40235.39646905292;40333.59666403342;40339.19321613566;40390.39414408779;6993.05593744843;7848.293653571178;8032.357411407073;8033.236842499953;8039.799005024863;7043.929560704404;7143.3570978611915;7150.034745309369;7153.964230178842;7154.284571542856;7069.187043490013;7154.8569028619395;10216.795664086714;10539.314944528582;10569.6300629478;10081.697549073502;10189.439580823051;10201.285909986304;10201.43892085935;10203.183745300395;9979.501024948724;10113.836908755513;10120.595176192943;10125.038121378457;10126.341787783771;37288.254234915425;37518.81240593807;37560.24879502422;37573.43639845377;37740.81129594362;2531.444905157509;2613.6732908386452;2694.663167104112;3037.4532584134845;3039.8936037238814;27321.180364589094;27341.86329068342;27560.17319480399;27776.30559236015;28085.85957070222;3359.8656053757823;3501.704829442807;3507.7895326280504;3558.982205088958;3633.128049268183;221087;221120;221373;223064;223583;56565;56740.71629641826;56868;57321.71339143278;57338.13992790112;55382.44617553773;56461.71769141128;59370.70314648399;59953.70023149944;61229.69385153046;13181.538646147339;13395.665108372368;13410.12834165776;13410.798838017437;13472.865271347357;9824.607015719434;10509;10708.571657133783;10713.35719856811;10721.624743133953;16209;18510.537236568925;20102.59794804125;20245.49386265355;20280.79719202789;7714.112877019103;7797.635413802562;7822.1004584472375;7849.843003139905;7894.605269736605;887.8890138732659;898.501331760879;900.1763386501409;907.7639813648499;1038.7610849504506;26667.733322666525;26760.464790704078;27025.1892443227;27040.864795675894;27112;955.3360414511848;1022.4887556221889;1035.0270745499206;1051.0645525482173;1083.095615161349;13624.727505449835;13728.176309421468;14039.087459315111;14069.2965351732;14086.15483071019;275326;279388;279944;280386;280762;45494.31758523625;45844.7707761459;45938.081238375045;46019.76990115028;46152.538474615496;1194.5162209305245;1196.3778835005749;1196.9521219151484;1219.2928101700993;1233.9506419743288;24992.625110623718;25533;25976.610350844374;26108.216753497425;26155.346116347242;40241.59758402379;40469;40790.79604601958;40905.38641920433;40907.59092409038;247817;248703;249493;249601;250188;29669.109926702233;29884;30157.396852062397;30336;30421.391572168875;39072.023199419105;39125.81711567461;39689;39691.40462893001;39810.66342775087;33067.35461163053;33501.83249083739;33586;33775.155621108686;33904.49143262902;32713.509297360084;33741.83129084339;33962.320753584296;34091;34239.315213696085;33180.66819331776;33647.66352336543;34014.48978265378;34072;34085.147871303416;29016.56475152832;29032.854835725688;30233.69766302397;30671.16572991637;30842.53736193914;23777.405564861016;23791.881040595377;23931.162409316286;24193.39516512101;24196.75803241945 12:34:13 INFO - 2015-12-04 12:34:13,060 DEBUG : BROWSER_OUTPUT: |2;jquery.html;308.08805934434076;327.75745947998473;331.600421492102;331.63851401971846;333.8765055587946;11603.245789023718;11954.64136075918;15213.239338033109;16107.758383624256;16836.66326673469;15742.842571574281;15892.443764468246;15910.52268431946;15922.442714504994;16037.83962160378;3911.9804400977955;5026.396832380119;5026.698398096108;5030.0694371541385;5040.571551418134;4978.477259887714;5011.649184557083;5021.949780502203;5026.949730502684;5028.723420211887;4893.6329775266995;4979.253112033188;5081.339425874631;5086.618503612225;5087.923681144785;4953.90092198154;4973.278874563168;5073.213651883964;5076.6700164489375;5223.033738758342;5055.014272216919;5055.974720126376;5064.848054558369;5065.240213967897;5066.341375621146;11574.131940104442;11583.18917675763;11603.245789023686;13226.338683065904;18326.90836545822;1730.126286225448;1772.7252275897256;1783.2688597674892;1807.3493542324752;1823.3982785680826;8765.693200737944;8913.28693704502;9033.277337813024;11372.60195893148;11793.587224447188;1576.7634854771761;1620.8703303735672;1657.65189310245;1690.1126908373203;1729.3947118508547;50123.49876501225;50652.746736266454;51047.48952510465;51265;56435.71782141104;8751.343649226334;9123.270138388913;9216.447013179097;9518.476483793458;9662.661806836726;11330.886691133148;11527.250728702607;11839.171258011856;11843.170978031627;11854.703632409259;6640.468762498988;6858;6874.037634731141;6891.655417229119;6914.481413893978;6559.901601475982;6607.702653380513;6619.602823830585;6630.237522684856;6676.732930682719;3876.4185372194397;3878.6315300047013;3902.5316961964745;4017.959820401817;4024.71209213049;1684.9157542122846;1709.1539687854593;1729.325563030419;1730.6106126121774;1741.4601473543241;363.7453782352311;367.61767761528245;370.65158750774185;377.86963497593285;934.3366209990846;9553;9832.508374581243;15297.311620977083;15895.761563576556;16788.916055419646;803.9075506316849;809.2999555384667;851.5146366570995;859.4198915731981;957.129012598546;8068;8389.832203355898;8559.871601925975;8662.090480499583;8690.08754080825;501174;512942;527474;528069;534880;68469.31530684729;70063;70608.2939170612;70683.6465817678;70748;1094.43089593411;1099.8680158381046;1155.3010428690689;1172.9061675065975;1179.5340840368178;13979.930100349433;14024.929875350557;14103.788443173566;14139.64650883736;14206.218657973497;23746.88126559356;28638.856805715837;29104.7089529102;29919.70080299169;30239.395212096075;34474.48288275728;34643;35650.8217458911;36055;36266.8186659065;8558.272546833588;8668.52323122209;8795.956020219857;8937.508437036025;8943.329250306122;15549.300281487587;15670;15712.685746285239;15727.292271848024;16485;13594.252316122709;13690.247036413093;13892.374843132286;13900.235487048309;13930.442782288595;12904.741905162033;13136.868631313946;13325.466981320638;13410.128341658152;13917.652058698613;13192.670183245496;13568.389422475815;13578.660533486742;13733.244671543162;14385.280735962951;7186.6047367395295;7737.883931740916;8711.128887111237;8727.912720872964;8752.868706969528;8963.865542016745;9079.137481939206;10094.697159085239;12857;12884.355782210665 12:34:13 INFO - 2015-12-04 12:34:13,062 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1439.9064060836038;1679.353448922165;1724.732666436702;1747.9912600436996;1752.6319472910695;5859.355470898203;7097.78706638801;7480.177180510146;7484.476086673935;7510.474266801326;7266.927330726704;7392.186859445456;7437.739679111232;7451.62741862906;7457.440691948099;2051.887146206958;2089.362744362969;2095.224766836265;2098.2865825619288;2098.9265375711852;2122.0556852200775;2130.20117455954;2143.742750869898;2146.7209262795814;2147.237730605636;2085.645440275149;2089.8014688604635;2102.7581828089737;2119.79861913118;2120.7031015657744;2088.3734879536155;2112.704221408989;2115.598036373084;2117.3224568138203;2119.364190742771;2052.220156340596;2074.1288658763356;2094.1414020251623;2094.2460714142894;2094.549671820566;7298.781036568911;7376.520526165836;7377.336039756394;7387.298206670358;7396.186419493852;4299.290617048183;4347.3696314034605;4383.232934236496;4397.098594788093;4404.163208990313;2632.6445929799424;2641.168032069892;2642.0620679658828;2646.0209722402833;2664.480426316869;846.6697987784769;856.7558245899888;864.8832407624953;879.331707901999;900.2617853360247;9918.950405247928;9924.603015879356;9925.1067403934;9944.403335799803;9946.801063978752;3868.845246190177;3880.1463677990796;3938.2911076006594;4001.7398869073418;4009;8660.566971651393;8679.826403472021;8685.6525738971;8687.52218627969;8706.6517339307;4290.206311832321;4308.224519586504;4309.91380172401;4314;4323.610875021201;3095.8297293649066;3155.4004739099496;3759.0790256386813;3908.726389152732;3910.081130934228;3536.45184996326;3562.2697347043795;3572.4284114541547;3587.8564857405413;3604.7296452766145;1115.1747706696985;1132.8697199822127;1135.517405102828;1135.8920902514249;1144.416347662698;906.1120102299651;921.0145144695246;1160.0835340081242;1169.4386694386742;1177.0348314382124;6942.583444993316;7008.614526201006;7011.964940175369;7028.086348774729;7030.929690703129;1070.1973519860105;1073.7637719701654;1084.3981590217504;1093.6281664234039;1104.9558017679365;5449.918251226235;5492.780288788484;5530.170474428787;5535.33575970878;5543.972280138573;8695.00007499133;8704.695335663222;8712.69505567302;8793.692220772242;8884.64461421549;8731.65073397057;8749.781255468664;8760.56197190138;8767.079456657088;8767.780805479913;6862.519623626398;6889.552179108342;6934.4452443804375;6971.163460384685;7009.7897063088185;6921.2732663069655;6968.268331825086;6976.372126508639;6982.406495447944;6986.371226589428;7726.806829829299;7877.645505952131;8004.839903201787;8011.559364235023;8016.799580010546;7944.404169687181;8276.462029968034;8293.58532073406;8325.209105135002;8339.45793523419;6265.342139075331;6314.55798094129;6556.541042127005;6701.899471507833;6707.295733947865;7060.6116663584;7136.107986501687;7149.53528020677;7154;7159.069320988238;6438.259600145856;6574.605523668595;6617.272100069084;6657.667116644246;6686.364795344434;6485.77299794505;6535;6609;6699.095622090956;6711.4966377520905;6175.938240617536;6216.751329946752;6219.657918814328;6220.813375598739;6226.533010024175;5738.942610574008;5975.16347711312;5997.100434934795;6015.759369625341;6019.759209631566;6042.244719410074;6042.637441753509;6061.242344706911;6098.054801505774;6106.847328816637 12:34:13 INFO - 2015-12-04 12:34:13,063 DEBUG : BROWSER_OUTPUT: |4;prototype.html;283.2324400873632;289.63795255930086;292.90334189717396;293.4849339409338;294.20417769932334;5361.785528578852;5415.766845640248;5419.241306217128;5450.411054748993;5452.9823965132855;5338.946610533893;5341.172118321666;5349.8127565535215;5352.785888564463;5357.276767636368;4115.9588404115875;4123.484564429446;4127.7936103194725;4130.256553820311;4135.110951145495;3869.671077958377;3966.2067586482676;4007.8597249096288;4128.339465685476;4140.855070072548;4075.857344992926;4076.388541718751;4081.510218773751;4096.446979657752;4097.364908439182;3828.1003964068423;3924.058226025762;4064.126212864234;4072.4705788247634;4084.979575102135;3502.124468882779;3569.8572057117685;3582.4805403216646;3583.050491619723;3588.4437912123662;5184.481551844823;5192.1692529195525;5192.324997750268;5194.844154675366;5202;4710.976445117787;4716.55192756691;4716.622670186377;4720.881977950545;4725.976370118162;5474.863128421782;5615.46653067962;5619.522340601054;5624.409437009096;5628.774849006035;3901.765894046338;3903.902402439933;3906.785126818024;3908.4332771747936;3911.9217615647813;5916;5923.881522369572;5925.2889653241455;5927.1405646181065;5927.3776253493625;4018.477597912253;4020.2964481216254;4025.1748391579654;4028.295048366524;4036.5357983832237;4097.610726980932;4097.959020409818;4103.056297051695;4103.4460347853255;4103.671706263492;4457.732536047847;4624.28323609841;4642.976785116053;4643.326717625993;4646.4888862225125;5637.746301416446;5648.209250704905;5650.124230744241;5654.971725141348;5655;1384.9169049857042;1398.1331574423923;1400.9369578368999;1401.5515035188641;1401.873831355183;915.5513798238815;929.7954450020984;933.8225737109927;943.2218419803689;947.5167664491021;4967.3294105296045;4977.104121258136;4979;4980.402351717817;4986.252062190628;5858.384869588717;5865.178874957509;5865.6480611162615;5866.735996880066;5872.915115134066;4965.081459929925;4973.477784832613;4975.104481193348;4976.975115124401;4981.526754958273;3044.0563425338214;3093.7215650591556;3135.1691801672573;3162.2726772842375;3170.1599076244815;5480.177973304037;5523.447655234444;5585.441455854463;5627.324721033502;5636.4927156556105;6067;6069.817905462844;6073.635581865102;6075.422834830684;6085.026395776655;5613.410591887793;5625.88748225025;5627.774889004394;5628.380878103405;5631.155326701028;5735.770569177186;5910.911336330045;5915.142304365929;5918.201042859159;5918.763249469973;5763.049096898964;5770.567207459373;5772.797952071657;5776.942230577809;5788.884222315446;5609.298837645294;5617.578681598979;5618.410066943075;5624.100143976944;5630.662160270397;3811.8856434307013;3922.8430862766313;3955.0310174007554;3958.6437220650278;3958.7228893977144;5831.7958871441;5841.211436456024;5847.766089356378;5850.23946886902;5852.4147585241135;5615.129654903497;5622.943770562406;5623.2127502148915;5624.521915637217;5627.43725627434;5568.470995255444;5571.108622620523;5621.156826476062;5623.3533143689;5643.88712225745;5388.919166212589;5502;5502.80740174092;5503.532199762904;5504;5634.88730225385;5642.88714225705;5651.858703532444;5653.689047102449;5653.773849046157;5481.424450432806;5490.945090549043;5494.725263736717;5497.092979658471;5497.147942068986 12:34:13 INFO - 2015-12-04 12:34:13,064 DEBUG : BROWSER_OUTPUT: |5;yui.html;676.2088356622751;687.748971625357;695.9199692035417;727.9490435669505;793.9325157361624;10920.1263898888;11097.944510277448;11164.665060048192;11197.608083717072;11198.664040078791;11613.593524226653;11637.650870473879;11658;11811.11416643753;11823.527058917633;623.9968800155992;632.5477283742124;795.546538473072;801.9639116239754;808.4623725222749;804.6258489802241;806.04483686831;812.8171161488677;813.2558708781457;813.4184058398245;651.7197605029835;835.3526017336552;841.734853521142;841.7685136587427;842.7219017724136;654.3750718064261;824.1511243419287;834.6911642692243;838.1995194589152;839.559231403512;615.7875532941129;619.2228752915108;619.7954674957298;619.9318075011745;619.9442050215503;11717.70705732355;11863.644090677208;11877.99037081849;11924.880751192464;11933;10156.847647285296;10304.536295866705;10809.297395669257;10857.185711071623;11202.215844890861;9113;9119.589618467186;9201.953990230006;9303.488308143049;9417.670381536613;3218.983905080483;3236.563063986379;3270.2478429961006;3301.224212310105;3313.9171520711934;38667.22665546674;38746.61253387486;39044.60955390438;39066.21867562661;39136.60863391358;8953.776155596162;9380.765480862896;9731.708048758548;9784.55969481375;9809.509524523744;15666.451674191349;15961;15965.121918294373;16022.919885400499;16024.359025638843;6354.266813451754;6415.101885736;6488.805335839932;6519.348065193538;6603.306652801482;3581.606023337431;3607.67530922213;3624.257027309395;3650.6166852480105;3666.5416822897137;2846.6014757933904;2938.14793709826;2941.838198899038;2948.395578906319;2951.439226546949;505.16395365669877;505.5020804507557;512.0654804980925;513.5583398277479;519.7349351830518;460.0752487500082;463.8075198792531;469.3921371823429;472.99763501182275;520.9164936931174;7055.753048643272;7384.224656410999;7577.88019345674;7694.538327700356;7779.3776497880035;578.7713853028031;583.0700033446645;586.0535235594484;593.0599999001631;604.2084868821858;3438.432658611351;3624.8006359649944;3640.162762564625;3671.4125739881492;3702.4816525686424;49246;49727.25409118866;49892.25161622579;50036.249456258185;50146.498535014915;42946;43767.56232437699;44129.55870441319;44219.33670994938;44231.336529952074;38365.424518632244;39391.40912886251;39469.605303947166;39579.40630890539;39842.80078599588;7042.929570704227;7215.927840721525;7964.761057168294;8012.599370031358;8071.266292000497;30134.397312054076;30266.69733302727;30878.84560577183;31131;32893.50659740058;40265.59734402619;40563;40800.79599602102;41847.58152418559;41952;9562.991771727737;10092.596296148073;10197.337173083726;10392.42841643717;10456.424896630759;10820.513076911715;10900.890991089987;10912.345259284151;10980.780384392427;11029.44852757375;10900;11086.501107450023;11272.887271127513;11325.15061370417;11634.418279086181;10057.597696092074;10106.898931010595;10110.241731870286;10348.482575871025;10421.68734937953;10147.086762191439;10366.688999330032;10435.165186784887;10622.946885265525;10665.786684266426;8912.643494260157;9076.546172691471;9335.57989890443;9723.124918757347;9725.221982241545;8454.1123182065;8665.870011949952;8709.695160669346;8748.1251874812;8989 12:34:13 INFO - 2015-12-04 12:34:13,064 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:34:13 INFO - 2015-12-04 12:34:13,064 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:34:13 INFO - 2015-12-04 12:34:13,064 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,994 12:34:13 INFO - 2015-12-04 12:34:13,064 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:34:13 INFO - 2015-12-04 12:34:13,065 DEBUG : BROWSER_OUTPUT: __startTimestamp1449261253052__endTimestamp 12:34:13 INFO - 2015-12-04 12:34:13,065 DEBUG : BROWSER_OUTPUT: 12:34:13 INFO - 2015-12-04 12:34:13,065 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:34:13 INFO - 2015-12-04 12:34:13,065 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:34:13 INFO - 2015-12-04 12:34:13,065 DEBUG : BROWSER_OUTPUT: 12:34:13 INFO - 2015-12-04 12:34:13,065 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4694.02 Median:4828.90 stddev:489.63 (10.1%) stddev-sans-first:463.57 12:34:13 INFO - 2015-12-04 12:34:13,065 DEBUG : BROWSER_OUTPUT: Values: 2629.6 2728.5 2732.3 2752.7 2763.9 4577.4 4702.0 4798.3 4837.2 4863.5 4647.4 4723.5 4738.3 4749.2 4878.8 4343.8 4347.1 4402.0 4470.3 4482.5 4405.8 4467.7 4470.4 4475.7 4516.1 4258.4 4292.9 4385.4 4391.6 4398.3 4398.6 4427.8 4440.4 4440.9 4451.6 4348.0 4373.9 4386.9 4392.2 4442.4 4489.5 4600.0 4610.9 4754.9 4772.5 5005.2 5107.9 5114.2 5123.4 5163.3 5147.8 5160.1 5168.6 5170.1 5209.6 4595.0 4717.2 4741.4 4776.4 4780.0 5114.9 5196.6 5242.2 5253.8 5254.5 5012.6 5063.1 5064.5 5074.1 5117.5 4871.5 4973.8 4988.3 5136.2 5149.3 4939.9 4962.9 5030.7 5035.2 5064.8 5043.4 5064.5 5080.7 5083.0 5127.5 4061.4 4247.3 4253.6 4266.5 4271.4 3619.8 3666.4 3701.5 3718.9 3730.2 4426.1 4433.0 4447.1 4448.0 4475.9 4864.0 5173.7 5179.8 5181.7 5185.8 4269.0 4358.9 4390.6 4394.4 4395.4 4492.6 4504.1 4510.9 4553.3 4560.7 4838.8 4853.8 4857.8 4863.6 4906.6 4867.5 4980.6 4994.4 5088.3 5103.4 4765.4 4787.0 4813.0 4821.9 4828.9 4892.4 4951.8 4965.0 4984.1 5016.2 5116.9 5159.3 5162.2 5166.5 5200.1 4697.0 4952.2 4998.8 4999.9 5002.9 4861.5 4896.2 4906.7 5021.1 5057.9 4806.5 4830.2 4833.9 4837.0 4866.4 4932.8 4945.1 4949.4 4953.6 4990.8 4698.8 4775.7 4782.9 4828.1 4833.3 12:34:13 INFO - 2015-12-04 12:34:13,065 DEBUG : BROWSER_OUTPUT: 12:34:13 INFO - 2015-12-04 12:34:13,065 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41324.58 Median:30546.28 stddev:65435.15 (214.2%) stddev-sans-first:65547.12 12:34:13 INFO - 2015-12-04 12:34:13,065 DEBUG : BROWSER_OUTPUT: Values: 559.1 564.5 573.3 578.0 590.7 27744.0 28305.7 37098.8 37657.8 37695.8 39554.8 40235.4 40333.6 40339.2 40390.4 6993.1 7848.3 8032.4 8033.2 8039.8 7043.9 7143.4 7150.0 7154.0 7154.3 7069.2 7154.9 10216.8 10539.3 10569.6 10081.7 10189.4 10201.3 10201.4 10203.2 9979.5 10113.8 10120.6 10125.0 10126.3 37288.3 37518.8 37560.2 37573.4 37740.8 2531.4 2613.7 2694.7 3037.5 3039.9 27321.2 27341.9 27560.2 27776.3 28085.9 3359.9 3501.7 3507.8 3559.0 3633.1 221087.0 221120.0 221373.0 223064.0 223583.0 56565.0 56740.7 56868.0 57321.7 57338.1 55382.4 56461.7 59370.7 59953.7 61229.7 13181.5 13395.7 13410.1 13410.8 13472.9 9824.6 10509.0 10708.6 10713.4 10721.6 16209.0 18510.5 20102.6 20245.5 20280.8 7714.1 7797.6 7822.1 7849.8 7894.6 887.9 898.5 900.2 907.8 1038.8 26667.7 26760.5 27025.2 27040.9 27112.0 955.3 1022.5 1035.0 1051.1 1083.1 13624.7 13728.2 14039.1 14069.3 14086.2 275326.0 279388.0 279944.0 280386.0 280762.0 45494.3 45844.8 45938.1 46019.8 46152.5 1194.5 1196.4 1197.0 1219.3 1234.0 24992.6 25533.0 25976.6 26108.2 26155.3 40241.6 40469.0 40790.8 40905.4 40907.6 247817.0 248703.0 249493.0 249601.0 250188.0 29669.1 29884.0 30157.4 30336.0 30421.4 39072.0 39125.8 39689.0 39691.4 39810.7 33067.4 33501.8 33586.0 33775.2 33904.5 32713.5 33741.8 33962.3 34091.0 34239.3 33180.7 33647.7 34014.5 34072.0 34085.1 29016.6 29032.9 30233.7 30671.2 30842.5 23777.4 23791.9 23931.2 24193.4 24196.8 12:34:13 INFO - 2015-12-04 12:34:13,066 DEBUG : BROWSER_OUTPUT: 12:34:13 INFO - 2015-12-04 12:34:13,066 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26441.57 Median:374.26 stddev:85015.24 (22715.5%) stddev-sans-first:85231.08 12:34:13 INFO - 2015-12-04 12:34:13,067 DEBUG : BROWSER_OUTPUT: Values: 308.1 327.8 331.6 331.6 333.9 11603.2 11954.6 15213.2 16107.8 16836.7 15742.8 15892.4 15910.5 15922.4 16037.8 3912.0 5026.4 5026.7 5030.1 5040.6 4978.5 5011.6 5021.9 5026.9 5028.7 4893.6 4979.3 5081.3 5086.6 5087.9 4953.9 4973.3 5073.2 5076.7 5223.0 5055.0 5056.0 5064.8 5065.2 5066.3 11574.1 11583.2 11603.2 13226.3 18326.9 1730.1 1772.7 1783.3 1807.3 1823.4 8765.7 8913.3 9033.3 11372.6 11793.6 1576.8 1620.9 1657.7 1690.1 1729.4 50123.5 50652.7 51047.5 51265.0 56435.7 8751.3 9123.3 9216.4 9518.5 9662.7 11330.9 11527.3 11839.2 11843.2 11854.7 6640.5 6858.0 6874.0 6891.7 6914.5 6559.9 6607.7 6619.6 6630.2 6676.7 3876.4 3878.6 3902.5 4018.0 4024.7 1684.9 1709.2 1729.3 1730.6 1741.5 363.7 367.6 370.7 377.9 934.3 9553.0 9832.5 15297.3 15895.8 16788.9 803.9 809.3 851.5 859.4 957.1 8068.0 8389.8 8559.9 8662.1 8690.1 501174.0 512942.0 527474.0 528069.0 534880.0 68469.3 70063.0 70608.3 70683.6 70748.0 1094.4 1099.9 1155.3 1172.9 1179.5 13979.9 14024.9 14103.8 14139.6 14206.2 23746.9 28638.9 29104.7 29919.7 30239.4 34474.5 34643.0 35650.8 36055.0 36266.8 8558.3 8668.5 8796.0 8937.5 8943.3 15549.3 15670.0 15712.7 15727.3 16485.0 13594.3 13690.2 13892.4 13900.2 13930.4 12904.7 13136.9 13325.5 13410.1 13917.7 13192.7 13568.4 13578.7 13733.2 14385.3 7186.6 7737.9 8711.1 8727.9 8752.9 8963.9 9079.1 10094.7 12857.0 12884.4 12:34:13 INFO - 2015-12-04 12:34:13,067 DEBUG : BROWSER_OUTPUT: 12:34:13 INFO - 2015-12-04 12:34:13,067 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5121.71 Median:6218.20 stddev:2673.43 (43.0%) stddev-sans-first:2666.61 12:34:13 INFO - 2015-12-04 12:34:13,067 DEBUG : BROWSER_OUTPUT: Values: 1439.9 1679.4 1724.7 1748.0 1752.6 5859.4 7097.8 7480.2 7484.5 7510.5 7266.9 7392.2 7437.7 7451.6 7457.4 2051.9 2089.4 2095.2 2098.3 2098.9 2122.1 2130.2 2143.7 2146.7 2147.2 2085.6 2089.8 2102.8 2119.8 2120.7 2088.4 2112.7 2115.6 2117.3 2119.4 2052.2 2074.1 2094.1 2094.2 2094.5 7298.8 7376.5 7377.3 7387.3 7396.2 4299.3 4347.4 4383.2 4397.1 4404.2 2632.6 2641.2 2642.1 2646.0 2664.5 846.7 856.8 864.9 879.3 900.3 9919.0 9924.6 9925.1 9944.4 9946.8 3868.8 3880.1 3938.3 4001.7 4009.0 8660.6 8679.8 8685.7 8687.5 8706.7 4290.2 4308.2 4309.9 4314.0 4323.6 3095.8 3155.4 3759.1 3908.7 3910.1 3536.5 3562.3 3572.4 3587.9 3604.7 1115.2 1132.9 1135.5 1135.9 1144.4 906.1 921.0 1160.1 1169.4 1177.0 6942.6 7008.6 7012.0 7028.1 7030.9 1070.2 1073.8 1084.4 1093.6 1105.0 5449.9 5492.8 5530.2 5535.3 5544.0 8695.0 8704.7 8712.7 8793.7 8884.6 8731.7 8749.8 8760.6 8767.1 8767.8 6862.5 6889.6 6934.4 6971.2 7009.8 6921.3 6968.3 6976.4 6982.4 6986.4 7726.8 7877.6 8004.8 8011.6 8016.8 7944.4 8276.5 8293.6 8325.2 8339.5 6265.3 6314.6 6556.5 6701.9 6707.3 7060.6 7136.1 7149.5 7154.0 7159.1 6438.3 6574.6 6617.3 6657.7 6686.4 6485.8 6535.0 6609.0 6699.1 6711.5 6175.9 6216.8 6219.7 6220.8 6226.5 5738.9 5975.2 5997.1 6015.8 6019.8 6042.2 6042.6 6061.2 6098.1 6106.8 12:34:13 INFO - 2015-12-04 12:34:13,067 DEBUG : BROWSER_OUTPUT: 12:34:13 INFO - 2015-12-04 12:34:13,067 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4666.56 Median:5375.35 stddev:1397.76 (26.0%) stddev-sans-first:1362.41 12:34:13 INFO - 2015-12-04 12:34:13,069 DEBUG : BROWSER_OUTPUT: Values: 283.2 289.6 292.9 293.5 294.2 5361.8 5415.8 5419.2 5450.4 5453.0 5338.9 5341.2 5349.8 5352.8 5357.3 4116.0 4123.5 4127.8 4130.3 4135.1 3869.7 3966.2 4007.9 4128.3 4140.9 4075.9 4076.4 4081.5 4096.4 4097.4 3828.1 3924.1 4064.1 4072.5 4085.0 3502.1 3569.9 3582.5 3583.1 3588.4 5184.5 5192.2 5192.3 5194.8 5202.0 4711.0 4716.6 4716.6 4720.9 4726.0 5474.9 5615.5 5619.5 5624.4 5628.8 3901.8 3903.9 3906.8 3908.4 3911.9 5916.0 5923.9 5925.3 5927.1 5927.4 4018.5 4020.3 4025.2 4028.3 4036.5 4097.6 4098.0 4103.1 4103.4 4103.7 4457.7 4624.3 4643.0 4643.3 4646.5 5637.7 5648.2 5650.1 5655.0 5655.0 1384.9 1398.1 1400.9 1401.6 1401.9 915.6 929.8 933.8 943.2 947.5 4967.3 4977.1 4979.0 4980.4 4986.3 5858.4 5865.2 5865.6 5866.7 5872.9 4965.1 4973.5 4975.1 4977.0 4981.5 3044.1 3093.7 3135.2 3162.3 3170.2 5480.2 5523.4 5585.4 5627.3 5636.5 6067.0 6069.8 6073.6 6075.4 6085.0 5613.4 5625.9 5627.8 5628.4 5631.2 5735.8 5910.9 5915.1 5918.2 5918.8 5763.0 5770.6 5772.8 5776.9 5788.9 5609.3 5617.6 5618.4 5624.1 5630.7 3811.9 3922.8 3955.0 3958.6 3958.7 5831.8 5841.2 5847.8 5850.2 5852.4 5615.1 5622.9 5623.2 5624.5 5627.4 5568.5 5571.1 5621.2 5623.4 5643.9 5388.9 5502.0 5502.8 5503.5 5504.0 5634.9 5642.9 5651.9 5653.7 5653.8 5481.4 5490.9 5494.7 5497.1 5497.1 12:34:13 INFO - 2015-12-04 12:34:13,069 DEBUG : BROWSER_OUTPUT: 12:34:13 INFO - 2015-12-04 12:34:13,069 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12119.09 Median:43948.56 stddev:13693.13 (31.2%) stddev-sans-first:13704.58 12:34:13 INFO - 2015-12-04 12:34:13,069 DEBUG : BROWSER_OUTPUT: Values: 676.2 687.7 695.9 727.9 793.9 10920.1 11097.9 11164.7 11197.6 11198.7 11613.6 11637.7 11658.0 11811.1 11823.5 624.0 632.5 795.5 802.0 808.5 804.6 806.0 812.8 813.3 813.4 651.7 835.4 841.7 841.8 842.7 654.4 824.2 834.7 838.2 839.6 615.8 619.2 619.8 619.9 619.9 11717.7 11863.6 11878.0 11924.9 11933.0 10156.8 10304.5 10809.3 10857.2 11202.2 9113.0 9119.6 9202.0 9303.5 9417.7 3219.0 3236.6 3270.2 3301.2 3313.9 38667.2 38746.6 39044.6 39066.2 39136.6 8953.8 9380.8 9731.7 9784.6 9809.5 15666.5 15961.0 15965.1 16022.9 16024.4 6354.3 6415.1 6488.8 6519.3 6603.3 3581.6 3607.7 3624.3 3650.6 3666.5 2846.6 2938.1 2941.8 2948.4 2951.4 505.2 505.5 512.1 513.6 519.7 460.1 463.8 469.4 473.0 520.9 7055.8 7384.2 7577.9 7694.5 7779.4 578.8 583.1 586.1 593.1 604.2 3438.4 3624.8 3640.2 3671.4 3702.5 49246.0 49727.3 49892.3 50036.2 50146.5 42946.0 43767.6 44129.6 44219.3 44231.3 38365.4 39391.4 39469.6 39579.4 39842.8 7042.9 7215.9 7964.8 8012.6 8071.3 30134.4 30266.7 30878.8 31131.0 32893.5 40265.6 40563.0 40800.8 41847.6 41952.0 9563.0 10092.6 10197.3 10392.4 10456.4 10820.5 10900.9 10912.3 10980.8 11029.4 10900.0 11086.5 11272.9 11325.2 11634.4 10057.6 10106.9 10110.2 10348.5 10421.7 10147.1 10366.7 10435.2 10622.9 10665.8 8912.6 9076.5 9335.6 9723.1 9725.2 8454.1 8665.9 8709.7 8748.1 8989.0 12:34:13 INFO - 2015-12-04 12:34:13,069 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:34:13 INFO - 2015-12-04 12:34:13,069 DEBUG : BROWSER_OUTPUT: 12:34:13 INFO - 2015-12-04 12:34:13,885 INFO : Browser exited with error code: 0 12:34:13 INFO - 2015-12-04 12:34:13,906 INFO : Completed test dromaeo_css (00:18:38) 12:34:13 INFO - 2015-12-04 12:34:13,906 INFO : Starting test kraken 12:34:13 INFO - 2015-12-04 12:34:13,906 DEBUG : operating with platform_type : linux_ 12:34:13 INFO - 2015-12-04 12:34:13,906 INFO : Initialising browser for kraken test... 12:34:13 INFO - 2015-12-04 12:34:13,912 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8KAZEV/profile http://localhost:59185/getInfo.html 12:34:18 INFO - 2015-12-04 12:34:18,280 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:34:18 INFO - 2015-12-04 12:34:18,280 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:34:18 INFO - 2015-12-04 12:34:18,281 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:34:18 INFO - 2015-12-04 12:34:18,281 DEBUG : BROWSER_OUTPUT: __metrics 12:34:18 INFO - 2015-12-04 12:34:18,397 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] 12:34:18 INFO - 2015-12-04 12:34:18,459 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] 12:34:19 INFO - 2015-12-04 12:34:19,733 INFO : Browser initialized. 12:34:19 INFO - 2015-12-04 12:34:19,734 INFO : Running cycle 1/1 for kraken test... 12:34:19 INFO - 2015-12-04 12:34:19,734 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8KAZEV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:34:31 INFO - 2015-12-04 12:34:31,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 143077376 12:34:31 INFO - 2015-12-04 12:34:31,782 DEBUG : BROWSER_OUTPUT: 12:34:34 INFO - 2015-12-04 12:34:34,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59185/tests/kraken/driver.html?testName=audio-beat-detection) 12:34:34 INFO - 2015-12-04 12:34:34,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 175714304 12:34:34 INFO - 2015-12-04 12:34:34,972 DEBUG : BROWSER_OUTPUT: 12:34:37 INFO - 2015-12-04 12:34:37,698 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59185/tests/kraken/driver.html?testName=audio-dft) 12:34:38 INFO - 2015-12-04 12:34:38,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 166490112 12:34:38 INFO - 2015-12-04 12:34:38,280 DEBUG : BROWSER_OUTPUT: 12:34:41 INFO - 2015-12-04 12:34:41,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59185/tests/kraken/driver.html?testName=audio-fft) 12:34:41 INFO - 2015-12-04 12:34:41,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 153862144 12:34:41 INFO - 2015-12-04 12:34:41,861 DEBUG : BROWSER_OUTPUT: 12:34:43 INFO - 2015-12-04 12:34:43,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59185/tests/kraken/driver.html?testName=audio-oscillator) 12:34:44 INFO - 2015-12-04 12:34:44,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 155299840 12:34:44 INFO - 2015-12-04 12:34:44,512 DEBUG : BROWSER_OUTPUT: 12:34:46 INFO - 2015-12-04 12:34:46,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59185/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:34:47 INFO - 2015-12-04 12:34:47,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 158232576 12:34:47 INFO - 2015-12-04 12:34:47,335 DEBUG : BROWSER_OUTPUT: 12:34:50 INFO - 2015-12-04 12:34:50,339 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59185/tests/kraken/driver.html?testName=imaging-darkroom) 12:34:50 INFO - 2015-12-04 12:34:50,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 158339072 12:34:50 INFO - 2015-12-04 12:34:50,921 DEBUG : BROWSER_OUTPUT: 12:34:54 INFO - 2015-12-04 12:34:54,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59185/tests/kraken/driver.html?testName=imaging-desaturate) 12:34:54 INFO - 2015-12-04 12:34:54,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 158728192 12:34:54 INFO - 2015-12-04 12:34:54,926 DEBUG : BROWSER_OUTPUT: 12:34:57 INFO - 2015-12-04 12:34:57,771 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59185/tests/kraken/driver.html?testName=json-parse-financial) 12:34:58 INFO - 2015-12-04 12:34:58,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 158068736 12:34:58 INFO - 2015-12-04 12:34:58,353 DEBUG : BROWSER_OUTPUT: 12:35:00 INFO - 2015-12-04 12:35:00,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59185/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:35:00 INFO - 2015-12-04 12:35:00,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 170475520 12:35:00 INFO - 2015-12-04 12:35:00,683 DEBUG : BROWSER_OUTPUT: 12:35:02 INFO - 2015-12-04 12:35:02,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59185/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:35:03 INFO - 2015-12-04 12:35:03,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 168837120 12:35:03 INFO - 2015-12-04 12:35:03,175 DEBUG : BROWSER_OUTPUT: 12:35:05 INFO - 2015-12-04 12:35:05,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59185/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:35:05 INFO - 2015-12-04 12:35:05,860 DEBUG : BROWSER_OUTPUT: RSS: Main: 179179520 12:35:05 INFO - 2015-12-04 12:35:05,861 DEBUG : BROWSER_OUTPUT: 12:35:08 INFO - 2015-12-04 12:35:08,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:35:08 INFO - 2015-12-04 12:35:08,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 184528896 12:35:08 INFO - 2015-12-04 12:35:08,987 DEBUG : BROWSER_OUTPUT: 12:35:11 INFO - 2015-12-04 12:35:11,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:35:12 INFO - 2015-12-04 12:35:12,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 182128640 12:35:12 INFO - 2015-12-04 12:35:12,132 DEBUG : BROWSER_OUTPUT: 12:35:13 INFO - 2015-12-04 12:35:13,895 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59185/tests/kraken/driver.html?testName=ai-astar) 12:35:14 INFO - 2015-12-04 12:35:14,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 239083520 12:35:14 INFO - 2015-12-04 12:35:14,153 DEBUG : BROWSER_OUTPUT: 12:35:14 INFO - 2015-12-04 12:35:14,153 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:35:14 INFO - 2015-12-04 12:35:14,153 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:35:14 INFO - 2015-12-04 12:35:14,154 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:35:14 INFO - 2015-12-04 12:35:14,154 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:35:14 INFO - 2015-12-04 12:35:14,154 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;105;112;111;113;101;110;111;102 12:35:14 INFO - 2015-12-04 12:35:14,154 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;135;155;166;129;163;159;130;167;129 12:35:14 INFO - 2015-12-04 12:35:14,154 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;160;160;163;161;162;161;161;162 12:35:14 INFO - 2015-12-04 12:35:14,154 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;86;97;72;72;73;102;89;74 12:35:14 INFO - 2015-12-04 12:35:14,154 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;133;94;95;94;135;96;95;133 12:35:14 INFO - 2015-12-04 12:35:14,154 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;110;109;109;110;110 12:35:14 INFO - 2015-12-04 12:35:14,154 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;146;147;147;147;147;146;147 12:35:14 INFO - 2015-12-04 12:35:14,154 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;96;96;96 12:35:14 INFO - 2015-12-04 12:35:14,154 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;71;70;70;71;69;70;70;68 12:35:14 INFO - 2015-12-04 12:35:14,154 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;68;70;69;69;69;69 12:35:14 INFO - 2015-12-04 12:35:14,154 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;85;83;91;83;82;83;83;83 12:35:14 INFO - 2015-12-04 12:35:14,155 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;139;120;126;119;120;119;131;125;128;133 12:35:14 INFO - 2015-12-04 12:35:14,155 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;133;143;143;143;145;133;136;150;142;135 12:35:14 INFO - 2015-12-04 12:35:14,155 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;71;67;67;67;67;68;67;67;67 12:35:14 INFO - 2015-12-04 12:35:14,155 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:35:14 INFO - 2015-12-04 12:35:14,155 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:35:14 INFO - 2015-12-04 12:35:14,155 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,995 12:35:14 INFO - 2015-12-04 12:35:14,155 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:35:14 INFO - 2015-12-04 12:35:14,155 DEBUG : BROWSER_OUTPUT: __startTimestamp1449261314148__endTimestamp 12:35:14 INFO - 2015-12-04 12:35:14,155 DEBUG : BROWSER_OUTPUT: 12:35:14 INFO - 2015-12-04 12:35:14,155 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:35:14 INFO - 2015-12-04 12:35:14,155 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:35:14 INFO - 2015-12-04 12:35:14,156 DEBUG : BROWSER_OUTPUT: 12:35:14 INFO - 2015-12-04 12:35:14,156 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.70 Median:111.00 stddev:4.37 (3.9%) stddev-sans-first:4.61 12:35:14 INFO - 2015-12-04 12:35:14,156 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 105.0 112.0 111.0 113.0 101.0 110.0 111.0 102.0 12:35:14 INFO - 2015-12-04 12:35:14,156 DEBUG : BROWSER_OUTPUT: 12:35:14 INFO - 2015-12-04 12:35:14,156 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.90 Median:157.50 stddev:16.16 (10.3%) stddev-sans-first:16.94 12:35:14 INFO - 2015-12-04 12:35:14,156 DEBUG : BROWSER_OUTPUT: Values: 156.0 135.0 155.0 166.0 129.0 163.0 159.0 130.0 167.0 129.0 12:35:14 INFO - 2015-12-04 12:35:14,156 DEBUG : BROWSER_OUTPUT: 12:35:14 INFO - 2015-12-04 12:35:14,156 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 12:35:14 INFO - 2015-12-04 12:35:14,156 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 160.0 160.0 163.0 161.0 162.0 161.0 161.0 162.0 12:35:14 INFO - 2015-12-04 12:35:14,156 DEBUG : BROWSER_OUTPUT: 12:35:14 INFO - 2015-12-04 12:35:14,156 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.10 Median:73.50 stddev:11.49 (15.6%) stddev-sans-first:11.81 12:35:14 INFO - 2015-12-04 12:35:14,157 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 86.0 97.0 72.0 72.0 73.0 102.0 89.0 74.0 12:35:14 INFO - 2015-12-04 12:35:14,157 DEBUG : BROWSER_OUTPUT: 12:35:14 INFO - 2015-12-04 12:35:14,157 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.30 Median:94.00 stddev:18.90 (20.1%) stddev-sans-first:19.52 12:35:14 INFO - 2015-12-04 12:35:14,157 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 133.0 94.0 95.0 94.0 135.0 96.0 95.0 133.0 12:35:14 INFO - 2015-12-04 12:35:14,157 DEBUG : BROWSER_OUTPUT: 12:35:14 INFO - 2015-12-04 12:35:14,158 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 12:35:14 INFO - 2015-12-04 12:35:14,158 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 110.0 110.0 12:35:14 INFO - 2015-12-04 12:35:14,158 DEBUG : BROWSER_OUTPUT: 12:35:14 INFO - 2015-12-04 12:35:14,158 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 12:35:14 INFO - 2015-12-04 12:35:14,158 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 12:35:14 INFO - 2015-12-04 12:35:14,158 DEBUG : BROWSER_OUTPUT: 12:35:14 INFO - 2015-12-04 12:35:14,158 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 12:35:14 INFO - 2015-12-04 12:35:14,158 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 12:35:14 INFO - 2015-12-04 12:35:14,159 DEBUG : BROWSER_OUTPUT: 12:35:14 INFO - 2015-12-04 12:35:14,159 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.10 Median:70.50 stddev:0.99 (1.4%) stddev-sans-first:1.00 12:35:14 INFO - 2015-12-04 12:35:14,159 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 70.0 70.0 71.0 69.0 70.0 70.0 68.0 12:35:14 INFO - 2015-12-04 12:35:14,159 DEBUG : BROWSER_OUTPUT: 12:35:14 INFO - 2015-12-04 12:35:14,159 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 12:35:14 INFO - 2015-12-04 12:35:14,159 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 70.0 69.0 69.0 69.0 69.0 12:35:14 INFO - 2015-12-04 12:35:14,159 DEBUG : BROWSER_OUTPUT: 12:35:14 INFO - 2015-12-04 12:35:14,159 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:2.80 (3.4%) stddev-sans-first:2.80 12:35:14 INFO - 2015-12-04 12:35:14,159 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 85.0 83.0 91.0 83.0 82.0 83.0 83.0 83.0 12:35:14 INFO - 2015-12-04 12:35:14,159 DEBUG : BROWSER_OUTPUT: 12:35:14 INFO - 2015-12-04 12:35:14,159 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:127.00 stddev:6.82 (5.4%) stddev-sans-first:5.36 12:35:14 INFO - 2015-12-04 12:35:14,159 DEBUG : BROWSER_OUTPUT: Values: 139.0 120.0 126.0 119.0 120.0 119.0 131.0 125.0 128.0 133.0 12:35:14 INFO - 2015-12-04 12:35:14,159 DEBUG : BROWSER_OUTPUT: 12:35:14 INFO - 2015-12-04 12:35:14,159 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.30 Median:143.00 stddev:5.72 (4.0%) stddev-sans-first:5.42 12:35:14 INFO - 2015-12-04 12:35:14,159 DEBUG : BROWSER_OUTPUT: Values: 133.0 143.0 143.0 143.0 145.0 133.0 136.0 150.0 142.0 135.0 12:35:14 INFO - 2015-12-04 12:35:14,159 DEBUG : BROWSER_OUTPUT: 12:35:14 INFO - 2015-12-04 12:35:14,160 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.00 stddev:1.66 (2.5%) stddev-sans-first:1.33 12:35:14 INFO - 2015-12-04 12:35:14,160 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 67.0 67.0 67.0 67.0 68.0 67.0 67.0 67.0 12:35:14 INFO - 2015-12-04 12:35:14,160 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:35:14 INFO - 2015-12-04 12:35:14,160 DEBUG : BROWSER_OUTPUT: 12:35:15 INFO - 2015-12-04 12:35:15,077 INFO : Browser exited with error code: 0 12:35:15 INFO - 2015-12-04 12:35:15,128 INFO : Completed test kraken (00:01:01) 12:35:15 INFO - 2015-12-04 12:35:15,128 INFO : Starting test v8_7 12:35:15 INFO - 2015-12-04 12:35:15,129 DEBUG : operating with platform_type : linux_ 12:35:15 INFO - 2015-12-04 12:35:15,129 INFO : Initialising browser for v8_7 test... 12:35:15 INFO - 2015-12-04 12:35:15,135 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBAUrPq/profile http://localhost:59185/getInfo.html 12:35:19 INFO - 2015-12-04 12:35:19,621 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:35:19 INFO - 2015-12-04 12:35:19,621 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:35:19 INFO - 2015-12-04 12:35:19,621 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:35:19 INFO - 2015-12-04 12:35:19,621 DEBUG : BROWSER_OUTPUT: __metrics 12:35:19 INFO - 2015-12-04 12:35:19,742 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] 12:35:19 INFO - 2015-12-04 12:35:19,818 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] 12:35:21 INFO - 2015-12-04 12:35:21,106 INFO : Browser initialized. 12:35:21 INFO - 2015-12-04 12:35:21,107 INFO : Running cycle 1/1 for v8_7 test... 12:35:21 INFO - 2015-12-04 12:35:21,107 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBAUrPq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:35:33 INFO - 2015-12-04 12:35:33,047 DEBUG : BROWSER_OUTPUT: RSS: Main: 142856192 12:35:33 INFO - 2015-12-04 12:35:33,048 DEBUG : BROWSER_OUTPUT: 12:35:54 INFO - 2015-12-04 12:35:54,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59185/tests/v8_7/run.html (next: http://localhost:59185/tests/v8_7/run.html) 12:35:54 INFO - 2015-12-04 12:35:54,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 450162688 12:35:54 INFO - 2015-12-04 12:35:54,665 DEBUG : BROWSER_OUTPUT: 12:35:54 INFO - 2015-12-04 12:35:54,666 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:35:54 INFO - 2015-12-04 12:35:54,667 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:35:54 INFO - 2015-12-04 12:35:54,667 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:35:54 INFO - 2015-12-04 12:35:54,667 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:35:54 INFO - 2015-12-04 12:35:54,667 DEBUG : BROWSER_OUTPUT: |0;Richards;165.97510373443984 12:35:54 INFO - 2015-12-04 12:35:54,667 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.5287569573284 12:35:54 INFO - 2015-12-04 12:35:54,667 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.9400278940028 12:35:54 INFO - 2015-12-04 12:35:54,667 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 12:35:54 INFO - 2015-12-04 12:35:54,667 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1976.2845849802372 12:35:54 INFO - 2015-12-04 12:35:54,668 DEBUG : BROWSER_OUTPUT: |5;Earley;783.0853563038371 12:35:54 INFO - 2015-12-04 12:35:54,668 DEBUG : BROWSER_OUTPUT: |6;Boyer;12231.707317073171 12:35:54 INFO - 2015-12-04 12:35:54,668 DEBUG : BROWSER_OUTPUT: |7;RegExp;26342.105263157893 12:35:54 INFO - 2015-12-04 12:35:54,668 DEBUG : BROWSER_OUTPUT: |8;Splay;609.7560975609756 12:35:54 INFO - 2015-12-04 12:35:54,668 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 12:35:54 INFO - 2015-12-04 12:35:54,668 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:35:54 INFO - 2015-12-04 12:35:54,669 DEBUG : BROWSER_OUTPUT: __startTimestamp1449261354665__endTimestamp 12:35:54 INFO - 2015-12-04 12:35:54,669 DEBUG : BROWSER_OUTPUT: 12:35:54 INFO - 2015-12-04 12:35:54,669 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:35:54 INFO - 2015-12-04 12:35:54,669 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:35:54 INFO - 2015-12-04 12:35:54,669 DEBUG : BROWSER_OUTPUT: 12:35:54 INFO - 2015-12-04 12:35:54,670 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.98 Median:165.98 stddev:0.00 (0.0%) 12:35:54 INFO - 2015-12-04 12:35:54,671 DEBUG : BROWSER_OUTPUT: Values: 166.0 12:35:54 INFO - 2015-12-04 12:35:54,671 DEBUG : BROWSER_OUTPUT: 12:35:54 INFO - 2015-12-04 12:35:54,671 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.53 Median:185.53 stddev:0.00 (0.0%) 12:35:54 INFO - 2015-12-04 12:35:54,671 DEBUG : BROWSER_OUTPUT: Values: 185.5 12:35:54 INFO - 2015-12-04 12:35:54,671 DEBUG : BROWSER_OUTPUT: 12:35:54 INFO - 2015-12-04 12:35:54,672 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 12:35:54 INFO - 2015-12-04 12:35:54,672 DEBUG : BROWSER_OUTPUT: Values: 278.9 12:35:54 INFO - 2015-12-04 12:35:54,672 DEBUG : BROWSER_OUTPUT: 12:35:54 INFO - 2015-12-04 12:35:54,672 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 12:35:54 INFO - 2015-12-04 12:35:54,672 DEBUG : BROWSER_OUTPUT: Values: 5128.2 12:35:54 INFO - 2015-12-04 12:35:54,672 DEBUG : BROWSER_OUTPUT: 12:35:54 INFO - 2015-12-04 12:35:54,672 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1976.28 Median:1976.28 stddev:0.00 (0.0%) 12:35:54 INFO - 2015-12-04 12:35:54,673 DEBUG : BROWSER_OUTPUT: Values: 1976.3 12:35:54 INFO - 2015-12-04 12:35:54,673 DEBUG : BROWSER_OUTPUT: 12:35:54 INFO - 2015-12-04 12:35:54,673 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.09 Median:783.09 stddev:0.00 (0.0%) 12:35:54 INFO - 2015-12-04 12:35:54,673 DEBUG : BROWSER_OUTPUT: Values: 783.1 12:35:54 INFO - 2015-12-04 12:35:54,673 DEBUG : BROWSER_OUTPUT: 12:35:54 INFO - 2015-12-04 12:35:54,673 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 12:35:54 INFO - 2015-12-04 12:35:54,673 DEBUG : BROWSER_OUTPUT: Values: 12231.7 12:35:54 INFO - 2015-12-04 12:35:54,674 DEBUG : BROWSER_OUTPUT: 12:35:54 INFO - 2015-12-04 12:35:54,674 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26342.11 Median:26342.11 stddev:0.00 (0.0%) 12:35:54 INFO - 2015-12-04 12:35:54,674 DEBUG : BROWSER_OUTPUT: Values: 26342.1 12:35:54 INFO - 2015-12-04 12:35:54,674 DEBUG : BROWSER_OUTPUT: 12:35:54 INFO - 2015-12-04 12:35:54,674 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:609.76 Median:609.76 stddev:0.00 (0.0%) 12:35:54 INFO - 2015-12-04 12:35:54,674 DEBUG : BROWSER_OUTPUT: Values: 609.8 12:35:54 INFO - 2015-12-04 12:35:54,674 DEBUG : BROWSER_OUTPUT: 12:35:54 INFO - 2015-12-04 12:35:54,674 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 12:35:54 INFO - 2015-12-04 12:35:54,675 DEBUG : BROWSER_OUTPUT: Values: 4840.6 12:35:54 INFO - 2015-12-04 12:35:54,675 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:35:54 INFO - 2015-12-04 12:35:54,675 DEBUG : BROWSER_OUTPUT: 12:35:55 INFO - 2015-12-04 12:35:55,625 INFO : Browser exited with error code: 0 12:35:55 INFO - 2015-12-04 12:35:55,642 INFO : Completed test v8_7 (00:00:40) 12:35:55 INFO - 2015-12-04 12:35:55,722 INFO : Completed test suite (00:20:20) 12:35:55 INFO - 2015-12-04 12:35:55,722 DEBUG : Working with test: dromaeo_css 12:35:55 INFO - 2015-12-04 12:35:55,722 DEBUG : Generating results file: dromaeo_css 12:35:55 INFO - 2015-12-04 12:35:55,723 DEBUG : Working with test: kraken 12:35:55 INFO - 2015-12-04 12:35:55,723 DEBUG : Generating results file: kraken 12:35:55 INFO - 2015-12-04 12:35:55,723 INFO : javascript benchmark 12:35:55 INFO - 2015-12-04 12:35:55,723 DEBUG : Working with test: v8_7 12:35:55 INFO - 2015-12-04 12:35:55,724 DEBUG : Generating results file: v8_7 12:35:55 INFO - 2015-12-04 12:35:55,724 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:35:55 INFO - 2015-12-04 12:35:55,783 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:35:55 INFO - 2015-12-04 12:35:55,783 DEBUG : process_Request line: dromaeo_css 6301.41 graph.html#tests=[[72,132,35]] 12:35:55 INFO - 2015-12-04 12:35:55,783 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:35:55 INFO - 2015-12-04 12:35:55,817 DEBUG : process_Request line: kraken 1514.20 graph.html#tests=[[232,132,35]] 12:35:55 INFO - 2015-12-04 12:35:55,817 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:35:55 INFO - 2015-12-04 12:35:55,857 DEBUG : process_Request line: v8_7 19871.56 graph.html#tests=[[230,132,35]] 12:35:55 INFO - 2015-12-04 12:35:55,859 INFO : javascript benchmark 12:35:55 INFO - 2015-12-04 12:35:55,862 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2629.618705287733, 2728.467948749992, 2732.289604702778, 2752.710965348638, 2763.8894444222224, 4577.404937358147, 4701.952980470194, 4798.304245884345, 4837.226043832992, 4863.537963893429, 4647.395838540993, 4723.456802467717, 4738.312944623036, 4749.168895443301, 4878.804847806093, 4343.847965321206, 4347.13057388522, 4401.987542865143, 4470.329450582406, 4482.5069242383315, 4405.80173892174, 4467.664925130595, 4470.441194850644, 4475.70907890986, 4516.074204788027, 4258.446401967724, 4292.935605965913, 4385.386045953569, 4391.6486681065435, 4398.34024896265, 4398.64810815134, 4427.822887084512, 4440.422745043156, 4440.933385999213, 4451.643868490513, 4347.956520434786, 4373.868783936487, 4386.868393948187, 4392.1874453226255, 4442.444694413199, 4489.528599497071, 4600.033992861503, 4610.884727881797, 4754.857354279377, 4772.475027746945, 5005.174146265862, 5107.923381149286, 5114.181730923035, 5123.436421993578, 5163.277141200235, 5147.819826306061, 5160.148575485078, 5168.638195326329, 5170.069387510247, 5209.635325527214, 4594.977025114853, 4717.174494463524, 4741.407324084489, 4776.426828780499, 4779.999999999965, 5114.948850511447, 5196.58427325813, 5242.16125419931, 5253.816116435906, 5254.474552544715, 5012.649114562018, 5063.063333283354, 5064.544191022752, 5074.08666440037, 5117.462666420047, 4871.488493708181, 4973.776180071905, 4988.326575912278, 5136.2295655651205, 5149.304843846033, 4939.876503087452, 4962.851114466572, 5030.673006254582, 5035.194368900959, 5064.772085256099, 5043.36957880265, 5064.468230835783, 5080.69515829044, 5083.0, 5127.461616530285, 4061.431399604058, 4247.341662042389, 4253.63844073251, 4266.52882292712, 4271.359296105609, 3619.8009109498703, 3666.431703086026, 3701.5002974598624, 3718.9070273242846, 3730.160713839419, 4426.136903303889, 4433.024734558392, 4447.110577884436, 4447.977760111179, 4475.932861007088, 4863.975680121647, 5173.741312934339, 5179.8446046618665, 5181.715005674649, 5185.844424667266, 4268.9786551067045, 4358.891027724332, 4390.604845563915, 4394.428724265825, 4395.428594282786, 4492.618127459137, 4504.054148628759, 4510.932336014962, 4553.33976573395, 4560.749158796231, 4838.830640927551, 4853.80584776605, 4857.805687772591, 4863.562279394871, 4906.55840974314, 4867.488913664014, 4980.576650984707, 4994.425641051325, 5088.262201980766, 5103.387593488805, 4765.428148622187, 4786.95213047865, 4812.975935120302, 4821.855344339676, 4828.903421931612, 4892.363992681071, 4951.801927922987, 4965.0, 4984.127777638972, 5016.247562865454, 5116.9232461512365, 5159.329287192641, 5162.199859021857, 5166.535011848951, 5200.115980283285, 4697.0, 4952.207646776498, 4998.775055122601, 4999.925001124913, 5002.949970500394, 4861.513848615252, 4896.2410826321975, 4906.656534042726, 5021.07110184617, 5057.949420505748, 4806.49531799156, 4830.178869592108, 4833.903321933612, 4837.032593481247, 4866.416030076413, 4932.753362331798, 4945.1346014448045, 4949.430815456125, 4953.554180123806, 4990.80036798524, 4698.812047518061, 4775.6657034007285, 4782.856514304576, 4828.130936431476, 4833.299171620166], "unit": "ms", "name": "dojo.html", "value": 4663.583932102002}, {"lowerIsBetter": false, "replicates": [559.1110134885531, 564.5483613109511, 573.2576313673793, 578.0462237308443, 590.6780804461569, 27744.0, 28305.716942830564, 37098.81450592747, 37657.811710941474, 37695.81152094243, 39554.80222598883, 40235.39646905292, 40333.59666403342, 40339.19321613566, 40390.39414408779, 6993.05593744843, 7848.293653571178, 8032.357411407073, 8033.236842499953, 8039.799005024863, 7043.929560704404, 7143.3570978611915, 7150.034745309369, 7153.964230178842, 7154.284571542856, 7069.187043490013, 7154.8569028619395, 10216.795664086714, 10539.314944528582, 10569.6300629478, 10081.697549073502, 10189.439580823051, 10201.285909986304, 10201.43892085935, 10203.183745300395, 9979.501024948724, 10113.836908755513, 10120.595176192943, 10125.038121378457, 10126.341787783771, 37288.254234915425, 37518.81240593807, 37560.24879502422, 37573.43639845377, 37740.81129594362, 2531.444905157509, 2613.6732908386452, 2694.663167104112, 3037.4532584134845, 3039.8936037238814, 27321.180364589094, 27341.86329068342, 27560.17319480399, 27776.30559236015, 28085.85957070222, 3359.8656053757823, 3501.704829442807, 3507.7895326280504, 3558.982205088958, 3633.128049268183, 221087.0, 221120.0, 221373.0, 223064.0, 223583.0, 56565.0, 56740.71629641826, 56868.0, 57321.71339143278, 57338.13992790112, 55382.44617553773, 56461.71769141128, 59370.70314648399, 59953.70023149944, 61229.69385153046, 13181.538646147339, 13395.665108372368, 13410.12834165776, 13410.798838017437, 13472.865271347357, 9824.607015719434, 10509.0, 10708.571657133783, 10713.35719856811, 10721.624743133953, 16209.0, 18510.537236568925, 20102.59794804125, 20245.49386265355, 20280.79719202789, 7714.112877019103, 7797.635413802562, 7822.1004584472375, 7849.843003139905, 7894.605269736605, 887.8890138732659, 898.501331760879, 900.1763386501409, 907.7639813648499, 1038.7610849504506, 26667.733322666525, 26760.464790704078, 27025.1892443227, 27040.864795675894, 27112.0, 955.3360414511848, 1022.4887556221889, 1035.0270745499206, 1051.0645525482173, 1083.095615161349, 13624.727505449835, 13728.176309421468, 14039.087459315111, 14069.2965351732, 14086.15483071019, 275326.0, 279388.0, 279944.0, 280386.0, 280762.0, 45494.31758523625, 45844.7707761459, 45938.081238375045, 46019.76990115028, 46152.538474615496, 1194.5162209305245, 1196.3778835005749, 1196.9521219151484, 1219.2928101700993, 1233.9506419743288, 24992.625110623718, 25533.0, 25976.610350844374, 26108.216753497425, 26155.346116347242, 40241.59758402379, 40469.0, 40790.79604601958, 40905.38641920433, 40907.59092409038, 247817.0, 248703.0, 249493.0, 249601.0, 250188.0, 29669.109926702233, 29884.0, 30157.396852062397, 30336.0, 30421.391572168875, 39072.023199419105, 39125.81711567461, 39689.0, 39691.40462893001, 39810.66342775087, 33067.35461163053, 33501.83249083739, 33586.0, 33775.155621108686, 33904.49143262902, 32713.509297360084, 33741.83129084339, 33962.320753584296, 34091.0, 34239.315213696085, 33180.66819331776, 33647.66352336543, 34014.48978265378, 34072.0, 34085.147871303416, 29016.56475152832, 29032.854835725688, 30233.69766302397, 30671.16572991637, 30842.53736193914, 23777.405564861016, 23791.881040595377, 23931.162409316286, 24193.39516512101, 24196.75803241945], "unit": "ms", "name": "ext.html", "value": 17196.992203718364}, {"lowerIsBetter": false, "replicates": [308.08805934434076, 327.75745947998473, 331.600421492102, 331.63851401971846, 333.8765055587946, 11603.245789023718, 11954.64136075918, 15213.239338033109, 16107.758383624256, 16836.66326673469, 15742.842571574281, 15892.443764468246, 15910.52268431946, 15922.442714504994, 16037.83962160378, 3911.9804400977955, 5026.396832380119, 5026.698398096108, 5030.0694371541385, 5040.571551418134, 4978.477259887714, 5011.649184557083, 5021.949780502203, 5026.949730502684, 5028.723420211887, 4893.6329775266995, 4979.253112033188, 5081.339425874631, 5086.618503612225, 5087.923681144785, 4953.90092198154, 4973.278874563168, 5073.213651883964, 5076.6700164489375, 5223.033738758342, 5055.014272216919, 5055.974720126376, 5064.848054558369, 5065.240213967897, 5066.341375621146, 11574.131940104442, 11583.18917675763, 11603.245789023686, 13226.338683065904, 18326.90836545822, 1730.126286225448, 1772.7252275897256, 1783.2688597674892, 1807.3493542324752, 1823.3982785680826, 8765.693200737944, 8913.28693704502, 9033.277337813024, 11372.60195893148, 11793.587224447188, 1576.7634854771761, 1620.8703303735672, 1657.65189310245, 1690.1126908373203, 1729.3947118508547, 50123.49876501225, 50652.746736266454, 51047.48952510465, 51265.0, 56435.71782141104, 8751.343649226334, 9123.270138388913, 9216.447013179097, 9518.476483793458, 9662.661806836726, 11330.886691133148, 11527.250728702607, 11839.171258011856, 11843.170978031627, 11854.703632409259, 6640.468762498988, 6858.0, 6874.037634731141, 6891.655417229119, 6914.481413893978, 6559.901601475982, 6607.702653380513, 6619.602823830585, 6630.237522684856, 6676.732930682719, 3876.4185372194397, 3878.6315300047013, 3902.5316961964745, 4017.959820401817, 4024.71209213049, 1684.9157542122846, 1709.1539687854593, 1729.325563030419, 1730.6106126121774, 1741.4601473543241, 363.7453782352311, 367.61767761528245, 370.65158750774185, 377.86963497593285, 934.3366209990846, 9553.0, 9832.508374581243, 15297.311620977083, 15895.761563576556, 16788.916055419646, 803.9075506316849, 809.2999555384667, 851.5146366570995, 859.4198915731981, 957.129012598546, 8068.0, 8389.832203355898, 8559.871601925975, 8662.090480499583, 8690.08754080825, 501174.0, 512942.0, 527474.0, 528069.0, 534880.0, 68469.31530684729, 70063.0, 70608.2939170612, 70683.6465817678, 70748.0, 1094.43089593411, 1099.8680158381046, 1155.3010428690689, 1172.9061675065975, 1179.5340840368178, 13979.930100349433, 14024.929875350557, 14103.788443173566, 14139.64650883736, 14206.218657973497, 23746.88126559356, 28638.856805715837, 29104.7089529102, 29919.70080299169, 30239.395212096075, 34474.48288275728, 34643.0, 35650.8217458911, 36055.0, 36266.8186659065, 8558.272546833588, 8668.52323122209, 8795.956020219857, 8937.508437036025, 8943.329250306122, 15549.300281487587, 15670.0, 15712.685746285239, 15727.292271848024, 16485.0, 13594.252316122709, 13690.247036413093, 13892.374843132286, 13900.235487048309, 13930.442782288595, 12904.741905162033, 13136.868631313946, 13325.466981320638, 13410.128341658152, 13917.652058698613, 13192.670183245496, 13568.389422475815, 13578.660533486742, 13733.244671543162, 14385.280735962951, 7186.6047367395295, 7737.883931740916, 8711.128887111237, 8727.912720872964, 8752.868706969528, 8963.865542016745, 9079.137481939206, 10094.697159085239, 12857.0, 12884.355782210665], "unit": "ms", "name": "jquery.html", "value": 7807.215167962389}, {"lowerIsBetter": false, "replicates": [1439.9064060836038, 1679.353448922165, 1724.732666436702, 1747.9912600436996, 1752.6319472910695, 5859.355470898203, 7097.78706638801, 7480.177180510146, 7484.476086673935, 7510.474266801326, 7266.927330726704, 7392.186859445456, 7437.739679111232, 7451.62741862906, 7457.440691948099, 2051.887146206958, 2089.362744362969, 2095.224766836265, 2098.2865825619288, 2098.9265375711852, 2122.0556852200775, 2130.20117455954, 2143.742750869898, 2146.7209262795814, 2147.237730605636, 2085.645440275149, 2089.8014688604635, 2102.7581828089737, 2119.79861913118, 2120.7031015657744, 2088.3734879536155, 2112.704221408989, 2115.598036373084, 2117.3224568138203, 2119.364190742771, 2052.220156340596, 2074.1288658763356, 2094.1414020251623, 2094.2460714142894, 2094.549671820566, 7298.781036568911, 7376.520526165836, 7377.336039756394, 7387.298206670358, 7396.186419493852, 4299.290617048183, 4347.3696314034605, 4383.232934236496, 4397.098594788093, 4404.163208990313, 2632.6445929799424, 2641.168032069892, 2642.0620679658828, 2646.0209722402833, 2664.480426316869, 846.6697987784769, 856.7558245899888, 864.8832407624953, 879.331707901999, 900.2617853360247, 9918.950405247928, 9924.603015879356, 9925.1067403934, 9944.403335799803, 9946.801063978752, 3868.845246190177, 3880.1463677990796, 3938.2911076006594, 4001.7398869073418, 4009.0, 8660.566971651393, 8679.826403472021, 8685.6525738971, 8687.52218627969, 8706.6517339307, 4290.206311832321, 4308.224519586504, 4309.91380172401, 4314.0, 4323.610875021201, 3095.8297293649066, 3155.4004739099496, 3759.0790256386813, 3908.726389152732, 3910.081130934228, 3536.45184996326, 3562.2697347043795, 3572.4284114541547, 3587.8564857405413, 3604.7296452766145, 1115.1747706696985, 1132.8697199822127, 1135.517405102828, 1135.8920902514249, 1144.416347662698, 906.1120102299651, 921.0145144695246, 1160.0835340081242, 1169.4386694386742, 1177.0348314382124, 6942.583444993316, 7008.614526201006, 7011.964940175369, 7028.086348774729, 7030.929690703129, 1070.1973519860105, 1073.7637719701654, 1084.3981590217504, 1093.6281664234039, 1104.9558017679365, 5449.918251226235, 5492.780288788484, 5530.170474428787, 5535.33575970878, 5543.972280138573, 8695.00007499133, 8704.695335663222, 8712.69505567302, 8793.692220772242, 8884.64461421549, 8731.65073397057, 8749.781255468664, 8760.56197190138, 8767.079456657088, 8767.780805479913, 6862.519623626398, 6889.552179108342, 6934.4452443804375, 6971.163460384685, 7009.7897063088185, 6921.2732663069655, 6968.268331825086, 6976.372126508639, 6982.406495447944, 6986.371226589428, 7726.806829829299, 7877.645505952131, 8004.839903201787, 8011.559364235023, 8016.799580010546, 7944.404169687181, 8276.462029968034, 8293.58532073406, 8325.209105135002, 8339.45793523419, 6265.342139075331, 6314.55798094129, 6556.541042127005, 6701.899471507833, 6707.295733947865, 7060.6116663584, 7136.107986501687, 7149.53528020677, 7154.0, 7159.069320988238, 6438.259600145856, 6574.605523668595, 6617.272100069084, 6657.667116644246, 6686.364795344434, 6485.77299794505, 6535.0, 6609.0, 6699.095622090956, 6711.4966377520905, 6175.938240617536, 6216.751329946752, 6219.657918814328, 6220.813375598739, 6226.533010024175, 5738.942610574008, 5975.16347711312, 5997.100434934795, 6015.759369625341, 6019.759209631566, 6042.244719410074, 6042.637441753509, 6061.242344706911, 6098.054801505774, 6106.847328816637], "unit": "ms", "name": "mootools.html", "value": 4201.7361547402}, {"lowerIsBetter": false, "replicates": [283.2324400873632, 289.63795255930086, 292.90334189717396, 293.4849339409338, 294.20417769932334, 5361.785528578852, 5415.766845640248, 5419.241306217128, 5450.411054748993, 5452.9823965132855, 5338.946610533893, 5341.172118321666, 5349.8127565535215, 5352.785888564463, 5357.276767636368, 4115.9588404115875, 4123.484564429446, 4127.7936103194725, 4130.256553820311, 4135.110951145495, 3869.671077958377, 3966.2067586482676, 4007.8597249096288, 4128.339465685476, 4140.855070072548, 4075.857344992926, 4076.388541718751, 4081.510218773751, 4096.446979657752, 4097.364908439182, 3828.1003964068423, 3924.058226025762, 4064.126212864234, 4072.4705788247634, 4084.979575102135, 3502.124468882779, 3569.8572057117685, 3582.4805403216646, 3583.050491619723, 3588.4437912123662, 5184.481551844823, 5192.1692529195525, 5192.324997750268, 5194.844154675366, 5202.0, 4710.976445117787, 4716.55192756691, 4716.622670186377, 4720.881977950545, 4725.976370118162, 5474.863128421782, 5615.46653067962, 5619.522340601054, 5624.409437009096, 5628.774849006035, 3901.765894046338, 3903.902402439933, 3906.785126818024, 3908.4332771747936, 3911.9217615647813, 5916.0, 5923.881522369572, 5925.2889653241455, 5927.1405646181065, 5927.3776253493625, 4018.477597912253, 4020.2964481216254, 4025.1748391579654, 4028.295048366524, 4036.5357983832237, 4097.610726980932, 4097.959020409818, 4103.056297051695, 4103.4460347853255, 4103.671706263492, 4457.732536047847, 4624.28323609841, 4642.976785116053, 4643.326717625993, 4646.4888862225125, 5637.746301416446, 5648.209250704905, 5650.124230744241, 5654.971725141348, 5655.0, 1384.9169049857042, 1398.1331574423923, 1400.9369578368999, 1401.5515035188641, 1401.873831355183, 915.5513798238815, 929.7954450020984, 933.8225737109927, 943.2218419803689, 947.5167664491021, 4967.3294105296045, 4977.104121258136, 4979.0, 4980.402351717817, 4986.252062190628, 5858.384869588717, 5865.178874957509, 5865.6480611162615, 5866.735996880066, 5872.915115134066, 4965.081459929925, 4973.477784832613, 4975.104481193348, 4976.975115124401, 4981.526754958273, 3044.0563425338214, 3093.7215650591556, 3135.1691801672573, 3162.2726772842375, 3170.1599076244815, 5480.177973304037, 5523.447655234444, 5585.441455854463, 5627.324721033502, 5636.4927156556105, 6067.0, 6069.817905462844, 6073.635581865102, 6075.422834830684, 6085.026395776655, 5613.410591887793, 5625.88748225025, 5627.774889004394, 5628.380878103405, 5631.155326701028, 5735.770569177186, 5910.911336330045, 5915.142304365929, 5918.201042859159, 5918.763249469973, 5763.049096898964, 5770.567207459373, 5772.797952071657, 5776.942230577809, 5788.884222315446, 5609.298837645294, 5617.578681598979, 5618.410066943075, 5624.100143976944, 5630.662160270397, 3811.8856434307013, 3922.8430862766313, 3955.0310174007554, 3958.6437220650278, 3958.7228893977144, 5831.7958871441, 5841.211436456024, 5847.766089356378, 5850.23946886902, 5852.4147585241135, 5615.129654903497, 5622.943770562406, 5623.2127502148915, 5624.521915637217, 5627.43725627434, 5568.470995255444, 5571.108622620523, 5621.156826476062, 5623.3533143689, 5643.88712225745, 5388.919166212589, 5502.0, 5502.80740174092, 5503.532199762904, 5504.0, 5634.88730225385, 5642.88714225705, 5651.858703532444, 5653.689047102449, 5653.773849046157, 5481.424450432806, 5490.945090549043, 5494.725263736717, 5497.092979658471, 5497.147942068986], "unit": "ms", "name": "prototype.html", "value": 4208.200160942452}, {"lowerIsBetter": false, "replicates": [676.2088356622751, 687.748971625357, 695.9199692035417, 727.9490435669505, 793.9325157361624, 10920.1263898888, 11097.944510277448, 11164.665060048192, 11197.608083717072, 11198.664040078791, 11613.593524226653, 11637.650870473879, 11658.0, 11811.11416643753, 11823.527058917633, 623.9968800155992, 632.5477283742124, 795.546538473072, 801.9639116239754, 808.4623725222749, 804.6258489802241, 806.04483686831, 812.8171161488677, 813.2558708781457, 813.4184058398245, 651.7197605029835, 835.3526017336552, 841.734853521142, 841.7685136587427, 842.7219017724136, 654.3750718064261, 824.1511243419287, 834.6911642692243, 838.1995194589152, 839.559231403512, 615.7875532941129, 619.2228752915108, 619.7954674957298, 619.9318075011745, 619.9442050215503, 11717.70705732355, 11863.644090677208, 11877.99037081849, 11924.880751192464, 11933.0, 10156.847647285296, 10304.536295866705, 10809.297395669257, 10857.185711071623, 11202.215844890861, 9113.0, 9119.589618467186, 9201.953990230006, 9303.488308143049, 9417.670381536613, 3218.983905080483, 3236.563063986379, 3270.2478429961006, 3301.224212310105, 3313.9171520711934, 38667.22665546674, 38746.61253387486, 39044.60955390438, 39066.21867562661, 39136.60863391358, 8953.776155596162, 9380.765480862896, 9731.708048758548, 9784.55969481375, 9809.509524523744, 15666.451674191349, 15961.0, 15965.121918294373, 16022.919885400499, 16024.359025638843, 6354.266813451754, 6415.101885736, 6488.805335839932, 6519.348065193538, 6603.306652801482, 3581.606023337431, 3607.67530922213, 3624.257027309395, 3650.6166852480105, 3666.5416822897137, 2846.6014757933904, 2938.14793709826, 2941.838198899038, 2948.395578906319, 2951.439226546949, 505.16395365669877, 505.5020804507557, 512.0654804980925, 513.5583398277479, 519.7349351830518, 460.0752487500082, 463.8075198792531, 469.3921371823429, 472.99763501182275, 520.9164936931174, 7055.753048643272, 7384.224656410999, 7577.88019345674, 7694.538327700356, 7779.3776497880035, 578.7713853028031, 583.0700033446645, 586.0535235594484, 593.0599999001631, 604.2084868821858, 3438.432658611351, 3624.8006359649944, 3640.162762564625, 3671.4125739881492, 3702.4816525686424, 49246.0, 49727.25409118866, 49892.25161622579, 50036.249456258185, 50146.498535014915, 42946.0, 43767.56232437699, 44129.55870441319, 44219.33670994938, 44231.336529952074, 38365.424518632244, 39391.40912886251, 39469.605303947166, 39579.40630890539, 39842.80078599588, 7042.929570704227, 7215.927840721525, 7964.761057168294, 8012.599370031358, 8071.266292000497, 30134.397312054076, 30266.69733302727, 30878.84560577183, 31131.0, 32893.50659740058, 40265.59734402619, 40563.0, 40800.79599602102, 41847.58152418559, 41952.0, 9562.991771727737, 10092.596296148073, 10197.337173083726, 10392.42841643717, 10456.424896630759, 10820.513076911715, 10900.890991089987, 10912.345259284151, 10980.780384392427, 11029.44852757375, 10900.0, 11086.501107450023, 11272.887271127513, 11325.15061370417, 11634.418279086181, 10057.597696092074, 10106.898931010595, 10110.241731870286, 10348.482575871025, 10421.68734937953, 10147.086762191439, 10366.688999330032, 10435.165186784887, 10622.946885265525, 10665.786684266426, 8912.643494260157, 9076.546172691471, 9335.57989890443, 9723.124918757347, 9725.221982241545, 8454.1123182065, 8665.870011949952, 8709.695160669346, 8748.1251874812, 8989.0], "unit": "ms", "name": "yui.html", "value": 5654.419660594653}], "name": "dromaeo_css", "value": 6301.4077230573785}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 112.0, 111.0, 113.0, 101.0, 110.0, 111.0, 102.0], "unit": "ms", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [156.0, 135.0, 155.0, 166.0, 129.0, 163.0, 159.0, 130.0, 167.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 160.0, 163.0, 161.0, 162.0, 161.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 86.0, 97.0, 72.0, 72.0, 73.0, 102.0, 89.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 133.0, 94.0, 95.0, 94.0, 135.0, 96.0, 95.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 70.0, 70.0, 71.0, 69.0, 70.0, 70.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 70.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 70.0, 69.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 85.0, 83.0, 91.0, 83.0, 82.0, 83.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [139.0, 120.0, 126.0, 119.0, 120.0, 119.0, 131.0, 125.0, 128.0, 133.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [133.0, 143.0, 143.0, 143.0, 145.0, 133.0, 136.0, 150.0, 142.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.3}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1514.1999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.97510373443984], "unit": "score", "name": "Richards", "value": 212.69455}, {"lowerIsBetter": false, "replicates": [185.5287569573284], "unit": "score", "name": "DeltaBlue", "value": 356.3760199999999}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [1976.2845849802372], "unit": "score", "name": "RayTrace", "value": 374.434434}, {"lowerIsBetter": false, "replicates": [783.0853563038371], "unit": "score", "name": "Earley", "value": 851.0732510000003}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [26342.105263157893], "unit": "score", "name": "RegExp", "value": 34.58284715284714}, {"lowerIsBetter": false, "replicates": [609.7560975609756], "unit": "score", "name": "Splay", "value": 133.64524}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19871.56056843293}]} 12:35:55 INFO - RETURN: dromaeo_css: 6301.41 12:35:55 INFO - RETURN: kraken: 1514.20 12:35:55 INFO - RETURN: v8_7: 19871.56 12:35:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19871.56"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1514.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6301.41"}}} 12:35:55 INFO - Return code: 0 12:35:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:35:56 INFO - # TBPL SUCCESS # 12:35:56 INFO - Running post-action listener: _resource_record_post_action 12:35:56 INFO - Running post-run listener: _resource_record_post_run 12:35:57 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505540608; Read time: 12; Write time: 348780 12:35:57 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 231383040; Read time: 0; Write time: 183376 12:35:57 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273338368; Read time: 12; Write time: 165380 12:35:57 INFO - Running post-run listener: _upload_blobber_files 12:35:57 INFO - Blob upload gear active. 12:35:57 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:35:57 INFO - Copying logs to upload dir... 12:35:57 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.336771 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-04 12:35:56.690588) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 12:35:56.693913) ========= 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=7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010060 build_url: 'https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 12:35:56.749055) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:35:56.749458) ========= 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=7f67ac1ceef7774224e327f2000001f6-1449260084.272450-1480545765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:35:56.803252) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 12:35:56.803995) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 12:35:56.804470) ========= ========= Total master_lag: 0.24 =========