builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1448301039.46 results: success (0) buildid: 20151123073219 builduid: c24c09f58e0d4bb7b4d21eec7a117cd6 revision: d3d286102ba7f8801e9dfe12d534f49554ba50c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:39.463542) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:39.464153) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:39.464498) ========= bash -c pwd in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006711 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:39.509677) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:39.510025) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:39.523388) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:39.523807) ========= rm -rf properties in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004642 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:39.572887) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:39.573174) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:39.573497) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:39.573784) ========= 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-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 09:50:39-- 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% 43.5M=0s 2015-11-23 09:50:39 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110241 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:39.696092) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:39.696390) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017062 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:39.746147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:39.746542) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d3d286102ba7f8801e9dfe12d534f49554ba50c0 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d3d286102ba7f8801e9dfe12d534f49554ba50c0 --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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 09:50:39,962 truncating revision to first 12 chars 2015-11-23 09:50:39,962 Setting DEBUG logging. 2015-11-23 09:50:39,962 attempt 1/10 2015-11-23 09:50:39,963 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d3d286102ba7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 09:50:40,219 unpacking tar archive at: mozilla-central-d3d286102ba7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.560114 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:40.358346) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:40.358639) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:40.392374) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:40.392701) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 09:50:40.393139) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-23 09:50:40.393612) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:50:40 INFO - MultiFileLogger online at 20151123 09:50:40 in /builds/slave/test-pgo 09:50:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:50:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:50:40 INFO - {'append_to_log': False, 09:50:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:50:40 INFO - 'blob_upload_branch': 'Firefox', 09:50:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:50:40 INFO - 'branch': 'Firefox', 09:50:40 INFO - 'buildbot_json_path': 'buildprops.json', 09:50:40 INFO - 'config_files': ('talos/linux_config.py',), 09:50:40 INFO - 'default_actions': ('clobber', 09:50:40 INFO - 'read-buildbot-config', 09:50:40 INFO - 'download-and-extract', 09:50:40 INFO - 'populate-webroot', 09:50:40 INFO - 'create-virtualenv', 09:50:40 INFO - 'install', 09:50:40 INFO - 'run-tests'), 09:50:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:50:40 INFO - 'download_minidump_stackwalk': True, 09:50:40 INFO - 'download_symbols': 'ondemand', 09:50:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:50:40 INFO - 'tooltool.py': '/tools/tooltool.py', 09:50:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:50:40 INFO - '/tools/misc-python/virtualenv.py')}, 09:50:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:50:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:50:40 INFO - 'installer_path': 'installer.exe', 09:50:40 INFO - 'log_level': 'info', 09:50:40 INFO - 'log_name': 'talos', 09:50:40 INFO - 'log_to_console': True, 09:50:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:50:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:50:40 INFO - 'opt_config_files': (), 09:50:40 INFO - 'pip_index': False, 09:50:40 INFO - 'sps_profile': False, 09:50:40 INFO - 'sps_profile_interval': 0, 09:50:40 INFO - 'suite': 'dromaeojs-e10s', 09:50:40 INFO - 'system_bits': '64', 09:50:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:50:40 INFO - 'title': 'talos-linux64-ix-038', 09:50:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:50:40 INFO - 'use_talos_json': True, 09:50:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:50:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:50:40 INFO - 'work_dir': 'build'} 09:50:40 INFO - ##### 09:50:40 INFO - ##### Running clobber step. 09:50:40 INFO - ##### 09:50:40 INFO - Running pre-action listener: _resource_record_pre_action 09:50:40 INFO - Running main action method: clobber 09:50:40 INFO - rmtree: /builds/slave/test-pgo/build 09:50:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:50:41 INFO - Running post-action listener: _resource_record_post_action 09:50:41 INFO - ##### 09:50:41 INFO - ##### Running read-buildbot-config step. 09:50:41 INFO - ##### 09:50:41 INFO - Running pre-action listener: _resource_record_pre_action 09:50:41 INFO - Running main action method: read_buildbot_config 09:50:41 INFO - Using buildbot properties: 09:50:41 INFO - { 09:50:41 INFO - "properties": { 09:50:41 INFO - "buildnumber": 559, 09:50:41 INFO - "product": "firefox", 09:50:41 INFO - "script_repo_revision": "production", 09:50:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:50:41 INFO - "repository": "", 09:50:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 09:50:41 INFO - "buildid": "20151123073219", 09:50:41 INFO - "slavename": "talos-linux64-ix-038", 09:50:41 INFO - "pgo_build": "True", 09:50:41 INFO - "basedir": "/builds/slave/test-pgo", 09:50:41 INFO - "project": "", 09:50:41 INFO - "platform": "ubuntu64_hw", 09:50:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:50:41 INFO - "slavebuilddir": "test", 09:50:41 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:50:41 INFO - "branch": "mozilla-central", 09:50:41 INFO - "repo_path": "mozilla-central", 09:50:41 INFO - "stage_platform": "linux64-pgo", 09:50:41 INFO - "builduid": "c24c09f58e0d4bb7b4d21eec7a117cd6", 09:50:41 INFO - "revision": "d3d286102ba7f8801e9dfe12d534f49554ba50c0" 09:50:41 INFO - }, 09:50:41 INFO - "sourcestamp": { 09:50:41 INFO - "repository": "", 09:50:41 INFO - "hasPatch": false, 09:50:41 INFO - "project": "", 09:50:41 INFO - "branch": "mozilla-central-linux64-pgo-talos", 09:50:41 INFO - "changes": [ 09:50:41 INFO - { 09:50:41 INFO - "category": null, 09:50:41 INFO - "files": [ 09:50:41 INFO - { 09:50:41 INFO - "url": null, 09:50:41 INFO - "name": "https://queue.taskcluster.net/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:50:41 INFO - } 09:50:41 INFO - ], 09:50:41 INFO - "repository": "", 09:50:41 INFO - "rev": "d3d286102ba7f8801e9dfe12d534f49554ba50c0", 09:50:41 INFO - "who": "sendchange", 09:50:41 INFO - "when": 1448301031, 09:50:41 INFO - "number": 6695969, 09:50:41 INFO - "comments": "", 09:50:41 INFO - "project": "", 09:50:41 INFO - "at": "Mon 23 Nov 2015 09:50:31", 09:50:41 INFO - "branch": "mozilla-central-linux64-pgo-talos", 09:50:41 INFO - "revlink": "", 09:50:41 INFO - "properties": [ 09:50:41 INFO - [ 09:50:41 INFO - "buildid", 09:50:41 INFO - "20151123073219", 09:50:41 INFO - "Change" 09:50:41 INFO - ], 09:50:41 INFO - [ 09:50:41 INFO - "builduid", 09:50:41 INFO - "c24c09f58e0d4bb7b4d21eec7a117cd6", 09:50:41 INFO - "Change" 09:50:41 INFO - ], 09:50:41 INFO - [ 09:50:41 INFO - "pgo_build", 09:50:41 INFO - "True", 09:50:41 INFO - "Change" 09:50:41 INFO - ] 09:50:41 INFO - ], 09:50:41 INFO - "revision": "d3d286102ba7f8801e9dfe12d534f49554ba50c0" 09:50:41 INFO - } 09:50:41 INFO - ], 09:50:41 INFO - "revision": "d3d286102ba7f8801e9dfe12d534f49554ba50c0" 09:50:41 INFO - } 09:50:41 INFO - } 09:50:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:50:41 INFO - Running post-action listener: _resource_record_post_action 09:50:41 INFO - ##### 09:50:41 INFO - ##### Running download-and-extract step. 09:50:41 INFO - ##### 09:50:41 INFO - Running pre-action listener: _resource_record_pre_action 09:50:41 INFO - Running main action method: download_and_extract 09:50:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:50: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')]} 09:50:41 INFO - https://queue.taskcluster.net/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:50:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/test_packages.json 09:50:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/test_packages.json 09:50:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:50:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:50:45 INFO - Downloaded 1302 bytes. 09:50:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:50:45 INFO - Using the following test package requirements: 09:50:45 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:50:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:50:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:45 INFO - u'jsshell-linux-x86_64.zip'], 09:50:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:50:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:50:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:50:45 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:50:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:50:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:50:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:50:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:50:45 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')]} 09:50:45 INFO - https://queue.taskcluster.net/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:50:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:50:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:50:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:50:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:50:47 INFO - Downloaded 22527334 bytes. 09:50:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:50:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:50:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:50:48 INFO - Return code: 0 09:50:48 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 09:50:48 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')]} 09:50:48 INFO - https://queue.taskcluster.net/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:50:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:50:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:50:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:50:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:50:53 INFO - Downloaded 22527334 bytes. 09:50:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:50:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:50:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:50:55 INFO - Return code: 0 09:50: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')]} 09:50:55 INFO - https://queue.taskcluster.net/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:50:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:50:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:50:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:50:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:50:56 INFO - Downloaded 11130997 bytes. 09:50:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 09:50:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:50:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:50:56 INFO - Return code: 0 09:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:56 INFO - https://queue.taskcluster.net/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:50:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:50:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:50:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:50:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:50:58 INFO - Downloaded 57551574 bytes. 09:50:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:50:58 INFO - mkdir: /builds/slave/test-pgo/properties 09:50:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:50:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:50:58 INFO - Contents: 09:50:58 INFO - build_url:https://queue.taskcluster.net/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:50:58 INFO - Running post-action listener: _resource_record_post_action 09:50:58 INFO - Running post-action listener: set_extra_try_arguments 09:50:58 INFO - ##### 09:50:58 INFO - ##### Running populate-webroot step. 09:50:58 INFO - ##### 09:50:58 INFO - Running pre-action listener: _resource_record_pre_action 09:50:58 INFO - Running main action method: populate_webroot 09:50:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:50:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:50:58 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:50:58 INFO - '../fennec_ids.txt'], 09:50:58 INFO - 'tests': ['tcheck2']}, 09:50:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:50:58 INFO - '--tppagecycles', 09:50:58 INFO - '7'], 09:50:58 INFO - 'tests': ['tsvgm']}}, 09:50:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:50:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:50:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:50:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:50:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'tests': ['damp', 'tps']}, 09:50:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['damp', 'tps']}, 09:50:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:50:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:50:58 INFO - 'other': {'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore']}, 09:50:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore']}, 09:50:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore']}, 09:50:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore']}, 09:50:58 INFO - 'other_l64': {'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore']}, 09:50:58 INFO - 'other_nol64': {'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore']}, 09:50:58 INFO - 'svgr': {'tests': ['tsvgx', 09:50:58 INFO - 'tsvgr_opacity', 09:50:58 INFO - 'tart', 09:50:58 INFO - 'tscrollx', 09:50:58 INFO - 'cart']}, 09:50:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['tsvgx', 09:50:58 INFO - 'tsvgr_opacity', 09:50:58 INFO - 'tart', 09:50:58 INFO - 'tscrollx', 09:50:58 INFO - 'cart']}, 09:50:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'tests': ['tp5o']}, 09:50:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['tp5o']}, 09:50:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'talos_options': ['--xperf_path', 09:50:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:58 INFO - 'tests': ['tp5n']}, 09:50:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'talos_options': ['--e10s', 09:50:58 INFO - '--xperf_path', 09:50:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:58 INFO - 'tests': ['tp5n']}}, 09:50:58 INFO - 'talos.zip': {'path': '', 09:50:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:50:58 INFO - Running post-action listener: _resource_record_post_action 09:50:58 INFO - ##### 09:50:58 INFO - ##### Running create-virtualenv step. 09:50:58 INFO - ##### 09:50:58 INFO - Running pre-action listener: _resource_record_pre_action 09:50:58 INFO - Running main action method: create_virtualenv 09:50:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:50:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 09:50:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:50:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:50:58 INFO - Using real prefix '/usr' 09:50:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:50:59 INFO - Installing distribute.............................................................................................................................................................................................done. 09:51:01 INFO - Installing pip.................done. 09:51:01 INFO - Return code: 0 09:51:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x7fed4d91fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24906e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a90>, '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 0x2518f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25192e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 09:51:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 09:51:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 09:51:01 INFO - Using env: {'DISPLAY': ':0', 09:51:01 INFO - 'HOME': '/home/cltbld', 09:51:01 INFO - 'LANG': 'en_US.UTF-8', 09:51:01 INFO - 'LANGUAGE': 'en_US:en', 09:51:01 INFO - 'LOGNAME': 'cltbld', 09:51:01 INFO - 'MAIL': '/var/mail/cltbld', 09:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:01 INFO - 'MOZ_NO_REMOTE': '1', 09:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:01 INFO - 'NO_EM_RESTART': '1', 09:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:01 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:01 INFO - 'SHELL': '/bin/bash', 09:51:01 INFO - 'SHLVL': '1', 09:51:01 INFO - 'TERM': 'linux', 09:51:01 INFO - 'TMOUT': '86400', 09:51:01 INFO - 'USER': 'cltbld', 09:51:01 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305', 09:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:01 INFO - '_': '/tools/buildbot/bin/python'} 09:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:51:01 INFO - Cleaning up... 09:51:01 INFO - Return code: 0 09:51:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x7fed4d91fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24906e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a90>, '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 0x2518f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25192e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 09:51:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 09:51:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 09:51:01 INFO - Using env: {'DISPLAY': ':0', 09:51:01 INFO - 'HOME': '/home/cltbld', 09:51:01 INFO - 'LANG': 'en_US.UTF-8', 09:51:01 INFO - 'LANGUAGE': 'en_US:en', 09:51:01 INFO - 'LOGNAME': 'cltbld', 09:51:01 INFO - 'MAIL': '/var/mail/cltbld', 09:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:01 INFO - 'MOZ_NO_REMOTE': '1', 09:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:01 INFO - 'NO_EM_RESTART': '1', 09:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:01 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:01 INFO - 'SHELL': '/bin/bash', 09:51:01 INFO - 'SHLVL': '1', 09:51:01 INFO - 'TERM': 'linux', 09:51:01 INFO - 'TMOUT': '86400', 09:51:01 INFO - 'USER': 'cltbld', 09:51:01 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305', 09:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:01 INFO - '_': '/tools/buildbot/bin/python'} 09:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:01 INFO - Downloading/unpacking psutil>=0.7.1 09:51:01 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 09:51:01 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 09:51:01 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 09:51:01 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 09:51:01 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 09:51:01 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 09:51:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:51:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:51:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:51:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:03 INFO - Installing collected packages: psutil 09:51:03 INFO - Running setup.py install for psutil 09:51:03 INFO - building 'psutil._psutil_linux' extension 09:51:03 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 09:51:03 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 09:51:03 INFO - building 'psutil._psutil_posix' extension 09:51:03 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 09:51:03 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 09:51:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:04 INFO - Successfully installed psutil 09:51:04 INFO - Cleaning up... 09:51:04 INFO - Return code: 0 09:51:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x7fed4d91fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24906e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a90>, '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 0x2518f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25192e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 09:51:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 09:51:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 09:51:04 INFO - Using env: {'DISPLAY': ':0', 09:51:04 INFO - 'HOME': '/home/cltbld', 09:51:04 INFO - 'LANG': 'en_US.UTF-8', 09:51:04 INFO - 'LANGUAGE': 'en_US:en', 09:51:04 INFO - 'LOGNAME': 'cltbld', 09:51:04 INFO - 'MAIL': '/var/mail/cltbld', 09:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:04 INFO - 'MOZ_NO_REMOTE': '1', 09:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:04 INFO - 'NO_EM_RESTART': '1', 09:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:04 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:04 INFO - 'SHELL': '/bin/bash', 09:51:04 INFO - 'SHLVL': '1', 09:51:04 INFO - 'TERM': 'linux', 09:51:04 INFO - 'TMOUT': '86400', 09:51:04 INFO - 'USER': 'cltbld', 09:51:04 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305', 09:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:04 INFO - '_': '/tools/buildbot/bin/python'} 09:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:51:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:51:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:51:06 INFO - Installing collected packages: mozsystemmonitor 09:51:06 INFO - Running setup.py install for mozsystemmonitor 09:51:06 INFO - Successfully installed mozsystemmonitor 09:51:06 INFO - Cleaning up... 09:51:06 INFO - Return code: 0 09:51:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:51: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')]} 09:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x7fed4d91fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24906e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a90>, '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 0x2518f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25192e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 09:51:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 09:51:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 09:51:06 INFO - Using env: {'DISPLAY': ':0', 09:51:06 INFO - 'HOME': '/home/cltbld', 09:51:06 INFO - 'LANG': 'en_US.UTF-8', 09:51:06 INFO - 'LANGUAGE': 'en_US:en', 09:51:06 INFO - 'LOGNAME': 'cltbld', 09:51:06 INFO - 'MAIL': '/var/mail/cltbld', 09:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:06 INFO - 'MOZ_NO_REMOTE': '1', 09:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:06 INFO - 'NO_EM_RESTART': '1', 09:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:06 INFO - 'SHELL': '/bin/bash', 09:51:06 INFO - 'SHLVL': '1', 09:51:06 INFO - 'TERM': 'linux', 09:51:06 INFO - 'TMOUT': '86400', 09:51:06 INFO - 'USER': 'cltbld', 09:51:06 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305', 09:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:06 INFO - '_': '/tools/buildbot/bin/python'} 09:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:06 INFO - Downloading/unpacking blobuploader==1.2.4 09:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:08 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:51:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:51:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:51:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:08 INFO - Downloading docopt-0.6.1.tar.gz 09:51:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:51:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:08 INFO - Running setup.py install for blobuploader 09:51:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:51:08 INFO - Running setup.py install for requests 09:51:09 INFO - Running setup.py install for docopt 09:51:09 INFO - Successfully installed blobuploader requests docopt 09:51:09 INFO - Cleaning up... 09:51:09 INFO - Return code: 0 09:51:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7fed4d91fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24906e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a90>, '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 0x2518f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25192e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 09:51:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 09:51:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 09:51:09 INFO - Using env: {'DISPLAY': ':0', 09:51:09 INFO - 'HOME': '/home/cltbld', 09:51:09 INFO - 'LANG': 'en_US.UTF-8', 09:51:09 INFO - 'LANGUAGE': 'en_US:en', 09:51:09 INFO - 'LOGNAME': 'cltbld', 09:51:09 INFO - 'MAIL': '/var/mail/cltbld', 09:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:09 INFO - 'MOZ_NO_REMOTE': '1', 09:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:09 INFO - 'NO_EM_RESTART': '1', 09:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:09 INFO - 'SHELL': '/bin/bash', 09:51:09 INFO - 'SHLVL': '1', 09:51:09 INFO - 'TERM': 'linux', 09:51:09 INFO - 'TMOUT': '86400', 09:51:09 INFO - 'USER': 'cltbld', 09:51:09 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305', 09:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:09 INFO - '_': '/tools/buildbot/bin/python'} 09:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:51:09 INFO - Running setup.py (path:/tmp/pip-DTw5qE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:51:09 INFO - Running setup.py (path:/tmp/pip-HZKn3G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:51:09 INFO - Running setup.py (path:/tmp/pip-yOs4NU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:51:09 INFO - Running setup.py (path:/tmp/pip-2YIfwk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:51:09 INFO - Running setup.py (path:/tmp/pip-ijGIHm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:51:10 INFO - Running setup.py (path:/tmp/pip-nVu2w2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:51:10 INFO - Running setup.py (path:/tmp/pip-Q5Ku95-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:51:10 INFO - Running setup.py (path:/tmp/pip-jCMcOy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:51:10 INFO - Running setup.py (path:/tmp/pip-2Brttm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:51:10 INFO - Running setup.py (path:/tmp/pip-T9xXTj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:51:10 INFO - Running setup.py (path:/tmp/pip-SMGP8k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:51:10 INFO - Running setup.py (path:/tmp/pip-EAaUXB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:51:10 INFO - Running setup.py (path:/tmp/pip-1sLjhP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:51:10 INFO - Running setup.py (path:/tmp/pip-N41GZt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:51:10 INFO - Running setup.py (path:/tmp/pip-ku0XB8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:51:10 INFO - Running setup.py (path:/tmp/pip-HdGvx8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:51:10 INFO - Running setup.py (path:/tmp/pip-OCjtxN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:51:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:10 INFO - Running setup.py install for manifestparser 09:51:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:51:10 INFO - Running setup.py install for mozcrash 09:51:11 INFO - Running setup.py install for mozdebug 09:51:11 INFO - Running setup.py install for mozdevice 09:51:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:51:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:51:11 INFO - Running setup.py install for mozfile 09:51:11 INFO - Running setup.py install for mozhttpd 09:51:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:51:11 INFO - Running setup.py install for mozinfo 09:51:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:51:11 INFO - Running setup.py install for mozInstall 09:51:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:51:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:51:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:51:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:51:11 INFO - Running setup.py install for mozleak 09:51:11 INFO - Running setup.py install for mozlog 09:51:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:51:11 INFO - Running setup.py install for moznetwork 09:51:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:51:11 INFO - Running setup.py install for mozprocess 09:51:12 INFO - Running setup.py install for mozprofile 09:51:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:51:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:51:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:51:12 INFO - Running setup.py install for mozrunner 09:51:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:51:12 INFO - Running setup.py install for mozscreenshot 09:51:12 INFO - Running setup.py install for moztest 09:51:12 INFO - Running setup.py install for mozversion 09:51:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:51:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:12 INFO - Cleaning up... 09:51:12 INFO - Return code: 0 09:51:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:51: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')]} 09:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7fed4d91fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24906e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a90>, '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 0x2518f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25192e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 09:51:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 09:51:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 09:51:12 INFO - Using env: {'DISPLAY': ':0', 09:51:12 INFO - 'HOME': '/home/cltbld', 09:51:12 INFO - 'LANG': 'en_US.UTF-8', 09:51:12 INFO - 'LANGUAGE': 'en_US:en', 09:51:12 INFO - 'LOGNAME': 'cltbld', 09:51:12 INFO - 'MAIL': '/var/mail/cltbld', 09:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:12 INFO - 'MOZ_NO_REMOTE': '1', 09:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:12 INFO - 'NO_EM_RESTART': '1', 09:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:12 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:12 INFO - 'SHELL': '/bin/bash', 09:51:12 INFO - 'SHLVL': '1', 09:51:12 INFO - 'TERM': 'linux', 09:51:12 INFO - 'TMOUT': '86400', 09:51:12 INFO - 'USER': 'cltbld', 09:51:12 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305', 09:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:12 INFO - '_': '/tools/buildbot/bin/python'} 09:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:51:12 INFO - Running setup.py (path:/tmp/pip-khDRQ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 09:51:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:51:12 INFO - Running setup.py (path:/tmp/pip-JQQaXN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:51:13 INFO - Running setup.py (path:/tmp/pip-BBeOXf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:51:13 INFO - Running setup.py (path:/tmp/pip-Ff0aUI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:51:13 INFO - Running setup.py (path:/tmp/pip-f0rBW0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 09:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:51:13 INFO - Running setup.py (path:/tmp/pip-xamuW8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 09:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:51:13 INFO - Running setup.py (path:/tmp/pip-_hWKod-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 09:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:51:13 INFO - Running setup.py (path:/tmp/pip-pGra_G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 09:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:51:13 INFO - Running setup.py (path:/tmp/pip-HYuogT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 09:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:51:13 INFO - Running setup.py (path:/tmp/pip-opH3xp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:51:13 INFO - Running setup.py (path:/tmp/pip-FBHXU5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 09:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:51:13 INFO - Running setup.py (path:/tmp/pip-17YT7r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 09:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:51:13 INFO - Running setup.py (path:/tmp/pip-IgA8s4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 09:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:51:13 INFO - Running setup.py (path:/tmp/pip-eu5P9x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 09:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:51:13 INFO - Running setup.py (path:/tmp/pip-9yDswl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 09:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:51:13 INFO - Running setup.py (path:/tmp/pip-xaAyet-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 09:51:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:51:14 INFO - Running setup.py (path:/tmp/pip-KNdP9S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 09:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:15 INFO - Downloading blessings-1.5.1.tar.gz 09:51:15 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:51:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:51:15 INFO - Installing collected packages: blessings 09:51:15 INFO - Running setup.py install for blessings 09:51:15 INFO - Successfully installed blessings 09:51:15 INFO - Cleaning up... 09:51:16 INFO - Return code: 0 09:51:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:51:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:51:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:51:16 INFO - Reading from file tmpfile_stdout 09:51:16 INFO - Current package versions: 09:51:16 INFO - argparse == 1.2.1 09:51:16 INFO - blessings == 1.5.1 09:51:16 INFO - blobuploader == 1.2.4 09:51:16 INFO - docopt == 0.6.1 09:51:16 INFO - manifestparser == 1.1 09:51:16 INFO - mozInstall == 1.12 09:51:16 INFO - mozcrash == 0.16 09:51:16 INFO - mozdebug == 0.1 09:51:16 INFO - mozdevice == 0.47 09:51:16 INFO - mozfile == 1.2 09:51:16 INFO - mozhttpd == 0.7 09:51:16 INFO - mozinfo == 0.9 09:51:16 INFO - mozleak == 0.1 09:51:16 INFO - mozlog == 3.1 09:51:16 INFO - moznetwork == 0.27 09:51:16 INFO - mozprocess == 0.22 09:51:16 INFO - mozprofile == 0.27 09:51:16 INFO - mozrunner == 6.11 09:51:16 INFO - mozscreenshot == 0.1 09:51:16 INFO - mozsystemmonitor == 0.0 09:51:16 INFO - moztest == 0.7 09:51:16 INFO - mozversion == 1.4 09:51:16 INFO - psutil == 3.1.1 09:51:16 INFO - requests == 1.2.3 09:51:16 INFO - wsgiref == 0.1.2 09:51:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7fed4d91fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24906e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c6a90>, '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 0x2518f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25192e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 09:51:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/talos 09:51:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 09:51:16 INFO - Using env: {'DISPLAY': ':0', 09:51:16 INFO - 'HOME': '/home/cltbld', 09:51:16 INFO - 'LANG': 'en_US.UTF-8', 09:51:16 INFO - 'LANGUAGE': 'en_US:en', 09:51:16 INFO - 'LOGNAME': 'cltbld', 09:51:16 INFO - 'MAIL': '/var/mail/cltbld', 09:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:16 INFO - 'MOZ_NO_REMOTE': '1', 09:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:16 INFO - 'NO_EM_RESTART': '1', 09:51:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:16 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:16 INFO - 'SHELL': '/bin/bash', 09:51:16 INFO - 'SHLVL': '1', 09:51:16 INFO - 'TERM': 'linux', 09:51:16 INFO - 'TMOUT': '86400', 09:51:16 INFO - 'USER': 'cltbld', 09:51:16 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305', 09:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:16 INFO - '_': '/tools/buildbot/bin/python'} 09:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 09:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 09:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 09:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 09:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 09:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:51:16 INFO - Cleaning up... 09:51:16 INFO - Return code: 0 09:51:16 INFO - Running post-action listener: _resource_record_post_action 09:51:16 INFO - Running post-action listener: _start_resource_monitoring 09:51:16 INFO - Starting resource monitoring. 09:51:16 INFO - ##### 09:51:16 INFO - ##### Running install step. 09:51:16 INFO - ##### 09:51:16 INFO - Running pre-action listener: _resource_record_pre_action 09:51:16 INFO - Running main action method: install 09:51:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:51:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:51:16 INFO - Reading from file tmpfile_stdout 09:51:16 INFO - Detecting whether we're running mozinstall >=1.0... 09:51:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:51:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:51:16 INFO - Reading from file tmpfile_stdout 09:51:16 INFO - Output received: 09:51:16 INFO - Usage: mozinstall [options] installer 09:51:16 INFO - Options: 09:51:16 INFO - -h, --help show this help message and exit 09:51:16 INFO - -d DEST, --destination=DEST 09:51:16 INFO - Directory to install application into. [default: 09:51:16 INFO - "/builds/slave/test-pgo"] 09:51:16 INFO - --app=APP Application being installed. [default: firefox] 09:51:16 INFO - mkdir: /builds/slave/test-pgo/build/application 09:51:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:51:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:51:31 INFO - Reading from file tmpfile_stdout 09:51:31 INFO - Output received: 09:51:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:51:31 INFO - Running post-action listener: _resource_record_post_action 09:51:31 INFO - ##### 09:51:31 INFO - ##### Running run-tests step. 09:51:31 INFO - ##### 09:51:31 INFO - Running pre-action listener: _resource_record_pre_action 09:51:31 INFO - Running main action method: run_tests 09:51:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:51:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:51:31 INFO - Python 2.7.3 09:51:31 INFO - Return code: 0 09:51:31 INFO - grabbing minidump binary from tooltool 09:51:31 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')]} 09:51:31 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-pgo/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 0x24c6a90>, '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 0x2518f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25192e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:51:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 09:51:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:51:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:51:31 INFO - Return code: 0 09:51:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:51:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:51:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:51:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:51:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:51:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:51:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost 09:51:31 INFO - Using env: {'DISPLAY': ':0', 09:51:31 INFO - 'HOME': '/home/cltbld', 09:51:31 INFO - 'LANG': 'en_US.UTF-8', 09:51:31 INFO - 'LANGUAGE': 'en_US:en', 09:51:31 INFO - 'LOGNAME': 'cltbld', 09:51:31 INFO - 'MAIL': '/var/mail/cltbld', 09:51:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:51:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:31 INFO - 'MOZ_NO_REMOTE': '1', 09:51:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:31 INFO - 'NO_EM_RESTART': '1', 09:51:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:31 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:51:31 INFO - 'SHELL': '/bin/bash', 09:51:31 INFO - 'SHLVL': '1', 09:51:31 INFO - 'TERM': 'linux', 09:51:31 INFO - 'TMOUT': '86400', 09:51:31 INFO - 'USER': 'cltbld', 09:51:31 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305', 09:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:31 INFO - '_': '/tools/buildbot/bin/python'} 09:51:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost'] with output_timeout 3600 09:51:31 INFO - mozversion INFO | application_buildid: 20151123073219 09:51:31 INFO - mozversion INFO | application_changeset: d3d286102ba7f8801e9dfe12d534f49554ba50c0 09:51:31 INFO - mozversion INFO | application_display_name: Nightly 09:51:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:51:31 INFO - mozversion INFO | application_name: Firefox 09:51:31 INFO - mozversion INFO | application_remotingname: firefox 09:51:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 09:51:31 INFO - mozversion INFO | application_vendor: Mozilla 09:51:31 INFO - mozversion INFO | application_version: 45.0a1 09:51:31 INFO - mozversion INFO | platform_buildid: 20151123073219 09:51:31 INFO - mozversion INFO | platform_changeset: d3d286102ba7f8801e9dfe12d534f49554ba50c0 09:51:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 09:51:31 INFO - mozversion INFO | platform_version: 45.0a1 09:51:31 INFO - 2015-11-23 09:51:31,515 DEBUG : using testdate: 1448301091 09:51:31 INFO - 2015-11-23 09:51:31,515 DEBUG : actual date: 1448301091 09:51:31 INFO - 2015-11-23 09:51:31,540 INFO : starting webserver on 'localhost:38640' 09:51:31 INFO - 2015-11-23 09:51:31,541 INFO : Starting test suite talos-linux64-ix-038.e 09:51:31 INFO - 2015-11-23 09:51:31,541 INFO : Starting test dromaeo_css 09:51:31 INFO - 2015-11-23 09:51:31,541 DEBUG : operating with platform_type : linux_ 09:51:31 INFO - 2015-11-23 09:51:31,542 INFO : Initialising browser for dromaeo_css test... 09:51:31 INFO - 2015-11-23 09:51:31,558 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphpOHFN/profile http://localhost:38640/getInfo.html 09:51:37 INFO - 2015-11-23 09:51:37,486 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:51:37 INFO - 2015-11-23 09:51:37,486 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:51:37 INFO - 2015-11-23 09:51:37,486 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:51:37 INFO - 2015-11-23 09:51:37,486 DEBUG : BROWSER_OUTPUT: __metrics 09:51:38 INFO - 2015-11-23 09:51:38,577 INFO : Browser initialized. 09:51:38 INFO - 2015-11-23 09:51:38,578 INFO : Running cycle 1/1 for dromaeo_css test... 09:51:38 INFO - 2015-11-23 09:51:38,578 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphpOHFN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:51:50 INFO - 2015-11-23 09:51:50,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 142487552 09:51:50 INFO - 2015-11-23 09:51:50,395 DEBUG : BROWSER_OUTPUT: 09:52:40 INFO - 2015-11-23 09:52:40,019 DEBUG : BROWSER_OUTPUT: 1448301160015 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] 09:54:48 INFO - 2015-11-23 09:54:48,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38640/tests/dromaeo/cssquery-ext.html) 09:54:50 INFO - 2015-11-23 09:54:50,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 148668416 09:54:50 INFO - 2015-11-23 09:54:50,078 DEBUG : BROWSER_OUTPUT: 09:57:51 INFO - 2015-11-23 09:57:51,998 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/dromaeo/cssquery-ext.html (next: http://localhost:38640/tests/dromaeo/cssquery-jquery.html) 09:57:52 INFO - 2015-11-23 09:57:52,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 143323136 09:57:52 INFO - 2015-11-23 09:57:52,585 DEBUG : BROWSER_OUTPUT: 10:00:54 INFO - 2015-11-23 10:00:54,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38640/tests/dromaeo/cssquery-mootools.html) 10:00:54 INFO - 2015-11-23 10:00:54,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 144273408 10:00:54 INFO - 2015-11-23 10:00:54,923 DEBUG : BROWSER_OUTPUT: 10:03:56 INFO - 2015-11-23 10:03:56,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38640/tests/dromaeo/cssquery-prototype.html) 10:03:57 INFO - 2015-11-23 10:03:57,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 141950976 10:03:57 INFO - 2015-11-23 10:03:57,164 DEBUG : BROWSER_OUTPUT: 10:06:59 INFO - 2015-11-23 10:06:59,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38640/tests/dromaeo/cssquery-yui.html) 10:07:00 INFO - 2015-11-23 10:07:00,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 141729792 10:07:00 INFO - 2015-11-23 10:07:00,148 DEBUG : BROWSER_OUTPUT: 10:10:02 INFO - 2015-11-23 10:10:02,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/dromaeo/cssquery-yui.html (next: http://localhost:38640/tests/dromaeo/cssquery-dojo.html) 10:10:02 INFO - 2015-11-23 10:10:02,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 145260544 10:10:02 INFO - 2015-11-23 10:10:02,873 DEBUG : BROWSER_OUTPUT: 10:10:02 INFO - 2015-11-23 10:10:02,874 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:10:02 INFO - 2015-11-23 10:10:02,875 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:10:02 INFO - 2015-11-23 10:10:02,875 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:10:02 INFO - 2015-11-23 10:10:02,875 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:10:02 INFO - 2015-11-23 10:10:02,879 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3212.9196770080753;3245.529398237254;3269.3461307738457;3291.7202037826783;3295.1762059485127;5322.547583455401;5544.473275038875;5546.805861794838;5554.666719996803;5554.805581804638;5446.891062178764;5447.210154527591;5460.6177567570285;5481.835544933649;5524.281843360358;4973.72644504553;5038.118329292359;5084.110280700863;5114.539691427771;5121.462246464105;5029;5104.923426148611;5115.283860259567;5148.253503242027;5161.7161056141895;4897.04507621014;4987.501249874984;4990.725510096943;5088.23676448532;5137.357830271216;5044.646874718771;5060.038592667382;5060.67105638136;5062.898742025176;5084.389873215201;5050.368703912011;5067.670601410897;5070;5081.18701007837;5102.69383836971;5208.453112423179;5256.395514515803;5322.9620224056325;5370.91943620846;5420;5893.941060589425;6020.6688632125215;6026.758929642809;6028.487578555828;6029.216201893726;6076.787312444043;6100.938990610081;6103.938960610381;6119.1739115219325;6120.877582448326;5441.2654291670515;5444;5554.361248456398;5564.805231816867;5601.243832082698;6051.152838602599;6051.757929682852;6072.878542429126;6080.726367313481;6102.847428814315;5754.1944127822135;5918.141869428909;5945.881082378328;5957.76168953237;5964.642121472725;5870.295564532198;5935.465808077208;5936.821895343147;5951.404859514014;6002.429769171922;5852.619579727304;5894.557908156906;5896;5937.495312898452;5957.851053723692;5658.179563963202;5776.971115144482;5877.588568800143;5947.107933809876;5957.344692083867;4500.954990450054;4531.22969095248;4534.070515544306;4585.977070114628;4592.10453961481;4032.6773858091283;4048.4332193492933;4058.7564746115327;4062.471878655756;4079.347304431277;5435.592330575223;5502.642328248651;5533;5675.404082571353;5676.77292908279;5833.591648584558;5890.440408161217;5905.43898329658;5923.674197919156;5931.58478906481;5697.544196464273;5718.914216286759;5724;5728.6276392035215;5732.942670573241;5033.446320904697;5147.7683504242395;5223.268742376071;5224.242484839677;5252.133397989365;6036.42653947883;6114.357992410822;6115.422885572139;6121.026213050743;6138.570300078952;5970.731317090655;6015.879682406415;6033.18551995475;6036.0644100164545;6051.818445446644;5909.793157239476;5978.4021597839865;6011.368806275278;6123.724432400463;6145.66198859067;5878.706064696834;5894.233749612523;5906.645601263938;5918.704064796829;5951.791687290924;6021.337652858095;6030.336662967158;6043.093535969464;6043.54673399488;6055.636661800306;5734.655920644775;5739.7417116229035;5848.2689663792025;5850.912236316373;5860.882782344244;5848.385919478564;5894.086416605433;5894.882102357843;5917.230760001173;5939.316978547522;5801.535877129904;5802.361740208489;5803.274590676166;5810.593258471867;5823.563232757476;5671;5756.913646295393;5857.824265272048;5932.703364831655;5952.494038006818;5758.856028599319;5840.445157710011;5841.036229022334;5847.26909136358;5862.94137058641 10:10:02 INFO - 2015-11-23 10:10:02,880 DEBUG : BROWSER_OUTPUT: |1;ext.html;597.0596310810473;597.8385835824328;604.2296072507552;613.2028363127932;617.2623714660976;36033.45949810755;36992.44511332332;37252.81373593135;37271.62728372715;37336.81331593342;40941;41318;41346.37980430296;41452.37821432681;41629.58370416295;8439;8623.525706086162;8655.913440865574;8657.177568131017;8665.39342246043;8579.52812595307;8579.699710510133;8618.741437756846;8675.132486751307;8713.128687131268;8690.826183476327;8771.210591046805;8807.075257097977;8816.206541411271;8851.33614978879;8625.439346442492;8727.083656216133;8771.824563508726;8789.780255493632;8796.516191609458;8707.390482666216;8848.690295839615;8871.2015918567;8877.778055548599;8881.200691937693;38684.806575967224;38782;38991;39170.412443813366;39355.40966885499;3212.550242965987;3292.720118789906;3304.686054824788;3343.648916863743;3541.3448512025357;28646;29061;29688.70311296881;29696.257593560116;30281.394372112656;3507.771994820354;3514.8418321175354;3589.856405743767;3682.834272457746;3711.814409279525;248556;249484;249715;250052;250323;49562.25656615154;51044;58016.70991645099;58902.705486472296;58920.705396472746;58048.129278060864;58702.706486467294;58901;59094.11358829621;59180.70409647924;13988.440462381594;13991.440342386191;14042.36809343582;14083.859161408254;14180.220087895059;10733.570657173781;10825.729356766144;10827.566897324177;10941.945290273497;10979.39613321275;19220.71168932439;19591.31430399929;19704.802951970298;19864.801351986294;19867;7378.151512576015;7655.617219139021;7704.30661240491;7722.691092356243;7725.227477252342;989.1246247071393;1001.4592120255127;1001.7695929936156;1015.8527013582989;1075.9778210699867;27580.724192757814;27914;27986.580201296998;28001.859990699915;29496;992.374803873555;1032.8450732390202;1050.4747626186906;1137.1698659978263;1143.4397145398696;14134.929325353512;14182.645433864029;14293.213873237071;14482.565523034325;14540.781888271684;318462;319898;321485;321638;321813;48594.02811943741;49046.26430603544;49204.507954919995;49266.75366623216;49346.259806102935;1300.8373953256032;1314.7436249931172;1315.224017829466;1333.613252156883;1334.5729366602789;26367;26448.338791530365;26488;26783.598246025937;26823.865880670473;44446.777766110965;44575.554244458435;44876.10247794961;44898.77550612226;44965.10069798651;291006;292994;293103;293581;293740;30172.698273016988;30921.8453907729;31024;31031.53452698166;31086.22284442907;37246;37772.62227377691;37805;38147.80926095463;38198;31485.370292594478;32001.67998319987;32125.67874321227;34365.65634343625;34884;33270;33510.16224594405;33766.3246735059;33912.15219619529;34734;33529.66470335363;33964.83017584896;34159.14602134967;34164.48753268653;34186.829065855505;30252.394952101276;31022;31966.680333197302;32052;32203.838980804947;24497.5904337221;24682.753172468765;24684.65495777898;24708.38229044288;24880.875595621907 10:10:02 INFO - 2015-11-23 10:10:02,883 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.97176225901933;356.7360153486419;358.0887385555434;360.1410635634012;360.8322130209453;17232.224549895254;17945.82054179458;18405.723914141265;18859.151338189797;19088.42734717957;15962.600934976632;16113.516594502154;16450.095244761535;16461.753073703905;17163.313467461317;4652.092841895832;4732.124556956956;4752.192127338343;4775.880602984918;4783.210770222909;4476.709013914102;4733.100710864942;4739.241721324589;4751.477337492873;4752.215884379073;4958.702477851322;5101.030804147219;5102.515261050195;5287.947120528803;5331.040412725708;5032.345795046657;5050.141475949097;5059.747012649371;5075.137226671474;5099.923501147448;5158.071547121516;5174.275601415768;5176.637635365526;5188.688678679254;5199.090159222159;11624.709382265426;11741.88258117425;15645.530634080997;19970;20187.495312617157;1929.8649094563386;1993.6610776168086;2036.2669439001947;2127.0747224957195;2130.392838041166;8921.598528066253;8998.370114092017;9060.864087038699;9133.36066475347;9180.586873590704;1740.3125765322752;1745.1361576019824;1816.1191821966336;1816.8626320654305;1827.4334956163632;60877.69561152166;64753.676231619014;65030.02454963132;65422;66830;9569.89946156201;9889;9924.106830385155;9942.652007179713;9984.700458986243;12739.36303184837;12781.16922400041;12807.423665934868;12817.23096614206;12836.80744788829;7678.692852285958;7683.538987660758;7686.116096648845;7699.307062364414;7779.8833017504785;7620.199879012624;7644.885326720104;7654.158042615308;7678.424118191158;7691.038620172479;4203.852865149766;4210.494740631144;4237.131388065439;4240.363945408152;4257.169851878916;1752.50053734685;1791.8566514678794;1792.5518620344915;1811.1397086384125;1836.4490652804104;384.31591766655396;394.2981492942567;398.06256266492574;400.82564084623283;404.88865561970107;10012.899871001197;10358.482075896174;10366.585336586602;10453.111485523663;10597.735056623493;406.42693801739404;423.9936400953988;426.45200916821733;426.5286858021903;435.906280149763;5358.115910874662;5649.322081350264;5651;5696.401877802854;9285.210757085588;495171;507177;509079.091440886;509935;516616;74501.25498745052;79177.20822791698;79912.20087799164;80799.5960020196;80945.59527202326;1098.5825386353135;1128.8081026225561;1130.7229728716352;1135.8807325230896;1160.5763896178003;15494.302756375764;15855;15906.60233494172;15974.60063498422;16128.354865805706;34902.650973490956;35226.823865880506;35511.644883550834;35986.82006590055;36046.819765901004;46054.309185362916;46690;46811.53188468072;51309.48690513047;51817.7409112952;8564.614592343234;8903.19871211594;8949.149830766068;8984.640614375352;9085.727428177166;10348;10349.379037257788;10431.895681043092;10436.843447348145;10452.790944181226;2891.060405368306;11478.196526243082;12022.75954480923;13357.66605834862;13765.902671898742;13115.213087214797;13850.238236896665;13881.583552493441;13998.230097344336;14158.221297828306;14669.706605868036;14866.925665372037;14885.479008234659;15115.470958516398;15251.771223431879;8904.777380565538;9080.182783549511;9119.908800911906;9165.816683666157;9230.307726920642;9039.231665308522;10575.894241057798;14870.405183792527;14888.330025149111;15062.548123556311 10:10:02 INFO - 2015-11-23 10:10:02,884 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1508.178042966583;1714.2371644618142;1755.648870225955;1770.9734353984693;1785.7232129020006;7133.393661538763;7498.062742157231;7645.579493127882;7751.302382785549;7808.258215469528;7887.763367098982;7943.92056079439;7991.920080799205;7992.240737129978;7994.4803587766755;2222.055626358795;2243.6298010828277;2261.536385041071;2262.6379779235326;2265.9433514162197;2241.8766967816764;2270.182734215681;2273.3975496493445;2274.3972847195505;2289.5764283607587;2180.062573093569;2229.8996545155505;2230.888455577223;2238.597052530552;2263.2191893796694;2187.3547303545333;2192.495725983025;2229.0972156276734;2231.3529076567775;2242.0583354990863;2227.13141874669;2227.7883601057874;2246.3597874605657;2259.53679495703;2261.2537862505333;7371;7385.815354616124;7431.256874312579;7467.365273951721;7485.7754267372065;4487.035287413222;4544.840930567414;4565.360849481075;4576.039031803325;4584.4957054723955;2930.413917216565;2970.8960186393588;3019.758419326449;3043.5738996540504;3045.162580290416;886.7517095213351;892.1702816380763;918.4168053286145;922.0180507759216;937.3906960475678;10431.321964072387;10507.054365107177;10518.579256829718;10535.157187424988;10580.047795698423;3975.5626881043063;3990.1421194443333;4027.556968733437;4029.4560234368573;4056.9797151014645;8603.139686031473;8624.051354351017;8625;8626;8643;4582.335561343587;4600.631949444037;4606.262997920317;4608.493065762764;4612.400387949545;4229.365595160751;4248.490181178278;4262.850800221977;4265.680073994463;4266.807993640294;3213.1485156433564;3228.0961330827404;3255.6814490131533;3275;3275.606927168755;954.9856752148723;955.4315182466421;963.0995019656503;963.2679163835536;966.4104896013426;1029.696239609317;1034.281174583657;1042.718466014172;1182.2020136408062;1338.7054847933439;7144.535605185646;7178.28217178278;7200.387967022757;7241.348278654947;7247.311505406978;1134.398285443713;1142.2803633710876;1154.2382027861572;1167.8656954450178;1186.163754553038;5774.162746401748;5801.245838041028;5814.069748840166;5832.066869300891;5835.708214589338;8690.261327787082;8880.467171969702;8898.822023559493;9086.363954523253;9120.58957346921;9060.909390906138;9066.410683305565;9118.772030699152;9175.495347755937;9205.079492050741;6981.511294209458;7015;7137.10786151731;7197.280271972761;7206.639668016683;7233.674484648098;7242.203357630551;7259.310365515479;7275.272472752682;7286.198518162892;7766.534007959541;7936.206379362017;7996.920030799618;8077.798055048671;8089.878651820345;8153.266206041485;8214.630341634522;8215.876761848458;8279.213474719892;8336.29141522953;6959.89560156588;7013.614251216232;7092.361687448154;7112.110986126734;7114.537555058904;7130.893036604559;7161.4628902831455;7202.71189152428;7205.279472052753;7218.169910460364;6715.731370745116;6775.661216939232;6892.689828957608;6983.895241571482;7028.402585780266;6589.80230593083;6665.633390163587;6746.325367463214;6764.594124352555;6774.898376524257;6890.793276201722;6890.8621827564175;6896.103506544117;6905.205901321412;6910.170779506491;6189.50483961273;6230.06549017651;6250.781222657185;6258.123862659322;6258.217722784652;6438.967805160944;6443.7744678936015;6449.161608990801;6458.61248325102;6473.805785826433 10:10:02 INFO - 2015-11-23 10:10:02,887 DEBUG : BROWSER_OUTPUT: |4;prototype.html;289.4587122081707;296.07181486041253;305.06649652064687;315.13966870443676;316.22682541186805;6270.937290627093;6316.589421687587;6345.079963405304;6419.775307864225;6532.706028228729;6339.366063393658;6380.585261957969;6400.295967443589;6403.519736019805;6404.039394090889;4813.061453016663;4814.1334559779225;4819.084373968953;4819.301201325806;4824.686395384307;4821.63837712173;4829.9275510867365;4833.347498087766;4837.540433658797;4843.128236917353;4650.9069818603775;4748.145333839908;4767.61859051275;4776.307435421862;4785.138675038492;4759.833405830796;4762.880927976794;4762.904741905159;4764.118638051954;4776.426828780569;4086;4096.897577560555;4107.650849677781;4108.301588729923;4119.711620186588;6037.72830222641;6061;6069.848253793646;6079.696015199266;6090.48230900374;5392.649477783932;5497.120460726264;5513.448655134494;5515.393306736256;5543.6119471637;6696.129503164606;6729.158855143107;6732.360425759545;6734.696938637773;6750.088738020353;4534.2971839364955;4535.4103966484145;4536.478304994935;4542.795574199169;4547.317902314646;6740.191177058735;6874.484413668944;6910.550814197061;6922.446204303644;6932;4523.185826551252;4536.909261814745;4537.274036154199;4542.523035081335;4546.954530454653;4560.6807523473035;4590.908181836345;4599;4604.539546045436;4608.446986361658;5450.8909821803345;5453.7818487260065;5460.781568737206;5461.1262198048125;5462.481064298885;6606.933930660632;6761.22245941723;6763.323667633295;6764.661766911635;6782.389584937379;1565.131352099573;1640.3848556791204;1657.6021754778767;1673.86609071274;1674.3553731813097;1084.728817795551;1089.9509522071526;1090.4929207918356;1092.3718861654581;1092.8415379770047;6388.425041746265;6405.807825765234;6408.03879418091;6408.967955160194;6437.839054023593;6777.085093512313;6838.623875686785;6846.281140480178;6852.931470685229;6854.794356169323;6327.651979141099;6381.234251889803;6423.614583124934;6436.678166091677;6455.61266324022;3812.2375524895133;3824.4072168813877;3825.713071519647;3830.444585535082;3853.5953724859046;7294.598797066213;7300.233475484997;7304.306090921354;7309.671064802096;7315.829467285315;6984.650767461708;7207.279272072751;7215.530990485707;7234.131904171533;7239.167495737952;7216.458765592602;7260.41916646667;7270.672819723125;7272.127344718562;7297.124345078624;6991.161060672752;6996.475264355092;7018.227994920657;7056.294370562902;7057.188423331382;6795.218549866829;6917.100776898971;6947.687354068978;6986.685599147949;7003.719851205895;7290.963545182452;7301.415886729155;7311.524750891175;7314.780556583311;7320.560766354036;4570.245909424908;4585.793639286173;4615.838445654386;4631.170687578455;4644.883877902945;6728.158980127484;6746.4940129489505;6877.037214789833;6998.475114366341;7042.084529011196;6652.933470665232;6810.523263371517;6812.386885180357;6841.760538381132;6859.862802744017;6756.087928129639;6786.592804431552;6814.591124532544;6819.5908245505425;6821.2155602106395;6522.641254731036;6647.534672572873;6662.533622646562;6686.69909854048;6686.866262674816;6786.457083433413;6797.93202067973;6823.727050918106;6835.726570937107;6851.862962740817;6600.372964568358;6649.966750166218;6659.234188068434;6660.2673705893285;6666.566673166229 10:10:02 INFO - 2015-11-23 10:10:02,888 DEBUG : BROWSER_OUTPUT: |5;yui.html;812.398824869596;836.7447928381845;842.7134774176778;847.0813607179737;855.9700410485638;12445.439955202015;12695.428705708242;12711.42798574064;12722.681932951658;12739;12110.576129835457;12226.57206997753;12234.082443816706;12247.448864801083;12256.877431225685;795.5624406576388;819.8442295963778;835.8787975743513;835.9331253499736;836.3016880904452;825.2531459029558;830.4809494066209;832.3965125284182;832.7876391520153;833.1044127562864;851.9062903080656;854.0306751836648;855.9743207703748;857.2713193785264;859.909709480505;842.995785021071;848.1052489623445;848.3679658654311;849.9405041647087;850.7490290364358;620.5780069552702;622.947049500793;623.0467384901109;623.1462895832693;624.0140577886928;12871.163374380636;12985.09104362695;13008.089433739642;13028.348582570834;13056.86943130566;12181.573644922386;12360.629181124581;12471.438785254686;12510.31193284369;13006.609801705965;9531.237500999903;9988.101070903653;9998.654889476731;10162.745931351701;10268.691939241835;3330.6502817204328;3424.9486257706153;3491.1970246843366;3533.611302756695;3533.787972721645;47445.288320675216;48800.75599621979;48802.267965980536;48983.51016489825;49013;9675.854862177073;9845.80308393828;10083.142932850644;10175.236857235737;10207.387556746618;17816.376426824998;17829.375971840924;17830.10849457522;17831.554211144565;17878.821211787716;6113.113598528277;6249.0626406039455;6264.749410023639;6421.165248517663;6572.737090516326;4014.75499725835;4019.618136277049;4097.508299004079;4144;4172.520160181557;3008.819470831757;3038.8632511537035;3055.1903745507457;3057.6942305769244;3058.067289476731;508.23764353469795;524.7009204753331;529.7298377827336;531.4605675239635;532.2840779152034;591.4676790888149;636.9681515924185;642.540583482812;679.419096672338;729.5185177782638;8711.303095752324;8845.557722113868;8867.600957956907;8926.241269492037;9142.222911052502;557.9218909352694;670.718298314709;729.7664747280925;732.3299181249204;741.4142827166586;4095.140020595649;4201.852935147316;4224.345226489899;4293.935590966138;4366.934495982563;51508.74245628748;56002.71998639981;56053.43946560564;56084.71957640268;56113.719431402584;47146.29280560794;48289.517104828505;48517.75741121272;49284.75357623189;49393;45323.77338113288;45439.77280113578;45473.545264547596;45564.316535252;45686.54313456889;9063.592138353923;9344.392614480037;9426.858597121185;9440.622375104918;9441.103095205945;33439.66560334365;34436.311273773885;34992;35014.64985350216;35442;39442.605573943896;39824.60175398209;40561.79719101386;44100.55899441093;44272.11455770931;11492.425378731197;11511.884881151082;11521.539138434704;11552.191346605658;11556.768864622829;12293.75412491763;12536.122471426912;12570.811437828257;12667.683307917376;12720.68198295013;10904.34573925567;10992.120630349393;11080.667579972614;11248;11365.943170284096;11575.942120289345;12058.180947535573;12254.509819607116;12326.445309961253;12735.681607959505;11621.186516943733;11712.004479619327;11764.176507644383;12030.338331391857;12133.150679452354;10107.69676909694;10122.544485498318;10646.361218326925;10727;10801.081908037904;9129.653658049758;9486.098820612031;9661.178799802095;9818.410895346302;9852.802943941224 10:10:02 INFO - 2015-11-23 10:10:02,889 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:10:02 INFO - 2015-11-23 10:10:02,889 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:10:02 INFO - 2015-11-23 10:10:02,889 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,307 10:10:02 INFO - 2015-11-23 10:10:02,889 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:10:02 INFO - 2015-11-23 10:10:02,890 DEBUG : BROWSER_OUTPUT: __startTimestamp1448302202874__endTimestamp 10:10:02 INFO - 2015-11-23 10:10:02,890 DEBUG : BROWSER_OUTPUT: 10:10:02 INFO - 2015-11-23 10:10:02,890 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:10:02 INFO - 2015-11-23 10:10:02,891 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:10:02 INFO - 2015-11-23 10:10:02,891 DEBUG : BROWSER_OUTPUT: 10:10:02 INFO - 2015-11-23 10:10:02,891 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5528.41 Median:5776.97 stddev:627.11 (10.9%) stddev-sans-first:602.15 10:10:02 INFO - 2015-11-23 10:10:02,892 DEBUG : BROWSER_OUTPUT: Values: 3212.9 3245.5 3269.3 3291.7 3295.2 5322.5 5544.5 5546.8 5554.7 5554.8 5446.9 5447.2 5460.6 5481.8 5524.3 4973.7 5038.1 5084.1 5114.5 5121.5 5029.0 5104.9 5115.3 5148.3 5161.7 4897.0 4987.5 4990.7 5088.2 5137.4 5044.6 5060.0 5060.7 5062.9 5084.4 5050.4 5067.7 5070.0 5081.2 5102.7 5208.5 5256.4 5323.0 5370.9 5420.0 5893.9 6020.7 6026.8 6028.5 6029.2 6076.8 6100.9 6103.9 6119.2 6120.9 5441.3 5444.0 5554.4 5564.8 5601.2 6051.2 6051.8 6072.9 6080.7 6102.8 5754.2 5918.1 5945.9 5957.8 5964.6 5870.3 5935.5 5936.8 5951.4 6002.4 5852.6 5894.6 5896.0 5937.5 5957.9 5658.2 5777.0 5877.6 5947.1 5957.3 4501.0 4531.2 4534.1 4586.0 4592.1 4032.7 4048.4 4058.8 4062.5 4079.3 5435.6 5502.6 5533.0 5675.4 5676.8 5833.6 5890.4 5905.4 5923.7 5931.6 5697.5 5718.9 5724.0 5728.6 5732.9 5033.4 5147.8 5223.3 5224.2 5252.1 6036.4 6114.4 6115.4 6121.0 6138.6 5970.7 6015.9 6033.2 6036.1 6051.8 5909.8 5978.4 6011.4 6123.7 6145.7 5878.7 5894.2 5906.6 5918.7 5951.8 6021.3 6030.3 6043.1 6043.5 6055.6 5734.7 5739.7 5848.3 5850.9 5860.9 5848.4 5894.1 5894.9 5917.2 5939.3 5801.5 5802.4 5803.3 5810.6 5823.6 5671.0 5756.9 5857.8 5932.7 5952.5 5758.9 5840.4 5841.0 5847.3 5862.9 10:10:02 INFO - 2015-11-23 10:10:02,893 DEBUG : BROWSER_OUTPUT: 10:10:02 INFO - 2015-11-23 10:10:02,893 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44984.20 Median:34061.99 stddev:75622.63 (222.0%) stddev-sans-first:75761.34 10:10:02 INFO - 2015-11-23 10:10:02,894 DEBUG : BROWSER_OUTPUT: Values: 597.1 597.8 604.2 613.2 617.3 36033.5 36992.4 37252.8 37271.6 37336.8 40941.0 41318.0 41346.4 41452.4 41629.6 8439.0 8623.5 8655.9 8657.2 8665.4 8579.5 8579.7 8618.7 8675.1 8713.1 8690.8 8771.2 8807.1 8816.2 8851.3 8625.4 8727.1 8771.8 8789.8 8796.5 8707.4 8848.7 8871.2 8877.8 8881.2 38684.8 38782.0 38991.0 39170.4 39355.4 3212.6 3292.7 3304.7 3343.6 3541.3 28646.0 29061.0 29688.7 29696.3 30281.4 3507.8 3514.8 3589.9 3682.8 3711.8 248556.0 249484.0 249715.0 250052.0 250323.0 49562.3 51044.0 58016.7 58902.7 58920.7 58048.1 58702.7 58901.0 59094.1 59180.7 13988.4 13991.4 14042.4 14083.9 14180.2 10733.6 10825.7 10827.6 10941.9 10979.4 19220.7 19591.3 19704.8 19864.8 19867.0 7378.2 7655.6 7704.3 7722.7 7725.2 989.1 1001.5 1001.8 1015.9 1076.0 27580.7 27914.0 27986.6 28001.9 29496.0 992.4 1032.8 1050.5 1137.2 1143.4 14134.9 14182.6 14293.2 14482.6 14540.8 318462.0 319898.0 321485.0 321638.0 321813.0 48594.0 49046.3 49204.5 49266.8 49346.3 1300.8 1314.7 1315.2 1333.6 1334.6 26367.0 26448.3 26488.0 26783.6 26823.9 44446.8 44575.6 44876.1 44898.8 44965.1 291006.0 292994.0 293103.0 293581.0 293740.0 30172.7 30921.8 31024.0 31031.5 31086.2 37246.0 37772.6 37805.0 38147.8 38198.0 31485.4 32001.7 32125.7 34365.7 34884.0 33270.0 33510.2 33766.3 33912.2 34734.0 33529.7 33964.8 34159.1 34164.5 34186.8 30252.4 31022.0 31966.7 32052.0 32203.8 24497.6 24682.8 24684.7 24708.4 24880.9 10:10:02 INFO - 2015-11-23 10:10:02,894 DEBUG : BROWSER_OUTPUT: 10:10:02 INFO - 2015-11-23 10:10:02,895 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27313.14 Median:4207.17 stddev:83193.51 (1977.4%) stddev-sans-first:83402.26 10:10:02 INFO - 2015-11-23 10:10:02,895 DEBUG : BROWSER_OUTPUT: Values: 353.0 356.7 358.1 360.1 360.8 17232.2 17945.8 18405.7 18859.2 19088.4 15962.6 16113.5 16450.1 16461.8 17163.3 4652.1 4732.1 4752.2 4775.9 4783.2 4476.7 4733.1 4739.2 4751.5 4752.2 4958.7 5101.0 5102.5 5287.9 5331.0 5032.3 5050.1 5059.7 5075.1 5099.9 5158.1 5174.3 5176.6 5188.7 5199.1 11624.7 11741.9 15645.5 19970.0 20187.5 1929.9 1993.7 2036.3 2127.1 2130.4 8921.6 8998.4 9060.9 9133.4 9180.6 1740.3 1745.1 1816.1 1816.9 1827.4 60877.7 64753.7 65030.0 65422.0 66830.0 9569.9 9889.0 9924.1 9942.7 9984.7 12739.4 12781.2 12807.4 12817.2 12836.8 7678.7 7683.5 7686.1 7699.3 7779.9 7620.2 7644.9 7654.2 7678.4 7691.0 4203.9 4210.5 4237.1 4240.4 4257.2 1752.5 1791.9 1792.6 1811.1 1836.4 384.3 394.3 398.1 400.8 404.9 10012.9 10358.5 10366.6 10453.1 10597.7 406.4 424.0 426.5 426.5 435.9 5358.1 5649.3 5651.0 5696.4 9285.2 495171.0 507177.0 509079.1 509935.0 516616.0 74501.3 79177.2 79912.2 80799.6 80945.6 1098.6 1128.8 1130.7 1135.9 1160.6 15494.3 15855.0 15906.6 15974.6 16128.4 34902.7 35226.8 35511.6 35986.8 36046.8 46054.3 46690.0 46811.5 51309.5 51817.7 8564.6 8903.2 8949.1 8984.6 9085.7 10348.0 10349.4 10431.9 10436.8 10452.8 2891.1 11478.2 12022.8 13357.7 13765.9 13115.2 13850.2 13881.6 13998.2 14158.2 14669.7 14866.9 14885.5 15115.5 15251.8 8904.8 9080.2 9119.9 9165.8 9230.3 9039.2 10575.9 14870.4 14888.3 15062.5 10:10:02 INFO - 2015-11-23 10:10:02,895 DEBUG : BROWSER_OUTPUT: 10:10:02 INFO - 2015-11-23 10:10:02,895 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5331.03 Median:6627.72 stddev:2752.70 (41.5%) stddev-sans-first:2745.43 10:10:02 INFO - 2015-11-23 10:10:02,896 DEBUG : BROWSER_OUTPUT: Values: 1508.2 1714.2 1755.6 1771.0 1785.7 7133.4 7498.1 7645.6 7751.3 7808.3 7887.8 7943.9 7991.9 7992.2 7994.5 2222.1 2243.6 2261.5 2262.6 2265.9 2241.9 2270.2 2273.4 2274.4 2289.6 2180.1 2229.9 2230.9 2238.6 2263.2 2187.4 2192.5 2229.1 2231.4 2242.1 2227.1 2227.8 2246.4 2259.5 2261.3 7371.0 7385.8 7431.3 7467.4 7485.8 4487.0 4544.8 4565.4 4576.0 4584.5 2930.4 2970.9 3019.8 3043.6 3045.2 886.8 892.2 918.4 922.0 937.4 10431.3 10507.1 10518.6 10535.2 10580.0 3975.6 3990.1 4027.6 4029.5 4057.0 8603.1 8624.1 8625.0 8626.0 8643.0 4582.3 4600.6 4606.3 4608.5 4612.4 4229.4 4248.5 4262.9 4265.7 4266.8 3213.1 3228.1 3255.7 3275.0 3275.6 955.0 955.4 963.1 963.3 966.4 1029.7 1034.3 1042.7 1182.2 1338.7 7144.5 7178.3 7200.4 7241.3 7247.3 1134.4 1142.3 1154.2 1167.9 1186.2 5774.2 5801.2 5814.1 5832.1 5835.7 8690.3 8880.5 8898.8 9086.4 9120.6 9060.9 9066.4 9118.8 9175.5 9205.1 6981.5 7015.0 7137.1 7197.3 7206.6 7233.7 7242.2 7259.3 7275.3 7286.2 7766.5 7936.2 7996.9 8077.8 8089.9 8153.3 8214.6 8215.9 8279.2 8336.3 6959.9 7013.6 7092.4 7112.1 7114.5 7130.9 7161.5 7202.7 7205.3 7218.2 6715.7 6775.7 6892.7 6983.9 7028.4 6589.8 6665.6 6746.3 6764.6 6774.9 6890.8 6890.9 6896.1 6905.2 6910.2 6189.5 6230.1 6250.8 6258.1 6258.2 6439.0 6443.8 6449.2 6458.6 6473.8 10:10:02 INFO - 2015-11-23 10:10:02,897 DEBUG : BROWSER_OUTPUT: 10:10:02 INFO - 2015-11-23 10:10:02,897 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5604.66 Median:6404.92 stddev:1736.08 (27.1%) stddev-sans-first:1694.50 10:10:02 INFO - 2015-11-23 10:10:02,898 DEBUG : BROWSER_OUTPUT: Values: 289.5 296.1 305.1 315.1 316.2 6270.9 6316.6 6345.1 6419.8 6532.7 6339.4 6380.6 6400.3 6403.5 6404.0 4813.1 4814.1 4819.1 4819.3 4824.7 4821.6 4829.9 4833.3 4837.5 4843.1 4650.9 4748.1 4767.6 4776.3 4785.1 4759.8 4762.9 4762.9 4764.1 4776.4 4086.0 4096.9 4107.7 4108.3 4119.7 6037.7 6061.0 6069.8 6079.7 6090.5 5392.6 5497.1 5513.4 5515.4 5543.6 6696.1 6729.2 6732.4 6734.7 6750.1 4534.3 4535.4 4536.5 4542.8 4547.3 6740.2 6874.5 6910.6 6922.4 6932.0 4523.2 4536.9 4537.3 4542.5 4547.0 4560.7 4590.9 4599.0 4604.5 4608.4 5450.9 5453.8 5460.8 5461.1 5462.5 6606.9 6761.2 6763.3 6764.7 6782.4 1565.1 1640.4 1657.6 1673.9 1674.4 1084.7 1090.0 1090.5 1092.4 1092.8 6388.4 6405.8 6408.0 6409.0 6437.8 6777.1 6838.6 6846.3 6852.9 6854.8 6327.7 6381.2 6423.6 6436.7 6455.6 3812.2 3824.4 3825.7 3830.4 3853.6 7294.6 7300.2 7304.3 7309.7 7315.8 6984.7 7207.3 7215.5 7234.1 7239.2 7216.5 7260.4 7270.7 7272.1 7297.1 6991.2 6996.5 7018.2 7056.3 7057.2 6795.2 6917.1 6947.7 6986.7 7003.7 7291.0 7301.4 7311.5 7314.8 7320.6 4570.2 4585.8 4615.8 4631.2 4644.9 6728.2 6746.5 6877.0 6998.5 7042.1 6652.9 6810.5 6812.4 6841.8 6859.9 6756.1 6786.6 6814.6 6819.6 6821.2 6522.6 6647.5 6662.5 6686.7 6686.9 6786.5 6797.9 6823.7 6835.7 6851.9 6600.4 6650.0 6659.2 6660.3 6666.6 10:10:02 INFO - 2015-11-23 10:10:02,898 DEBUG : BROWSER_OUTPUT: 10:10:02 INFO - 2015-11-23 10:10:02,899 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13547.02 Median:45381.77 stddev:15402.79 (33.9%) stddev-sans-first:15416.31 10:10:02 INFO - 2015-11-23 10:10:02,900 DEBUG : BROWSER_OUTPUT: Values: 812.4 836.7 842.7 847.1 856.0 12445.4 12695.4 12711.4 12722.7 12739.0 12110.6 12226.6 12234.1 12247.4 12256.9 795.6 819.8 835.9 835.9 836.3 825.3 830.5 832.4 832.8 833.1 851.9 854.0 856.0 857.3 859.9 843.0 848.1 848.4 849.9 850.7 620.6 622.9 623.0 623.1 624.0 12871.2 12985.1 13008.1 13028.3 13056.9 12181.6 12360.6 12471.4 12510.3 13006.6 9531.2 9988.1 9998.7 10162.7 10268.7 3330.7 3424.9 3491.2 3533.6 3533.8 47445.3 48800.8 48802.3 48983.5 49013.0 9675.9 9845.8 10083.1 10175.2 10207.4 17816.4 17829.4 17830.1 17831.6 17878.8 6113.1 6249.1 6264.7 6421.2 6572.7 4014.8 4019.6 4097.5 4144.0 4172.5 3008.8 3038.9 3055.2 3057.7 3058.1 508.2 524.7 529.7 531.5 532.3 591.5 637.0 642.5 679.4 729.5 8711.3 8845.6 8867.6 8926.2 9142.2 557.9 670.7 729.8 732.3 741.4 4095.1 4201.9 4224.3 4293.9 4366.9 51508.7 56002.7 56053.4 56084.7 56113.7 47146.3 48289.5 48517.8 49284.8 49393.0 45323.8 45439.8 45473.5 45564.3 45686.5 9063.6 9344.4 9426.9 9440.6 9441.1 33439.7 34436.3 34992.0 35014.6 35442.0 39442.6 39824.6 40561.8 44100.6 44272.1 11492.4 11511.9 11521.5 11552.2 11556.8 12293.8 12536.1 12570.8 12667.7 12720.7 10904.3 10992.1 11080.7 11248.0 11365.9 11575.9 12058.2 12254.5 12326.4 12735.7 11621.2 11712.0 11764.2 12030.3 12133.2 10107.7 10122.5 10646.4 10727.0 10801.1 9129.7 9486.1 9661.2 9818.4 9852.8 10:10:02 INFO - 2015-11-23 10:10:02,900 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:10:02 INFO - 2015-11-23 10:10:02,900 DEBUG : BROWSER_OUTPUT: 10:10:03 INFO - 2015-11-23 10:10:03,581 INFO : Browser exited with error code: 0 10:10:03 INFO - 2015-11-23 10:10:03,598 INFO : Completed test dromaeo_css (00:18:32) 10:10:03 INFO - 2015-11-23 10:10:03,598 INFO : Starting test kraken 10:10:03 INFO - 2015-11-23 10:10:03,598 DEBUG : operating with platform_type : linux_ 10:10:03 INFO - 2015-11-23 10:10:03,598 INFO : Initialising browser for kraken test... 10:10:03 INFO - 2015-11-23 10:10:03,604 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0n3re_/profile http://localhost:38640/getInfo.html 10:10:08 INFO - 2015-11-23 10:10:08,594 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:10:08 INFO - 2015-11-23 10:10:08,594 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:10:08 INFO - 2015-11-23 10:10:08,594 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:10:08 INFO - 2015-11-23 10:10:08,594 DEBUG : BROWSER_OUTPUT: __metrics 10:10:09 INFO - 2015-11-23 10:10:09,613 INFO : Browser initialized. 10:10:09 INFO - 2015-11-23 10:10:09,614 INFO : Running cycle 1/1 for kraken test... 10:10:09 INFO - 2015-11-23 10:10:09,614 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0n3re_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:10:21 INFO - 2015-11-23 10:10:21,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 140062720 10:10:21 INFO - 2015-11-23 10:10:21,388 DEBUG : BROWSER_OUTPUT: 10:10:23 INFO - 2015-11-23 10:10:23,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38640/tests/kraken/driver.html?testName=audio-beat-detection) 10:10:24 INFO - 2015-11-23 10:10:24,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 143323136 10:10:24 INFO - 2015-11-23 10:10:24,454 DEBUG : BROWSER_OUTPUT: 10:10:27 INFO - 2015-11-23 10:10:27,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38640/tests/kraken/driver.html?testName=audio-dft) 10:10:27 INFO - 2015-11-23 10:10:27,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 142839808 10:10:27 INFO - 2015-11-23 10:10:27,713 DEBUG : BROWSER_OUTPUT: 10:10:30 INFO - 2015-11-23 10:10:30,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38640/tests/kraken/driver.html?testName=audio-fft) 10:10:31 INFO - 2015-11-23 10:10:31,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 137969664 10:10:31 INFO - 2015-11-23 10:10:31,137 DEBUG : BROWSER_OUTPUT: 10:10:33 INFO - 2015-11-23 10:10:33,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38640/tests/kraken/driver.html?testName=audio-oscillator) 10:10:33 INFO - 2015-11-23 10:10:33,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 137756672 10:10:33 INFO - 2015-11-23 10:10:33,769 DEBUG : BROWSER_OUTPUT: 10:10:35 INFO - 2015-11-23 10:10:35,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38640/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:10:36 INFO - 2015-11-23 10:10:36,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 138993664 10:10:36 INFO - 2015-11-23 10:10:36,572 DEBUG : BROWSER_OUTPUT: 10:10:39 INFO - 2015-11-23 10:10:39,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38640/tests/kraken/driver.html?testName=imaging-darkroom) 10:10:40 INFO - 2015-11-23 10:10:40,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 140144640 10:10:40 INFO - 2015-11-23 10:10:40,150 DEBUG : BROWSER_OUTPUT: 10:10:43 INFO - 2015-11-23 10:10:43,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38640/tests/kraken/driver.html?testName=imaging-desaturate) 10:10:44 INFO - 2015-11-23 10:10:44,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 140361728 10:10:44 INFO - 2015-11-23 10:10:44,152 DEBUG : BROWSER_OUTPUT: 10:10:46 INFO - 2015-11-23 10:10:46,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38640/tests/kraken/driver.html?testName=json-parse-financial) 10:10:47 INFO - 2015-11-23 10:10:47,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 138051584 10:10:47 INFO - 2015-11-23 10:10:47,547 DEBUG : BROWSER_OUTPUT: 10:10:49 INFO - 2015-11-23 10:10:49,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38640/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:10:49 INFO - 2015-11-23 10:10:49,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 139763712 10:10:49 INFO - 2015-11-23 10:10:49,722 DEBUG : BROWSER_OUTPUT: 10:10:51 INFO - 2015-11-23 10:10:51,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38640/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:10:52 INFO - 2015-11-23 10:10:52,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 140091392 10:10:52 INFO - 2015-11-23 10:10:52,160 DEBUG : BROWSER_OUTPUT: 10:10:54 INFO - 2015-11-23 10:10:54,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38640/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:10:54 INFO - 2015-11-23 10:10:54,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 139415552 10:10:54 INFO - 2015-11-23 10:10:54,802 DEBUG : BROWSER_OUTPUT: 10:10:57 INFO - 2015-11-23 10:10:57,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38640/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:10:57 INFO - 2015-11-23 10:10:57,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 140300288 10:10:57 INFO - 2015-11-23 10:10:57,871 DEBUG : BROWSER_OUTPUT: 10:11:00 INFO - 2015-11-23 10:11:00,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38640/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:01 INFO - 2015-11-23 10:11:01,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 139956224 10:11:01 INFO - 2015-11-23 10:11:01,077 DEBUG : BROWSER_OUTPUT: 10:11:02 INFO - 2015-11-23 10:11:02,751 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38640/tests/kraken/driver.html?testName=ai-astar) 10:11:03 INFO - 2015-11-23 10:11:03,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 139415552 10:11:03 INFO - 2015-11-23 10:11:03,009 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,009 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:11:03 INFO - 2015-11-23 10:11:03,009 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:11:03 INFO - 2015-11-23 10:11:03,009 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:11:03 INFO - 2015-11-23 10:11:03,010 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:11:03 INFO - 2015-11-23 10:11:03,010 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;104;112;110;112;123;110;112;110;109 10:11:03 INFO - 2015-11-23 10:11:03,010 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;126;155;165;132;159;158;129;158;126 10:11:03 INFO - 2015-11-23 10:11:03,010 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;162;164;161;162;165;171;163 10:11:03 INFO - 2015-11-23 10:11:03,010 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;71;71;72;74;158;71;73;74 10:11:03 INFO - 2015-11-23 10:11:03,011 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;138;92;93;93;146;93;93;142 10:11:03 INFO - 2015-11-23 10:11:03,011 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;109;110;110;110;110;110;111;110;109 10:11:03 INFO - 2015-11-23 10:11:03,011 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;147;147;148;147;146;147;147 10:11:03 INFO - 2015-11-23 10:11:03,011 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;96;96;96;97;97;97;100 10:11:03 INFO - 2015-11-23 10:11:03,012 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;65;65;64;68;64;66;62;63;62;63 10:11:03 INFO - 2015-11-23 10:11:03,012 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;69;69;69;69;70;70;69;70;70 10:11:03 INFO - 2015-11-23 10:11:03,012 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;85;84;84;84;83;85;85;84;87 10:11:03 INFO - 2015-11-23 10:11:03,012 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;129;118;142;128;118;120;125;119;129 10:11:03 INFO - 2015-11-23 10:11:03,013 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;153;152;165;154;142;154;151;153;157 10:11:03 INFO - 2015-11-23 10:11:03,013 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;76;69;70;67;72;66;66;68 10:11:03 INFO - 2015-11-23 10:11:03,013 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:11:03 INFO - 2015-11-23 10:11:03,013 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:11:03 INFO - 2015-11-23 10:11:03,013 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,703 10:11:03 INFO - 2015-11-23 10:11:03,013 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:11:03 INFO - 2015-11-23 10:11:03,014 DEBUG : BROWSER_OUTPUT: __startTimestamp1448302263003__endTimestamp 10:11:03 INFO - 2015-11-23 10:11:03,014 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,014 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:11:03 INFO - 2015-11-23 10:11:03,014 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:11:03 INFO - 2015-11-23 10:11:03,014 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,014 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:4.76 (4.3%) stddev-sans-first:5.02 10:11:03 INFO - 2015-11-23 10:11:03,014 DEBUG : BROWSER_OUTPUT: Values: 110.0 104.0 112.0 110.0 112.0 123.0 110.0 112.0 110.0 109.0 10:11:03 INFO - 2015-11-23 10:11:03,014 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,014 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.20 Median:156.50 stddev:15.80 (10.1%) stddev-sans-first:16.51 10:11:03 INFO - 2015-11-23 10:11:03,016 DEBUG : BROWSER_OUTPUT: Values: 154.0 126.0 155.0 165.0 132.0 159.0 158.0 129.0 158.0 126.0 10:11:03 INFO - 2015-11-23 10:11:03,016 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,016 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.40 Median:162.50 stddev:2.91 (1.8%) stddev-sans-first:3.05 10:11:03 INFO - 2015-11-23 10:11:03,016 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 162.0 164.0 161.0 162.0 165.0 171.0 163.0 10:11:03 INFO - 2015-11-23 10:11:03,016 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,016 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.80 Median:72.00 stddev:27.15 (37.7%) stddev-sans-first:28.61 10:11:03 INFO - 2015-11-23 10:11:03,016 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 71.0 71.0 72.0 74.0 158.0 71.0 73.0 74.0 10:11:03 INFO - 2015-11-23 10:11:03,016 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,016 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.60 Median:93.00 stddev:23.82 (25.6%) stddev-sans-first:24.67 10:11:03 INFO - 2015-11-23 10:11:03,017 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 138.0 92.0 93.0 93.0 146.0 93.0 93.0 142.0 10:11:03 INFO - 2015-11-23 10:11:03,017 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,017 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 10:11:03 INFO - 2015-11-23 10:11:03,017 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 109.0 10:11:03 INFO - 2015-11-23 10:11:03,017 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,017 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 10:11:03 INFO - 2015-11-23 10:11:03,017 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 147.0 147.0 148.0 147.0 146.0 147.0 147.0 10:11:03 INFO - 2015-11-23 10:11:03,017 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,017 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.50 stddev:1.23 (1.3%) stddev-sans-first:1.27 10:11:03 INFO - 2015-11-23 10:11:03,017 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 96.0 96.0 96.0 97.0 97.0 97.0 100.0 10:11:03 INFO - 2015-11-23 10:11:03,017 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,018 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.50 stddev:1.87 (2.9%) stddev-sans-first:1.96 10:11:03 INFO - 2015-11-23 10:11:03,018 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 64.0 68.0 64.0 66.0 62.0 63.0 62.0 63.0 10:11:03 INFO - 2015-11-23 10:11:03,018 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,018 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 10:11:03 INFO - 2015-11-23 10:11:03,018 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 69.0 69.0 70.0 70.0 69.0 70.0 70.0 10:11:03 INFO - 2015-11-23 10:11:03,018 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,018 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:1.07 (1.3%) stddev-sans-first:1.13 10:11:03 INFO - 2015-11-23 10:11:03,018 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 84.0 84.0 84.0 83.0 85.0 85.0 84.0 87.0 10:11:03 INFO - 2015-11-23 10:11:03,018 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,018 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:126.50 stddev:7.82 (6.2%) stddev-sans-first:7.81 10:11:03 INFO - 2015-11-23 10:11:03,019 DEBUG : BROWSER_OUTPUT: Values: 117.0 129.0 118.0 142.0 128.0 118.0 120.0 125.0 119.0 129.0 10:11:03 INFO - 2015-11-23 10:11:03,019 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,019 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:153.50 stddev:5.66 (3.7%) stddev-sans-first:5.98 10:11:03 INFO - 2015-11-23 10:11:03,019 DEBUG : BROWSER_OUTPUT: Values: 152.0 153.0 152.0 165.0 154.0 142.0 154.0 151.0 153.0 157.0 10:11:03 INFO - 2015-11-23 10:11:03,019 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,019 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.50 stddev:3.16 (4.6%) stddev-sans-first:3.28 10:11:03 INFO - 2015-11-23 10:11:03,019 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 76.0 69.0 70.0 67.0 72.0 66.0 66.0 68.0 10:11:03 INFO - 2015-11-23 10:11:03,019 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:11:03 INFO - 2015-11-23 10:11:03,019 DEBUG : BROWSER_OUTPUT: 10:11:03 INFO - 2015-11-23 10:11:03,953 INFO : Browser exited with error code: 0 10:11:04 INFO - 2015-11-23 10:11:04,002 INFO : Completed test kraken (00:01:00) 10:11:04 INFO - 2015-11-23 10:11:04,002 INFO : Starting test v8_7 10:11:04 INFO - 2015-11-23 10:11:04,002 DEBUG : operating with platform_type : linux_ 10:11:04 INFO - 2015-11-23 10:11:04,002 INFO : Initialising browser for v8_7 test... 10:11:04 INFO - 2015-11-23 10:11:04,008 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSUFCHi/profile http://localhost:38640/getInfo.html 10:11:09 INFO - 2015-11-23 10:11:09,196 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:11:09 INFO - 2015-11-23 10:11:09,197 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:11:09 INFO - 2015-11-23 10:11:09,197 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:11:09 INFO - 2015-11-23 10:11:09,197 DEBUG : BROWSER_OUTPUT: __metrics 10:11:10 INFO - 2015-11-23 10:11:10,373 INFO : Browser initialized. 10:11:10 INFO - 2015-11-23 10:11:10,374 INFO : Running cycle 1/1 for v8_7 test... 10:11:10 INFO - 2015-11-23 10:11:10,374 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSUFCHi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:11:22 INFO - 2015-11-23 10:11:22,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 141795328 10:11:22 INFO - 2015-11-23 10:11:22,181 DEBUG : BROWSER_OUTPUT: 10:11:43 INFO - 2015-11-23 10:11:43,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38640/tests/v8_7/run.html (next: http://localhost:38640/tests/v8_7/run.html) 10:11:43 INFO - 2015-11-23 10:11:43,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 138629120 10:11:43 INFO - 2015-11-23 10:11:43,856 DEBUG : BROWSER_OUTPUT: 10:11:43 INFO - 2015-11-23 10:11:43,858 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:11:43 INFO - 2015-11-23 10:11:43,858 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:11:43 INFO - 2015-11-23 10:11:43,858 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:11:43 INFO - 2015-11-23 10:11:43,858 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:11:43 INFO - 2015-11-23 10:11:43,858 DEBUG : BROWSER_OUTPUT: |0;Richards;184.945441094877 10:11:43 INFO - 2015-11-23 10:11:43,858 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.01293186643505 10:11:43 INFO - 2015-11-23 10:11:43,859 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.2690582959641 10:11:43 INFO - 2015-11-23 10:11:43,859 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4990.049751243781 10:11:43 INFO - 2015-11-23 10:11:43,859 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1059.322033898305 10:11:43 INFO - 2015-11-23 10:11:43,859 DEBUG : BROWSER_OUTPUT: |5;Earley;709.7232079488999 10:11:43 INFO - 2015-11-23 10:11:43,859 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 10:11:43 INFO - 2015-11-23 10:11:43,860 DEBUG : BROWSER_OUTPUT: |7;RegExp;24829.268292682926 10:11:43 INFO - 2015-11-23 10:11:43,860 DEBUG : BROWSER_OUTPUT: |8;Splay;653.2988357050452 10:11:43 INFO - 2015-11-23 10:11:43,860 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 10:11:43 INFO - 2015-11-23 10:11:43,860 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:11:43 INFO - 2015-11-23 10:11:43,860 DEBUG : BROWSER_OUTPUT: __startTimestamp1448302303856__endTimestamp 10:11:43 INFO - 2015-11-23 10:11:43,861 DEBUG : BROWSER_OUTPUT: 10:11:43 INFO - 2015-11-23 10:11:43,861 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:11:43 INFO - 2015-11-23 10:11:43,861 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:11:43 INFO - 2015-11-23 10:11:43,861 DEBUG : BROWSER_OUTPUT: 10:11:43 INFO - 2015-11-23 10:11:43,861 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:184.95 Median:184.95 stddev:0.00 (0.0%) 10:11:43 INFO - 2015-11-23 10:11:43,861 DEBUG : BROWSER_OUTPUT: Values: 184.9 10:11:43 INFO - 2015-11-23 10:11:43,861 DEBUG : BROWSER_OUTPUT: 10:11:43 INFO - 2015-11-23 10:11:43,861 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.01 Median:193.01 stddev:0.00 (0.0%) 10:11:43 INFO - 2015-11-23 10:11:43,861 DEBUG : BROWSER_OUTPUT: Values: 193.0 10:11:43 INFO - 2015-11-23 10:11:43,862 DEBUG : BROWSER_OUTPUT: 10:11:43 INFO - 2015-11-23 10:11:43,862 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 10:11:43 INFO - 2015-11-23 10:11:43,862 DEBUG : BROWSER_OUTPUT: Values: 280.3 10:11:43 INFO - 2015-11-23 10:11:43,862 DEBUG : BROWSER_OUTPUT: 10:11:43 INFO - 2015-11-23 10:11:43,862 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4990.05 Median:4990.05 stddev:0.00 (0.0%) 10:11:43 INFO - 2015-11-23 10:11:43,862 DEBUG : BROWSER_OUTPUT: Values: 4990.0 10:11:43 INFO - 2015-11-23 10:11:43,862 DEBUG : BROWSER_OUTPUT: 10:11:43 INFO - 2015-11-23 10:11:43,862 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1059.32 Median:1059.32 stddev:0.00 (0.0%) 10:11:43 INFO - 2015-11-23 10:11:43,864 DEBUG : BROWSER_OUTPUT: Values: 1059.3 10:11:43 INFO - 2015-11-23 10:11:43,864 DEBUG : BROWSER_OUTPUT: 10:11:43 INFO - 2015-11-23 10:11:43,864 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:709.72 Median:709.72 stddev:0.00 (0.0%) 10:11:43 INFO - 2015-11-23 10:11:43,864 DEBUG : BROWSER_OUTPUT: Values: 709.7 10:11:43 INFO - 2015-11-23 10:11:43,864 DEBUG : BROWSER_OUTPUT: 10:11:43 INFO - 2015-11-23 10:11:43,864 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 10:11:43 INFO - 2015-11-23 10:11:43,865 DEBUG : BROWSER_OUTPUT: Values: 12195.1 10:11:43 INFO - 2015-11-23 10:11:43,865 DEBUG : BROWSER_OUTPUT: 10:11:43 INFO - 2015-11-23 10:11:43,865 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24829.27 Median:24829.27 stddev:0.00 (0.0%) 10:11:43 INFO - 2015-11-23 10:11:43,865 DEBUG : BROWSER_OUTPUT: Values: 24829.3 10:11:43 INFO - 2015-11-23 10:11:43,865 DEBUG : BROWSER_OUTPUT: 10:11:43 INFO - 2015-11-23 10:11:43,865 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:653.30 Median:653.30 stddev:0.00 (0.0%) 10:11:43 INFO - 2015-11-23 10:11:43,865 DEBUG : BROWSER_OUTPUT: Values: 653.3 10:11:43 INFO - 2015-11-23 10:11:43,866 DEBUG : BROWSER_OUTPUT: 10:11:43 INFO - 2015-11-23 10:11:43,866 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 10:11:43 INFO - 2015-11-23 10:11:43,866 DEBUG : BROWSER_OUTPUT: Values: 4845.4 10:11:43 INFO - 2015-11-23 10:11:43,866 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:11:43 INFO - 2015-11-23 10:11:43,866 DEBUG : BROWSER_OUTPUT: 10:11:44 INFO - 2015-11-23 10:11:44,769 INFO : Browser exited with error code: 0 10:11:44 INFO - 2015-11-23 10:11:44,788 INFO : Completed test v8_7 (00:00:40) 10:11:44 INFO - 2015-11-23 10:11:44,906 INFO : Completed test suite (00:20:13) 10:11:44 INFO - 2015-11-23 10:11:44,906 DEBUG : Working with test: dromaeo_css 10:11:44 INFO - 2015-11-23 10:11:44,907 DEBUG : Generating results file: dromaeo_css 10:11:44 INFO - 2015-11-23 10:11:44,908 DEBUG : Working with test: kraken 10:11:44 INFO - 2015-11-23 10:11:44,908 DEBUG : Generating results file: kraken 10:11:44 INFO - 2015-11-23 10:11:44,908 INFO : javascript benchmark 10:11:44 INFO - 2015-11-23 10:11:44,908 DEBUG : Working with test: v8_7 10:11:44 INFO - 2015-11-23 10:11:44,908 DEBUG : Generating results file: v8_7 10:11:44 INFO - 2015-11-23 10:11:44,909 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:11:44 INFO - 2015-11-23 10:11:44,962 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 10:11:44 INFO - 2015-11-23 10:11:44,962 DEBUG : process_Request line: dromaeo_css 6890.77 graph.html#tests=[[72,1,43]] 10:11:44 INFO - 2015-11-23 10:11:44,962 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:11:44 INFO - 2015-11-23 10:11:44,997 DEBUG : process_Request line: kraken 1527.90 graph.html#tests=[[232,1,43]] 10:11:44 INFO - 2015-11-23 10:11:44,997 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:11:45 INFO - 2015-11-23 10:11:45,028 DEBUG : process_Request line: v8_7 21078.07 graph.html#tests=[[230,1,43]] 10:11:45 INFO - 2015-11-23 10:11:45,030 INFO : javascript benchmark 10:11:45 INFO - 2015-11-23 10:11:45,034 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3212.9196770080753, 3245.529398237254, 3269.3461307738457, 3291.7202037826783, 3295.1762059485127, 5322.547583455401, 5544.473275038875, 5546.805861794838, 5554.666719996803, 5554.805581804638, 5446.891062178764, 5447.210154527591, 5460.6177567570285, 5481.835544933649, 5524.281843360358, 4973.72644504553, 5038.118329292359, 5084.110280700863, 5114.539691427771, 5121.462246464105, 5029.0, 5104.923426148611, 5115.283860259567, 5148.253503242027, 5161.7161056141895, 4897.04507621014, 4987.501249874984, 4990.725510096943, 5088.23676448532, 5137.357830271216, 5044.646874718771, 5060.038592667382, 5060.67105638136, 5062.898742025176, 5084.389873215201, 5050.368703912011, 5067.670601410897, 5070.0, 5081.18701007837, 5102.69383836971, 5208.453112423179, 5256.395514515803, 5322.9620224056325, 5370.91943620846, 5420.0, 5893.941060589425, 6020.6688632125215, 6026.758929642809, 6028.487578555828, 6029.216201893726, 6076.787312444043, 6100.938990610081, 6103.938960610381, 6119.1739115219325, 6120.877582448326, 5441.2654291670515, 5444.0, 5554.361248456398, 5564.805231816867, 5601.243832082698, 6051.152838602599, 6051.757929682852, 6072.878542429126, 6080.726367313481, 6102.847428814315, 5754.1944127822135, 5918.141869428909, 5945.881082378328, 5957.76168953237, 5964.642121472725, 5870.295564532198, 5935.465808077208, 5936.821895343147, 5951.404859514014, 6002.429769171922, 5852.619579727304, 5894.557908156906, 5896.0, 5937.495312898452, 5957.851053723692, 5658.179563963202, 5776.971115144482, 5877.588568800143, 5947.107933809876, 5957.344692083867, 4500.954990450054, 4531.22969095248, 4534.070515544306, 4585.977070114628, 4592.10453961481, 4032.6773858091283, 4048.4332193492933, 4058.7564746115327, 4062.471878655756, 4079.347304431277, 5435.592330575223, 5502.642328248651, 5533.0, 5675.404082571353, 5676.77292908279, 5833.591648584558, 5890.440408161217, 5905.43898329658, 5923.674197919156, 5931.58478906481, 5697.544196464273, 5718.914216286759, 5724.0, 5728.6276392035215, 5732.942670573241, 5033.446320904697, 5147.7683504242395, 5223.268742376071, 5224.242484839677, 5252.133397989365, 6036.42653947883, 6114.357992410822, 6115.422885572139, 6121.026213050743, 6138.570300078952, 5970.731317090655, 6015.879682406415, 6033.18551995475, 6036.0644100164545, 6051.818445446644, 5909.793157239476, 5978.4021597839865, 6011.368806275278, 6123.724432400463, 6145.66198859067, 5878.706064696834, 5894.233749612523, 5906.645601263938, 5918.704064796829, 5951.791687290924, 6021.337652858095, 6030.336662967158, 6043.093535969464, 6043.54673399488, 6055.636661800306, 5734.655920644775, 5739.7417116229035, 5848.2689663792025, 5850.912236316373, 5860.882782344244, 5848.385919478564, 5894.086416605433, 5894.882102357843, 5917.230760001173, 5939.316978547522, 5801.535877129904, 5802.361740208489, 5803.274590676166, 5810.593258471867, 5823.563232757476, 5671.0, 5756.913646295393, 5857.824265272048, 5932.703364831655, 5952.494038006818, 5758.856028599319, 5840.445157710011, 5841.036229022334, 5847.26909136358, 5862.94137058641], "unit": "ms", "name": "dojo.html", "value": 5486.487263604503}, {"lowerIsBetter": false, "replicates": [597.0596310810473, 597.8385835824328, 604.2296072507552, 613.2028363127932, 617.2623714660976, 36033.45949810755, 36992.44511332332, 37252.81373593135, 37271.62728372715, 37336.81331593342, 40941.0, 41318.0, 41346.37980430296, 41452.37821432681, 41629.58370416295, 8439.0, 8623.525706086162, 8655.913440865574, 8657.177568131017, 8665.39342246043, 8579.52812595307, 8579.699710510133, 8618.741437756846, 8675.132486751307, 8713.128687131268, 8690.826183476327, 8771.210591046805, 8807.075257097977, 8816.206541411271, 8851.33614978879, 8625.439346442492, 8727.083656216133, 8771.824563508726, 8789.780255493632, 8796.516191609458, 8707.390482666216, 8848.690295839615, 8871.2015918567, 8877.778055548599, 8881.200691937693, 38684.806575967224, 38782.0, 38991.0, 39170.412443813366, 39355.40966885499, 3212.550242965987, 3292.720118789906, 3304.686054824788, 3343.648916863743, 3541.3448512025357, 28646.0, 29061.0, 29688.70311296881, 29696.257593560116, 30281.394372112656, 3507.771994820354, 3514.8418321175354, 3589.856405743767, 3682.834272457746, 3711.814409279525, 248556.0, 249484.0, 249715.0, 250052.0, 250323.0, 49562.25656615154, 51044.0, 58016.70991645099, 58902.705486472296, 58920.705396472746, 58048.129278060864, 58702.706486467294, 58901.0, 59094.11358829621, 59180.70409647924, 13988.440462381594, 13991.440342386191, 14042.36809343582, 14083.859161408254, 14180.220087895059, 10733.570657173781, 10825.729356766144, 10827.566897324177, 10941.945290273497, 10979.39613321275, 19220.71168932439, 19591.31430399929, 19704.802951970298, 19864.801351986294, 19867.0, 7378.151512576015, 7655.617219139021, 7704.30661240491, 7722.691092356243, 7725.227477252342, 989.1246247071393, 1001.4592120255127, 1001.7695929936156, 1015.8527013582989, 1075.9778210699867, 27580.724192757814, 27914.0, 27986.580201296998, 28001.859990699915, 29496.0, 992.374803873555, 1032.8450732390202, 1050.4747626186906, 1137.1698659978263, 1143.4397145398696, 14134.929325353512, 14182.645433864029, 14293.213873237071, 14482.565523034325, 14540.781888271684, 318462.0, 319898.0, 321485.0, 321638.0, 321813.0, 48594.02811943741, 49046.26430603544, 49204.507954919995, 49266.75366623216, 49346.259806102935, 1300.8373953256032, 1314.7436249931172, 1315.224017829466, 1333.613252156883, 1334.5729366602789, 26367.0, 26448.338791530365, 26488.0, 26783.598246025937, 26823.865880670473, 44446.777766110965, 44575.554244458435, 44876.10247794961, 44898.77550612226, 44965.10069798651, 291006.0, 292994.0, 293103.0, 293581.0, 293740.0, 30172.698273016988, 30921.8453907729, 31024.0, 31031.53452698166, 31086.22284442907, 37246.0, 37772.62227377691, 37805.0, 38147.80926095463, 38198.0, 31485.370292594478, 32001.67998319987, 32125.67874321227, 34365.65634343625, 34884.0, 33270.0, 33510.16224594405, 33766.3246735059, 33912.15219619529, 34734.0, 33529.66470335363, 33964.83017584896, 34159.14602134967, 34164.48753268653, 34186.829065855505, 30252.394952101276, 31022.0, 31966.680333197302, 32052.0, 32203.838980804947, 24497.5904337221, 24682.753172468765, 24684.65495777898, 24708.38229044288, 24880.875595621907], "unit": "ms", "name": "ext.html", "value": 17921.47884446439}, {"lowerIsBetter": false, "replicates": [352.97176225901933, 356.7360153486419, 358.0887385555434, 360.1410635634012, 360.8322130209453, 17232.224549895254, 17945.82054179458, 18405.723914141265, 18859.151338189797, 19088.42734717957, 15962.600934976632, 16113.516594502154, 16450.095244761535, 16461.753073703905, 17163.313467461317, 4652.092841895832, 4732.124556956956, 4752.192127338343, 4775.880602984918, 4783.210770222909, 4476.709013914102, 4733.100710864942, 4739.241721324589, 4751.477337492873, 4752.215884379073, 4958.702477851322, 5101.030804147219, 5102.515261050195, 5287.947120528803, 5331.040412725708, 5032.345795046657, 5050.141475949097, 5059.747012649371, 5075.137226671474, 5099.923501147448, 5158.071547121516, 5174.275601415768, 5176.637635365526, 5188.688678679254, 5199.090159222159, 11624.709382265426, 11741.88258117425, 15645.530634080997, 19970.0, 20187.495312617157, 1929.8649094563386, 1993.6610776168086, 2036.2669439001947, 2127.0747224957195, 2130.392838041166, 8921.598528066253, 8998.370114092017, 9060.864087038699, 9133.36066475347, 9180.586873590704, 1740.3125765322752, 1745.1361576019824, 1816.1191821966336, 1816.8626320654305, 1827.4334956163632, 60877.69561152166, 64753.676231619014, 65030.02454963132, 65422.0, 66830.0, 9569.89946156201, 9889.0, 9924.106830385155, 9942.652007179713, 9984.700458986243, 12739.36303184837, 12781.16922400041, 12807.423665934868, 12817.23096614206, 12836.80744788829, 7678.692852285958, 7683.538987660758, 7686.116096648845, 7699.307062364414, 7779.8833017504785, 7620.199879012624, 7644.885326720104, 7654.158042615308, 7678.424118191158, 7691.038620172479, 4203.852865149766, 4210.494740631144, 4237.131388065439, 4240.363945408152, 4257.169851878916, 1752.50053734685, 1791.8566514678794, 1792.5518620344915, 1811.1397086384125, 1836.4490652804104, 384.31591766655396, 394.2981492942567, 398.06256266492574, 400.82564084623283, 404.88865561970107, 10012.899871001197, 10358.482075896174, 10366.585336586602, 10453.111485523663, 10597.735056623493, 406.42693801739404, 423.9936400953988, 426.45200916821733, 426.5286858021903, 435.906280149763, 5358.115910874662, 5649.322081350264, 5651.0, 5696.401877802854, 9285.210757085588, 495171.0, 507177.0, 509079.091440886, 509935.0, 516616.0, 74501.25498745052, 79177.20822791698, 79912.20087799164, 80799.5960020196, 80945.59527202326, 1098.5825386353135, 1128.8081026225561, 1130.7229728716352, 1135.8807325230896, 1160.5763896178003, 15494.302756375764, 15855.0, 15906.60233494172, 15974.60063498422, 16128.354865805706, 34902.650973490956, 35226.823865880506, 35511.644883550834, 35986.82006590055, 36046.819765901004, 46054.309185362916, 46690.0, 46811.53188468072, 51309.48690513047, 51817.7409112952, 8564.614592343234, 8903.19871211594, 8949.149830766068, 8984.640614375352, 9085.727428177166, 10348.0, 10349.379037257788, 10431.895681043092, 10436.843447348145, 10452.790944181226, 2891.060405368306, 11478.196526243082, 12022.75954480923, 13357.66605834862, 13765.902671898742, 13115.213087214797, 13850.238236896665, 13881.583552493441, 13998.230097344336, 14158.221297828306, 14669.706605868036, 14866.925665372037, 14885.479008234659, 15115.470958516398, 15251.771223431879, 8904.777380565538, 9080.182783549511, 9119.908800911906, 9165.816683666157, 9230.307726920642, 9039.231665308522, 10575.894241057798, 14870.405183792527, 14888.330025149111, 15062.548123556311], "unit": "ms", "name": "jquery.html", "value": 7898.881271428769}, {"lowerIsBetter": false, "replicates": [1508.178042966583, 1714.2371644618142, 1755.648870225955, 1770.9734353984693, 1785.7232129020006, 7133.393661538763, 7498.062742157231, 7645.579493127882, 7751.302382785549, 7808.258215469528, 7887.763367098982, 7943.92056079439, 7991.920080799205, 7992.240737129978, 7994.4803587766755, 2222.055626358795, 2243.6298010828277, 2261.536385041071, 2262.6379779235326, 2265.9433514162197, 2241.8766967816764, 2270.182734215681, 2273.3975496493445, 2274.3972847195505, 2289.5764283607587, 2180.062573093569, 2229.8996545155505, 2230.888455577223, 2238.597052530552, 2263.2191893796694, 2187.3547303545333, 2192.495725983025, 2229.0972156276734, 2231.3529076567775, 2242.0583354990863, 2227.13141874669, 2227.7883601057874, 2246.3597874605657, 2259.53679495703, 2261.2537862505333, 7371.0, 7385.815354616124, 7431.256874312579, 7467.365273951721, 7485.7754267372065, 4487.035287413222, 4544.840930567414, 4565.360849481075, 4576.039031803325, 4584.4957054723955, 2930.413917216565, 2970.8960186393588, 3019.758419326449, 3043.5738996540504, 3045.162580290416, 886.7517095213351, 892.1702816380763, 918.4168053286145, 922.0180507759216, 937.3906960475678, 10431.321964072387, 10507.054365107177, 10518.579256829718, 10535.157187424988, 10580.047795698423, 3975.5626881043063, 3990.1421194443333, 4027.556968733437, 4029.4560234368573, 4056.9797151014645, 8603.139686031473, 8624.051354351017, 8625.0, 8626.0, 8643.0, 4582.335561343587, 4600.631949444037, 4606.262997920317, 4608.493065762764, 4612.400387949545, 4229.365595160751, 4248.490181178278, 4262.850800221977, 4265.680073994463, 4266.807993640294, 3213.1485156433564, 3228.0961330827404, 3255.6814490131533, 3275.0, 3275.606927168755, 954.9856752148723, 955.4315182466421, 963.0995019656503, 963.2679163835536, 966.4104896013426, 1029.696239609317, 1034.281174583657, 1042.718466014172, 1182.2020136408062, 1338.7054847933439, 7144.535605185646, 7178.28217178278, 7200.387967022757, 7241.348278654947, 7247.311505406978, 1134.398285443713, 1142.2803633710876, 1154.2382027861572, 1167.8656954450178, 1186.163754553038, 5774.162746401748, 5801.245838041028, 5814.069748840166, 5832.066869300891, 5835.708214589338, 8690.261327787082, 8880.467171969702, 8898.822023559493, 9086.363954523253, 9120.58957346921, 9060.909390906138, 9066.410683305565, 9118.772030699152, 9175.495347755937, 9205.079492050741, 6981.511294209458, 7015.0, 7137.10786151731, 7197.280271972761, 7206.639668016683, 7233.674484648098, 7242.203357630551, 7259.310365515479, 7275.272472752682, 7286.198518162892, 7766.534007959541, 7936.206379362017, 7996.920030799618, 8077.798055048671, 8089.878651820345, 8153.266206041485, 8214.630341634522, 8215.876761848458, 8279.213474719892, 8336.29141522953, 6959.89560156588, 7013.614251216232, 7092.361687448154, 7112.110986126734, 7114.537555058904, 7130.893036604559, 7161.4628902831455, 7202.71189152428, 7205.279472052753, 7218.169910460364, 6715.731370745116, 6775.661216939232, 6892.689828957608, 6983.895241571482, 7028.402585780266, 6589.80230593083, 6665.633390163587, 6746.325367463214, 6764.594124352555, 6774.898376524257, 6890.793276201722, 6890.8621827564175, 6896.103506544117, 6905.205901321412, 6910.170779506491, 6189.50483961273, 6230.06549017651, 6250.781222657185, 6258.123862659322, 6258.217722784652, 6438.967805160944, 6443.7744678936015, 6449.161608990801, 6458.61248325102, 6473.805785826433], "unit": "ms", "name": "mootools.html", "value": 4373.793814083118}, {"lowerIsBetter": false, "replicates": [289.4587122081707, 296.07181486041253, 305.06649652064687, 315.13966870443676, 316.22682541186805, 6270.937290627093, 6316.589421687587, 6345.079963405304, 6419.775307864225, 6532.706028228729, 6339.366063393658, 6380.585261957969, 6400.295967443589, 6403.519736019805, 6404.039394090889, 4813.061453016663, 4814.1334559779225, 4819.084373968953, 4819.301201325806, 4824.686395384307, 4821.63837712173, 4829.9275510867365, 4833.347498087766, 4837.540433658797, 4843.128236917353, 4650.9069818603775, 4748.145333839908, 4767.61859051275, 4776.307435421862, 4785.138675038492, 4759.833405830796, 4762.880927976794, 4762.904741905159, 4764.118638051954, 4776.426828780569, 4086.0, 4096.897577560555, 4107.650849677781, 4108.301588729923, 4119.711620186588, 6037.72830222641, 6061.0, 6069.848253793646, 6079.696015199266, 6090.48230900374, 5392.649477783932, 5497.120460726264, 5513.448655134494, 5515.393306736256, 5543.6119471637, 6696.129503164606, 6729.158855143107, 6732.360425759545, 6734.696938637773, 6750.088738020353, 4534.2971839364955, 4535.4103966484145, 4536.478304994935, 4542.795574199169, 4547.317902314646, 6740.191177058735, 6874.484413668944, 6910.550814197061, 6922.446204303644, 6932.0, 4523.185826551252, 4536.909261814745, 4537.274036154199, 4542.523035081335, 4546.954530454653, 4560.6807523473035, 4590.908181836345, 4599.0, 4604.539546045436, 4608.446986361658, 5450.8909821803345, 5453.7818487260065, 5460.781568737206, 5461.1262198048125, 5462.481064298885, 6606.933930660632, 6761.22245941723, 6763.323667633295, 6764.661766911635, 6782.389584937379, 1565.131352099573, 1640.3848556791204, 1657.6021754778767, 1673.86609071274, 1674.3553731813097, 1084.728817795551, 1089.9509522071526, 1090.4929207918356, 1092.3718861654581, 1092.8415379770047, 6388.425041746265, 6405.807825765234, 6408.03879418091, 6408.967955160194, 6437.839054023593, 6777.085093512313, 6838.623875686785, 6846.281140480178, 6852.931470685229, 6854.794356169323, 6327.651979141099, 6381.234251889803, 6423.614583124934, 6436.678166091677, 6455.61266324022, 3812.2375524895133, 3824.4072168813877, 3825.713071519647, 3830.444585535082, 3853.5953724859046, 7294.598797066213, 7300.233475484997, 7304.306090921354, 7309.671064802096, 7315.829467285315, 6984.650767461708, 7207.279272072751, 7215.530990485707, 7234.131904171533, 7239.167495737952, 7216.458765592602, 7260.41916646667, 7270.672819723125, 7272.127344718562, 7297.124345078624, 6991.161060672752, 6996.475264355092, 7018.227994920657, 7056.294370562902, 7057.188423331382, 6795.218549866829, 6917.100776898971, 6947.687354068978, 6986.685599147949, 7003.719851205895, 7290.963545182452, 7301.415886729155, 7311.524750891175, 7314.780556583311, 7320.560766354036, 4570.245909424908, 4585.793639286173, 4615.838445654386, 4631.170687578455, 4644.883877902945, 6728.158980127484, 6746.4940129489505, 6877.037214789833, 6998.475114366341, 7042.084529011196, 6652.933470665232, 6810.523263371517, 6812.386885180357, 6841.760538381132, 6859.862802744017, 6756.087928129639, 6786.592804431552, 6814.591124532544, 6819.5908245505425, 6821.2155602106395, 6522.641254731036, 6647.534672572873, 6662.533622646562, 6686.69909854048, 6686.866262674816, 6786.457083433413, 6797.93202067973, 6823.727050918106, 6835.726570937107, 6851.862962740817, 6600.372964568358, 6649.966750166218, 6659.234188068434, 6660.2673705893285, 6666.566673166229], "unit": "ms", "name": "prototype.html", "value": 5017.944316461908}, {"lowerIsBetter": false, "replicates": [812.398824869596, 836.7447928381845, 842.7134774176778, 847.0813607179737, 855.9700410485638, 12445.439955202015, 12695.428705708242, 12711.42798574064, 12722.681932951658, 12739.0, 12110.576129835457, 12226.57206997753, 12234.082443816706, 12247.448864801083, 12256.877431225685, 795.5624406576388, 819.8442295963778, 835.8787975743513, 835.9331253499736, 836.3016880904452, 825.2531459029558, 830.4809494066209, 832.3965125284182, 832.7876391520153, 833.1044127562864, 851.9062903080656, 854.0306751836648, 855.9743207703748, 857.2713193785264, 859.909709480505, 842.995785021071, 848.1052489623445, 848.3679658654311, 849.9405041647087, 850.7490290364358, 620.5780069552702, 622.947049500793, 623.0467384901109, 623.1462895832693, 624.0140577886928, 12871.163374380636, 12985.09104362695, 13008.089433739642, 13028.348582570834, 13056.86943130566, 12181.573644922386, 12360.629181124581, 12471.438785254686, 12510.31193284369, 13006.609801705965, 9531.237500999903, 9988.101070903653, 9998.654889476731, 10162.745931351701, 10268.691939241835, 3330.6502817204328, 3424.9486257706153, 3491.1970246843366, 3533.611302756695, 3533.787972721645, 47445.288320675216, 48800.75599621979, 48802.267965980536, 48983.51016489825, 49013.0, 9675.854862177073, 9845.80308393828, 10083.142932850644, 10175.236857235737, 10207.387556746618, 17816.376426824998, 17829.375971840924, 17830.10849457522, 17831.554211144565, 17878.821211787716, 6113.113598528277, 6249.0626406039455, 6264.749410023639, 6421.165248517663, 6572.737090516326, 4014.75499725835, 4019.618136277049, 4097.508299004079, 4144.0, 4172.520160181557, 3008.819470831757, 3038.8632511537035, 3055.1903745507457, 3057.6942305769244, 3058.067289476731, 508.23764353469795, 524.7009204753331, 529.7298377827336, 531.4605675239635, 532.2840779152034, 591.4676790888149, 636.9681515924185, 642.540583482812, 679.419096672338, 729.5185177782638, 8711.303095752324, 8845.557722113868, 8867.600957956907, 8926.241269492037, 9142.222911052502, 557.9218909352694, 670.718298314709, 729.7664747280925, 732.3299181249204, 741.4142827166586, 4095.140020595649, 4201.852935147316, 4224.345226489899, 4293.935590966138, 4366.934495982563, 51508.74245628748, 56002.71998639981, 56053.43946560564, 56084.71957640268, 56113.719431402584, 47146.29280560794, 48289.517104828505, 48517.75741121272, 49284.75357623189, 49393.0, 45323.77338113288, 45439.77280113578, 45473.545264547596, 45564.316535252, 45686.54313456889, 9063.592138353923, 9344.392614480037, 9426.858597121185, 9440.622375104918, 9441.103095205945, 33439.66560334365, 34436.311273773885, 34992.0, 35014.64985350216, 35442.0, 39442.605573943896, 39824.60175398209, 40561.79719101386, 44100.55899441093, 44272.11455770931, 11492.425378731197, 11511.884881151082, 11521.539138434704, 11552.191346605658, 11556.768864622829, 12293.75412491763, 12536.122471426912, 12570.811437828257, 12667.683307917376, 12720.68198295013, 10904.34573925567, 10992.120630349393, 11080.667579972614, 11248.0, 11365.943170284096, 11575.942120289345, 12058.180947535573, 12254.509819607116, 12326.445309961253, 12735.681607959505, 11621.186516943733, 11712.004479619327, 11764.176507644383, 12030.338331391857, 12133.150679452354, 10107.69676909694, 10122.544485498318, 10646.361218326925, 10727.0, 10801.081908037904, 9129.653658049758, 9486.098820612031, 9661.178799802095, 9818.410895346302, 9852.802943941224], "unit": "ms", "name": "yui.html", "value": 6279.893056942578}], "name": "dromaeo_css", "value": 6890.767037847389}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 104.0, 112.0, 110.0, 112.0, 123.0, 110.0, 112.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [154.0, 126.0, 155.0, 165.0, 132.0, 159.0, 158.0, 129.0, 158.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 162.0, 164.0, 161.0, 162.0, 165.0, 171.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 71.0, 72.0, 74.0, 158.0, 71.0, 73.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 138.0, 92.0, 93.0, 93.0, 146.0, 93.0, 93.0, 142.0], "unit": "ms", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 100.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 68.0, 64.0, 66.0, 62.0, 63.0, 62.0, 63.0], "unit": "ms", "name": "json-parse-financial", "value": 64.2}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 69.0, 69.0, 70.0, 70.0, 69.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 84.0, 84.0, 84.0, 83.0, 85.0, 85.0, 84.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [117.0, 129.0, 118.0, 142.0, 128.0, 118.0, 120.0, 125.0, 119.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [152.0, 153.0, 152.0, 165.0, 154.0, 142.0, 154.0, 151.0, 153.0, 157.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 153.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 76.0, 69.0, 70.0, 67.0, 72.0, 66.0, 66.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1527.8999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [184.945441094877], "unit": "score", "name": "Richards", "value": 190.877914}, {"lowerIsBetter": false, "replicates": [193.01293186643505], "unit": "score", "name": "DeltaBlue", "value": 342.557358}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [4990.049751243781], "unit": "score", "name": "Decrypt", "value": 53.34235393818545}, {"lowerIsBetter": false, "replicates": [1059.322033898305], "unit": "score", "name": "RayTrace", "value": 698.549616}, {"lowerIsBetter": false, "replicates": [709.7232079488999], "unit": "score", "name": "Earley", "value": 939.0463669999997}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [24829.268292682926], "unit": "score", "name": "RegExp", "value": 36.68996561886052}, {"lowerIsBetter": false, "replicates": [653.2988357050452], "unit": "score", "name": "Splay", "value": 124.73770891089112}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21078.07408070291}]} 10:11:45 INFO - RETURN: dromaeo_css: 6890.77 10:11:45 INFO - RETURN: kraken: 1527.90 10:11:45 INFO - RETURN: v8_7: 21078.07 10:11:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21078.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1527.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6890.77"}}} 10:11:45 INFO - Return code: 0 10:11:45 INFO - # TBPL SUCCESS # 10:11:45 INFO - Running post-action listener: _resource_record_post_action 10:11:45 INFO - Running post-run listener: _resource_record_post_run 10:11:46 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 12288; Write bytes: 524632064; Read time: 380; Write time: 592148 10:11:46 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 143425536; Read time: 0; Write time: 263260 10:11:46 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8192; Write bytes: 305020928; Read time: 272; Write time: 289596 10:11:46 INFO - Running post-run listener: _upload_blobber_files 10:11:46 INFO - Blob upload gear active. 10:11:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:11:46 INFO - Copying logs to upload dir... 10:11:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1265.650674 ========= master_lag: -0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-23 10:11:45.993138) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 10:11:46.001359) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/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-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009898 build_url: 'https://queue.taskcluster.net/v1/task/qsWPhsHnRuazZXhAs6utwQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 10:11:46.056284) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:11:46.056752) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e8c3f5a4c0a512351e80f2ca000001d7-1448299007.367499-1039499305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004667 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:11:46.110614) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 10:11:46.111093) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 10:11:46.111562) ========= ========= Total master_lag: 0.22 =========