builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1449693024.24 results: success (0) buildid: 20151209115739 builduid: 94e1297d49474a9a8b6ff1fb9136d56f revision: 455af65081f54070206a8e38a512033311205282 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.242312) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.243217) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.243533) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006333 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.342554) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.342876) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.527016) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.527273) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.604730) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.605074) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.605478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.605760) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-09 12:30:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-12-09 12:30:25 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176395 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.822126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.822412) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016037 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.885861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.886173) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 455af65081f54070206a8e38a512033311205282 --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 455af65081f54070206a8e38a512033311205282 --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=5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-09 12:30:25,260 truncating revision to first 12 chars 2015-12-09 12:30:25,260 Setting DEBUG logging. 2015-12-09 12:30:25,260 attempt 1/10 2015-12-09 12:30:25,260 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/455af65081f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-09 12:30:25,506 unpacking tar archive at: fx-team-455af65081f5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525260 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:25.430494) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:25.430877) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:25.456957) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:25.457225) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:25.457623) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-09 12:30:25.458175) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:30:25 INFO - MultiFileLogger online at 20151209 12:30:25 in /builds/slave/test 12:30:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:30:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:30:25 INFO - {'append_to_log': False, 12:30:25 INFO - 'base_work_dir': '/builds/slave/test', 12:30:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:30:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:30:25 INFO - 'branch': 'Fx-Team-Non-PGO', 12:30:25 INFO - 'buildbot_json_path': 'buildprops.json', 12:30:25 INFO - 'config_files': ('talos/linux_config.py',), 12:30:25 INFO - 'default_actions': ('clobber', 12:30:25 INFO - 'read-buildbot-config', 12:30:25 INFO - 'download-and-extract', 12:30:25 INFO - 'populate-webroot', 12:30:25 INFO - 'create-virtualenv', 12:30:25 INFO - 'install', 12:30:25 INFO - 'run-tests'), 12:30:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:30:25 INFO - 'download_minidump_stackwalk': True, 12:30:25 INFO - 'download_symbols': 'ondemand', 12:30:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:30:25 INFO - 'tooltool.py': '/tools/tooltool.py', 12:30:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:30:25 INFO - '/tools/misc-python/virtualenv.py')}, 12:30:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:30:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:30:25 INFO - 'installer_path': 'installer.exe', 12:30:25 INFO - 'log_level': 'info', 12:30:25 INFO - 'log_name': 'talos', 12:30:25 INFO - 'log_to_console': True, 12:30:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:30:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:30:25 INFO - 'opt_config_files': (), 12:30:25 INFO - 'pip_index': False, 12:30:25 INFO - 'sps_profile': False, 12:30:25 INFO - 'sps_profile_interval': 0, 12:30:25 INFO - 'suite': 'dromaeojs-e10s', 12:30:25 INFO - 'system_bits': '64', 12:30:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:30:25 INFO - 'title': 'talos-linux64-ix-024', 12:30:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:30:25 INFO - 'use_talos_json': True, 12:30:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:30:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:30:25 INFO - 'work_dir': 'build'} 12:30:25 INFO - ##### 12:30:25 INFO - ##### Running clobber step. 12:30:25 INFO - ##### 12:30:25 INFO - Running pre-action listener: _resource_record_pre_action 12:30:25 INFO - Running main action method: clobber 12:30:25 INFO - rmtree: /builds/slave/test/build 12:30:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:30:26 INFO - Running post-action listener: _resource_record_post_action 12:30:26 INFO - ##### 12:30:26 INFO - ##### Running read-buildbot-config step. 12:30:26 INFO - ##### 12:30:26 INFO - Running pre-action listener: _resource_record_pre_action 12:30:26 INFO - Running main action method: read_buildbot_config 12:30:26 INFO - Using buildbot properties: 12:30:26 INFO - { 12:30:26 INFO - "properties": { 12:30:26 INFO - "buildnumber": 558, 12:30:26 INFO - "product": "firefox", 12:30:26 INFO - "script_repo_revision": "production", 12:30:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:30:26 INFO - "repository": "", 12:30:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:30:26 INFO - "buildid": "20151209115739", 12:30:26 INFO - "slavename": "talos-linux64-ix-024", 12:30:26 INFO - "pgo_build": "False", 12:30:26 INFO - "basedir": "/builds/slave/test", 12:30:26 INFO - "project": "", 12:30:26 INFO - "platform": "ubuntu64_hw", 12:30:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:30:26 INFO - "slavebuilddir": "test", 12:30:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:30:26 INFO - "branch": "fx-team", 12:30:26 INFO - "repo_path": "integration/fx-team", 12:30:26 INFO - "stage_platform": "linux64", 12:30:26 INFO - "builduid": "94e1297d49474a9a8b6ff1fb9136d56f", 12:30:26 INFO - "revision": "455af65081f54070206a8e38a512033311205282" 12:30:26 INFO - }, 12:30:26 INFO - "sourcestamp": { 12:30:26 INFO - "repository": "", 12:30:26 INFO - "hasPatch": false, 12:30:26 INFO - "project": "", 12:30:26 INFO - "branch": "fx-team-linux64-talos", 12:30:26 INFO - "changes": [ 12:30:26 INFO - { 12:30:26 INFO - "category": null, 12:30:26 INFO - "files": [ 12:30:26 INFO - { 12:30:26 INFO - "url": null, 12:30:26 INFO - "name": "https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:30:26 INFO - } 12:30:26 INFO - ], 12:30:26 INFO - "repository": "", 12:30:26 INFO - "rev": "455af65081f54070206a8e38a512033311205282", 12:30:26 INFO - "who": "edilee@gmail.com", 12:30:26 INFO - "when": 1449692961, 12:30:26 INFO - "number": 7175472, 12:30:26 INFO - "comments": "Bug 1213844 - Update Loop's user journey strings with final versions [r=mikedeboer]", 12:30:26 INFO - "project": "", 12:30:26 INFO - "at": "Wed 09 Dec 2015 12:29:21", 12:30:26 INFO - "branch": "fx-team-linux64-talos", 12:30:26 INFO - "revlink": "", 12:30:26 INFO - "properties": [ 12:30:26 INFO - [ 12:30:26 INFO - "buildid", 12:30:26 INFO - "20151209115739", 12:30:26 INFO - "Change" 12:30:26 INFO - ], 12:30:26 INFO - [ 12:30:26 INFO - "builduid", 12:30:26 INFO - "94e1297d49474a9a8b6ff1fb9136d56f", 12:30:26 INFO - "Change" 12:30:26 INFO - ], 12:30:26 INFO - [ 12:30:26 INFO - "pgo_build", 12:30:26 INFO - "False", 12:30:26 INFO - "Change" 12:30:26 INFO - ] 12:30:26 INFO - ], 12:30:26 INFO - "revision": "455af65081f54070206a8e38a512033311205282" 12:30:26 INFO - } 12:30:26 INFO - ], 12:30:26 INFO - "revision": "455af65081f54070206a8e38a512033311205282" 12:30:26 INFO - } 12:30:26 INFO - } 12:30:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:30:26 INFO - Running post-action listener: _resource_record_post_action 12:30:26 INFO - ##### 12:30:26 INFO - ##### Running download-and-extract step. 12:30:26 INFO - ##### 12:30:26 INFO - Running pre-action listener: _resource_record_pre_action 12:30:26 INFO - Running main action method: download_and_extract 12:30:26 INFO - mkdir: /builds/slave/test/build/tests 12:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:26 INFO - https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:30:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/test_packages.json 12:30:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/test_packages.json 12:30:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:30:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:30:33 INFO - Downloaded 1302 bytes. 12:30:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:30:33 INFO - Using the following test package requirements: 12:30:33 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:30:33 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:30:33 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:33 INFO - u'jsshell-linux-x86_64.zip'], 12:30:33 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:30:33 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:30:33 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:30:33 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:30:33 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:30:33 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:30:33 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:30:34 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:30: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:30:34 INFO - https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:30:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:30:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:30:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/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:30:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/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:30:39 INFO - Downloaded 21860154 bytes. 12:30:39 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:30:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:30:39 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:30:41 INFO - Return code: 0 12:30:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:41 INFO - https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:30:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:30:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:30:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/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:30:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/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:30:49 INFO - Downloaded 21860154 bytes. 12:30:49 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:30:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:30:49 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:30:50 INFO - Return code: 0 12:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:50 INFO - https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:30:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:30:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:30:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/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:30:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/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:30:51 INFO - Downloaded 11132038 bytes. 12:30:51 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:30:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:30:51 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:30:51 INFO - Return code: 0 12:30:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:51 INFO - https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:30:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:30:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:30:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/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:30:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/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:30:52 INFO - Downloaded 57735325 bytes. 12:30:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:30:52 INFO - mkdir: /builds/slave/test/properties 12:30:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:30:52 INFO - Writing to file /builds/slave/test/properties/build_url 12:30:52 INFO - Contents: 12:30:52 INFO - build_url:https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:30:52 INFO - Running post-action listener: _resource_record_post_action 12:30:52 INFO - Running post-action listener: set_extra_try_arguments 12:30:52 INFO - ##### 12:30:52 INFO - ##### Running populate-webroot step. 12:30:52 INFO - ##### 12:30:52 INFO - Running pre-action listener: _resource_record_pre_action 12:30:52 INFO - Running main action method: populate_webroot 12:30:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:30:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:30:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:30:52 INFO - '--tppagecycles', 12:30:52 INFO - '7'], 12:30:52 INFO - 'tests': ['tsvgm']}}, 12:30:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:30:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:30:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:30:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:30:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:30:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:30:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:30:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:52 INFO - 'talos_options': ['--e10s'], 12:30:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:30:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:52 INFO - 'tests': ['damp', 'tps']}, 12:30:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:52 INFO - 'talos_options': ['--e10s'], 12:30:52 INFO - 'tests': ['damp', 'tps']}, 12:30:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:30:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:30:52 INFO - 'other': {'tests': ['a11yr', 12:30:52 INFO - 'ts_paint', 12:30:52 INFO - 'tpaint', 12:30:52 INFO - 'sessionrestore', 12:30:52 INFO - 'sessionrestore_no_auto_restore']}, 12:30:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:30:52 INFO - 'tests': ['a11yr', 12:30:52 INFO - 'ts_paint', 12:30:52 INFO - 'tpaint', 12:30:52 INFO - 'sessionrestore', 12:30:52 INFO - 'sessionrestore_no_auto_restore']}, 12:30:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:30:52 INFO - 'tests': ['a11yr', 12:30:52 INFO - 'ts_paint', 12:30:52 INFO - 'tpaint', 12:30:52 INFO - 'sessionrestore', 12:30:52 INFO - 'sessionrestore_no_auto_restore']}, 12:30:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:30:52 INFO - 'tests': ['a11yr', 12:30:52 INFO - 'ts_paint', 12:30:52 INFO - 'tpaint', 12:30:52 INFO - 'sessionrestore', 12:30:52 INFO - 'sessionrestore_no_auto_restore']}, 12:30:52 INFO - 'other_l64': {'tests': ['a11yr', 12:30:52 INFO - 'ts_paint', 12:30:52 INFO - 'tpaint', 12:30:52 INFO - 'sessionrestore', 12:30:52 INFO - 'sessionrestore_no_auto_restore']}, 12:30:52 INFO - 'other_nol64': {'tests': ['a11yr', 12:30:52 INFO - 'ts_paint', 12:30:52 INFO - 'tpaint', 12:30:52 INFO - 'sessionrestore', 12:30:52 INFO - 'sessionrestore_no_auto_restore']}, 12:30:52 INFO - 'svgr': {'tests': ['tsvgx', 12:30:52 INFO - 'tsvgr_opacity', 12:30:52 INFO - 'tart', 12:30:52 INFO - 'tscrollx', 12:30:52 INFO - 'cart']}, 12:30:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:30:52 INFO - 'tests': ['tsvgx', 12:30:52 INFO - 'tsvgr_opacity', 12:30:52 INFO - 'tart', 12:30:52 INFO - 'tscrollx', 12:30:52 INFO - 'cart']}, 12:30:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:52 INFO - 'tests': ['tp5o']}, 12:30:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:52 INFO - 'talos_options': ['--e10s'], 12:30:52 INFO - 'tests': ['tp5o']}, 12:30:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:52 INFO - 'talos_options': ['--xperf_path', 12:30:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:30:52 INFO - 'tests': ['tp5n']}, 12:30:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:52 INFO - 'talos_options': ['--e10s', 12:30:52 INFO - '--xperf_path', 12:30:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:30:52 INFO - 'tests': ['tp5n']}}, 12:30:52 INFO - 'talos.zip': {'path': '', 12:30:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:30:52 INFO - Running post-action listener: _resource_record_post_action 12:30:52 INFO - ##### 12:30:52 INFO - ##### Running create-virtualenv step. 12:30:52 INFO - ##### 12:30:52 INFO - Running pre-action listener: _resource_record_pre_action 12:30:52 INFO - Running main action method: create_virtualenv 12:30:52 INFO - Creating virtualenv /builds/slave/test/build/venv 12:30:52 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:30:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:30:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:30:52 INFO - Using real prefix '/usr' 12:30:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:30:53 INFO - Installing distribute.............................................................................................................................................................................................done. 12:30:55 INFO - Installing pip.................done. 12:30:55 INFO - Return code: 0 12:30:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:55 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 0x7fefe68cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16540b0>, '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 0x1654fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1655440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', '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:30:55 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:30:55 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:30:55 INFO - Using env: {'DISPLAY': ':0', 12:30:55 INFO - 'HOME': '/home/cltbld', 12:30:55 INFO - 'LANG': 'en_US.UTF-8', 12:30:55 INFO - 'LANGUAGE': 'en_US:en', 12:30:55 INFO - 'LOGNAME': 'cltbld', 12:30:55 INFO - 'MAIL': '/var/mail/cltbld', 12:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:55 INFO - 'MOZ_NO_REMOTE': '1', 12:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:55 INFO - 'NO_EM_RESTART': '1', 12:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:55 INFO - 'PWD': '/builds/slave/test', 12:30:55 INFO - 'SHELL': '/bin/bash', 12:30:55 INFO - 'SHLVL': '1', 12:30:55 INFO - 'TERM': 'linux', 12:30:55 INFO - 'TMOUT': '86400', 12:30:55 INFO - 'USER': 'cltbld', 12:30:55 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', 12:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:55 INFO - '_': '/tools/buildbot/bin/python'} 12:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:55 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:30:55 INFO - Cleaning up... 12:30:55 INFO - Return code: 0 12:30:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:55 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 0x7fefe68cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16540b0>, '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 0x1654fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1655440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', '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:30:55 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:30:55 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:30:55 INFO - Using env: {'DISPLAY': ':0', 12:30:55 INFO - 'HOME': '/home/cltbld', 12:30:55 INFO - 'LANG': 'en_US.UTF-8', 12:30:55 INFO - 'LANGUAGE': 'en_US:en', 12:30:55 INFO - 'LOGNAME': 'cltbld', 12:30:55 INFO - 'MAIL': '/var/mail/cltbld', 12:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:55 INFO - 'MOZ_NO_REMOTE': '1', 12:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:55 INFO - 'NO_EM_RESTART': '1', 12:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:55 INFO - 'PWD': '/builds/slave/test', 12:30:55 INFO - 'SHELL': '/bin/bash', 12:30:55 INFO - 'SHLVL': '1', 12:30:55 INFO - 'TERM': 'linux', 12:30:55 INFO - 'TMOUT': '86400', 12:30:55 INFO - 'USER': 'cltbld', 12:30:55 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', 12:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:55 INFO - '_': '/tools/buildbot/bin/python'} 12:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:55 INFO - Downloading/unpacking psutil>=0.7.1 12:30:55 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:30:55 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:30:55 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:30:55 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:30:55 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:30:55 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:30:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:30:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:30:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:30:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:30:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:30:57 INFO - Installing collected packages: psutil 12:30:57 INFO - Running setup.py install for psutil 12:30:57 INFO - building 'psutil._psutil_linux' extension 12:30:57 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:30:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:30:57 INFO - building 'psutil._psutil_posix' extension 12:30:57 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:30:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:30:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:30:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:30:58 INFO - Successfully installed psutil 12:30:58 INFO - Cleaning up... 12:30:58 INFO - Return code: 0 12:30:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefe68cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16540b0>, '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 0x1654fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1655440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', '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:30:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:30:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:30:58 INFO - Using env: {'DISPLAY': ':0', 12:30:58 INFO - 'HOME': '/home/cltbld', 12:30:58 INFO - 'LANG': 'en_US.UTF-8', 12:30:58 INFO - 'LANGUAGE': 'en_US:en', 12:30:58 INFO - 'LOGNAME': 'cltbld', 12:30:58 INFO - 'MAIL': '/var/mail/cltbld', 12:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:58 INFO - 'MOZ_NO_REMOTE': '1', 12:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:58 INFO - 'NO_EM_RESTART': '1', 12:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:58 INFO - 'PWD': '/builds/slave/test', 12:30:58 INFO - 'SHELL': '/bin/bash', 12:30:58 INFO - 'SHLVL': '1', 12:30:58 INFO - 'TERM': 'linux', 12:30:58 INFO - 'TMOUT': '86400', 12:30:58 INFO - 'USER': 'cltbld', 12:30:58 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', 12:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:58 INFO - '_': '/tools/buildbot/bin/python'} 12:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:31:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:31:00 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:31:00 INFO - Installing collected packages: mozsystemmonitor 12:31:00 INFO - Running setup.py install for mozsystemmonitor 12:31:00 INFO - Successfully installed mozsystemmonitor 12:31:00 INFO - Cleaning up... 12:31:00 INFO - Return code: 0 12:31:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefe68cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16540b0>, '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 0x1654fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1655440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', '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:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:31:00 INFO - Using env: {'DISPLAY': ':0', 12:31:00 INFO - 'HOME': '/home/cltbld', 12:31:00 INFO - 'LANG': 'en_US.UTF-8', 12:31:00 INFO - 'LANGUAGE': 'en_US:en', 12:31:00 INFO - 'LOGNAME': 'cltbld', 12:31:00 INFO - 'MAIL': '/var/mail/cltbld', 12:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:00 INFO - 'MOZ_NO_REMOTE': '1', 12:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:00 INFO - 'NO_EM_RESTART': '1', 12:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:00 INFO - 'PWD': '/builds/slave/test', 12:31:00 INFO - 'SHELL': '/bin/bash', 12:31:00 INFO - 'SHLVL': '1', 12:31:00 INFO - 'TERM': 'linux', 12:31:00 INFO - 'TMOUT': '86400', 12:31:00 INFO - 'USER': 'cltbld', 12:31:00 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', 12:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:00 INFO - '_': '/tools/buildbot/bin/python'} 12:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:00 INFO - Downloading/unpacking blobuploader==1.2.4 12:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:02 INFO - Downloading blobuploader-1.2.4.tar.gz 12:31:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:31:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:31: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:31: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:31: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:31: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:31: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:31: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:31:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:31:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:31: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:31: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:31: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:31: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:31: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:31: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:31:02 INFO - Downloading docopt-0.6.1.tar.gz 12:31:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:31:02 INFO - Installing collected packages: blobuploader, requests, docopt 12:31:02 INFO - Running setup.py install for blobuploader 12:31:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:31:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:31:02 INFO - Running setup.py install for requests 12:31:03 INFO - Running setup.py install for docopt 12:31:03 INFO - Successfully installed blobuploader requests docopt 12:31:03 INFO - Cleaning up... 12:31:03 INFO - Return code: 0 12:31:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefe68cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16540b0>, '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 0x1654fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1655440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', '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:31:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:31:03 INFO - Using env: {'DISPLAY': ':0', 12:31:03 INFO - 'HOME': '/home/cltbld', 12:31:03 INFO - 'LANG': 'en_US.UTF-8', 12:31:03 INFO - 'LANGUAGE': 'en_US:en', 12:31:03 INFO - 'LOGNAME': 'cltbld', 12:31:03 INFO - 'MAIL': '/var/mail/cltbld', 12:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:03 INFO - 'MOZ_NO_REMOTE': '1', 12:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:03 INFO - 'NO_EM_RESTART': '1', 12:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:03 INFO - 'PWD': '/builds/slave/test', 12:31:03 INFO - 'SHELL': '/bin/bash', 12:31:03 INFO - 'SHLVL': '1', 12:31:03 INFO - 'TERM': 'linux', 12:31:03 INFO - 'TMOUT': '86400', 12:31:03 INFO - 'USER': 'cltbld', 12:31:03 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', 12:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:03 INFO - '_': '/tools/buildbot/bin/python'} 12:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:31:03 INFO - Running setup.py (path:/tmp/pip-BdBwnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:31:03 INFO - Running setup.py (path:/tmp/pip-JVoXNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:31:03 INFO - Running setup.py (path:/tmp/pip-O23Lk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:31:03 INFO - Running setup.py (path:/tmp/pip-ff1UqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:31:03 INFO - Running setup.py (path:/tmp/pip-LlCgVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:31:04 INFO - Running setup.py (path:/tmp/pip-stR2CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:31:04 INFO - Running setup.py (path:/tmp/pip-7PdCx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:31:04 INFO - Running setup.py (path:/tmp/pip-_XguON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:31:04 INFO - Running setup.py (path:/tmp/pip-fJFFAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:31:04 INFO - Running setup.py (path:/tmp/pip-4V5Shc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:31:04 INFO - Running setup.py (path:/tmp/pip-lpbatM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:31:04 INFO - Running setup.py (path:/tmp/pip-37mmFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:31:04 INFO - Running setup.py (path:/tmp/pip-llkIt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:31:04 INFO - Running setup.py (path:/tmp/pip-GAh_ZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:04 INFO - Running setup.py (path:/tmp/pip-Hn5c1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:31:04 INFO - Running setup.py (path:/tmp/pip-L1P8lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:31:04 INFO - Running setup.py (path:/tmp/pip-gq7KxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:31:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:31:04 INFO - Running setup.py install for manifestparser 12:31:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:31:04 INFO - Running setup.py install for mozcrash 12:31:05 INFO - Running setup.py install for mozdebug 12:31:05 INFO - Running setup.py install for mozdevice 12:31:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:31:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:31:05 INFO - Running setup.py install for mozfile 12:31:05 INFO - Running setup.py install for mozhttpd 12:31:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:31:05 INFO - Running setup.py install for mozinfo 12:31:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:31:05 INFO - Running setup.py install for mozInstall 12:31:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:31:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:31:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:31:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:31:05 INFO - Running setup.py install for mozleak 12:31:05 INFO - Running setup.py install for mozlog 12:31:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:31:05 INFO - Running setup.py install for moznetwork 12:31:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:31:06 INFO - Running setup.py install for mozprocess 12:31:06 INFO - Running setup.py install for mozprofile 12:31:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:31:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:31:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:31:06 INFO - Running setup.py install for mozrunner 12:31:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:31:06 INFO - Running setup.py install for mozscreenshot 12:31:06 INFO - Running setup.py install for moztest 12:31:06 INFO - Running setup.py install for mozversion 12:31:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:31:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:31:06 INFO - Cleaning up... 12:31:06 INFO - Return code: 0 12:31:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefe68cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16540b0>, '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 0x1654fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1655440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', '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:31:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:31:06 INFO - Using env: {'DISPLAY': ':0', 12:31:06 INFO - 'HOME': '/home/cltbld', 12:31:06 INFO - 'LANG': 'en_US.UTF-8', 12:31:06 INFO - 'LANGUAGE': 'en_US:en', 12:31:06 INFO - 'LOGNAME': 'cltbld', 12:31:06 INFO - 'MAIL': '/var/mail/cltbld', 12:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:06 INFO - 'MOZ_NO_REMOTE': '1', 12:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:06 INFO - 'NO_EM_RESTART': '1', 12:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:06 INFO - 'PWD': '/builds/slave/test', 12:31:06 INFO - 'SHELL': '/bin/bash', 12:31:06 INFO - 'SHLVL': '1', 12:31:06 INFO - 'TERM': 'linux', 12:31:06 INFO - 'TMOUT': '86400', 12:31:06 INFO - 'USER': 'cltbld', 12:31:06 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', 12:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:06 INFO - '_': '/tools/buildbot/bin/python'} 12:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:31:06 INFO - Running setup.py (path:/tmp/pip-BzhVMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:31:06 INFO - Running setup.py (path:/tmp/pip-1CaDjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:31:07 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:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:31:07 INFO - Running setup.py (path:/tmp/pip-jX5_Qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:31:07 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:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:31:07 INFO - Running setup.py (path:/tmp/pip-thnoem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:31:07 INFO - Running setup.py (path:/tmp/pip-cC1YHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:31:07 INFO - Running setup.py (path:/tmp/pip-Z41sMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:31:07 INFO - Running setup.py (path:/tmp/pip-spqEOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:31:07 INFO - Running setup.py (path:/tmp/pip-He0Pbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:31:07 INFO - Running setup.py (path:/tmp/pip-q8_G5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:31:07 INFO - Running setup.py (path:/tmp/pip-FUwdv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:31:07 INFO - Running setup.py (path:/tmp/pip-YNcd_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:31:07 INFO - Running setup.py (path:/tmp/pip-szKljE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:31:07 INFO - Running setup.py (path:/tmp/pip-gkdMTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:31:07 INFO - Running setup.py (path:/tmp/pip-AJU1UF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:07 INFO - Running setup.py (path:/tmp/pip-7QsC21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:31:07 INFO - Running setup.py (path:/tmp/pip-Qqm97o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:31:08 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:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:31:08 INFO - Running setup.py (path:/tmp/pip-jYQeba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:31:08 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:31:08 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:31:08 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:31:08 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:31:08 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:31:08 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:31:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:09 INFO - Downloading blessings-1.5.1.tar.gz 12:31:09 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 12:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:31:09 INFO - Installing collected packages: blessings 12:31:09 INFO - Running setup.py install for blessings 12:31:10 INFO - Successfully installed blessings 12:31:10 INFO - Cleaning up... 12:31:10 INFO - Return code: 0 12:31:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:31:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:31:10 INFO - Reading from file tmpfile_stdout 12:31:10 INFO - Current package versions: 12:31:10 INFO - argparse == 1.2.1 12:31:10 INFO - blessings == 1.5.1 12:31:10 INFO - blobuploader == 1.2.4 12:31:10 INFO - docopt == 0.6.1 12:31:10 INFO - manifestparser == 1.1 12:31:10 INFO - mozInstall == 1.12 12:31:10 INFO - mozcrash == 0.16 12:31:10 INFO - mozdebug == 0.1 12:31:10 INFO - mozdevice == 0.47 12:31:10 INFO - mozfile == 1.2 12:31:10 INFO - mozhttpd == 0.7 12:31:10 INFO - mozinfo == 0.9 12:31:10 INFO - mozleak == 0.1 12:31:10 INFO - mozlog == 3.1 12:31:10 INFO - moznetwork == 0.27 12:31:10 INFO - mozprocess == 0.22 12:31:10 INFO - mozprofile == 0.27 12:31:10 INFO - mozrunner == 6.11 12:31:10 INFO - mozscreenshot == 0.1 12:31:10 INFO - mozsystemmonitor == 0.0 12:31:10 INFO - moztest == 0.7 12:31:10 INFO - mozversion == 1.4 12:31:10 INFO - psutil == 3.1.1 12:31:10 INFO - requests == 1.2.3 12:31:10 INFO - wsgiref == 0.1.2 12:31:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31: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:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefe68cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16540b0>, '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 0x1654fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1655440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', '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:31:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:31:10 INFO - Using env: {'DISPLAY': ':0', 12:31:10 INFO - 'HOME': '/home/cltbld', 12:31:10 INFO - 'LANG': 'en_US.UTF-8', 12:31:10 INFO - 'LANGUAGE': 'en_US:en', 12:31:10 INFO - 'LOGNAME': 'cltbld', 12:31:10 INFO - 'MAIL': '/var/mail/cltbld', 12:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:10 INFO - 'MOZ_NO_REMOTE': '1', 12:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:10 INFO - 'NO_EM_RESTART': '1', 12:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:10 INFO - 'PWD': '/builds/slave/test', 12:31:10 INFO - 'SHELL': '/bin/bash', 12:31:10 INFO - 'SHLVL': '1', 12:31:10 INFO - 'TERM': 'linux', 12:31:10 INFO - 'TMOUT': '86400', 12:31:10 INFO - 'USER': 'cltbld', 12:31:10 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', 12:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:10 INFO - '_': '/tools/buildbot/bin/python'} 12:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:31:10 INFO - Cleaning up... 12:31:10 INFO - Return code: 0 12:31:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:31: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:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefe68cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16540b0>, '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 0x1654fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1655440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', '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:31:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:31:10 INFO - Using env: {'DISPLAY': ':0', 12:31:10 INFO - 'HOME': '/home/cltbld', 12:31:10 INFO - 'LANG': 'en_US.UTF-8', 12:31:10 INFO - 'LANGUAGE': 'en_US:en', 12:31:10 INFO - 'LOGNAME': 'cltbld', 12:31:10 INFO - 'MAIL': '/var/mail/cltbld', 12:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:10 INFO - 'MOZ_NO_REMOTE': '1', 12:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:10 INFO - 'NO_EM_RESTART': '1', 12:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:10 INFO - 'PWD': '/builds/slave/test', 12:31:10 INFO - 'SHELL': '/bin/bash', 12:31:10 INFO - 'SHLVL': '1', 12:31:10 INFO - 'TERM': 'linux', 12:31:10 INFO - 'TMOUT': '86400', 12:31:10 INFO - 'USER': 'cltbld', 12:31:10 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', 12:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:10 INFO - '_': '/tools/buildbot/bin/python'} 12:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:10 INFO - Downloading/unpacking jsonschema 12:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:31:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 12:31:12 INFO - Downloading/unpacking functools32 (from jsonschema) 12:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:12 INFO - Downloading functools32-3.2.3-2.tar.gz 12:31:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:31:12 INFO - warning: no files found matching '*.txt' 12:31:12 INFO - no previously-included directories found matching 'build' 12:31:12 INFO - no previously-included directories found matching 'dist' 12:31:12 INFO - no previously-included directories found matching '.git*' 12:31:12 INFO - Installing collected packages: jsonschema, functools32 12:31:12 INFO - Running setup.py install for functools32 12:31:12 INFO - warning: no files found matching '*.txt' 12:31:12 INFO - no previously-included directories found matching 'build' 12:31:12 INFO - no previously-included directories found matching 'dist' 12:31:12 INFO - no previously-included directories found matching '.git*' 12:31:12 INFO - Successfully installed jsonschema functools32 12:31:12 INFO - Cleaning up... 12:31:12 INFO - Return code: 0 12:31:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefe68cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16540b0>, '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 0x1654fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1655440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', '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:31:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:31:12 INFO - Using env: {'DISPLAY': ':0', 12:31:12 INFO - 'HOME': '/home/cltbld', 12:31:12 INFO - 'LANG': 'en_US.UTF-8', 12:31:12 INFO - 'LANGUAGE': 'en_US:en', 12:31:12 INFO - 'LOGNAME': 'cltbld', 12:31:12 INFO - 'MAIL': '/var/mail/cltbld', 12:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:12 INFO - 'MOZ_NO_REMOTE': '1', 12:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:12 INFO - 'NO_EM_RESTART': '1', 12:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:12 INFO - 'PWD': '/builds/slave/test', 12:31:12 INFO - 'SHELL': '/bin/bash', 12:31:12 INFO - 'SHLVL': '1', 12:31:12 INFO - 'TERM': 'linux', 12:31:12 INFO - 'TMOUT': '86400', 12:31:12 INFO - 'USER': 'cltbld', 12:31:12 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', 12:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:12 INFO - '_': '/tools/buildbot/bin/python'} 12:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:13 INFO - Downloading/unpacking flake8 12:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:31:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 12:31:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:31: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:31: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:31: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:31: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:31: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:31: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:31:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:31:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 12:31:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:31: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:31: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:31: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:31: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:31: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:31: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:31:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 12:31:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:31:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:31:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:31:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:31:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:31:15 INFO - no previously-included directories found matching 'docs/_build' 12:31:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:31:15 INFO - Running setup.py install for pep8 12:31:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:31:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:31:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:31:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:31:15 INFO - no previously-included directories found matching 'docs/_build' 12:31:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:31:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:31:15 INFO - Cleaning up... 12:31:15 INFO - Return code: 0 12:31:15 INFO - Running post-action listener: _resource_record_post_action 12:31:15 INFO - Running post-action listener: _start_resource_monitoring 12:31:15 INFO - Starting resource monitoring. 12:31:15 INFO - ##### 12:31:15 INFO - ##### Running install step. 12:31:15 INFO - ##### 12:31:15 INFO - Running pre-action listener: _resource_record_pre_action 12:31:15 INFO - Running main action method: install 12:31:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:31:15 INFO - Reading from file tmpfile_stdout 12:31:15 INFO - Detecting whether we're running mozinstall >=1.0... 12:31:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:31:15 INFO - Reading from file tmpfile_stdout 12:31:15 INFO - Output received: 12:31:15 INFO - Usage: mozinstall [options] installer 12:31:15 INFO - Options: 12:31:15 INFO - -h, --help show this help message and exit 12:31:15 INFO - -d DEST, --destination=DEST 12:31:15 INFO - Directory to install application into. [default: 12:31:15 INFO - "/builds/slave/test"] 12:31:15 INFO - --app=APP Application being installed. [default: firefox] 12:31:15 INFO - mkdir: /builds/slave/test/build/application 12:31:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:31:30 INFO - Reading from file tmpfile_stdout 12:31:30 INFO - Output received: 12:31:30 INFO - /builds/slave/test/build/application/firefox/firefox 12:31:30 INFO - Running post-action listener: _resource_record_post_action 12:31:30 INFO - ##### 12:31:30 INFO - ##### Running run-tests step. 12:31:30 INFO - ##### 12:31:30 INFO - Running pre-action listener: _resource_record_pre_action 12:31:30 INFO - Running main action method: run_tests 12:31:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:31:30 INFO - Python 2.7.3 12:31:30 INFO - Return code: 0 12:31:30 INFO - grabbing minidump binary from tooltool 12:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16540b0>, '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 0x1654fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1655440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:31:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:31:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:31:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:31:30 INFO - Return code: 0 12:31:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:31:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:31:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:31:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:31:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:31:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:31:31 INFO - Return code: 0 12:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost'] in /builds/slave/test/build 12:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost 12:31:31 INFO - Using env: {'DISPLAY': ':0', 12:31:31 INFO - 'HOME': '/home/cltbld', 12:31:31 INFO - 'LANG': 'en_US.UTF-8', 12:31:31 INFO - 'LANGUAGE': 'en_US:en', 12:31:31 INFO - 'LOGNAME': 'cltbld', 12:31:31 INFO - 'MAIL': '/var/mail/cltbld', 12:31:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:31:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:31 INFO - 'MOZ_NO_REMOTE': '1', 12:31:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:31 INFO - 'NO_EM_RESTART': '1', 12:31:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:31 INFO - 'PWD': '/builds/slave/test', 12:31:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:31:31 INFO - 'SHELL': '/bin/bash', 12:31:31 INFO - 'SHLVL': '1', 12:31:31 INFO - 'TERM': 'linux', 12:31:31 INFO - 'TMOUT': '86400', 12:31:31 INFO - 'USER': 'cltbld', 12:31:31 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172', 12:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:31 INFO - '_': '/tools/buildbot/bin/python'} 12:31:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost'] with output_timeout 3600 12:31:31 INFO - mozversion INFO | application_buildid: 20151209115739 12:31:31 INFO - mozversion INFO | application_changeset: 455af65081f54070206a8e38a512033311205282 12:31:31 INFO - mozversion INFO | application_display_name: Nightly 12:31:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:31:31 INFO - mozversion INFO | application_name: Firefox 12:31:31 INFO - mozversion INFO | application_remotingname: firefox 12:31:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:31:31 INFO - mozversion INFO | application_vendor: Mozilla 12:31:31 INFO - mozversion INFO | application_version: 45.0a1 12:31:31 INFO - mozversion INFO | platform_buildid: 20151209115739 12:31:31 INFO - mozversion INFO | platform_changeset: 455af65081f54070206a8e38a512033311205282 12:31:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:31:31 INFO - mozversion INFO | platform_version: 45.0a1 12:31:31 INFO - 2015-12-09 12:31:31,645 DEBUG : using testdate: 1449693091 12:31:31 INFO - 2015-12-09 12:31:31,645 DEBUG : actual date: 1449693091 12:31:31 INFO - 2015-12-09 12:31:31,656 INFO : starting webserver on 'localhost:46827' 12:31:31 INFO - 2015-12-09 12:31:31,657 INFO : Starting test suite talos-linux64-ix-024.e 12:31:31 INFO - 2015-12-09 12:31:31,658 INFO : Starting test dromaeo_css 12:31:31 INFO - 2015-12-09 12:31:31,658 DEBUG : operating with platform_type : linux_ 12:31:31 INFO - 2015-12-09 12:31:31,658 INFO : Initialising browser for dromaeo_css test... 12:31:31 INFO - 2015-12-09 12:31:31,673 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVzt4Em/profile http://localhost:46827/getInfo.html 12:31:36 INFO - 2015-12-09 12:31:36,212 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:31:36 INFO - 2015-12-09 12:31:36,212 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:31:36 INFO - 2015-12-09 12:31:36,212 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:31:36 INFO - 2015-12-09 12:31:36,212 DEBUG : BROWSER_OUTPUT: __metrics 12:31:36 INFO - 2015-12-09 12:31:36,349 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:31:37 INFO - 2015-12-09 12:31:37,252 INFO : Browser initialized. 12:31:37 INFO - 2015-12-09 12:31:37,253 INFO : Running cycle 1/1 for dromaeo_css test... 12:31:37 INFO - 2015-12-09 12:31:37,253 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVzt4Em/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:31:49 INFO - 2015-12-09 12:31:49,258 DEBUG : BROWSER_OUTPUT: RSS: Main: 143085568 12:31:49 INFO - 2015-12-09 12:31:49,258 DEBUG : BROWSER_OUTPUT: 12:32:38 INFO - 2015-12-09 12:32:38,905 DEBUG : BROWSER_OUTPUT: 1449693158904 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:34:50 INFO - 2015-12-09 12:34:50,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46827/tests/dromaeo/cssquery-ext.html) 12:34:51 INFO - 2015-12-09 12:34:51,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 145940480 12:34:51 INFO - 2015-12-09 12:34:51,667 DEBUG : BROWSER_OUTPUT: 12:37:53 INFO - 2015-12-09 12:37:53,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/dromaeo/cssquery-ext.html (next: http://localhost:46827/tests/dromaeo/cssquery-jquery.html) 12:37:54 INFO - 2015-12-09 12:37:54,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 145502208 12:37:54 INFO - 2015-12-09 12:37:54,391 DEBUG : BROWSER_OUTPUT: 12:40:56 INFO - 2015-12-09 12:40:56,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46827/tests/dromaeo/cssquery-mootools.html) 12:40:56 INFO - 2015-12-09 12:40:56,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 145469440 12:40:56 INFO - 2015-12-09 12:40:56,792 DEBUG : BROWSER_OUTPUT: 12:43:58 INFO - 2015-12-09 12:43:58,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46827/tests/dromaeo/cssquery-prototype.html) 12:43:59 INFO - 2015-12-09 12:43:59,171 DEBUG : BROWSER_OUTPUT: RSS: Main: 144273408 12:43:59 INFO - 2015-12-09 12:43:59,171 DEBUG : BROWSER_OUTPUT: 12:47:01 INFO - 2015-12-09 12:47:01,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46827/tests/dromaeo/cssquery-yui.html) 12:47:02 INFO - 2015-12-09 12:47:02,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 145145856 12:47:02 INFO - 2015-12-09 12:47:02,364 DEBUG : BROWSER_OUTPUT: 12:50:04 INFO - 2015-12-09 12:50:04,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/dromaeo/cssquery-yui.html (next: http://localhost:46827/tests/dromaeo/cssquery-dojo.html) 12:50:04 INFO - 2015-12-09 12:50:04,889 DEBUG : BROWSER_OUTPUT: RSS: Main: 146640896 12:50:04 INFO - 2015-12-09 12:50:04,889 DEBUG : BROWSER_OUTPUT: 12:50:04 INFO - 2015-12-09 12:50:04,890 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:50:04 INFO - 2015-12-09 12:50:04,890 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:50:04 INFO - 2015-12-09 12:50:04,891 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:50:04 INFO - 2015-12-09 12:50:04,891 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:50:04 INFO - 2015-12-09 12:50:04,892 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2624.842509449434;2654.1639383594165;2663.8668066596665;2670.292372521282;2677.3975855432523;4522.344260082286;4677.508861569533;4692.788824502897;4706.929396059062;4763.2378819388905;4571.702839315451;4642.675012749109;4662.114198302329;4673.883152921178;4677;4124.257633625946;4383.408239887623;4439.489458712257;4457.175422546839;4490.169318676039;4204.810783514734;4386.363977223301;4443.688941774077;4446.244138496447;4446.533114023029;4291.377750226231;4298.978505107486;4378.846740364103;4402.207602631525;4415.690901636886;4352.238358287319;4365.2142614329405;4390.056137930328;4393.9121217575785;4415.2935530315;4204.495460544754;4320.13597280542;4368.082702632451;4399.23013472641;4445.110977804452;4621.098885717286;4690.061987602459;4721.504242054569;4733.9763301183275;4769.666123371366;5078.933423980969;5092.770825312869;5111.437741848394;5113.258577506241;5116.411612664517;4914.16459201933;5014.548690617826;5025.572826309768;5120.641555091145;5196.870078248036;4564.064366804797;4736.526347365236;4811.78346974387;4826.372571565744;4873.02539492103;5244.239585260116;5280.867978300574;5286.920696189561;5306.734663266821;5342.519173274346;4824.228123500223;4930.260460930889;5039.84880453587;5069.847904562869;5091;4887;4912.901741965212;4913.434954980223;5054.949450505522;5151.6136289778415;5029.094762942632;5029.421616514074;5030.044291584661;5031.52200540948;5035.093683137071;4929.433115191727;4933.358663373739;4944;4952.257161425743;5031.924521132186;4017.6384125428854;4092.4270602115726;4104.692148088905;4193.727407718549;4234.174336004449;3613.1870329175727;3615.475756015363;3636.563612366533;3643.0892276930767;3664;4266.146770645822;4304.612584867377;4323.265044942367;4331.393604895317;4339.4792624884585;4865.051314993613;4978.5270399312;5069.695818250917;5157.793688252428;5214.061468935628;4326.6538676905775;4334.393184954109;4350.869473915787;4362.280223763107;4394.604485596312;4251.702380833312;4464.665150113755;4481.910361792746;4502.729836209838;4519.796609152596;4701.130290896195;4766.428028636655;4807.278908163804;4822.180229361087;4864.343313652612;5066.873328166826;5089.8727531812;5133.7689803958165;5133.948660513347;5196.792128314976;4633.768311584475;4756.357891684578;4821.662483626113;4841.370621819141;4868.318435419115;4980.327655766425;4994.525520075587;5000.424951130666;5007.098722230034;5090.287359769709;5052.5705315048635;5141.974290128675;5145.948540514547;5174.404943431403;5180.171172612364;4778.976105119452;4861.975690121527;4875.0493653737185;4973.428055773487;5015.849524514125;4880.633952453509;4890.5353991372185;4903.632227583017;5031.320771695774;5045.899082018413;4926.187179115549;4941.50584941503;4961.727105009115;4961.975190124026;4970.3290055842;5028.145215313332;5080;5084.745762711776;5085.059264036166;5136.7945282189785;4705.435347758291;4734.786934587883;4802.807887684454;4821.831235906727;4830.7101573905675 12:50:04 INFO - 2015-12-09 12:50:04,896 DEBUG : BROWSER_OUTPUT: |1;ext.html;521.8199721096222;528.1259515501846;528.4741682026385;531.5163201486647;537.188844844285;35365;35925.28149437013;35970;35975.82012089942;36003.639963600355;39142.21715565687;39789.60210397895;39813.203735925264;39999.60000399995;40011.399829002585;7780.183080776522;7886.974693289893;7902.960485197566;7909;7917.049954005527;7624.0851097868335;7769.766906992771;7776.53340799551;7825.843483130334;7828.804279892991;7797.844043119134;7802.258785415376;7850.3327217186325;7851.882221766678;7859;7790.8441831163345;7829;7846.372290216826;7855.057393112806;7864.213578642119;7706.922930770676;7781.3385862201785;7788.649510771972;7795.454318197729;7804.3756499479905;36454.63545364539;36610.45084323737;36641.26717465663;36892.81553592215;37070.25859482795;2940.5148150555133;3005.068428787083;3037.331787006855;3054.8167109973474;3412.266362732;27638;27949.441011179864;28038.71961280402;28043;28336.858315708494;3399.8640054397792;3403.3193361327835;3497.632748561415;3502.894913152584;3576.9642303576893;215625;216036;217485;218374;218865.9999999984;52309.7384513075;52328.73835630798;52442.47557524452;52752.736236318575;53035.20447193295;48463.51536484661;49357.25964110469;56857.14714279289;57381;57890.421095789345;12180.086493512845;12194.085443591766;12230.877691223151;12289.139760216878;12310.199837010565;9889.653862114936;9919.851202231972;9927.702168934944;9975.201983841276;10017.69946901594;18098.185581648857;18349.816501835077;18404.907975460035;18414.815851841577;18510.907445462686;7080.787576372717;7197.71209151628;7291.671874765649;7292.270772922665;7367.77896663101;887.6183241206214;890.7862113092812;911.5670056723136;935.8689783430325;946.5267366316841;21999.2300269493;22046.559068818533;22407.21574744909;23333.883330583238;24149.275521734377;952.9285303602257;959.2134449751137;991.8264303746815;1007.2596641468515;1065.4992153687754;12923.22460652364;13044.152130111512;13094.738105238033;13282.66793330155;13361.532346368025;272714;276584;276996;277044;278476;45185.54814451879;45313.093738125055;45487.09025819465;45547.54452455499;45759.5424045762;1206.5234232478122;1219.4207751318054;1221.2794451273792;1232.0697873105928;1234.8086046662602;23817.931529806523;24285.514289713752;24317.392065197804;24459.143929962367;24510.142145024838;37926.62073379231;38288;38377.040573984756;38384.42423363707;38413.423798642485;255503;257716;258941;258988;259246;28278.717212828433;28985.275368115967;29408;29473;29490;34249.31501369909;34397.82801085978;34559;34896.47655285223;35137.29725405529;31352.37295254128;31365;31980.360392792478;32082.83958580192;32607.18482037968;32258.677413225567;32351.67648323581;33829.66170338265;34023.149421264665;34282.314353713286;30152.547711783904;30397.088087357413;30762;30821.8458907713;30897.227569310948;27774.305642359104;29088.619864400072;29731.702682972893;29962.25094372658;31552;22647.20734774275;23210.419739506648;23465.530689386458;23512.6473102907;23545.41136471602 12:50:04 INFO - 2015-12-09 12:50:04,897 DEBUG : BROWSER_OUTPUT: |2;jquery.html;269.13473183714365;269.451665859975;271.1364304689564;274.308741970235;276.2678900912582;13305.334733263346;13937.860621393784;15168.924155379222;15598.999999999985;15631.3747450102;8975.910240897589;9561.235101191905;9573.952130239339;11393.48729307181;15636.374545018214;4616.538346165382;4733.881652958687;4739.549742774431;4741.549552792497;4760.738159401231;4684.3676103726075;4773.928391074137;4962.305277261186;4983.078130545842;4986.276989836471;4870.391201099863;4928.728919909404;4930.063287975273;4945.085159245533;4948.38145231846;4972.477889821571;5002.049610573979;5008.524190201943;5021.497850214986;5033.496650334974;4760.95239047612;4864.854054378375;5040.117979353635;5073.365829271341;5077.441481437039;10695.304805187638;10923.235373523856;10939.070179034792;12610.432530536147;19611.411657650293;1884.7926728059902;1898.6677331466938;1908.265317852623;1908.6659834529041;1962.2739586352998;9126.634934602675;10244.795104097951;11592.014678752315;12956.80564791529;13009.154404963647;1650.867930565552;1707.26587567346;1735.8958462492292;1738.4871462918343;1790.9612424793588;50306.7484662578;51242.23136652953;51884.48115518872;54761.726191369184;56244.43755562433;8910.663400489979;9114.772130696652;9288.767780805534;9307.06929307064;9415.15263626277;11891.513560804899;11898.821517677241;11920.880791191978;11926.821097683542;11960.76078478443;6861.4853885958755;6905.75829845953;6907.102076729993;6943.618101004392;6948.235694073648;6564.916788729806;6611.86776264472;6621.404073633396;6644.335566443414;6645.833854153588;3756.042209236627;3978.1645854370904;4020.0552870075508;4032;4059.1475790083823;1619.3684463059417;1643.4494444361274;1646.5060481855396;1661.2192269633254;1681.28545368218;862.7713655881197;866.5493943149653;870.3124531620076;888.560162719458;927.324668331854;14144.36350364236;14779.482718104815;14957.252137393087;15050;15053.322600483005;841.5539763925129;845.6828689241535;850.1965642467932;887.5251740318898;925.8750068740768;8393.874091888627;8974.14745599167;9411.152996230236;9708.708738737849;9771.853422198672;487925;491278;497052;497524;498030;72696;74285.25714742784;75618.81621245973;76183.61908190534;79096;1061.596593294543;1069.0699091790036;1093.2565855218368;1126.9718257043476;1127.5658871334595;14426.927865360605;14662.340194691478;14860.925695371887;14985.775213372026;14987.250637468302;31457.685423145474;34547;34769.30461390707;34967.82516087403;35788.64211357853;36993.44509832408;39285.2142957145;39867.60132398639;40355.59644403518;41369.79315103405;8546.658133674584;8700.825983480168;8722.171393717586;8806.559672016501;8847.380683352361;10168.593256269667;13002.479900803863;16009.759853601972;16565.834341656428;16958.576035598715;13319.200847949154;13575.592732218049;13877.653058673613;13958.790618140532;14550;10741.409222492526;12822.358882056047;13237.338133093499;13274.070815042855;13819.654508637364;14619.269036548343;14644;14865.405383784528;15119.622009449851;15209.543713688607;8677.783055423664;8780.25367843715;8849.601767920587;8867.645294188418;9038.819223615623;11431.199816012799;14391.496297629532;14414.42342306296;14792.260386980823;14845.183514906785 12:50:04 INFO - 2015-12-09 12:50:04,897 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1461.6199788055103;1651.5128037229017;1706.5392344067102;1707.0355249284153;1727.861771058315;5778.3643799182055;5898.587098903078;6409.807705768822;6633.568818026825;6635.071090047397;6543.2148142222995;6639.767608133716;6749.527533072687;6750.426213771835;6756.594604323732;1938.9515262118455;1953.8241558259754;1956.6086782643456;1964.4106767969624;1971.733815934852;2044.7750747417772;2068.1934045722182;2076.3044380132674;2105.52625659227;2112.0812446585705;1978.297704314969;2001.5696625225573;2024.6861736430876;2030.7360043194365;2035.4199053269822;2036.6537688592975;2058.166442590753;2061.0828181459333;2061.4949337412354;2066.173530587777;1984.9106790194332;2024.180207016161;2027.2397850805949;2029.2593203480624;2034.8779073255653;6872.759453419107;6962.756303529352;7007.509474336798;7009.579425234451;7015.8596828063155;4131.834726610932;4176.832926682929;4196.223698615766;4218.11419601884;4219.578042195786;2692.5422678144764;2719;2741.1776467059804;2756.9172924812087;2767.5433553463854;822.4366309078241;846.8856704344958;851.2508992086986;876.8071024374627;879.5821984557348;9246.676366327214;9281.67514137002;9292.256619470494;9292.53537323131;9297.256219502424;3790.3745881929726;3808.2383523295453;3839.8080095995088;3876.7673939563715;3885.2812229737588;8046.235607617267;8058.11360750317;8110.026796784424;8134.83730325402;8144.226298501633;4213.536510983789;4244.957550424518;4247.426597409372;4258.361245813153;4273.18809426208;3167.984160079231;3253.0403530958424;3683.318586061587;3869.8258578364043;3881.3595756700392;3283.113559338965;3327.03515980363;3342.331533693271;3362.159460134966;3367.848446819899;1033.9069483746498;1040.1107053469327;1051.3113910388709;1061.8991195836384;1068.5458680060942;1166.5742004168587;1176.7293522489874;1196.9825648198962;1215.501644325822;1220.45079714129;6444.387783160592;6489.837754056092;6498.252700939453;6536.575122617015;6549.083128362033;1068.4154661111859;1108.3239224073309;1132.2753437799815;1135.239389608964;1147.0708725932022;5220.608454365862;5249.527542521191;5348.171033489815;5364.114921038063;5376.516113549799;8336.958315208385;8342.66629334832;8374.916250837536;8482.491050536988;8491.278241349431;8102.270795628304;8171.142030086874;8271.503709777433;8365.07984121746;8393.706220282384;6580.276169621337;6604.1084453599115;6611.537192396486;6661.700223489955;6679.799606011828;6324.146240257691;6363.61818290904;6431.935680643133;6461.160049193575;6483.740650374121;7382.815429614087;7510.737124200846;7528.623568821427;7538.547687138789;7579.166291708018;7466.477346585687;7685.423593230642;7733.613319334123;7743.070831500256;7744.49660772048;5176.7152806596;5298.576113910955;5862.794802181903;5969.04495280753;5970.791022314198;6247.718852651551;6331.430171284606;6429.164208652845;6448.709808058555;6466.676666166767;6235.1003100628;6250.187475628321;6268.780592679234;6339.112524246517;6416.454601358937;6173.259208894961;6192.349803270592;6202.56582039271;6248.656323902229;6321.968390158204;6430.7749228776765;6472.449841763503;6475.320091390525;6478.4169424752;6492.48060155177;5884.35272120075;5892.646441213541;5898.9115163273445;5911.379305173067;5915.615484993462;5918.526517878646;5947.940520594739;6000.489958353589;6024.246969128859;6049.122877182872 12:50:04 INFO - 2015-12-09 12:50:04,898 DEBUG : BROWSER_OUTPUT: |4;prototype.html;251.14860622489763;252.400548696845;258.3090233625053;259.2171641642239;259.9636050952867;5508.476694714006;5534;5543.722813859306;5599.076152434844;5618.690971996539;5345.7594408251625;5538.169274608811;5549.5837812164145;5549.694766787825;5554.777808887639;4161.916761664765;4175;4178.415021896922;4183.644390226835;4186.058136919184;4176.624103830654;4176.937345939813;4177.916441671165;4181.937270940938;4182.937255941163;3971.9801400992956;4094.283500387435;4136.21411931732;4139.441175441307;4147.274227010261;4068.471098757172;4076.5515793262716;4079.122988557445;4081.8979525511654;4088.121053973395;3500.3524347995703;3502.0719509330047;3503.667151620592;3505.8422370993367;3511.1046683095647;5324.627276090675;5345.7594408251725;5349.491798279158;5353.223782551547;5355.464453554652;4562;4711.552402521755;4715.750326163569;4720.103180395714;4727.101850648401;5646.870625874801;5778.59549831512;5787.305523337226;5787.536997040269;5799.797007104731;3781.1681430085337;3793.070697679086;3807.961920380816;3809.676177524886;3812.6377994090517;6082.908756368658;6131.96934015327;6138.662373569452;6147.47746441553;6151.384861513858;3813.7139714521522;3867.5358956925347;3887.9805600971813;3892.746971446847;3910.804459777;3965.306071437487;3968.3650615901893;3969.702272329587;3973.6423721864594;3977.105151340925;4670.859874203779;4683.110209060335;4684.6486513510945;4688.038952014897;4689.6717229793585;5835.44563266489;5845.298564172242;5848.853778655568;5853.590248682552;5861.70691465425;1373.2653030628567;1401.075290308412;1403.1721284442228;1403.3754979034231;1404.2978510744629;870.9738707838775;879.2614204068614;886.4769785826394;894.6779159502574;896.7040876510736;4947.381577302837;4960.23116416956;4963.6525443218625;5014.498550144956;5025.321581586439;5989.520838332923;6024.367441418588;6025.8192254232445;6027.336992930774;6042.909356359658;4982.701037937735;4987.650864439454;4988.72562009093;4997.200447928314;5004.4995500450395;3191.3776813521604;3221.7422606191917;3268.117608245808;3292.1275861896615;3308.4210263204322;5725.112607545754;5744.1096630021575;5746.626469279567;5750.367459579443;5764.510016648632;6306.148669929501;6322.430981211713;6324.608586111048;6359.332270111664;6374.426301632875;5653.321601407857;5735.053716136874;5748.568857335633;5753.446569426232;5761.654300741969;6129.2032035835055;6144.4777193937225;6148.292946311052;6159.4456498915315;6171.506279497539;5989.3711160329285;5996.220491336098;6017.097435384728;6017.518598512021;6029.668368239789;5693.3168019837885;5708.600397972268;5737.454941780524;5742.856428589319;5747.683877386784;3739.1960728442427;3842.4044273137706;3848.07646164924;3848.288066707668;3850.4801851749653;6125.356837532173;6129.141920131275;6134.601250918676;6137.60105593135;6141.754329826936;5896.734646940984;5902.586818922634;5907.4683278505145;5915.852103697442;5918.348981611933;5719.685417302088;5797.188393624811;5855.443732845373;5865.736041878211;5866.823995280149;5740.512056475246;5742.741576628978;5751.223584816164;5753.079507278815;5760.654360738369;5890.4993075587345;5903.852403689943;5915.201447804491;5918.733656985532;5923.940760592339;5633.8309850704545;5765.769369225184;5767.711614419179;5768.365479797303;5777.306723193244 12:50:04 INFO - 2015-12-09 12:50:04,900 DEBUG : BROWSER_OUTPUT: |5;yui.html;651.0624700431375;654.8297442664906;656.8948968165093;659.1464054050005;708.4898872811575;11190.160737944656;11402.429878506084;11427.828582571257;11458.083353331735;11492.425378731072;11695.415229238546;11707.765844683123;11734.29594224347;11778.882211177886;11867.228630139034;759.7454852624378;792.5640897506378;812.3135950122166;813.4915677701437;814.7107776739261;802.743122200896;805.3154818404367;808.0465051239535;811.4725428471481;812.3704129299811;835.3692961813853;840.8318336332727;846.0101681033175;846.018618402653;848.088305072047;828.5981299069977;832.0223737108934;834.3992325525642;838.6477679374677;838.9790255243606;616.6669998200966;617.7776000639766;620.2433031701318;621.26069976728;622.0389498225253;12229.388530573437;12362.567310144103;12363.258204507758;12366.258024518467;12370.443330050079;11157.163212759075;11187.216894817366;11239.66281011571;11359;11590;9179.586918588613;9378.390404623746;9391.34260601758;9400.811983760286;9522.238220942378;3151.3382189739955;3218.243712727507;3246.188452886778;3248.870045198189;3267.2322004329203;40714.79642601768;40952.79523602393;41137.588624113676;41179.382309265384;41215.1756964862;8568.528730919734;8632.611532481053;8666.6100025499;8683.305335573139;8786.516741579275;15784.131872746879;15843.683126337408;15889.682206355808;15943.282552285174;15988.200589970455;6302.71637776292;6319.05214217871;6377.457916077093;6389.265234498;6447.4197322241225;3324.7838890472526;3426.2462258303135;3501.6848483636595;3545.9290814183573;3643.1620727232353;2709.6477457930737;2739.0824073935455;2739.7123302052996;2750.2849259192353;2753.20157154427;473.6684320975331;479.2619366176119;484.10440684733663;485.82995951416723;491.5453205784635;427.6429181633371;518.3235877180316;545.3455852976444;610.1457958857635;633.4362417448475;7395.889061664079;7470.103587569418;7715.575643339558;7968.800779980547;8006.439549231614;472.510951165542;526.3920172201114;612.3294991983771;638.237306418825;662.68522451835;3288.391647545164;3349.179451034512;3454.222799870009;3495.7727747696317;3523.5771707395274;52356.73821630944;52854.82871027751;52939.205911911355;53093;53110.46889531132;45546.77226613912;45947;45949.78351515362;46004.539954600696;46089.30866037012;42054.94862628398;42083.78958105251;42357.788211058745;42416.57583424126;43219;6954.269801670954;7571.3564347031115;8108.918910811052;8235.547044912588;8664.740057798275;32759.67240327566;33086;33356.499652505714;34594.308113837076;35970.10074748152;44426;44565;45232.54767452284;45429;46081.76959115317;10475.94762026185;11014.284071535325;11179.329240245612;11236.101111910864;11343.602973895873;11504.827427588425;11576.652700419001;11621.941890290494;11627.302361858316;11715.707107322045;10519.631812886511;10568;10579.10077643409;10957.287776294515;10973.670789876316;10529.894701053197;10585.682429527127;10600.204984626029;10608.469576520989;10785.946070269913;10701.304415212986;10748.301360411548;10762.892371076188;10909.890901090888;10989.230753847474;9149.862752058858;9251.444913305224;9255.814883702424;9406.05939406054;9747.220222382051;8822.338324625807;9055.456672599665;9060.728178154666;9200.447973121634;9297.209737172416 12:50:04 INFO - 2015-12-09 12:50:04,900 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:50:04 INFO - 2015-12-09 12:50:04,900 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:50:04 INFO - 2015-12-09 12:50:04,900 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,326 12:50:04 INFO - 2015-12-09 12:50:04,900 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:50:04 INFO - 2015-12-09 12:50:04,900 DEBUG : BROWSER_OUTPUT: __startTimestamp1449694204889__endTimestamp 12:50:04 INFO - 2015-12-09 12:50:04,900 DEBUG : BROWSER_OUTPUT: 12:50:04 INFO - 2015-12-09 12:50:04,900 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:50:04 INFO - 2015-12-09 12:50:04,900 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:50:04 INFO - 2015-12-09 12:50:04,900 DEBUG : BROWSER_OUTPUT: 12:50:04 INFO - 2015-12-09 12:50:04,900 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4671.60 Median:4821.66 stddev:510.91 (10.6%) stddev-sans-first:486.59 12:50:04 INFO - 2015-12-09 12:50:04,900 DEBUG : BROWSER_OUTPUT: Values: 2624.8 2654.2 2663.9 2670.3 2677.4 4522.3 4677.5 4692.8 4706.9 4763.2 4571.7 4642.7 4662.1 4673.9 4677.0 4124.3 4383.4 4439.5 4457.2 4490.2 4204.8 4386.4 4443.7 4446.2 4446.5 4291.4 4299.0 4378.8 4402.2 4415.7 4352.2 4365.2 4390.1 4393.9 4415.3 4204.5 4320.1 4368.1 4399.2 4445.1 4621.1 4690.1 4721.5 4734.0 4769.7 5078.9 5092.8 5111.4 5113.3 5116.4 4914.2 5014.5 5025.6 5120.6 5196.9 4564.1 4736.5 4811.8 4826.4 4873.0 5244.2 5280.9 5286.9 5306.7 5342.5 4824.2 4930.3 5039.8 5069.8 5091.0 4887.0 4912.9 4913.4 5054.9 5151.6 5029.1 5029.4 5030.0 5031.5 5035.1 4929.4 4933.4 4944.0 4952.3 5031.9 4017.6 4092.4 4104.7 4193.7 4234.2 3613.2 3615.5 3636.6 3643.1 3664.0 4266.1 4304.6 4323.3 4331.4 4339.5 4865.1 4978.5 5069.7 5157.8 5214.1 4326.7 4334.4 4350.9 4362.3 4394.6 4251.7 4464.7 4481.9 4502.7 4519.8 4701.1 4766.4 4807.3 4822.2 4864.3 5066.9 5089.9 5133.8 5133.9 5196.8 4633.8 4756.4 4821.7 4841.4 4868.3 4980.3 4994.5 5000.4 5007.1 5090.3 5052.6 5142.0 5145.9 5174.4 5180.2 4779.0 4862.0 4875.0 4973.4 5015.8 4880.6 4890.5 4903.6 5031.3 5045.9 4926.2 4941.5 4961.7 4962.0 4970.3 5028.1 5080.0 5084.7 5085.1 5136.8 4705.4 4734.8 4802.8 4821.8 4830.7 12:50:04 INFO - 2015-12-09 12:50:04,900 DEBUG : BROWSER_OUTPUT: 12:50:04 INFO - 2015-12-09 12:50:04,901 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40338.09 Median:34340.07 stddev:65722.12 (191.4%) stddev-sans-first:65838.49 12:50:04 INFO - 2015-12-09 12:50:04,901 DEBUG : BROWSER_OUTPUT: Values: 521.8 528.1 528.5 531.5 537.2 35365.0 35925.3 35970.0 35975.8 36003.6 39142.2 39789.6 39813.2 39999.6 40011.4 7780.2 7887.0 7903.0 7909.0 7917.0 7624.1 7769.8 7776.5 7825.8 7828.8 7797.8 7802.3 7850.3 7851.9 7859.0 7790.8 7829.0 7846.4 7855.1 7864.2 7706.9 7781.3 7788.6 7795.5 7804.4 36454.6 36610.5 36641.3 36892.8 37070.3 2940.5 3005.1 3037.3 3054.8 3412.3 27638.0 27949.4 28038.7 28043.0 28336.9 3399.9 3403.3 3497.6 3502.9 3577.0 215625.0 216036.0 217485.0 218374.0 218866.0 52309.7 52328.7 52442.5 52752.7 53035.2 48463.5 49357.3 56857.1 57381.0 57890.4 12180.1 12194.1 12230.9 12289.1 12310.2 9889.7 9919.9 9927.7 9975.2 10017.7 18098.2 18349.8 18404.9 18414.8 18510.9 7080.8 7197.7 7291.7 7292.3 7367.8 887.6 890.8 911.6 935.9 946.5 21999.2 22046.6 22407.2 23333.9 24149.3 952.9 959.2 991.8 1007.3 1065.5 12923.2 13044.2 13094.7 13282.7 13361.5 272714.0 276584.0 276996.0 277044.0 278476.0 45185.5 45313.1 45487.1 45547.5 45759.5 1206.5 1219.4 1221.3 1232.1 1234.8 23817.9 24285.5 24317.4 24459.1 24510.1 37926.6 38288.0 38377.0 38384.4 38413.4 255503.0 257716.0 258941.0 258988.0 259246.0 28278.7 28985.3 29408.0 29473.0 29490.0 34249.3 34397.8 34559.0 34896.5 35137.3 31352.4 31365.0 31980.4 32082.8 32607.2 32258.7 32351.7 33829.7 34023.1 34282.3 30152.5 30397.1 30762.0 30821.8 30897.2 27774.3 29088.6 29731.7 29962.3 31552.0 22647.2 23210.4 23465.5 23512.6 23545.4 12:50:04 INFO - 2015-12-09 12:50:04,901 DEBUG : BROWSER_OUTPUT: 12:50:04 INFO - 2015-12-09 12:50:04,901 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26243.77 Median:21943.83 stddev:80791.46 (368.2%) stddev-sans-first:80994.56 12:50:04 INFO - 2015-12-09 12:50:04,902 DEBUG : BROWSER_OUTPUT: Values: 269.1 269.5 271.1 274.3 276.3 13305.3 13937.9 15168.9 15599.0 15631.4 8975.9 9561.2 9574.0 11393.5 15636.4 4616.5 4733.9 4739.5 4741.5 4760.7 4684.4 4773.9 4962.3 4983.1 4986.3 4870.4 4928.7 4930.1 4945.1 4948.4 4972.5 5002.0 5008.5 5021.5 5033.5 4761.0 4864.9 5040.1 5073.4 5077.4 10695.3 10923.2 10939.1 12610.4 19611.4 1884.8 1898.7 1908.3 1908.7 1962.3 9126.6 10244.8 11592.0 12956.8 13009.2 1650.9 1707.3 1735.9 1738.5 1791.0 50306.7 51242.2 51884.5 54761.7 56244.4 8910.7 9114.8 9288.8 9307.1 9415.2 11891.5 11898.8 11920.9 11926.8 11960.8 6861.5 6905.8 6907.1 6943.6 6948.2 6564.9 6611.9 6621.4 6644.3 6645.8 3756.0 3978.2 4020.1 4032.0 4059.1 1619.4 1643.4 1646.5 1661.2 1681.3 862.8 866.5 870.3 888.6 927.3 14144.4 14779.5 14957.3 15050.0 15053.3 841.6 845.7 850.2 887.5 925.9 8393.9 8974.1 9411.2 9708.7 9771.9 487925.0 491278.0 497052.0 497524.0 498030.0 72696.0 74285.3 75618.8 76183.6 79096.0 1061.6 1069.1 1093.3 1127.0 1127.6 14426.9 14662.3 14860.9 14985.8 14987.3 31457.7 34547.0 34769.3 34967.8 35788.6 36993.4 39285.2 39867.6 40355.6 41369.8 8546.7 8700.8 8722.2 8806.6 8847.4 10168.6 13002.5 16009.8 16565.8 16958.6 13319.2 13575.6 13877.7 13958.8 14550.0 10741.4 12822.4 13237.3 13274.1 13819.7 14619.3 14644.0 14865.4 15119.6 15209.5 8677.8 8780.3 8849.6 8867.6 9038.8 11431.2 14391.5 14414.4 14792.3 14845.2 12:50:04 INFO - 2015-12-09 12:50:04,902 DEBUG : BROWSER_OUTPUT: 12:50:04 INFO - 2015-12-09 12:50:04,902 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4857.40 Median:5933.23 stddev:2470.22 (41.6%) stddev-sans-first:2463.96 12:50:04 INFO - 2015-12-09 12:50:04,902 DEBUG : BROWSER_OUTPUT: Values: 1461.6 1651.5 1706.5 1707.0 1727.9 5778.4 5898.6 6409.8 6633.6 6635.1 6543.2 6639.8 6749.5 6750.4 6756.6 1939.0 1953.8 1956.6 1964.4 1971.7 2044.8 2068.2 2076.3 2105.5 2112.1 1978.3 2001.6 2024.7 2030.7 2035.4 2036.7 2058.2 2061.1 2061.5 2066.2 1984.9 2024.2 2027.2 2029.3 2034.9 6872.8 6962.8 7007.5 7009.6 7015.9 4131.8 4176.8 4196.2 4218.1 4219.6 2692.5 2719.0 2741.2 2756.9 2767.5 822.4 846.9 851.3 876.8 879.6 9246.7 9281.7 9292.3 9292.5 9297.3 3790.4 3808.2 3839.8 3876.8 3885.3 8046.2 8058.1 8110.0 8134.8 8144.2 4213.5 4245.0 4247.4 4258.4 4273.2 3168.0 3253.0 3683.3 3869.8 3881.4 3283.1 3327.0 3342.3 3362.2 3367.8 1033.9 1040.1 1051.3 1061.9 1068.5 1166.6 1176.7 1197.0 1215.5 1220.5 6444.4 6489.8 6498.3 6536.6 6549.1 1068.4 1108.3 1132.3 1135.2 1147.1 5220.6 5249.5 5348.2 5364.1 5376.5 8337.0 8342.7 8374.9 8482.5 8491.3 8102.3 8171.1 8271.5 8365.1 8393.7 6580.3 6604.1 6611.5 6661.7 6679.8 6324.1 6363.6 6431.9 6461.2 6483.7 7382.8 7510.7 7528.6 7538.5 7579.2 7466.5 7685.4 7733.6 7743.1 7744.5 5176.7 5298.6 5862.8 5969.0 5970.8 6247.7 6331.4 6429.2 6448.7 6466.7 6235.1 6250.2 6268.8 6339.1 6416.5 6173.3 6192.3 6202.6 6248.7 6322.0 6430.8 6472.4 6475.3 6478.4 6492.5 5884.4 5892.6 5898.9 5911.4 5915.6 5918.5 5947.9 6000.5 6024.2 6049.1 12:50:04 INFO - 2015-12-09 12:50:04,902 DEBUG : BROWSER_OUTPUT: 12:50:04 INFO - 2015-12-09 12:50:04,902 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4771.98 Median:5549.64 stddev:1485.48 (26.8%) stddev-sans-first:1450.38 12:50:04 INFO - 2015-12-09 12:50:04,902 DEBUG : BROWSER_OUTPUT: Values: 251.1 252.4 258.3 259.2 260.0 5508.5 5534.0 5543.7 5599.1 5618.7 5345.8 5538.2 5549.6 5549.7 5554.8 4161.9 4175.0 4178.4 4183.6 4186.1 4176.6 4176.9 4177.9 4181.9 4182.9 3972.0 4094.3 4136.2 4139.4 4147.3 4068.5 4076.6 4079.1 4081.9 4088.1 3500.4 3502.1 3503.7 3505.8 3511.1 5324.6 5345.8 5349.5 5353.2 5355.5 4562.0 4711.6 4715.8 4720.1 4727.1 5646.9 5778.6 5787.3 5787.5 5799.8 3781.2 3793.1 3808.0 3809.7 3812.6 6082.9 6132.0 6138.7 6147.5 6151.4 3813.7 3867.5 3888.0 3892.7 3910.8 3965.3 3968.4 3969.7 3973.6 3977.1 4670.9 4683.1 4684.6 4688.0 4689.7 5835.4 5845.3 5848.9 5853.6 5861.7 1373.3 1401.1 1403.2 1403.4 1404.3 871.0 879.3 886.5 894.7 896.7 4947.4 4960.2 4963.7 5014.5 5025.3 5989.5 6024.4 6025.8 6027.3 6042.9 4982.7 4987.7 4988.7 4997.2 5004.5 3191.4 3221.7 3268.1 3292.1 3308.4 5725.1 5744.1 5746.6 5750.4 5764.5 6306.1 6322.4 6324.6 6359.3 6374.4 5653.3 5735.1 5748.6 5753.4 5761.7 6129.2 6144.5 6148.3 6159.4 6171.5 5989.4 5996.2 6017.1 6017.5 6029.7 5693.3 5708.6 5737.5 5742.9 5747.7 3739.2 3842.4 3848.1 3848.3 3850.5 6125.4 6129.1 6134.6 6137.6 6141.8 5896.7 5902.6 5907.5 5915.9 5918.3 5719.7 5797.2 5855.4 5865.7 5866.8 5740.5 5742.7 5751.2 5753.1 5760.7 5890.5 5903.9 5915.2 5918.7 5923.9 5633.8 5765.8 5767.7 5768.4 5777.3 12:50:04 INFO - 2015-12-09 12:50:04,902 DEBUG : BROWSER_OUTPUT: 12:50:04 INFO - 2015-12-09 12:50:04,903 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12677.45 Median:45746.89 stddev:14703.26 (32.1%) stddev-sans-first:14716.76 12:50:04 INFO - 2015-12-09 12:50:04,904 DEBUG : BROWSER_OUTPUT: Values: 651.1 654.8 656.9 659.1 708.5 11190.2 11402.4 11427.8 11458.1 11492.4 11695.4 11707.8 11734.3 11778.9 11867.2 759.7 792.6 812.3 813.5 814.7 802.7 805.3 808.0 811.5 812.4 835.4 840.8 846.0 846.0 848.1 828.6 832.0 834.4 838.6 839.0 616.7 617.8 620.2 621.3 622.0 12229.4 12362.6 12363.3 12366.3 12370.4 11157.2 11187.2 11239.7 11359.0 11590.0 9179.6 9378.4 9391.3 9400.8 9522.2 3151.3 3218.2 3246.2 3248.9 3267.2 40714.8 40952.8 41137.6 41179.4 41215.2 8568.5 8632.6 8666.6 8683.3 8786.5 15784.1 15843.7 15889.7 15943.3 15988.2 6302.7 6319.1 6377.5 6389.3 6447.4 3324.8 3426.2 3501.7 3545.9 3643.2 2709.6 2739.1 2739.7 2750.3 2753.2 473.7 479.3 484.1 485.8 491.5 427.6 518.3 545.3 610.1 633.4 7395.9 7470.1 7715.6 7968.8 8006.4 472.5 526.4 612.3 638.2 662.7 3288.4 3349.2 3454.2 3495.8 3523.6 52356.7 52854.8 52939.2 53093.0 53110.5 45546.8 45947.0 45949.8 46004.5 46089.3 42054.9 42083.8 42357.8 42416.6 43219.0 6954.3 7571.4 8108.9 8235.5 8664.7 32759.7 33086.0 33356.5 34594.3 35970.1 44426.0 44565.0 45232.5 45429.0 46081.8 10475.9 11014.3 11179.3 11236.1 11343.6 11504.8 11576.7 11621.9 11627.3 11715.7 10519.6 10568.0 10579.1 10957.3 10973.7 10529.9 10585.7 10600.2 10608.5 10785.9 10701.3 10748.3 10762.9 10909.9 10989.2 9149.9 9251.4 9255.8 9406.1 9747.2 8822.3 9055.5 9060.7 9200.4 9297.2 12:50:04 INFO - 2015-12-09 12:50:04,904 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:50:04 INFO - 2015-12-09 12:50:04,904 DEBUG : BROWSER_OUTPUT: 12:50:05 INFO - 2015-12-09 12:50:05,616 INFO : Browser exited with error code: 0 12:50:05 INFO - 2015-12-09 12:50:05,635 INFO : Completed test dromaeo_css (00:18:33) 12:50:05 INFO - 2015-12-09 12:50:05,635 INFO : Starting test kraken 12:50:05 INFO - 2015-12-09 12:50:05,635 DEBUG : operating with platform_type : linux_ 12:50:05 INFO - 2015-12-09 12:50:05,635 INFO : Initialising browser for kraken test... 12:50:05 INFO - 2015-12-09 12:50:05,641 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9E7oNv/profile http://localhost:46827/getInfo.html 12:50:09 INFO - 2015-12-09 12:50:09,821 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:50:09 INFO - 2015-12-09 12:50:09,821 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:50:09 INFO - 2015-12-09 12:50:09,821 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:50:09 INFO - 2015-12-09 12:50:09,821 DEBUG : BROWSER_OUTPUT: __metrics 12:50:09 INFO - 2015-12-09 12:50:09,938 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:50:10 INFO - 2015-12-09 12:50:10,804 INFO : Browser initialized. 12:50:10 INFO - 2015-12-09 12:50:10,805 INFO : Running cycle 1/1 for kraken test... 12:50:10 INFO - 2015-12-09 12:50:10,805 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9E7oNv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:50:22 INFO - 2015-12-09 12:50:22,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 143331328 12:50:22 INFO - 2015-12-09 12:50:22,884 DEBUG : BROWSER_OUTPUT: 12:50:25 INFO - 2015-12-09 12:50:25,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46827/tests/kraken/driver.html?testName=audio-beat-detection) 12:50:26 INFO - 2015-12-09 12:50:26,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 143056896 12:50:26 INFO - 2015-12-09 12:50:26,126 DEBUG : BROWSER_OUTPUT: 12:50:28 INFO - 2015-12-09 12:50:28,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46827/tests/kraken/driver.html?testName=audio-dft) 12:50:29 INFO - 2015-12-09 12:50:29,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 143208448 12:50:29 INFO - 2015-12-09 12:50:29,485 DEBUG : BROWSER_OUTPUT: 12:50:32 INFO - 2015-12-09 12:50:32,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46827/tests/kraken/driver.html?testName=audio-fft) 12:50:33 INFO - 2015-12-09 12:50:33,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 138424320 12:50:33 INFO - 2015-12-09 12:50:33,020 DEBUG : BROWSER_OUTPUT: 12:50:35 INFO - 2015-12-09 12:50:35,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46827/tests/kraken/driver.html?testName=audio-oscillator) 12:50:35 INFO - 2015-12-09 12:50:35,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 139538432 12:50:35 INFO - 2015-12-09 12:50:35,697 DEBUG : BROWSER_OUTPUT: 12:50:37 INFO - 2015-12-09 12:50:37,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46827/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:50:38 INFO - 2015-12-09 12:50:38,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 140988416 12:50:38 INFO - 2015-12-09 12:50:38,545 DEBUG : BROWSER_OUTPUT: 12:50:41 INFO - 2015-12-09 12:50:41,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46827/tests/kraken/driver.html?testName=imaging-darkroom) 12:50:42 INFO - 2015-12-09 12:50:42,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 139710464 12:50:42 INFO - 2015-12-09 12:50:42,186 DEBUG : BROWSER_OUTPUT: 12:50:45 INFO - 2015-12-09 12:50:45,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46827/tests/kraken/driver.html?testName=imaging-desaturate) 12:50:46 INFO - 2015-12-09 12:50:46,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 138010624 12:50:46 INFO - 2015-12-09 12:50:46,279 DEBUG : BROWSER_OUTPUT: 12:50:49 INFO - 2015-12-09 12:50:49,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46827/tests/kraken/driver.html?testName=json-parse-financial) 12:50:49 INFO - 2015-12-09 12:50:49,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 137637888 12:50:49 INFO - 2015-12-09 12:50:49,798 DEBUG : BROWSER_OUTPUT: 12:50:51 INFO - 2015-12-09 12:50:51,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46827/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:50:52 INFO - 2015-12-09 12:50:52,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 140824576 12:50:52 INFO - 2015-12-09 12:50:52,190 DEBUG : BROWSER_OUTPUT: 12:50:54 INFO - 2015-12-09 12:50:54,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46827/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:50:54 INFO - 2015-12-09 12:50:54,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 141574144 12:50:54 INFO - 2015-12-09 12:50:54,706 DEBUG : BROWSER_OUTPUT: 12:50:56 INFO - 2015-12-09 12:50:56,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46827/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:50:57 INFO - 2015-12-09 12:50:57,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 141529088 12:50:57 INFO - 2015-12-09 12:50:57,473 DEBUG : BROWSER_OUTPUT: 12:51:00 INFO - 2015-12-09 12:51:00,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46827/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:51:00 INFO - 2015-12-09 12:51:00,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 141565952 12:51:00 INFO - 2015-12-09 12:51:00,712 DEBUG : BROWSER_OUTPUT: 12:51:03 INFO - 2015-12-09 12:51:03,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46827/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:51:03 INFO - 2015-12-09 12:51:03,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 141524992 12:51:03 INFO - 2015-12-09 12:51:03,914 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46827/tests/kraken/driver.html?testName=ai-astar) 12:51:05 INFO - 2015-12-09 12:51:05,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 141799424 12:51:05 INFO - 2015-12-09 12:51:05,946 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,950 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:51:05 INFO - 2015-12-09 12:51:05,950 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:51:05 INFO - 2015-12-09 12:51:05,950 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:51:05 INFO - 2015-12-09 12:51:05,950 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:51:05 INFO - 2015-12-09 12:51:05,950 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;111;117;114;115;126;114;114;116;114 12:51:05 INFO - 2015-12-09 12:51:05,950 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;165;140;162;165;134;165;153;132;168;130 12:51:05 INFO - 2015-12-09 12:51:05,950 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;166;163;162;167;173;162;162;164;164 12:51:05 INFO - 2015-12-09 12:51:05,950 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;72;163;73;72;73;73;158;73 12:51:05 INFO - 2015-12-09 12:51:05,950 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;128;96;95;95;130;94;94;139 12:51:05 INFO - 2015-12-09 12:51:05,950 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;111;110;110;110;111 12:51:05 INFO - 2015-12-09 12:51:05,950 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;150;147;149;149;149;147;147;147;148 12:51:05 INFO - 2015-12-09 12:51:05,950 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;96;96;96;97;96;96 12:51:05 INFO - 2015-12-09 12:51:05,951 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;76;76;74;74;74;74;74;83;77;73 12:51:05 INFO - 2015-12-09 12:51:05,951 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;73;70;69;69;68;68 12:51:05 INFO - 2015-12-09 12:51:05,951 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;86;87;83;95;86;85;89;84 12:51:05 INFO - 2015-12-09 12:51:05,951 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;124;140;124;132;128;128;142;139;141 12:51:05 INFO - 2015-12-09 12:51:05,951 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;152;168;142;150;140;148;149;147;139 12:51:05 INFO - 2015-12-09 12:51:05,951 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;75;73;71;70;72;71;70;70;73;70 12:51:05 INFO - 2015-12-09 12:51:05,951 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:51:05 INFO - 2015-12-09 12:51:05,951 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:51:05 INFO - 2015-12-09 12:51:05,951 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,790 12:51:05 INFO - 2015-12-09 12:51:05,951 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:51:05 INFO - 2015-12-09 12:51:05,951 DEBUG : BROWSER_OUTPUT: __startTimestamp1449694265948__endTimestamp 12:51:05 INFO - 2015-12-09 12:51:05,951 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,954 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:51:05 INFO - 2015-12-09 12:51:05,955 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:51:05 INFO - 2015-12-09 12:51:05,955 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,955 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.60 Median:115.00 stddev:3.98 (3.5%) stddev-sans-first:4.21 12:51:05 INFO - 2015-12-09 12:51:05,955 DEBUG : BROWSER_OUTPUT: Values: 115.0 111.0 117.0 114.0 115.0 126.0 114.0 114.0 116.0 114.0 12:51:05 INFO - 2015-12-09 12:51:05,955 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,955 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.40 Median:163.50 stddev:15.68 (9.6%) stddev-sans-first:15.84 12:51:05 INFO - 2015-12-09 12:51:05,955 DEBUG : BROWSER_OUTPUT: Values: 165.0 140.0 162.0 165.0 134.0 165.0 153.0 132.0 168.0 130.0 12:51:05 INFO - 2015-12-09 12:51:05,955 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,955 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:3.47 (2.1%) stddev-sans-first:3.56 12:51:05 INFO - 2015-12-09 12:51:05,955 DEBUG : BROWSER_OUTPUT: Values: 162.0 166.0 163.0 162.0 167.0 173.0 162.0 162.0 164.0 164.0 12:51:05 INFO - 2015-12-09 12:51:05,955 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,955 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.20 Median:73.00 stddev:37.07 (50.8%) stddev-sans-first:38.73 12:51:05 INFO - 2015-12-09 12:51:05,955 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 163.0 73.0 72.0 73.0 73.0 158.0 73.0 12:51:05 INFO - 2015-12-09 12:51:05,955 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,955 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:94.00 stddev:18.46 (19.6%) stddev-sans-first:19.07 12:51:05 INFO - 2015-12-09 12:51:05,956 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 128.0 96.0 95.0 95.0 130.0 94.0 94.0 139.0 12:51:05 INFO - 2015-12-09 12:51:05,956 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,956 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:51:05 INFO - 2015-12-09 12:51:05,956 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 110.0 111.0 12:51:05 INFO - 2015-12-09 12:51:05,956 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,956 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.50 stddev:1.15 (0.8%) stddev-sans-first:1.17 12:51:05 INFO - 2015-12-09 12:51:05,956 DEBUG : BROWSER_OUTPUT: Values: 147.0 150.0 147.0 149.0 149.0 149.0 147.0 147.0 147.0 148.0 12:51:05 INFO - 2015-12-09 12:51:05,956 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,956 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:51:05 INFO - 2015-12-09 12:51:05,956 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 12:51:05 INFO - 2015-12-09 12:51:05,956 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,956 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.50 Median:75.00 stddev:2.92 (3.9%) stddev-sans-first:3.09 12:51:05 INFO - 2015-12-09 12:51:05,956 DEBUG : BROWSER_OUTPUT: Values: 76.0 76.0 74.0 74.0 74.0 74.0 74.0 83.0 77.0 73.0 12:51:05 INFO - 2015-12-09 12:51:05,956 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,956 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:1.56 (2.3%) stddev-sans-first:1.62 12:51:05 INFO - 2015-12-09 12:51:05,957 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 73.0 70.0 69.0 69.0 68.0 68.0 12:51:05 INFO - 2015-12-09 12:51:05,957 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,957 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:3.47 (4.0%) stddev-sans-first:3.57 12:51:05 INFO - 2015-12-09 12:51:05,957 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 86.0 87.0 83.0 95.0 86.0 85.0 89.0 84.0 12:51:05 INFO - 2015-12-09 12:51:05,957 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,957 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:135.50 stddev:7.37 (5.4%) stddev-sans-first:7.44 12:51:05 INFO - 2015-12-09 12:51:05,957 DEBUG : BROWSER_OUTPUT: Values: 126.0 124.0 140.0 124.0 132.0 128.0 128.0 142.0 139.0 141.0 12:51:05 INFO - 2015-12-09 12:51:05,957 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,957 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:148.50 stddev:8.59 (5.8%) stddev-sans-first:8.67 12:51:05 INFO - 2015-12-09 12:51:05,957 DEBUG : BROWSER_OUTPUT: Values: 140.0 152.0 168.0 142.0 150.0 140.0 148.0 149.0 147.0 139.0 12:51:05 INFO - 2015-12-09 12:51:05,957 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,957 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:1.72 (2.4%) stddev-sans-first:1.27 12:51:05 INFO - 2015-12-09 12:51:05,957 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 71.0 70.0 72.0 71.0 70.0 70.0 73.0 70.0 12:51:05 INFO - 2015-12-09 12:51:05,957 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:51:05 INFO - 2015-12-09 12:51:05,957 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,840 INFO : Browser exited with error code: 0 12:51:06 INFO - 2015-12-09 12:51:06,894 INFO : Completed test kraken (00:01:01) 12:51:06 INFO - 2015-12-09 12:51:06,894 INFO : Starting test v8_7 12:51:06 INFO - 2015-12-09 12:51:06,894 DEBUG : operating with platform_type : linux_ 12:51:06 INFO - 2015-12-09 12:51:06,894 INFO : Initialising browser for v8_7 test... 12:51:06 INFO - 2015-12-09 12:51:06,900 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZQDn7V/profile http://localhost:46827/getInfo.html 12:51:11 INFO - 2015-12-09 12:51:11,020 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:51:11 INFO - 2015-12-09 12:51:11,020 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:51:11 INFO - 2015-12-09 12:51:11,020 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:51:11 INFO - 2015-12-09 12:51:11,020 DEBUG : BROWSER_OUTPUT: __metrics 12:51:11 INFO - 2015-12-09 12:51:11,136 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:51:12 INFO - 2015-12-09 12:51:12,036 INFO : Browser initialized. 12:51:12 INFO - 2015-12-09 12:51:12,037 INFO : Running cycle 1/1 for v8_7 test... 12:51:12 INFO - 2015-12-09 12:51:12,037 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZQDn7V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:51:24 INFO - 2015-12-09 12:51:24,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 143433728 12:51:24 INFO - 2015-12-09 12:51:24,090 DEBUG : BROWSER_OUTPUT: 12:51:45 INFO - 2015-12-09 12:51:45,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46827/tests/v8_7/run.html (next: http://localhost:46827/tests/v8_7/run.html) 12:51:45 INFO - 2015-12-09 12:51:45,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 138543104 12:51:45 INFO - 2015-12-09 12:51:45,789 DEBUG : BROWSER_OUTPUT: 12:51:45 INFO - 2015-12-09 12:51:45,790 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:51:45 INFO - 2015-12-09 12:51:45,790 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:51:45 INFO - 2015-12-09 12:51:45,790 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:51:45 INFO - 2015-12-09 12:51:45,790 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:51:45 INFO - 2015-12-09 12:51:45,790 DEBUG : BROWSER_OUTPUT: |0;Richards;167.8697330871244 12:51:45 INFO - 2015-12-09 12:51:45,790 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.32246108228318 12:51:45 INFO - 2015-12-09 12:51:45,790 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.8622420524261 12:51:45 INFO - 2015-12-09 12:51:45,791 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5154.639175257732 12:51:45 INFO - 2015-12-09 12:51:45,791 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1083.4236186348862 12:51:45 INFO - 2015-12-09 12:51:45,791 DEBUG : BROWSER_OUTPUT: |5;Earley;721.5007215007215 12:51:45 INFO - 2015-12-09 12:51:45,791 DEBUG : BROWSER_OUTPUT: |6;Boyer;12256.09756097561 12:51:45 INFO - 2015-12-09 12:51:45,791 DEBUG : BROWSER_OUTPUT: |7;RegExp;25974.358974358973 12:51:45 INFO - 2015-12-09 12:51:45,791 DEBUG : BROWSER_OUTPUT: |8;Splay;597.1563981042653 12:51:45 INFO - 2015-12-09 12:51:45,792 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 12:51:45 INFO - 2015-12-09 12:51:45,792 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:51:45 INFO - 2015-12-09 12:51:45,792 DEBUG : BROWSER_OUTPUT: __startTimestamp1449694305783__endTimestamp 12:51:45 INFO - 2015-12-09 12:51:45,792 DEBUG : BROWSER_OUTPUT: 12:51:45 INFO - 2015-12-09 12:51:45,792 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:51:45 INFO - 2015-12-09 12:51:45,792 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:51:45 INFO - 2015-12-09 12:51:45,792 DEBUG : BROWSER_OUTPUT: 12:51:45 INFO - 2015-12-09 12:51:45,792 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.87 Median:167.87 stddev:0.00 (0.0%) 12:51:45 INFO - 2015-12-09 12:51:45,792 DEBUG : BROWSER_OUTPUT: Values: 167.9 12:51:45 INFO - 2015-12-09 12:51:45,792 DEBUG : BROWSER_OUTPUT: 12:51:45 INFO - 2015-12-09 12:51:45,792 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.32 Median:185.32 stddev:0.00 (0.0%) 12:51:45 INFO - 2015-12-09 12:51:45,792 DEBUG : BROWSER_OUTPUT: Values: 185.3 12:51:45 INFO - 2015-12-09 12:51:45,792 DEBUG : BROWSER_OUTPUT: 12:51:45 INFO - 2015-12-09 12:51:45,793 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 12:51:45 INFO - 2015-12-09 12:51:45,793 DEBUG : BROWSER_OUTPUT: Values: 278.9 12:51:45 INFO - 2015-12-09 12:51:45,793 DEBUG : BROWSER_OUTPUT: 12:51:45 INFO - 2015-12-09 12:51:45,793 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 12:51:45 INFO - 2015-12-09 12:51:45,793 DEBUG : BROWSER_OUTPUT: Values: 5154.6 12:51:45 INFO - 2015-12-09 12:51:45,793 DEBUG : BROWSER_OUTPUT: 12:51:45 INFO - 2015-12-09 12:51:45,793 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1083.42 Median:1083.42 stddev:0.00 (0.0%) 12:51:45 INFO - 2015-12-09 12:51:45,793 DEBUG : BROWSER_OUTPUT: Values: 1083.4 12:51:45 INFO - 2015-12-09 12:51:45,793 DEBUG : BROWSER_OUTPUT: 12:51:45 INFO - 2015-12-09 12:51:45,793 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:721.50 Median:721.50 stddev:0.00 (0.0%) 12:51:45 INFO - 2015-12-09 12:51:45,793 DEBUG : BROWSER_OUTPUT: Values: 721.5 12:51:45 INFO - 2015-12-09 12:51:45,794 DEBUG : BROWSER_OUTPUT: 12:51:45 INFO - 2015-12-09 12:51:45,794 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 12:51:45 INFO - 2015-12-09 12:51:45,794 DEBUG : BROWSER_OUTPUT: Values: 12256.1 12:51:45 INFO - 2015-12-09 12:51:45,794 DEBUG : BROWSER_OUTPUT: 12:51:45 INFO - 2015-12-09 12:51:45,794 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25974.36 Median:25974.36 stddev:0.00 (0.0%) 12:51:45 INFO - 2015-12-09 12:51:45,794 DEBUG : BROWSER_OUTPUT: Values: 25974.4 12:51:45 INFO - 2015-12-09 12:51:45,794 DEBUG : BROWSER_OUTPUT: 12:51:45 INFO - 2015-12-09 12:51:45,795 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.16 Median:597.16 stddev:0.00 (0.0%) 12:51:45 INFO - 2015-12-09 12:51:45,795 DEBUG : BROWSER_OUTPUT: Values: 597.2 12:51:45 INFO - 2015-12-09 12:51:45,795 DEBUG : BROWSER_OUTPUT: 12:51:45 INFO - 2015-12-09 12:51:45,795 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 12:51:45 INFO - 2015-12-09 12:51:45,795 DEBUG : BROWSER_OUTPUT: Values: 4830.9 12:51:45 INFO - 2015-12-09 12:51:45,795 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:51:45 INFO - 2015-12-09 12:51:45,795 DEBUG : BROWSER_OUTPUT: 12:51:46 INFO - 2015-12-09 12:51:46,652 INFO : Browser exited with error code: 0 12:51:46 INFO - 2015-12-09 12:51:46,671 INFO : Completed test v8_7 (00:00:39) 12:51:46 INFO - 2015-12-09 12:51:46,805 INFO : Completed test suite (00:20:15) 12:51:46 INFO - 2015-12-09 12:51:46,805 DEBUG : Working with test: dromaeo_css 12:51:46 INFO - 2015-12-09 12:51:46,805 DEBUG : Generating results file: dromaeo_css 12:51:46 INFO - 2015-12-09 12:51:46,807 DEBUG : Working with test: kraken 12:51:46 INFO - 2015-12-09 12:51:46,807 DEBUG : Generating results file: kraken 12:51:46 INFO - 2015-12-09 12:51:46,807 INFO : javascript benchmark 12:51:46 INFO - 2015-12-09 12:51:46,807 DEBUG : Working with test: v8_7 12:51:46 INFO - 2015-12-09 12:51:46,807 DEBUG : Generating results file: v8_7 12:51:46 INFO - 2015-12-09 12:51:46,808 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:51:46 INFO - 2015-12-09 12:51:46,934 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 12:51:46 INFO - 2015-12-09 12:51:46,934 DEBUG : process_Request line: dromaeo_css 6268.99 graph.html#tests=[[72,132,43]] 12:51:46 INFO - 2015-12-09 12:51:46,934 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:51:47 INFO - 2015-12-09 12:51:47,051 DEBUG : process_Request line: kraken 1564.30 graph.html#tests=[[232,132,43]] 12:51:47 INFO - 2015-12-09 12:51:47,052 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:51:47 INFO - 2015-12-09 12:51:47,171 DEBUG : process_Request line: v8_7 21322.19 graph.html#tests=[[230,132,43]] 12:51:47 INFO - 2015-12-09 12:51:47,172 INFO : javascript benchmark 12:51:47 INFO - 2015-12-09 12:51:47,176 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2624.842509449434, 2654.1639383594165, 2663.8668066596665, 2670.292372521282, 2677.3975855432523, 4522.344260082286, 4677.508861569533, 4692.788824502897, 4706.929396059062, 4763.2378819388905, 4571.702839315451, 4642.675012749109, 4662.114198302329, 4673.883152921178, 4677.0, 4124.257633625946, 4383.408239887623, 4439.489458712257, 4457.175422546839, 4490.169318676039, 4204.810783514734, 4386.363977223301, 4443.688941774077, 4446.244138496447, 4446.533114023029, 4291.377750226231, 4298.978505107486, 4378.846740364103, 4402.207602631525, 4415.690901636886, 4352.238358287319, 4365.2142614329405, 4390.056137930328, 4393.9121217575785, 4415.2935530315, 4204.495460544754, 4320.13597280542, 4368.082702632451, 4399.23013472641, 4445.110977804452, 4621.098885717286, 4690.061987602459, 4721.504242054569, 4733.9763301183275, 4769.666123371366, 5078.933423980969, 5092.770825312869, 5111.437741848394, 5113.258577506241, 5116.411612664517, 4914.16459201933, 5014.548690617826, 5025.572826309768, 5120.641555091145, 5196.870078248036, 4564.064366804797, 4736.526347365236, 4811.78346974387, 4826.372571565744, 4873.02539492103, 5244.239585260116, 5280.867978300574, 5286.920696189561, 5306.734663266821, 5342.519173274346, 4824.228123500223, 4930.260460930889, 5039.84880453587, 5069.847904562869, 5091.0, 4887.0, 4912.901741965212, 4913.434954980223, 5054.949450505522, 5151.6136289778415, 5029.094762942632, 5029.421616514074, 5030.044291584661, 5031.52200540948, 5035.093683137071, 4929.433115191727, 4933.358663373739, 4944.0, 4952.257161425743, 5031.924521132186, 4017.6384125428854, 4092.4270602115726, 4104.692148088905, 4193.727407718549, 4234.174336004449, 3613.1870329175727, 3615.475756015363, 3636.563612366533, 3643.0892276930767, 3664.0, 4266.146770645822, 4304.612584867377, 4323.265044942367, 4331.393604895317, 4339.4792624884585, 4865.051314993613, 4978.5270399312, 5069.695818250917, 5157.793688252428, 5214.061468935628, 4326.6538676905775, 4334.393184954109, 4350.869473915787, 4362.280223763107, 4394.604485596312, 4251.702380833312, 4464.665150113755, 4481.910361792746, 4502.729836209838, 4519.796609152596, 4701.130290896195, 4766.428028636655, 4807.278908163804, 4822.180229361087, 4864.343313652612, 5066.873328166826, 5089.8727531812, 5133.7689803958165, 5133.948660513347, 5196.792128314976, 4633.768311584475, 4756.357891684578, 4821.662483626113, 4841.370621819141, 4868.318435419115, 4980.327655766425, 4994.525520075587, 5000.424951130666, 5007.098722230034, 5090.287359769709, 5052.5705315048635, 5141.974290128675, 5145.948540514547, 5174.404943431403, 5180.171172612364, 4778.976105119452, 4861.975690121527, 4875.0493653737185, 4973.428055773487, 5015.849524514125, 4880.633952453509, 4890.5353991372185, 4903.632227583017, 5031.320771695774, 5045.899082018413, 4926.187179115549, 4941.50584941503, 4961.727105009115, 4961.975190124026, 4970.3290055842, 5028.145215313332, 5080.0, 5084.745762711776, 5085.059264036166, 5136.7945282189785, 4705.435347758291, 4734.786934587883, 4802.807887684454, 4821.831235906727, 4830.7101573905675], "unit": "ms", "name": "dojo.html", "value": 4638.396462311089}, {"lowerIsBetter": false, "replicates": [521.8199721096222, 528.1259515501846, 528.4741682026385, 531.5163201486647, 537.188844844285, 35365.0, 35925.28149437013, 35970.0, 35975.82012089942, 36003.639963600355, 39142.21715565687, 39789.60210397895, 39813.203735925264, 39999.60000399995, 40011.399829002585, 7780.183080776522, 7886.974693289893, 7902.960485197566, 7909.0, 7917.049954005527, 7624.0851097868335, 7769.766906992771, 7776.53340799551, 7825.843483130334, 7828.804279892991, 7797.844043119134, 7802.258785415376, 7850.3327217186325, 7851.882221766678, 7859.0, 7790.8441831163345, 7829.0, 7846.372290216826, 7855.057393112806, 7864.213578642119, 7706.922930770676, 7781.3385862201785, 7788.649510771972, 7795.454318197729, 7804.3756499479905, 36454.63545364539, 36610.45084323737, 36641.26717465663, 36892.81553592215, 37070.25859482795, 2940.5148150555133, 3005.068428787083, 3037.331787006855, 3054.8167109973474, 3412.266362732, 27638.0, 27949.441011179864, 28038.71961280402, 28043.0, 28336.858315708494, 3399.8640054397792, 3403.3193361327835, 3497.632748561415, 3502.894913152584, 3576.9642303576893, 215625.0, 216036.0, 217485.0, 218374.0, 218865.9999999984, 52309.7384513075, 52328.73835630798, 52442.47557524452, 52752.736236318575, 53035.20447193295, 48463.51536484661, 49357.25964110469, 56857.14714279289, 57381.0, 57890.421095789345, 12180.086493512845, 12194.085443591766, 12230.877691223151, 12289.139760216878, 12310.199837010565, 9889.653862114936, 9919.851202231972, 9927.702168934944, 9975.201983841276, 10017.69946901594, 18098.185581648857, 18349.816501835077, 18404.907975460035, 18414.815851841577, 18510.907445462686, 7080.787576372717, 7197.71209151628, 7291.671874765649, 7292.270772922665, 7367.77896663101, 887.6183241206214, 890.7862113092812, 911.5670056723136, 935.8689783430325, 946.5267366316841, 21999.2300269493, 22046.559068818533, 22407.21574744909, 23333.883330583238, 24149.275521734377, 952.9285303602257, 959.2134449751137, 991.8264303746815, 1007.2596641468515, 1065.4992153687754, 12923.22460652364, 13044.152130111512, 13094.738105238033, 13282.66793330155, 13361.532346368025, 272714.0, 276584.0, 276996.0, 277044.0, 278476.0, 45185.54814451879, 45313.093738125055, 45487.09025819465, 45547.54452455499, 45759.5424045762, 1206.5234232478122, 1219.4207751318054, 1221.2794451273792, 1232.0697873105928, 1234.8086046662602, 23817.931529806523, 24285.514289713752, 24317.392065197804, 24459.143929962367, 24510.142145024838, 37926.62073379231, 38288.0, 38377.040573984756, 38384.42423363707, 38413.423798642485, 255503.0, 257716.0, 258941.0, 258988.0, 259246.0, 28278.717212828433, 28985.275368115967, 29408.0, 29473.0, 29490.0, 34249.31501369909, 34397.82801085978, 34559.0, 34896.47655285223, 35137.29725405529, 31352.37295254128, 31365.0, 31980.360392792478, 32082.83958580192, 32607.18482037968, 32258.677413225567, 32351.67648323581, 33829.66170338265, 34023.149421264665, 34282.314353713286, 30152.547711783904, 30397.088087357413, 30762.0, 30821.8458907713, 30897.227569310948, 27774.305642359104, 29088.619864400072, 29731.702682972893, 29962.25094372658, 31552.0, 22647.20734774275, 23210.419739506648, 23465.530689386458, 23512.6473102907, 23545.41136471602], "unit": "ms", "name": "ext.html", "value": 16410.68312320501}, {"lowerIsBetter": false, "replicates": [269.13473183714365, 269.451665859975, 271.1364304689564, 274.308741970235, 276.2678900912582, 13305.334733263346, 13937.860621393784, 15168.924155379222, 15598.999999999985, 15631.3747450102, 8975.910240897589, 9561.235101191905, 9573.952130239339, 11393.48729307181, 15636.374545018214, 4616.538346165382, 4733.881652958687, 4739.549742774431, 4741.549552792497, 4760.738159401231, 4684.3676103726075, 4773.928391074137, 4962.305277261186, 4983.078130545842, 4986.276989836471, 4870.391201099863, 4928.728919909404, 4930.063287975273, 4945.085159245533, 4948.38145231846, 4972.477889821571, 5002.049610573979, 5008.524190201943, 5021.497850214986, 5033.496650334974, 4760.95239047612, 4864.854054378375, 5040.117979353635, 5073.365829271341, 5077.441481437039, 10695.304805187638, 10923.235373523856, 10939.070179034792, 12610.432530536147, 19611.411657650293, 1884.7926728059902, 1898.6677331466938, 1908.265317852623, 1908.6659834529041, 1962.2739586352998, 9126.634934602675, 10244.795104097951, 11592.014678752315, 12956.80564791529, 13009.154404963647, 1650.867930565552, 1707.26587567346, 1735.8958462492292, 1738.4871462918343, 1790.9612424793588, 50306.7484662578, 51242.23136652953, 51884.48115518872, 54761.726191369184, 56244.43755562433, 8910.663400489979, 9114.772130696652, 9288.767780805534, 9307.06929307064, 9415.15263626277, 11891.513560804899, 11898.821517677241, 11920.880791191978, 11926.821097683542, 11960.76078478443, 6861.4853885958755, 6905.75829845953, 6907.102076729993, 6943.618101004392, 6948.235694073648, 6564.916788729806, 6611.86776264472, 6621.404073633396, 6644.335566443414, 6645.833854153588, 3756.042209236627, 3978.1645854370904, 4020.0552870075508, 4032.0, 4059.1475790083823, 1619.3684463059417, 1643.4494444361274, 1646.5060481855396, 1661.2192269633254, 1681.28545368218, 862.7713655881197, 866.5493943149653, 870.3124531620076, 888.560162719458, 927.324668331854, 14144.36350364236, 14779.482718104815, 14957.252137393087, 15050.0, 15053.322600483005, 841.5539763925129, 845.6828689241535, 850.1965642467932, 887.5251740318898, 925.8750068740768, 8393.874091888627, 8974.14745599167, 9411.152996230236, 9708.708738737849, 9771.853422198672, 487925.0, 491278.0, 497052.0, 497524.0, 498030.0, 72696.0, 74285.25714742784, 75618.81621245973, 76183.61908190534, 79096.0, 1061.596593294543, 1069.0699091790036, 1093.2565855218368, 1126.9718257043476, 1127.5658871334595, 14426.927865360605, 14662.340194691478, 14860.925695371887, 14985.775213372026, 14987.250637468302, 31457.685423145474, 34547.0, 34769.30461390707, 34967.82516087403, 35788.64211357853, 36993.44509832408, 39285.2142957145, 39867.60132398639, 40355.59644403518, 41369.79315103405, 8546.658133674584, 8700.825983480168, 8722.171393717586, 8806.559672016501, 8847.380683352361, 10168.593256269667, 13002.479900803863, 16009.759853601972, 16565.834341656428, 16958.576035598715, 13319.200847949154, 13575.592732218049, 13877.653058673613, 13958.790618140532, 14550.0, 10741.409222492526, 12822.358882056047, 13237.338133093499, 13274.070815042855, 13819.654508637364, 14619.269036548343, 14644.0, 14865.405383784528, 15119.622009449851, 15209.543713688607, 8677.783055423664, 8780.25367843715, 8849.601767920587, 8867.645294188418, 9038.819223615623, 11431.199816012799, 14391.496297629532, 14414.42342306296, 14792.260386980823, 14845.183514906785], "unit": "ms", "name": "jquery.html", "value": 8034.688009437629}, {"lowerIsBetter": false, "replicates": [1461.6199788055103, 1651.5128037229017, 1706.5392344067102, 1707.0355249284153, 1727.861771058315, 5778.3643799182055, 5898.587098903078, 6409.807705768822, 6633.568818026825, 6635.071090047397, 6543.2148142222995, 6639.767608133716, 6749.527533072687, 6750.426213771835, 6756.594604323732, 1938.9515262118455, 1953.8241558259754, 1956.6086782643456, 1964.4106767969624, 1971.733815934852, 2044.7750747417772, 2068.1934045722182, 2076.3044380132674, 2105.52625659227, 2112.0812446585705, 1978.297704314969, 2001.5696625225573, 2024.6861736430876, 2030.7360043194365, 2035.4199053269822, 2036.6537688592975, 2058.166442590753, 2061.0828181459333, 2061.4949337412354, 2066.173530587777, 1984.9106790194332, 2024.180207016161, 2027.2397850805949, 2029.2593203480624, 2034.8779073255653, 6872.759453419107, 6962.756303529352, 7007.509474336798, 7009.579425234451, 7015.8596828063155, 4131.834726610932, 4176.832926682929, 4196.223698615766, 4218.11419601884, 4219.578042195786, 2692.5422678144764, 2719.0, 2741.1776467059804, 2756.9172924812087, 2767.5433553463854, 822.4366309078241, 846.8856704344958, 851.2508992086986, 876.8071024374627, 879.5821984557348, 9246.676366327214, 9281.67514137002, 9292.256619470494, 9292.53537323131, 9297.256219502424, 3790.3745881929726, 3808.2383523295453, 3839.8080095995088, 3876.7673939563715, 3885.2812229737588, 8046.235607617267, 8058.11360750317, 8110.026796784424, 8134.83730325402, 8144.226298501633, 4213.536510983789, 4244.957550424518, 4247.426597409372, 4258.361245813153, 4273.18809426208, 3167.984160079231, 3253.0403530958424, 3683.318586061587, 3869.8258578364043, 3881.3595756700392, 3283.113559338965, 3327.03515980363, 3342.331533693271, 3362.159460134966, 3367.848446819899, 1033.9069483746498, 1040.1107053469327, 1051.3113910388709, 1061.8991195836384, 1068.5458680060942, 1166.5742004168587, 1176.7293522489874, 1196.9825648198962, 1215.501644325822, 1220.45079714129, 6444.387783160592, 6489.837754056092, 6498.252700939453, 6536.575122617015, 6549.083128362033, 1068.4154661111859, 1108.3239224073309, 1132.2753437799815, 1135.239389608964, 1147.0708725932022, 5220.608454365862, 5249.527542521191, 5348.171033489815, 5364.114921038063, 5376.516113549799, 8336.958315208385, 8342.66629334832, 8374.916250837536, 8482.491050536988, 8491.278241349431, 8102.270795628304, 8171.142030086874, 8271.503709777433, 8365.07984121746, 8393.706220282384, 6580.276169621337, 6604.1084453599115, 6611.537192396486, 6661.700223489955, 6679.799606011828, 6324.146240257691, 6363.61818290904, 6431.935680643133, 6461.160049193575, 6483.740650374121, 7382.815429614087, 7510.737124200846, 7528.623568821427, 7538.547687138789, 7579.166291708018, 7466.477346585687, 7685.423593230642, 7733.613319334123, 7743.070831500256, 7744.49660772048, 5176.7152806596, 5298.576113910955, 5862.794802181903, 5969.04495280753, 5970.791022314198, 6247.718852651551, 6331.430171284606, 6429.164208652845, 6448.709808058555, 6466.676666166767, 6235.1003100628, 6250.187475628321, 6268.780592679234, 6339.112524246517, 6416.454601358937, 6173.259208894961, 6192.349803270592, 6202.56582039271, 6248.656323902229, 6321.968390158204, 6430.7749228776765, 6472.449841763503, 6475.320091390525, 6478.4169424752, 6492.48060155177, 5884.35272120075, 5892.646441213541, 5898.9115163273445, 5911.379305173067, 5915.615484993462, 5918.526517878646, 5947.940520594739, 6000.489958353589, 6024.246969128859, 6049.122877182872], "unit": "ms", "name": "mootools.html", "value": 4032.479716249149}, {"lowerIsBetter": false, "replicates": [251.14860622489763, 252.400548696845, 258.3090233625053, 259.2171641642239, 259.9636050952867, 5508.476694714006, 5534.0, 5543.722813859306, 5599.076152434844, 5618.690971996539, 5345.7594408251625, 5538.169274608811, 5549.5837812164145, 5549.694766787825, 5554.777808887639, 4161.916761664765, 4175.0, 4178.415021896922, 4183.644390226835, 4186.058136919184, 4176.624103830654, 4176.937345939813, 4177.916441671165, 4181.937270940938, 4182.937255941163, 3971.9801400992956, 4094.283500387435, 4136.21411931732, 4139.441175441307, 4147.274227010261, 4068.471098757172, 4076.5515793262716, 4079.122988557445, 4081.8979525511654, 4088.121053973395, 3500.3524347995703, 3502.0719509330047, 3503.667151620592, 3505.8422370993367, 3511.1046683095647, 5324.627276090675, 5345.7594408251725, 5349.491798279158, 5353.223782551547, 5355.464453554652, 4562.0, 4711.552402521755, 4715.750326163569, 4720.103180395714, 4727.101850648401, 5646.870625874801, 5778.59549831512, 5787.305523337226, 5787.536997040269, 5799.797007104731, 3781.1681430085337, 3793.070697679086, 3807.961920380816, 3809.676177524886, 3812.6377994090517, 6082.908756368658, 6131.96934015327, 6138.662373569452, 6147.47746441553, 6151.384861513858, 3813.7139714521522, 3867.5358956925347, 3887.9805600971813, 3892.746971446847, 3910.804459777, 3965.306071437487, 3968.3650615901893, 3969.702272329587, 3973.6423721864594, 3977.105151340925, 4670.859874203779, 4683.110209060335, 4684.6486513510945, 4688.038952014897, 4689.6717229793585, 5835.44563266489, 5845.298564172242, 5848.853778655568, 5853.590248682552, 5861.70691465425, 1373.2653030628567, 1401.075290308412, 1403.1721284442228, 1403.3754979034231, 1404.2978510744629, 870.9738707838775, 879.2614204068614, 886.4769785826394, 894.6779159502574, 896.7040876510736, 4947.381577302837, 4960.23116416956, 4963.6525443218625, 5014.498550144956, 5025.321581586439, 5989.520838332923, 6024.367441418588, 6025.8192254232445, 6027.336992930774, 6042.909356359658, 4982.701037937735, 4987.650864439454, 4988.72562009093, 4997.200447928314, 5004.4995500450395, 3191.3776813521604, 3221.7422606191917, 3268.117608245808, 3292.1275861896615, 3308.4210263204322, 5725.112607545754, 5744.1096630021575, 5746.626469279567, 5750.367459579443, 5764.510016648632, 6306.148669929501, 6322.430981211713, 6324.608586111048, 6359.332270111664, 6374.426301632875, 5653.321601407857, 5735.053716136874, 5748.568857335633, 5753.446569426232, 5761.654300741969, 6129.2032035835055, 6144.4777193937225, 6148.292946311052, 6159.4456498915315, 6171.506279497539, 5989.3711160329285, 5996.220491336098, 6017.097435384728, 6017.518598512021, 6029.668368239789, 5693.3168019837885, 5708.600397972268, 5737.454941780524, 5742.856428589319, 5747.683877386784, 3739.1960728442427, 3842.4044273137706, 3848.07646164924, 3848.288066707668, 3850.4801851749653, 6125.356837532173, 6129.141920131275, 6134.601250918676, 6137.60105593135, 6141.754329826936, 5896.734646940984, 5902.586818922634, 5907.4683278505145, 5915.852103697442, 5918.348981611933, 5719.685417302088, 5797.188393624811, 5855.443732845373, 5865.736041878211, 5866.823995280149, 5740.512056475246, 5742.741576628978, 5751.223584816164, 5753.079507278815, 5760.654360738369, 5890.4993075587345, 5903.852403689943, 5915.201447804491, 5918.733656985532, 5923.940760592339, 5633.8309850704545, 5765.769369225184, 5767.711614419179, 5768.365479797303, 5777.306723193244], "unit": "ms", "name": "prototype.html", "value": 4265.953704403564}, {"lowerIsBetter": false, "replicates": [651.0624700431375, 654.8297442664906, 656.8948968165093, 659.1464054050005, 708.4898872811575, 11190.160737944656, 11402.429878506084, 11427.828582571257, 11458.083353331735, 11492.425378731072, 11695.415229238546, 11707.765844683123, 11734.29594224347, 11778.882211177886, 11867.228630139034, 759.7454852624378, 792.5640897506378, 812.3135950122166, 813.4915677701437, 814.7107776739261, 802.743122200896, 805.3154818404367, 808.0465051239535, 811.4725428471481, 812.3704129299811, 835.3692961813853, 840.8318336332727, 846.0101681033175, 846.018618402653, 848.088305072047, 828.5981299069977, 832.0223737108934, 834.3992325525642, 838.6477679374677, 838.9790255243606, 616.6669998200966, 617.7776000639766, 620.2433031701318, 621.26069976728, 622.0389498225253, 12229.388530573437, 12362.567310144103, 12363.258204507758, 12366.258024518467, 12370.443330050079, 11157.163212759075, 11187.216894817366, 11239.66281011571, 11359.0, 11590.0, 9179.586918588613, 9378.390404623746, 9391.34260601758, 9400.811983760286, 9522.238220942378, 3151.3382189739955, 3218.243712727507, 3246.188452886778, 3248.870045198189, 3267.2322004329203, 40714.79642601768, 40952.79523602393, 41137.588624113676, 41179.382309265384, 41215.1756964862, 8568.528730919734, 8632.611532481053, 8666.6100025499, 8683.305335573139, 8786.516741579275, 15784.131872746879, 15843.683126337408, 15889.682206355808, 15943.282552285174, 15988.200589970455, 6302.71637776292, 6319.05214217871, 6377.457916077093, 6389.265234498, 6447.4197322241225, 3324.7838890472526, 3426.2462258303135, 3501.6848483636595, 3545.9290814183573, 3643.1620727232353, 2709.6477457930737, 2739.0824073935455, 2739.7123302052996, 2750.2849259192353, 2753.20157154427, 473.6684320975331, 479.2619366176119, 484.10440684733663, 485.82995951416723, 491.5453205784635, 427.6429181633371, 518.3235877180316, 545.3455852976444, 610.1457958857635, 633.4362417448475, 7395.889061664079, 7470.103587569418, 7715.575643339558, 7968.800779980547, 8006.439549231614, 472.510951165542, 526.3920172201114, 612.3294991983771, 638.237306418825, 662.68522451835, 3288.391647545164, 3349.179451034512, 3454.222799870009, 3495.7727747696317, 3523.5771707395274, 52356.73821630944, 52854.82871027751, 52939.205911911355, 53093.0, 53110.46889531132, 45546.77226613912, 45947.0, 45949.78351515362, 46004.539954600696, 46089.30866037012, 42054.94862628398, 42083.78958105251, 42357.788211058745, 42416.57583424126, 43219.0, 6954.269801670954, 7571.3564347031115, 8108.918910811052, 8235.547044912588, 8664.740057798275, 32759.67240327566, 33086.0, 33356.499652505714, 34594.308113837076, 35970.10074748152, 44426.0, 44565.0, 45232.54767452284, 45429.0, 46081.76959115317, 10475.94762026185, 11014.284071535325, 11179.329240245612, 11236.101111910864, 11343.602973895873, 11504.827427588425, 11576.652700419001, 11621.941890290494, 11627.302361858316, 11715.707107322045, 10519.631812886511, 10568.0, 10579.10077643409, 10957.287776294515, 10973.670789876316, 10529.894701053197, 10585.682429527127, 10600.204984626029, 10608.469576520989, 10785.946070269913, 10701.304415212986, 10748.301360411548, 10762.892371076188, 10909.890901090888, 10989.230753847474, 9149.862752058858, 9251.444913305224, 9255.814883702424, 9406.05939406054, 9747.220222382051, 8822.338324625807, 9055.456672599665, 9060.728178154666, 9200.447973121634, 9297.209737172416], "unit": "ms", "name": "yui.html", "value": 5768.856847703968}], "name": "dromaeo_css", "value": 6268.988638210598}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 117.0, 114.0, 115.0, 126.0, 114.0, 114.0, 116.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 115.6}, {"lowerIsBetter": true, "replicates": [165.0, 140.0, 162.0, 165.0, 134.0, 165.0, 153.0, 132.0, 168.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.4}, {"lowerIsBetter": true, "replicates": [162.0, 166.0, 163.0, 162.0, 167.0, 173.0, 162.0, 162.0, 164.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 163.0, 73.0, 72.0, 73.0, 73.0, 158.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 90.2}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 128.0, 96.0, 95.0, 95.0, 130.0, 94.0, 94.0, 139.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [147.0, 150.0, 147.0, 149.0, 149.0, 149.0, 147.0, 147.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 74.0, 74.0, 74.0, 74.0, 74.0, 83.0, 77.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 75.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 73.0, 70.0, 69.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 87.0, 83.0, 95.0, 86.0, 85.0, 89.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [126.0, 124.0, 140.0, 124.0, 132.0, 128.0, 128.0, 142.0, 139.0, 141.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 132.4}, {"lowerIsBetter": true, "replicates": [140.0, 152.0, 168.0, 142.0, 150.0, 140.0, 148.0, 149.0, 147.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.5}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 71.0, 70.0, 72.0, 71.0, 70.0, 70.0, 73.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.5}], "name": "kraken", "value": 1564.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.8697330871244], "unit": "score", "name": "Richards", "value": 210.29401399999998}, {"lowerIsBetter": false, "replicates": [185.32246108228318], "unit": "score", "name": "DeltaBlue", "value": 356.77272800000003}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [1083.4236186348862], "unit": "score", "name": "RayTrace", "value": 683.0098469999997}, {"lowerIsBetter": false, "replicates": [721.5007215007215], "unit": "score", "name": "Earley", "value": 923.7177179999996}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [25974.358974358973], "unit": "score", "name": "RegExp", "value": 35.072472852912156}, {"lowerIsBetter": false, "replicates": [597.1563981042653], "unit": "score", "name": "Splay", "value": 136.4650873015873}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21322.18929494819}]} 12:51:47 INFO - RETURN: dromaeo_css: 6268.99 12:51:47 INFO - RETURN: kraken: 1564.30 12:51:47 INFO - RETURN: v8_7: 21322.19 12:51:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21322.19"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1564.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6268.99"}}} 12:51:47 INFO - Return code: 0 12:51:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:51:47 INFO - # TBPL SUCCESS # 12:51:47 INFO - Running post-action listener: _resource_record_post_action 12:51:47 INFO - Running post-run listener: _resource_record_post_run 12:51:48 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509341696; Read time: 8; Write time: 346820 12:51:48 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231424000; Read time: 0; Write time: 193852 12:51:48 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276893696; Read time: 8; Write time: 152900 12:51:48 INFO - Running post-run listener: _upload_blobber_files 12:51:48 INFO - Blob upload gear active. 12:51:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:51:48 INFO - Copying logs to upload dir... 12:51:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.615119 ========= master_lag: 0.58 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-09 12:51:48.648402) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 12:51:48.655891) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009995 build_url: 'https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 12:51:48.682449) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:51:48.682805) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1449689596.364544-1224919172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004621 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:51:48.733578) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 12:51:48.733929) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 12:51:48.734236) ========= ========= Total master_lag: 0.91 =========