builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1448211213.83 results: success (0) buildid: 20151122073153 builduid: d3f61880d13f43d594e5899a3d6f7c52 revision: 26bf115402e27a4f24de8a040f8b36ac8e7d8ce4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:33.825874) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:33.826336) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:33.826643) ========= 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=919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006588 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:33.901816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:33.902166) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:33.972230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:33.972485) ========= 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=919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004663 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:34.025636) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:34.025923) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:34.026859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:34.027175) ========= 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=919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-22 08:53:34-- 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% 219M=0s 2015-11-22 08:53:34 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153175 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:34.217139) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:34.217466) ========= 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=919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020154 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:34.299385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:34.299773) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 26bf115402e27a4f24de8a040f8b36ac8e7d8ce4 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 26bf115402e27a4f24de8a040f8b36ac8e7d8ce4 --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=919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-22 08:53:34,898 truncating revision to first 12 chars 2015-11-22 08:53:34,898 Setting DEBUG logging. 2015-11-22 08:53:34,898 attempt 1/10 2015-11-22 08:53:34,898 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/26bf115402e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-22 08:53:35,155 unpacking tar archive at: mozilla-inbound-26bf115402e2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.556583 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:34.872904) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:34.876337) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:34.914741) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:34.915187) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-22 08:53:34.915833) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-22 08:53:34.916227) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:53:35 INFO - MultiFileLogger online at 20151122 08:53:35 in /builds/slave/test-pgo 08:53:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 08:53:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:53:35 INFO - {'append_to_log': False, 08:53:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:53:35 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 08:53:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:53:35 INFO - 'branch': 'Mozilla-Inbound', 08:53:35 INFO - 'buildbot_json_path': 'buildprops.json', 08:53:35 INFO - 'config_files': ('talos/linux_config.py',), 08:53:35 INFO - 'default_actions': ('clobber', 08:53:35 INFO - 'read-buildbot-config', 08:53:35 INFO - 'download-and-extract', 08:53:35 INFO - 'populate-webroot', 08:53:35 INFO - 'create-virtualenv', 08:53:35 INFO - 'install', 08:53:35 INFO - 'run-tests'), 08:53:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:53:35 INFO - 'download_minidump_stackwalk': True, 08:53:35 INFO - 'download_symbols': 'ondemand', 08:53:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:53:35 INFO - 'tooltool.py': '/tools/tooltool.py', 08:53:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:53:35 INFO - '/tools/misc-python/virtualenv.py')}, 08:53:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:53:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:53:35 INFO - 'installer_path': 'installer.exe', 08:53:35 INFO - 'log_level': 'info', 08:53:35 INFO - 'log_name': 'talos', 08:53:35 INFO - 'log_to_console': True, 08:53:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:53:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:53:35 INFO - 'opt_config_files': (), 08:53:35 INFO - 'pip_index': False, 08:53:35 INFO - 'sps_profile': False, 08:53:35 INFO - 'sps_profile_interval': 0, 08:53:35 INFO - 'suite': 'dromaeojs-e10s', 08:53:35 INFO - 'system_bits': '64', 08:53:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:53:35 INFO - 'title': 'talos-linux64-ix-053', 08:53:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:53:35 INFO - 'use_talos_json': True, 08:53:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:53:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:53:35 INFO - 'work_dir': 'build'} 08:53:35 INFO - ##### 08:53:35 INFO - ##### Running clobber step. 08:53:35 INFO - ##### 08:53:35 INFO - Running pre-action listener: _resource_record_pre_action 08:53:35 INFO - Running main action method: clobber 08:53:35 INFO - rmtree: /builds/slave/test-pgo/build 08:53:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:53:36 INFO - Running post-action listener: _resource_record_post_action 08:53:36 INFO - ##### 08:53:36 INFO - ##### Running read-buildbot-config step. 08:53:36 INFO - ##### 08:53:36 INFO - Running pre-action listener: _resource_record_pre_action 08:53:36 INFO - Running main action method: read_buildbot_config 08:53:36 INFO - Using buildbot properties: 08:53:36 INFO - { 08:53:36 INFO - "properties": { 08:53:36 INFO - "buildnumber": 162, 08:53:36 INFO - "product": "firefox", 08:53:36 INFO - "script_repo_revision": "production", 08:53:36 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 08:53:36 INFO - "repository": "", 08:53:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 08:53:36 INFO - "buildid": "20151122073153", 08:53:36 INFO - "slavename": "talos-linux64-ix-053", 08:53:36 INFO - "pgo_build": "True", 08:53:36 INFO - "basedir": "/builds/slave/test-pgo", 08:53:36 INFO - "project": "", 08:53:36 INFO - "platform": "ubuntu64_hw", 08:53:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:53:36 INFO - "slavebuilddir": "test", 08:53:36 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 08:53:36 INFO - "branch": "mozilla-inbound", 08:53:36 INFO - "repo_path": "integration/mozilla-inbound", 08:53:36 INFO - "stage_platform": "linux64-pgo", 08:53:36 INFO - "builduid": "d3f61880d13f43d594e5899a3d6f7c52", 08:53:36 INFO - "revision": "26bf115402e27a4f24de8a040f8b36ac8e7d8ce4" 08:53:36 INFO - }, 08:53:36 INFO - "sourcestamp": { 08:53:36 INFO - "repository": "", 08:53:36 INFO - "hasPatch": false, 08:53:36 INFO - "project": "", 08:53:36 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 08:53:36 INFO - "changes": [ 08:53:36 INFO - { 08:53:36 INFO - "category": null, 08:53:36 INFO - "files": [ 08:53:36 INFO - { 08:53:36 INFO - "url": null, 08:53:36 INFO - "name": "https://queue.taskcluster.net/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 08:53:36 INFO - } 08:53:36 INFO - ], 08:53:36 INFO - "repository": "", 08:53:36 INFO - "rev": "26bf115402e27a4f24de8a040f8b36ac8e7d8ce4", 08:53:36 INFO - "who": "sendchange", 08:53:36 INFO - "when": 1448211189, 08:53:36 INFO - "number": 6693221, 08:53:36 INFO - "comments": "", 08:53:36 INFO - "project": "", 08:53:36 INFO - "at": "Sun 22 Nov 2015 08:53:09", 08:53:36 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 08:53:36 INFO - "revlink": "", 08:53:36 INFO - "properties": [ 08:53:36 INFO - [ 08:53:36 INFO - "buildid", 08:53:36 INFO - "20151122073153", 08:53:36 INFO - "Change" 08:53:36 INFO - ], 08:53:36 INFO - [ 08:53:36 INFO - "builduid", 08:53:36 INFO - "d3f61880d13f43d594e5899a3d6f7c52", 08:53:36 INFO - "Change" 08:53:36 INFO - ], 08:53:36 INFO - [ 08:53:36 INFO - "pgo_build", 08:53:36 INFO - "True", 08:53:36 INFO - "Change" 08:53:36 INFO - ] 08:53:36 INFO - ], 08:53:36 INFO - "revision": "26bf115402e27a4f24de8a040f8b36ac8e7d8ce4" 08:53:36 INFO - } 08:53:36 INFO - ], 08:53:36 INFO - "revision": "26bf115402e27a4f24de8a040f8b36ac8e7d8ce4" 08:53:36 INFO - } 08:53:36 INFO - } 08:53:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 08:53:36 INFO - Running post-action listener: _resource_record_post_action 08:53:36 INFO - ##### 08:53:36 INFO - ##### Running download-and-extract step. 08:53:36 INFO - ##### 08:53:36 INFO - Running pre-action listener: _resource_record_pre_action 08:53:36 INFO - Running main action method: download_and_extract 08:53:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:53:36 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')]} 08:53:36 INFO - https://queue.taskcluster.net/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:53:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/test_packages.json 08:53:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/test_packages.json 08:53:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:53:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:53:45 INFO - Downloaded 1302 bytes. 08:53:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:53:45 INFO - Using the following test package requirements: 08:53:45 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:53:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:53:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:45 INFO - u'jsshell-linux-x86_64.zip'], 08:53:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:53:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:53:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:53:45 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:53:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:53:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:53:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:53:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:53: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')]} 08:53:45 INFO - https://queue.taskcluster.net/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:53:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:53:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:53:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/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 08:53:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/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 08:53:49 INFO - Downloaded 22526041 bytes. 08:53:49 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 08:53:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:53:49 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 08:53:50 INFO - Return code: 0 08:53:50 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 08:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:50 INFO - https://queue.taskcluster.net/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:53:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:53:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:53:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/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 08:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/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 08:53:54 INFO - Downloaded 22526041 bytes. 08:53:54 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 08:53:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:53:54 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 08:53:55 INFO - Return code: 0 08:53: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')]} 08:53:55 INFO - https://queue.taskcluster.net/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:53:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:53:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:53:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/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 08:53:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/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 08:53:57 INFO - Downloaded 11130997 bytes. 08:53:57 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 08:53:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:53:57 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 08:53:57 INFO - Return code: 0 08:53:57 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')]} 08:53:57 INFO - https://queue.taskcluster.net/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:53:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:53:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:53:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/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 08:53:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMagpsvDThCzwHuIzJtoZQ/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 08:53:59 INFO - Downloaded 57537110 bytes. 08:53:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:53:59 INFO - mkdir: /builds/slave/test-pgo/properties 08:53:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:53:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:53:59 INFO - Contents: 08:53:59 INFO - build_url:https://queue.taskcluster.net/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:53:59 INFO - Running post-action listener: _resource_record_post_action 08:53:59 INFO - Running post-action listener: set_extra_try_arguments 08:53:59 INFO - ##### 08:53:59 INFO - ##### Running populate-webroot step. 08:53:59 INFO - ##### 08:53:59 INFO - Running pre-action listener: _resource_record_pre_action 08:53:59 INFO - Running main action method: populate_webroot 08:53:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:53:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:53:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:53:59 INFO - '../fennec_ids.txt'], 08:53:59 INFO - 'tests': ['tcheck2']}, 08:53:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:53:59 INFO - '--tppagecycles', 08:53:59 INFO - '7'], 08:53:59 INFO - 'tests': ['tsvgm']}}, 08:53:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:53:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:53:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:53:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:53:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:53:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:53:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:59 INFO - 'talos_options': ['--e10s'], 08:53:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:59 INFO - 'tests': ['damp', 'tps']}, 08:53:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:59 INFO - 'talos_options': ['--e10s'], 08:53:59 INFO - 'tests': ['damp', 'tps']}, 08:53:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:53:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:53:59 INFO - 'other': {'tests': ['a11yr', 08:53:59 INFO - 'ts_paint', 08:53:59 INFO - 'tpaint', 08:53:59 INFO - 'sessionrestore', 08:53:59 INFO - 'sessionrestore_no_auto_restore']}, 08:53:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:53:59 INFO - 'tests': ['a11yr', 08:53:59 INFO - 'ts_paint', 08:53:59 INFO - 'tpaint', 08:53:59 INFO - 'sessionrestore', 08:53:59 INFO - 'sessionrestore_no_auto_restore']}, 08:53:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:53:59 INFO - 'tests': ['a11yr', 08:53:59 INFO - 'ts_paint', 08:53:59 INFO - 'tpaint', 08:53:59 INFO - 'sessionrestore', 08:53:59 INFO - 'sessionrestore_no_auto_restore']}, 08:53:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:53:59 INFO - 'tests': ['a11yr', 08:53:59 INFO - 'ts_paint', 08:53:59 INFO - 'tpaint', 08:53:59 INFO - 'sessionrestore', 08:53:59 INFO - 'sessionrestore_no_auto_restore']}, 08:53:59 INFO - 'other_l64': {'tests': ['a11yr', 08:53:59 INFO - 'ts_paint', 08:53:59 INFO - 'tpaint', 08:53:59 INFO - 'sessionrestore', 08:53:59 INFO - 'sessionrestore_no_auto_restore']}, 08:53:59 INFO - 'other_nol64': {'tests': ['a11yr', 08:53:59 INFO - 'ts_paint', 08:53:59 INFO - 'tpaint', 08:53:59 INFO - 'sessionrestore', 08:53:59 INFO - 'sessionrestore_no_auto_restore']}, 08:53:59 INFO - 'svgr': {'tests': ['tsvgx', 08:53:59 INFO - 'tsvgr_opacity', 08:53:59 INFO - 'tart', 08:53:59 INFO - 'tscrollx', 08:53:59 INFO - 'cart']}, 08:53:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:53:59 INFO - 'tests': ['tsvgx', 08:53:59 INFO - 'tsvgr_opacity', 08:53:59 INFO - 'tart', 08:53:59 INFO - 'tscrollx', 08:53:59 INFO - 'cart']}, 08:53:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:59 INFO - 'tests': ['tp5o']}, 08:53:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:59 INFO - 'talos_options': ['--e10s'], 08:53:59 INFO - 'tests': ['tp5o']}, 08:53:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:59 INFO - 'talos_options': ['--xperf_path', 08:53:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:59 INFO - 'tests': ['tp5n']}, 08:53:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:59 INFO - 'talos_options': ['--e10s', 08:53:59 INFO - '--xperf_path', 08:53:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:59 INFO - 'tests': ['tp5n']}}, 08:53:59 INFO - 'talos.zip': {'path': '', 08:53:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:53:59 INFO - Running post-action listener: _resource_record_post_action 08:53:59 INFO - ##### 08:53:59 INFO - ##### Running create-virtualenv step. 08:53:59 INFO - ##### 08:53:59 INFO - Running pre-action listener: _resource_record_pre_action 08:53:59 INFO - Running main action method: create_virtualenv 08:53:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:53:59 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 08:53:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:53:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:53:59 INFO - Using real prefix '/usr' 08:53:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:53:59 INFO - Installing distribute.............................................................................................................................................................................................done. 08:54:01 INFO - Installing pip.................done. 08:54:01 INFO - Return code: 0 08:54:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:54: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')]} 08:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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')]} 08:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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 0x7f9b1f748c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f9a90>, '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 0x284bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284c2e0>, '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': '919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996', '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 08:54: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 08:54: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 08:54:01 INFO - Using env: {'DISPLAY': ':0', 08:54:01 INFO - 'HOME': '/home/cltbld', 08:54:01 INFO - 'LANG': 'en_US.UTF-8', 08:54:01 INFO - 'LANGUAGE': 'en_US:en', 08:54:01 INFO - 'LOGNAME': 'cltbld', 08:54:01 INFO - 'MAIL': '/var/mail/cltbld', 08:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:01 INFO - 'MOZ_NO_REMOTE': '1', 08:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:01 INFO - 'NO_EM_RESTART': '1', 08:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:54:01 INFO - 'PWD': '/builds/slave/test-pgo', 08:54:01 INFO - 'SHELL': '/bin/bash', 08:54:01 INFO - 'SHLVL': '1', 08:54:01 INFO - 'TERM': 'linux', 08:54:01 INFO - 'TMOUT': '86400', 08:54:01 INFO - 'USER': 'cltbld', 08:54:01 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996', 08:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:01 INFO - '_': '/tools/buildbot/bin/python'} 08:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:02 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 08:54:02 INFO - Cleaning up... 08:54:02 INFO - Return code: 0 08:54:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:02 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 0x7f9b1f748c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f9a90>, '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 0x284bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284c2e0>, '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': '919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996', '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 08:54:02 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 08:54:02 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 08:54:02 INFO - Using env: {'DISPLAY': ':0', 08:54:02 INFO - 'HOME': '/home/cltbld', 08:54:02 INFO - 'LANG': 'en_US.UTF-8', 08:54:02 INFO - 'LANGUAGE': 'en_US:en', 08:54:02 INFO - 'LOGNAME': 'cltbld', 08:54:02 INFO - 'MAIL': '/var/mail/cltbld', 08:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:02 INFO - 'MOZ_NO_REMOTE': '1', 08:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:02 INFO - 'NO_EM_RESTART': '1', 08:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:54:02 INFO - 'PWD': '/builds/slave/test-pgo', 08:54:02 INFO - 'SHELL': '/bin/bash', 08:54:02 INFO - 'SHLVL': '1', 08:54:02 INFO - 'TERM': 'linux', 08:54:02 INFO - 'TMOUT': '86400', 08:54:02 INFO - 'USER': 'cltbld', 08:54:02 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996', 08:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:02 INFO - '_': '/tools/buildbot/bin/python'} 08:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:02 INFO - Downloading/unpacking psutil>=0.7.1 08:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:54:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:54:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:54:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:04 INFO - Installing collected packages: psutil 08:54:04 INFO - Running setup.py install for psutil 08:54:04 INFO - building 'psutil._psutil_linux' extension 08:54:04 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 08:54:04 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 08:54:04 INFO - building 'psutil._psutil_posix' extension 08:54:04 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 08:54:04 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 08:54:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:04 INFO - Successfully installed psutil 08:54:04 INFO - Cleaning up... 08:54:04 INFO - Return code: 0 08:54:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:54: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')]} 08:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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')]} 08:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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 0x7f9b1f748c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f9a90>, '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 0x284bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284c2e0>, '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': '919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996', '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 08:54: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 08:54: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 08:54:04 INFO - Using env: {'DISPLAY': ':0', 08:54:04 INFO - 'HOME': '/home/cltbld', 08:54:04 INFO - 'LANG': 'en_US.UTF-8', 08:54:04 INFO - 'LANGUAGE': 'en_US:en', 08:54:04 INFO - 'LOGNAME': 'cltbld', 08:54:04 INFO - 'MAIL': '/var/mail/cltbld', 08:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:04 INFO - 'MOZ_NO_REMOTE': '1', 08:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:04 INFO - 'NO_EM_RESTART': '1', 08:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:54:04 INFO - 'PWD': '/builds/slave/test-pgo', 08:54:04 INFO - 'SHELL': '/bin/bash', 08:54:04 INFO - 'SHLVL': '1', 08:54:04 INFO - 'TERM': 'linux', 08:54:04 INFO - 'TMOUT': '86400', 08:54:04 INFO - 'USER': 'cltbld', 08:54:04 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996', 08:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:04 INFO - '_': '/tools/buildbot/bin/python'} 08:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:54:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:54:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:54: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) 08:54:06 INFO - Installing collected packages: mozsystemmonitor 08:54:06 INFO - Running setup.py install for mozsystemmonitor 08:54:06 INFO - Successfully installed mozsystemmonitor 08:54:06 INFO - Cleaning up... 08:54:06 INFO - Return code: 0 08:54:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:54: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')]} 08:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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')]} 08:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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 0x7f9b1f748c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f9a90>, '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 0x284bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284c2e0>, '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': '919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996', '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 08:54: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 08:54: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 08:54:06 INFO - Using env: {'DISPLAY': ':0', 08:54:06 INFO - 'HOME': '/home/cltbld', 08:54:06 INFO - 'LANG': 'en_US.UTF-8', 08:54:06 INFO - 'LANGUAGE': 'en_US:en', 08:54:06 INFO - 'LOGNAME': 'cltbld', 08:54:06 INFO - 'MAIL': '/var/mail/cltbld', 08:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:06 INFO - 'MOZ_NO_REMOTE': '1', 08:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:06 INFO - 'NO_EM_RESTART': '1', 08:54:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:54:06 INFO - 'PWD': '/builds/slave/test-pgo', 08:54:06 INFO - 'SHELL': '/bin/bash', 08:54:06 INFO - 'SHLVL': '1', 08:54:06 INFO - 'TERM': 'linux', 08:54:06 INFO - 'TMOUT': '86400', 08:54:06 INFO - 'USER': 'cltbld', 08:54:06 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996', 08:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:06 INFO - '_': '/tools/buildbot/bin/python'} 08:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:06 INFO - Downloading/unpacking blobuploader==1.2.4 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54:08 INFO - Downloading blobuploader-1.2.4.tar.gz 08:54:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:54:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:54:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:54:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:54:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54:09 INFO - Downloading docopt-0.6.1.tar.gz 08:54:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:54:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:54:09 INFO - Installing collected packages: blobuploader, requests, docopt 08:54:09 INFO - Running setup.py install for blobuploader 08:54:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:54:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:54:09 INFO - Running setup.py install for requests 08:54:09 INFO - Running setup.py install for docopt 08:54:09 INFO - Successfully installed blobuploader requests docopt 08:54:09 INFO - Cleaning up... 08:54:09 INFO - Return code: 0 08:54:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:54: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')]} 08:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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')]} 08:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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 0x7f9b1f748c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f9a90>, '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 0x284bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284c2e0>, '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': '919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996', '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 08:54: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 08:54: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 08:54:09 INFO - Using env: {'DISPLAY': ':0', 08:54:09 INFO - 'HOME': '/home/cltbld', 08:54:09 INFO - 'LANG': 'en_US.UTF-8', 08:54:09 INFO - 'LANGUAGE': 'en_US:en', 08:54:09 INFO - 'LOGNAME': 'cltbld', 08:54:09 INFO - 'MAIL': '/var/mail/cltbld', 08:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:09 INFO - 'MOZ_NO_REMOTE': '1', 08:54:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:09 INFO - 'NO_EM_RESTART': '1', 08:54:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:54:09 INFO - 'PWD': '/builds/slave/test-pgo', 08:54:09 INFO - 'SHELL': '/bin/bash', 08:54:09 INFO - 'SHLVL': '1', 08:54:09 INFO - 'TERM': 'linux', 08:54:09 INFO - 'TMOUT': '86400', 08:54:09 INFO - 'USER': 'cltbld', 08:54:09 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996', 08:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:09 INFO - '_': '/tools/buildbot/bin/python'} 08:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:54:09 INFO - Running setup.py (path:/tmp/pip-WQ7t7U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:54:10 INFO - Running setup.py (path:/tmp/pip-ItOkjY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:54:10 INFO - Running setup.py (path:/tmp/pip-Cf35Wk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:54:10 INFO - Running setup.py (path:/tmp/pip-4soYx0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:54:10 INFO - Running setup.py (path:/tmp/pip-XoVb5A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:54:10 INFO - Running setup.py (path:/tmp/pip-Ae791U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:54:10 INFO - Running setup.py (path:/tmp/pip-0nflVF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:54:10 INFO - Running setup.py (path:/tmp/pip-3z0CzO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:54:10 INFO - Running setup.py (path:/tmp/pip-WPJB9G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:54:10 INFO - Running setup.py (path:/tmp/pip-3g4leM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:54:10 INFO - Running setup.py (path:/tmp/pip-JbzrFP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:54:10 INFO - Running setup.py (path:/tmp/pip-OaVd9F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:54:10 INFO - Running setup.py (path:/tmp/pip-abMAV1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:54:10 INFO - Running setup.py (path:/tmp/pip-_AWVYC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:54:11 INFO - Running setup.py (path:/tmp/pip-bDlMsx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:54:11 INFO - Running setup.py (path:/tmp/pip-qQcC6K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:54:11 INFO - Running setup.py (path:/tmp/pip-bPuIoc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:54:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:54:11 INFO - Running setup.py install for manifestparser 08:54:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:54:11 INFO - Running setup.py install for mozcrash 08:54:11 INFO - Running setup.py install for mozdebug 08:54:11 INFO - Running setup.py install for mozdevice 08:54:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:54:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:54:11 INFO - Running setup.py install for mozfile 08:54:11 INFO - Running setup.py install for mozhttpd 08:54:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:54:11 INFO - Running setup.py install for mozinfo 08:54:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:54:11 INFO - Running setup.py install for mozInstall 08:54:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:54:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:54:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:54:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:54:12 INFO - Running setup.py install for mozleak 08:54:12 INFO - Running setup.py install for mozlog 08:54:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:54:12 INFO - Running setup.py install for moznetwork 08:54:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:54:12 INFO - Running setup.py install for mozprocess 08:54:12 INFO - Running setup.py install for mozprofile 08:54:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:54:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:54:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:54:12 INFO - Running setup.py install for mozrunner 08:54:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:54:12 INFO - Running setup.py install for mozscreenshot 08:54:12 INFO - Running setup.py install for moztest 08:54:12 INFO - Running setup.py install for mozversion 08:54:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:54:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:54:12 INFO - Cleaning up... 08:54:13 INFO - Return code: 0 08:54:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:54:13 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')]} 08:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:13 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')]} 08:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:13 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 0x7f9b1f748c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f9a90>, '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 0x284bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284c2e0>, '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': '919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996', '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 08:54:13 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 08:54:13 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 08:54:13 INFO - Using env: {'DISPLAY': ':0', 08:54:13 INFO - 'HOME': '/home/cltbld', 08:54:13 INFO - 'LANG': 'en_US.UTF-8', 08:54:13 INFO - 'LANGUAGE': 'en_US:en', 08:54:13 INFO - 'LOGNAME': 'cltbld', 08:54:13 INFO - 'MAIL': '/var/mail/cltbld', 08:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:13 INFO - 'MOZ_NO_REMOTE': '1', 08:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:13 INFO - 'NO_EM_RESTART': '1', 08:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:54:13 INFO - 'PWD': '/builds/slave/test-pgo', 08:54:13 INFO - 'SHELL': '/bin/bash', 08:54:13 INFO - 'SHLVL': '1', 08:54:13 INFO - 'TERM': 'linux', 08:54:13 INFO - 'TMOUT': '86400', 08:54:13 INFO - 'USER': 'cltbld', 08:54:13 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996', 08:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:13 INFO - '_': '/tools/buildbot/bin/python'} 08:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:54:13 INFO - Running setup.py (path:/tmp/pip-aXJFJn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:54:13 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)) 08:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:54:13 INFO - Running setup.py (path:/tmp/pip-D7aeDV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:54: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)) 08:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:54:13 INFO - Running setup.py (path:/tmp/pip-33UK8h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:54: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)) 08:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:54:13 INFO - Running setup.py (path:/tmp/pip-3Sw1Kj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:54: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)) 08:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:54:13 INFO - Running setup.py (path:/tmp/pip-5V4D8t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:54: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)) 08:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:54:13 INFO - Running setup.py (path:/tmp/pip-c5Dlng-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:54: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)) 08:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:54:13 INFO - Running setup.py (path:/tmp/pip-83pBki-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:54: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)) 08:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:54:13 INFO - Running setup.py (path:/tmp/pip-ut929k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:54: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)) 08:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:54:13 INFO - Running setup.py (path:/tmp/pip-weRfSW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:54: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)) 08:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:54:13 INFO - Running setup.py (path:/tmp/pip-6v7Mby-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:54: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)) 08:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:54:13 INFO - Running setup.py (path:/tmp/pip-rwyUnr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:54:14 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)) 08:54:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:54:14 INFO - Running setup.py (path:/tmp/pip-MbyHk2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:54:14 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)) 08:54:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:54:14 INFO - Running setup.py (path:/tmp/pip-gPBIo4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:54:14 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)) 08:54:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:54:14 INFO - Running setup.py (path:/tmp/pip-QRDdDG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:54:14 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)) 08:54:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:54:14 INFO - Running setup.py (path:/tmp/pip-OsBqwR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:54:14 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)) 08:54:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:54:14 INFO - Running setup.py (path:/tmp/pip-pqtsRu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:54: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)) 08:54:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:54:14 INFO - Running setup.py (path:/tmp/pip-UC1KIj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:54: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)) 08:54: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)) 08:54: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)) 08:54: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)) 08:54: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)) 08:54: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)) 08:54:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54:16 INFO - Downloading blessings-1.5.1.tar.gz 08:54:16 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 08:54:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:54:16 INFO - Installing collected packages: blessings 08:54:16 INFO - Running setup.py install for blessings 08:54:16 INFO - Successfully installed blessings 08:54:16 INFO - Cleaning up... 08:54:16 INFO - Return code: 0 08:54:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:54:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:54:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:54:16 INFO - Reading from file tmpfile_stdout 08:54:16 INFO - Current package versions: 08:54:16 INFO - argparse == 1.2.1 08:54:16 INFO - blessings == 1.5.1 08:54:16 INFO - blobuploader == 1.2.4 08:54:16 INFO - docopt == 0.6.1 08:54:16 INFO - manifestparser == 1.1 08:54:16 INFO - mozInstall == 1.12 08:54:16 INFO - mozcrash == 0.16 08:54:16 INFO - mozdebug == 0.1 08:54:16 INFO - mozdevice == 0.47 08:54:16 INFO - mozfile == 1.2 08:54:16 INFO - mozhttpd == 0.7 08:54:16 INFO - mozinfo == 0.9 08:54:16 INFO - mozleak == 0.1 08:54:16 INFO - mozlog == 3.1 08:54:16 INFO - moznetwork == 0.27 08:54:16 INFO - mozprocess == 0.22 08:54:16 INFO - mozprofile == 0.27 08:54:16 INFO - mozrunner == 6.11 08:54:16 INFO - mozscreenshot == 0.1 08:54:16 INFO - mozsystemmonitor == 0.0 08:54:16 INFO - moztest == 0.7 08:54:16 INFO - mozversion == 1.4 08:54:16 INFO - psutil == 3.1.1 08:54:16 INFO - requests == 1.2.3 08:54:16 INFO - wsgiref == 0.1.2 08:54:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:54: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')]} 08:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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')]} 08:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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 0x7f9b1f748c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f9a90>, '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 0x284bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284c2e0>, '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': '919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996', '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 08:54: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 08:54: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 08:54:16 INFO - Using env: {'DISPLAY': ':0', 08:54:16 INFO - 'HOME': '/home/cltbld', 08:54:16 INFO - 'LANG': 'en_US.UTF-8', 08:54:16 INFO - 'LANGUAGE': 'en_US:en', 08:54:16 INFO - 'LOGNAME': 'cltbld', 08:54:16 INFO - 'MAIL': '/var/mail/cltbld', 08:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:16 INFO - 'MOZ_NO_REMOTE': '1', 08:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:16 INFO - 'NO_EM_RESTART': '1', 08:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:54:16 INFO - 'PWD': '/builds/slave/test-pgo', 08:54:16 INFO - 'SHELL': '/bin/bash', 08:54:16 INFO - 'SHLVL': '1', 08:54:16 INFO - 'TERM': 'linux', 08:54:16 INFO - 'TMOUT': '86400', 08:54:16 INFO - 'USER': 'cltbld', 08:54:16 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996', 08:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:16 INFO - '_': '/tools/buildbot/bin/python'} 08:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54: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)) 08:54: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)) 08:54: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)) 08:54: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)) 08:54: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)) 08:54: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)) 08:54: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)) 08:54: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)) 08:54: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)) 08:54: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)) 08:54: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)) 08:54:16 INFO - Cleaning up... 08:54:16 INFO - Return code: 0 08:54:16 INFO - Running post-action listener: _resource_record_post_action 08:54:16 INFO - Running post-action listener: _start_resource_monitoring 08:54:16 INFO - Starting resource monitoring. 08:54:16 INFO - ##### 08:54:16 INFO - ##### Running install step. 08:54:16 INFO - ##### 08:54:16 INFO - Running pre-action listener: _resource_record_pre_action 08:54:16 INFO - Running main action method: install 08:54:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:54:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:54:17 INFO - Reading from file tmpfile_stdout 08:54:17 INFO - Detecting whether we're running mozinstall >=1.0... 08:54:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:54:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:54:17 INFO - Reading from file tmpfile_stdout 08:54:17 INFO - Output received: 08:54:17 INFO - Usage: mozinstall [options] installer 08:54:17 INFO - Options: 08:54:17 INFO - -h, --help show this help message and exit 08:54:17 INFO - -d DEST, --destination=DEST 08:54:17 INFO - Directory to install application into. [default: 08:54:17 INFO - "/builds/slave/test-pgo"] 08:54:17 INFO - --app=APP Application being installed. [default: firefox] 08:54:17 INFO - mkdir: /builds/slave/test-pgo/build/application 08:54:17 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'] 08:54:17 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 08:54:31 INFO - Reading from file tmpfile_stdout 08:54:31 INFO - Output received: 08:54:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:54:31 INFO - Running post-action listener: _resource_record_post_action 08:54:31 INFO - ##### 08:54:31 INFO - ##### Running run-tests step. 08:54:31 INFO - ##### 08:54:31 INFO - Running pre-action listener: _resource_record_pre_action 08:54:31 INFO - Running main action method: run_tests 08:54:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:54:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:54:31 INFO - Python 2.7.3 08:54:31 INFO - Return code: 0 08:54:31 INFO - grabbing minidump binary from tooltool 08:54: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')]} 08:54: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 0x27f9a90>, '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 0x284bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284c2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:54: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 08:54: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 08:54:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:54:31 INFO - Return code: 0 08:54:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:54:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:54:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:54:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:54:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:54: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', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 08:54: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 Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost 08:54:31 INFO - Using env: {'DISPLAY': ':0', 08:54:31 INFO - 'HOME': '/home/cltbld', 08:54:31 INFO - 'LANG': 'en_US.UTF-8', 08:54:31 INFO - 'LANGUAGE': 'en_US:en', 08:54:31 INFO - 'LOGNAME': 'cltbld', 08:54:31 INFO - 'MAIL': '/var/mail/cltbld', 08:54:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:54:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:31 INFO - 'MOZ_NO_REMOTE': '1', 08:54:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:31 INFO - 'NO_EM_RESTART': '1', 08:54:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:54:31 INFO - 'PWD': '/builds/slave/test-pgo', 08:54:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:54:31 INFO - 'SHELL': '/bin/bash', 08:54:31 INFO - 'SHLVL': '1', 08:54:31 INFO - 'TERM': 'linux', 08:54:31 INFO - 'TMOUT': '86400', 08:54:31 INFO - 'USER': 'cltbld', 08:54:31 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996', 08:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:31 INFO - '_': '/tools/buildbot/bin/python'} 08:54:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] with output_timeout 3600 08:54:31 INFO - mozversion INFO | application_buildid: 20151122073153 08:54:31 INFO - mozversion INFO | application_changeset: 26bf115402e27a4f24de8a040f8b36ac8e7d8ce4 08:54:31 INFO - mozversion INFO | application_display_name: Nightly 08:54:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:54:31 INFO - mozversion INFO | application_name: Firefox 08:54:31 INFO - mozversion INFO | application_remotingname: firefox 08:54:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:54:31 INFO - mozversion INFO | application_vendor: Mozilla 08:54:31 INFO - mozversion INFO | application_version: 45.0a1 08:54:31 INFO - mozversion INFO | platform_buildid: 20151122073153 08:54:31 INFO - mozversion INFO | platform_changeset: 26bf115402e27a4f24de8a040f8b36ac8e7d8ce4 08:54:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:54:31 INFO - mozversion INFO | platform_version: 45.0a1 08:54:31 INFO - 2015-11-22 08:54:31,772 DEBUG : using testdate: 1448211271 08:54:31 INFO - 2015-11-22 08:54:31,772 DEBUG : actual date: 1448211271 08:54:31 INFO - 2015-11-22 08:54:31,859 INFO : starting webserver on 'localhost:53969' 08:54:31 INFO - 2015-11-22 08:54:31,861 INFO : Starting test suite talos-linux64-ix-053.e 08:54:31 INFO - 2015-11-22 08:54:31,861 INFO : Starting test dromaeo_css 08:54:31 INFO - 2015-11-22 08:54:31,861 DEBUG : operating with platform_type : linux_ 08:54:31 INFO - 2015-11-22 08:54:31,862 INFO : Initialising browser for dromaeo_css test... 08:54:31 INFO - 2015-11-22 08:54:31,879 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsxbJfT/profile http://localhost:53969/getInfo.html 08:54:36 INFO - 2015-11-22 08:54:36,007 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:54:36 INFO - 2015-11-22 08:54:36,007 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:54:36 INFO - 2015-11-22 08:54:36,008 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:54:36 INFO - 2015-11-22 08:54:36,008 DEBUG : BROWSER_OUTPUT: __metrics 08:54:36 INFO - 2015-11-22 08:54:36,955 INFO : Browser initialized. 08:54:36 INFO - 2015-11-22 08:54:36,956 INFO : Running cycle 1/1 for dromaeo_css test... 08:54:36 INFO - 2015-11-22 08:54:36,956 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsxbJfT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:54:48 INFO - 2015-11-22 08:54:48,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 142520320 08:54:48 INFO - 2015-11-22 08:54:48,738 DEBUG : BROWSER_OUTPUT: 08:55:38 INFO - 2015-11-22 08:55:38,369 DEBUG : BROWSER_OUTPUT: 1448211338369 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] 08:57:47 INFO - 2015-11-22 08:57:47,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53969/tests/dromaeo/cssquery-ext.html) 08:57:48 INFO - 2015-11-22 08:57:48,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 148299776 08:57:48 INFO - 2015-11-22 08:57:48,485 DEBUG : BROWSER_OUTPUT: 09:00:50 INFO - 2015-11-22 09:00:50,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/dromaeo/cssquery-ext.html (next: http://localhost:53969/tests/dromaeo/cssquery-jquery.html) 09:00:50 INFO - 2015-11-22 09:00:50,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 142106624 09:00:50 INFO - 2015-11-22 09:00:50,994 DEBUG : BROWSER_OUTPUT: 09:03:52 INFO - 2015-11-22 09:03:52,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53969/tests/dromaeo/cssquery-mootools.html) 09:03:53 INFO - 2015-11-22 09:03:53,258 DEBUG : BROWSER_OUTPUT: RSS: Main: 143024128 09:03:53 INFO - 2015-11-22 09:03:53,258 DEBUG : BROWSER_OUTPUT: 09:06:54 INFO - 2015-11-22 09:06:54,923 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53969/tests/dromaeo/cssquery-prototype.html) 09:06:55 INFO - 2015-11-22 09:06:55,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 141520896 09:06:55 INFO - 2015-11-22 09:06:55,505 DEBUG : BROWSER_OUTPUT: 09:09:57 INFO - 2015-11-22 09:09:57,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53969/tests/dromaeo/cssquery-yui.html) 09:09:58 INFO - 2015-11-22 09:09:58,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 140582912 09:09:58 INFO - 2015-11-22 09:09:58,375 DEBUG : BROWSER_OUTPUT: 09:13:00 INFO - 2015-11-22 09:13:00,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/dromaeo/cssquery-yui.html (next: http://localhost:53969/tests/dromaeo/cssquery-dojo.html) 09:13:01 INFO - 2015-11-22 09:13:01,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 143953920 09:13:01 INFO - 2015-11-22 09:13:01,156 DEBUG : BROWSER_OUTPUT: 09:13:01 INFO - 2015-11-22 09:13:01,157 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:13:01 INFO - 2015-11-22 09:13:01,158 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:13:01 INFO - 2015-11-22 09:13:01,158 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:13:01 INFO - 2015-11-22 09:13:01,158 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:13:01 INFO - 2015-11-22 09:13:01,159 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3244.399786039583;3277.4100661880866;3295.6704329567033;3326.301476689895;3333.3666603345364;5260.605454590902;5456.154296084108;5479.835604931854;5481.561475081994;5483.972580137099;5260.132078207101;5393.7033463159605;5395.325584301962;5459.12653975364;5473.644213126154;4897.045076210149;4909.263610458424;4916.410030796309;4965.3048573199785;5020.472850350716;5002.549770520653;5027.145385284511;5040.218766091261;5091.338126043628;5092.898142037157;4860;4877.829275975341;4998;5005.849824505271;5021.974890125526;4948.480409557017;4953.9504604953845;4954.603631709455;4956.330895329121;5020.874478138039;4840.782164802592;4949.109160351135;4955.5044495550155;4972.229304457815;5027.4721154279005;5191.506806853343;5198.090334191501;5222.294990176316;5257.421683614838;5277.788888444457;5884.882302353929;5913.231279933624;5927.703614819242;5930.851728706773;5939.109133629947;5771.653700777924;5905.438983296623;5965.433283838029;5966.403359664042;5972.581919265654;5454.59090568205;5527.364353099445;5534.861628459281;5556.083246264361;5578.358488773762;5994.400559944058;5995.280566332068;6024.246969128859;6035.78874739382;6039.78860739872;5731.942680573141;5853.356130825606;5856.0630299151935;5860.443257890493;5880.529557635379;5848.619839710405;5916.349201587822;5917.201177841022;5937.614055086492;5971.343152253248;5836.6646496910025;5844.736986835603;5903.380145084704;5911.231539899872;5915.053591425351;5728.799492017843;5792.189093526909;5834.5624078194305;5882.911756323659;5891.263592050994;4573.0396616710195;4577.908441831211;4584.266517357207;4610.515895830957;4611.654125940568;4061.6750659947725;4064.065264989069;4072.572379900127;4075.694322925792;4116.91766164675;5441.047816632074;5531.308586426697;5543.251661025791;5681.488666020078;5687.459691329317;5926.407359264125;5944.405559444108;5945.227120474397;5945.346011938684;5961.850953726105;5578.24693666358;5580.776768929279;5624.184493248456;5628.521575666115;5628.549716022709;5019.071471777733;5085;5150.0472412603785;5171.4311425743135;5215.348081489814;6097.3292937776805;6133.172021777003;6142.324344322032;6144.2319710036245;6148.1085242639565;5749.223854779551;5934.347221805511;5939.138824870283;5947.613405128653;5950.494207992369;6021.638701677738;6054.061620448661;6098.3414614785315;6112.74665817949;6142.385761423822;5734;5822.155787410717;5863.2670916135485;5867.9413205867395;5878.294604647299;5766.163906233656;5888.293404791452;5936.614120082181;5966.612170208922;5966.731497082728;5748.9425105748405;5795.884082318415;5810.128480727924;5815.505682016907;5852.122181672783;5714.771409143587;5742.626729262584;5775.133729940542;5791.102379131242;5791.131330300489;5466.207399926909;5532.972335138298;5582.692951887685;5670.461306175906;5691.601587888974;5655.038643430709;5672.886542269214;5703.657780533182;5731.283589551306;5782.190493331022;5696.772129114789;5716.828495145152;5735.283089613798;5757.712114394348;5780.277465316835 09:13:01 INFO - 2015-11-22 09:13:01,159 DEBUG : BROWSER_OUTPUT: |1;ext.html;584.4272612839417;590.4036922708066;594.3076316091752;610.3896103896104;616.6269407008759;37913.810430947844;39280;39391.60608393915;39393.21213575727;39470.21059578807;41398.37902431466;41943.370849437284;41946;41985.7900710496;42050.57949420505;8635.611397487097;8840.38117331787;8845.557722113901;8849.513276769776;8856.911430885673;8619.224269815715;8634.050254472035;8648.394612377137;8675.95662021689;8680.08859069798;8704.129587041278;8719.128087191293;8761.693340733076;8769.736907892773;8794.912050879506;8570.100139485357;8734.170253825876;8763.167499087609;8768.386212965095;8780.868286975636;8580.099089595627;8727.432716873383;8750.86873696895;8762.036176020696;8763;37512.437313440045;37994.81002594997;38043.8097809512;38171.23657526834;38215;3261.4052116777234;3388.542546756206;3396.9490457643155;3401.897943061712;3485.7734247273847;28679.56980645292;28928;29308.12075637713;29492.41015179706;29942.55086173709;3918.255531449044;3927.9214415711526;4031.1333063391216;4098.938515922264;4111.5477297497255;254963;256271;256625;257342;257407;55460.72269638626;55654.72172639111;55753.163702544494;55938;56034.439655602924;58305.70847145737;58415.415845840995;58743.706281468316;59104.40895591075;59219;14968.550943471713;15371.231438428034;15401.537953861402;15403.383864645513;15414.460493882885;11811.586594469152;11823.586174484024;11854.348010859314;11864.584739534075;11870.940645296718;18692.61555363725;19174;19274.903625481784;19288.324908628132;19497.8050219496;7628.504147230412;7858.489198202098;7885.1326354101;7908.960455197687;7967.760967170994;894.141624040915;938.6104766521953;977.4233202410612;980.5048450532578;1072.6889202131451;27830.3042423941;28184.85907570449;28260.71739282581;28367.43265134686;28434.71565284362;1002.4486532407146;1047.706642140202;1054.4674939155677;1063.2663462211049;1124.3197865291545;13969.650758731113;13978.370973306226;14163;14176.220307882959;14306.57080287593;325633;332742;332745;333991;334016;48988.510114898396;49082.75458622684;49447.50552494429;49627.25559116616;49789.50210497921;1295.591888555102;1311.2853494845333;1327.4424741608548;1359.3271330691173;1359.802828589849;25966.870165649052;26382.604260935717;26820.59769103426;26973.3256668577;27213.455730885667;43406.34890476582;43439.56560434355;43511.12977740491;43702.344464832415;43801;300555;305199;305283;305516;305755;30340.84829575838;30588;30743.2314192147;30748.385032299677;30835.69164308418;42869.57130428656;43103.568964309954;44141;44182.55817441784;44262.33606495841;33010.83494582512;33343.46005010308;35784.284314314085;35862.46206306855;36412.81793591015;34697.306053878274;35178;35619;35877.82061089678;36187.81906090453;35333.29333413266;35336.64663353334;35659.10852228715;36278;36435.81782091073;28771;29220.123396298146;31181.53227701632;32630.184245394055;33056.83471582627;24673;24757.752422476264;24871.502569948138;25012.858990556873;25140.874295628404 09:13:01 INFO - 2015-11-22 09:13:01,163 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.56265793074516;355.87010741079513;357.69953239279;358.9066842620919;361.4776647744009;16309.510714678563;16854.91572542137;17439.389621363254;17740.645187096266;18209;10572.04851563359;11313.604023859167;16251.268692908818;16379.508614741577;16447.342106315733;4656.906861862769;5324.840254792343;5328.786848526054;5342.866428339303;5360.597955153359;5245.527902488775;5295.417504074549;5300.310959575249;5306.124489459235;5318.042752304584;4762.547557981986;5003.349564556603;5033.295338652573;5169.948300516984;5195.844124676266;5138.7687554059785;5148.330717006803;5162.045021671003;5164.380274367081;5195.9480405195845;5179.249008893727;5196.818111366084;5200.505951934598;5202.869928251786;5205;12543.372831358396;12544.310062946533;12562.560310389092;15356.539303820791;19346.709799353022;1987.5627361980341;2086.0821238654944;2142.1645558232303;2252.819774418059;2319.1651005637955;9292;9447.291453141042;10596.894031059745;10984.395858227794;13466.057375983684;1722.509084910807;1763.9911800441043;1794.318159099534;1810.7012342963396;1814.6915024445875;55711.72144139253;56376.154357685075;56449;59148;63762;9779.266555008402;10018.3488073275;10052.447115408722;10071.14395276395;10107.241956853119;12920.612381628565;12947.870521294855;13007.154534955198;13023.47906083746;13068.281244531641;7584.469087163846;7677.347425468786;7718.691252349955;7725.652345644347;7751.992241008633;7376.704931802775;7377.3360397564475;7439.851202976019;7441.665125069385;7467.887981680279;4215.6205941464805;4251.277282861921;4383.561643835591;4417.536158703354;4440.3561483585345;1818.4362847517311;1855.044652004219;1855.4248183063294;1875.1468082022648;1876.9301498145926;386.43580372655674;393.4314914947873;397.5428257503836;398.8683734367652;402.70200051961336;10262.589496420209;10479.476026198812;10490.737731556772;10540.578376864993;10630.521626526825;409.51472505081574;419.92231437184216;422.5858658514673;422.8752518007195;423.56796068011073;5710.885782284414;5786.623869448473;5830.679312637845;5861.472467477947;5874.823755287348;539443;551897;552837;556998;577714;77066;78056;80592;81716.59141704372;84816.99999999876;424.898024474124;430.9806058727365;432.08398195825055;432.54366643191736;433.22452809470695;9867.605295788087;10209.285350025724;10234.488275586042;14855.108693478425;16174.838251617804;36452.81773591115;36566.81716591506;36760.44859327059;36856.63143368532;37476.62523374731;45211;45481.54518454905;46013.769931151466;46873.296900547204;46877.531224687315;8390.909181806326;8773.166549177819;8797.648094076165;8799.736007919773;9077.863832042392;10241.897581024094;10294;11966.750705174678;16784.832151678325;17076.23156957915;13902.443902243796;13943.233122178377;14352.784708229176;14482.275886205858;14538;14097.506587269396;14099.718005639625;14103.2948352584;14139.505117320845;14626.902982276584;15039.774403384177;15274.312655930287;15332.770008450105;15399.230038497806;15641.608959775642;8764.91235087641;9016.819663606822;9194.770130746785;9198.540072996457;9273.953630231807;9768.267379946674;13006.80489792635;14223.715525689222;14565.563033109023;14629.195394253418 09:13:01 INFO - 2015-11-22 09:13:01,163 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1518.4913054126866;1694.2291257477848;1746.755454236407;1761.621251430942;1775.289884046382;7062.611556364404;7218.891716624248;7271.672774725137;7494.250574942503;7623.428242881779;7484.251574842513;7512.549247045181;7540.849183016337;7559.206283340239;7589.506682065662;2232.151782322715;2247.2359397804744;2261.050358849279;2265.0373591223747;2266.9433264168365;2242.091952759127;2262.1856131792542;2283.212291759349;2283.9885800570974;2285.7714228577174;2163.1131236193164;2222.744384395799;2223.344113486525;2223.9332820015343;2248.4940888300166;2231.141010710888;2239.1715065425733;2277.2257432472875;2279.623862062758;2283.6346184610466;2242.237639202679;2272.9659055114184;2274;2275.1354485295483;2283.828712846543;7401.814954626124;7518.473706840468;7536.095668519758;7536.5101268417375;7555.055618047744;4504;4532.161550113206;4598.632109431271;4607.470140933769;4610.561996610317;2877.985610071957;2968.302448924501;2972.093511478998;2979.508381117113;2987.4622567937763;1008.6469735592557;1010.2170817616333;1018.4551265073151;1045.8169820281496;1060.151878497199;9777.217822574248;9816.509174541316;9884.456354900478;9893.258005649534;9931.503424828801;3921.1569512554365;3979.3235150024566;4021.095253567924;4041.2927737645796;4052.452918855976;8038.236367545074;8099.028116626043;8115.959420202861;8133.471324363897;8139.79650508742;4544.6818722689095;4545.568171023748;4548.067646132535;4552.88617784558;4554.544545545419;4181.6236538711055;4189.308764053958;4192.972721683207;4207.768572728468;4232.851850185229;3411.3177364527196;3413.061408112739;3420.0765793236183;3420.931581368359;3444.293919746446;1058.5924419098549;1070.1331921143899;1070.4808168038496;1076.8546246256656;1094.108301734084;948.2603569216022;960.4669408478222;1083.926912356761;1142.308903113621;1320.1353113710536;6555.80332590023;6556.049372840911;6596.241432235354;6610.504212184105;6612.471002319803;571.6198727845936;577.6043410263983;584.5528170949227;589.3399392680226;727.3381223086966;5087.567556757717;5181.792728290901;5220.92168617471;5225.007248622749;5251.081060814342;8525.65897364111;8629.482231066157;8677.088905664941;8684.522351270742;8827.955860220658;8508.829823403497;8550.358723095793;8584.828303434022;8614.913850861536;8644.481331120152;6973.93026069743;7018.859622807618;7089.7873063808165;7092.645367731696;7139.178994415709;6731.1922569292;6740.427063699444;6790.388865002174;6803.047573339835;6805.625690587065;7668.424868135024;7812.804679883048;7834.4907581007055;7854.1753115922;7875.921240787518;8028.959855200686;8051.074126475531;8129.105798362294;8195.83608327842;8276.420650554644;6651.401373876374;6670.166229221348;6731.596104233761;6739.865202695821;6780.627065511247;7233.348998590152;7255.383292420203;7317.231690672403;7328.120625524971;7328.34044935937;6430.7749228776765;6799.11611490503;6813.488988325995;6825;6978.581285122909;5587.916181257203;6308.369163083655;6765.8985115224295;6854.691538880663;6858.691358888762;6441.516886233458;6456.903146452901;6695.196576410862;6796.388325050769;6823.522353435212;6313.08460273267;6313.652749098844;6326.272478664829;6349.269833968968;6349.396807303298;5907.113932910098;5931.970340148272;5966.224390829338;5983.282006159288;6015.157877897011 09:13:01 INFO - 2015-11-22 09:13:01,167 DEBUG : BROWSER_OUTPUT: |4;prototype.html;303.78431313767226;312.40175064750997;313.0046452281743;313.42799391111214;317.7791434952709;6322.367763223675;6339.683015849207;6360.713767880445;6390;6469.773557925473;6186.783462578811;6196.101565273033;6235.844103897405;6252.812415627527;6264.84337891553;4740.051989602076;4763.595094416962;4765.880852978668;4768.809247630099;4774.1645212087915;4717.504662010491;4735.573798358147;4745.050989802036;4746.501617330183;4748.620110391178;4639.072185562884;4698.177818881699;4712.976435117836;4715.976420117895;4731.219348807443;4684.953150468486;4686.742229177394;4705.223638099709;4720.055988802219;4720.504347043546;4034.616711412411;4045.656119229869;4046.919061618751;4049.5950404959563;4054.736442131252;5931.673757943311;5953.3451320354725;5964.7315870785915;5992;6011.57918945674;5390.595705322116;5469.042917489423;5469.288992430958;5482.2873026506695;5483.204935284361;6645.368689974444;6652.667366631649;6655.633940133291;6665.4001139897155;6668.166479190101;4481.103779244164;4488.438945131858;4493.056458143794;4505;4508.458984921797;6788.966055169742;6851.862962740767;6878.38094571491;6895.241523432418;6925.688344024531;4418;4431.047324825178;4432.601065904019;4442.400275962704;4443.777811109431;4436.378906953029;4471.105778844244;4473.485549161888;4490.416245888014;4506.188886000486;5313.256144139824;5322.4411436799355;5325.121354976385;5341.985022845647;5343.385510666245;6581.210254769362;6674.899876501856;6711.395974362331;6714.422110803957;6724.697388617426;1552.3790483806567;1578.5737850780224;1585.2311628859993;1593.3148746039315;1596.3534768418808;1037.056278786301;1038.6416686243233;1043.2175868098925;1055.9313644613076;1057.180684969155;6363.172787537591;6394.552381333262;6396.42432181106;6398.712057957403;6424.743010279536;6755.3582409671;6773.288804675537;6836.93163068363;6846.383825455633;6855.485838562127;6231.2522497300615;6375.171227740364;6377.457916077093;6384.106225128486;6391.936080639227;3706.29580379727;3712.832922518493;3725.832337544817;3730.973982154929;3732.664060234592;7114.857702845914;7132.930060490968;7147.1780745214965;7149.14210294768;7151.177614574391;6947.305269473012;7023.613701246379;7024.192217894905;7025.156981162293;7032.367086962198;7317.304856038668;7333.339999400079;7337.779866604011;7346.449016323797;7353.963230183922;6905.343992320722;6989.056477375692;6990.860182796418;6996.720131194696;7021.929780702128;6801.2178599461695;6923.688434020381;6941.548799328028;6952.478564107611;6955.547889387173;7277.9272207277245;7301.52540084914;7312.634368281459;7340.11918569775;7352.301531354513;4577.588017078346;4578.793954272132;4589.151007063704;4599.494055653942;4607.44710634726;6832.385085342343;6940.757073502403;6948.444124470131;6950.652467376712;6952.374286314256;6712.765053223114;6716.1940567130305;6718.966405167943;6735.730570777114;6789.490788190807;6712.53012289135;6753.898691519729;6762.797116086525;6768.695408706521;6773.254941956282;6517.674116294261;6611.173603299588;6651.933480665131;6659.334066593302;6665.900011499734;6769.559978601375;6815.659217039228;6820.07928929608;6826.2832402599;6826.351496607815;6624.138861947916;6630.171228596426;6644.069830223676;6645.634490103091;6660.0675905374255 09:13:01 INFO - 2015-11-22 09:13:01,168 DEBUG : BROWSER_OUTPUT: |5;yui.html;746.5371469688794;775.3215936055951;786.1980779604806;796.9163237860024;847.2163248994686;13058.477660893564;13268.270245136513;13289.800652990212;13337.933310333434;13343.199408035513;13236.272005039718;13305.06864519484;13320.40058197381;13361.732765344686;13377.665558361046;812.6424373275769;824.1799409587439;835.6615570693879;840.8276303357796;840.8822764812932;834.3825569078869;837.7109897085496;840.756180707594;841.3353450773882;844.1727107434687;861.0571424290423;862.7756783236372;868.3530769576674;869.0223498564116;871.6295574380895;860.1914200651399;864.2437866866492;864.5590748718137;865.1953683074738;869.6738722978914;626.76183050441;631.1038325577691;632.8892443822313;633.5470138850698;637.9011253255707;13656.112352697042;13699.45202191911;13787.793183102262;13792.586222413243;13824.101433406797;11711.824322635168;11790.646280611596;12002.339871307075;12023.545113193843;12032.939835300767;10284.228682848816;10524.78950420995;10566.577336906514;10785.352878827296;10805.945970270099;3640.7087433005295;3710.870119545803;3740.1023754299044;3799.145192331731;3839.596842331543;43155.56844431578;43636;43684.56315436837;43723.78138109289;43954.56045439537;9365.906340936639;9985.850212246822;10020.99580083986;10215.13171380441;10547.367157970546;17790;17896.9105154476;17967.73048404275;17992.640147197246;18004.729929051075;7811.726589569338;7839.412044096715;7889.605519723991;7918.564478953713;8083.393745468996;4513.842015529506;4515.503294637587;4517.344984977226;4575.405197324327;4606.792694328763;2957.157210195084;2957.955630665542;2969.8960536381123;2995.790294679395;3003.609530761031;538.2572050570188;545.1686178577701;545.2557259340971;553.3498139685853;560.9635373700696;626;666.4568376773011;674.7233634210048;679.2121139478181;682.952193346461;8454;8534.914650853536;8660.78348041304;8667.609957551926;8863.734087977371;493.1542404775827;629.5624540944092;667.4960404894274;667.7295695243434;694.5381321421299;3888.0862997195636;4062.126642771759;4237.936430953539;4281.464816897887;4500.234960056799;58018.709906450196;58877;58899.70550147307;58980.7050964751;60324.69837650783;50660.493395065576;51330.74334628303;52919.735401322745;53141.73429132907;53861.46138538564;47348.28977565339;47535.811604709466;47948.28077578839;48180.5181948183;48272.51727482751;8549.743507694779;8662.393632445668;8728.258098061737;8825.867611985954;9067;34745.826270868485;34894;35379;35549.64450355567;35730.821345893106;43208.135837283706;46629;46751;46993.53006469891;47553;10765.246432749633;11266.94366528162;11460.312381257152;11661;11724.355160466257;11599.6520104397;11720.120990925545;11959.820602691141;12123.151379403356;12145.939270303592;11468.541258349906;11480.024197943269;11504.482298296429;11761.588344407905;12140.15018948665;11703.648890533297;11731.183542984101;11749.823752643888;11968.700782480508;12268.754624907631;11048.337099773718;11141.498632561392;11342.319460832376;11375.20373573842;11671.708207294885;9519.76200594963;9531.952340238255;9764.755881103029;9906.900930990598;9945.651902183388;9056.139666731913;9369.297302702189;9702.175315098013;9744.220462362851;9791.608335666779 09:13:01 INFO - 2015-11-22 09:13:01,168 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:13:01 INFO - 2015-11-22 09:13:01,168 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:13:01 INFO - 2015-11-22 09:13:01,168 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,296 09:13:01 INFO - 2015-11-22 09:13:01,169 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:13:01 INFO - 2015-11-22 09:13:01,169 DEBUG : BROWSER_OUTPUT: __startTimestamp1448212381157__endTimestamp 09:13:01 INFO - 2015-11-22 09:13:01,169 DEBUG : BROWSER_OUTPUT: 09:13:01 INFO - 2015-11-22 09:13:01,169 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:13:01 INFO - 2015-11-22 09:13:01,169 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:13:01 INFO - 2015-11-22 09:13:01,169 DEBUG : BROWSER_OUTPUT: 09:13:01 INFO - 2015-11-22 09:13:01,169 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5468.25 Median:5696.77 stddev:610.29 (10.7%) stddev-sans-first:586.70 09:13:01 INFO - 2015-11-22 09:13:01,169 DEBUG : BROWSER_OUTPUT: Values: 3244.4 3277.4 3295.7 3326.3 3333.4 5260.6 5456.2 5479.8 5481.6 5484.0 5260.1 5393.7 5395.3 5459.1 5473.6 4897.0 4909.3 4916.4 4965.3 5020.5 5002.5 5027.1 5040.2 5091.3 5092.9 4860.0 4877.8 4998.0 5005.8 5022.0 4948.5 4954.0 4954.6 4956.3 5020.9 4840.8 4949.1 4955.5 4972.2 5027.5 5191.5 5198.1 5222.3 5257.4 5277.8 5884.9 5913.2 5927.7 5930.9 5939.1 5771.7 5905.4 5965.4 5966.4 5972.6 5454.6 5527.4 5534.9 5556.1 5578.4 5994.4 5995.3 6024.2 6035.8 6039.8 5731.9 5853.4 5856.1 5860.4 5880.5 5848.6 5916.3 5917.2 5937.6 5971.3 5836.7 5844.7 5903.4 5911.2 5915.1 5728.8 5792.2 5834.6 5882.9 5891.3 4573.0 4577.9 4584.3 4610.5 4611.7 4061.7 4064.1 4072.6 4075.7 4116.9 5441.0 5531.3 5543.3 5681.5 5687.5 5926.4 5944.4 5945.2 5945.3 5961.9 5578.2 5580.8 5624.2 5628.5 5628.5 5019.1 5085.0 5150.0 5171.4 5215.3 6097.3 6133.2 6142.3 6144.2 6148.1 5749.2 5934.3 5939.1 5947.6 5950.5 6021.6 6054.1 6098.3 6112.7 6142.4 5734.0 5822.2 5863.3 5867.9 5878.3 5766.2 5888.3 5936.6 5966.6 5966.7 5748.9 5795.9 5810.1 5815.5 5852.1 5714.8 5742.6 5775.1 5791.1 5791.1 5466.2 5533.0 5582.7 5670.5 5691.6 5655.0 5672.9 5703.7 5731.3 5782.2 5696.8 5716.8 5735.3 5757.7 5780.3 09:13:01 INFO - 2015-11-22 09:13:01,169 DEBUG : BROWSER_OUTPUT: 09:13:01 INFO - 2015-11-22 09:13:01,169 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46198.49 Median:35870.14 stddev:78282.77 (218.2%) stddev-sans-first:78427.45 09:13:01 INFO - 2015-11-22 09:13:01,169 DEBUG : BROWSER_OUTPUT: Values: 584.4 590.4 594.3 610.4 616.6 37913.8 39280.0 39391.6 39393.2 39470.2 41398.4 41943.4 41946.0 41985.8 42050.6 8635.6 8840.4 8845.6 8849.5 8856.9 8619.2 8634.1 8648.4 8676.0 8680.1 8704.1 8719.1 8761.7 8769.7 8794.9 8570.1 8734.2 8763.2 8768.4 8780.9 8580.1 8727.4 8750.9 8762.0 8763.0 37512.4 37994.8 38043.8 38171.2 38215.0 3261.4 3388.5 3396.9 3401.9 3485.8 28679.6 28928.0 29308.1 29492.4 29942.6 3918.3 3927.9 4031.1 4098.9 4111.5 254963.0 256271.0 256625.0 257342.0 257407.0 55460.7 55654.7 55753.2 55938.0 56034.4 58305.7 58415.4 58743.7 59104.4 59219.0 14968.6 15371.2 15401.5 15403.4 15414.5 11811.6 11823.6 11854.3 11864.6 11870.9 18692.6 19174.0 19274.9 19288.3 19497.8 7628.5 7858.5 7885.1 7909.0 7967.8 894.1 938.6 977.4 980.5 1072.7 27830.3 28184.9 28260.7 28367.4 28434.7 1002.4 1047.7 1054.5 1063.3 1124.3 13969.7 13978.4 14163.0 14176.2 14306.6 325633.0 332742.0 332745.0 333991.0 334016.0 48988.5 49082.8 49447.5 49627.3 49789.5 1295.6 1311.3 1327.4 1359.3 1359.8 25966.9 26382.6 26820.6 26973.3 27213.5 43406.3 43439.6 43511.1 43702.3 43801.0 300555.0 305199.0 305283.0 305516.0 305755.0 30340.8 30588.0 30743.2 30748.4 30835.7 42869.6 43103.6 44141.0 44182.6 44262.3 33010.8 33343.5 35784.3 35862.5 36412.8 34697.3 35178.0 35619.0 35877.8 36187.8 35333.3 35336.6 35659.1 36278.0 36435.8 28771.0 29220.1 31181.5 32630.2 33056.8 24673.0 24757.8 24871.5 25012.9 25140.9 09:13:01 INFO - 2015-11-22 09:13:01,169 DEBUG : BROWSER_OUTPUT: 09:13:01 INFO - 2015-11-22 09:13:01,170 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28517.44 Median:414.72 stddev:90927.96 (21925.2%) stddev-sans-first:91158.45 09:13:01 INFO - 2015-11-22 09:13:01,171 DEBUG : BROWSER_OUTPUT: Values: 355.6 355.9 357.7 358.9 361.5 16309.5 16854.9 17439.4 17740.6 18209.0 10572.0 11313.6 16251.3 16379.5 16447.3 4656.9 5324.8 5328.8 5342.9 5360.6 5245.5 5295.4 5300.3 5306.1 5318.0 4762.5 5003.3 5033.3 5169.9 5195.8 5138.8 5148.3 5162.0 5164.4 5195.9 5179.2 5196.8 5200.5 5202.9 5205.0 12543.4 12544.3 12562.6 15356.5 19346.7 1987.6 2086.1 2142.2 2252.8 2319.2 9292.0 9447.3 10596.9 10984.4 13466.1 1722.5 1764.0 1794.3 1810.7 1814.7 55711.7 56376.2 56449.0 59148.0 63762.0 9779.3 10018.3 10052.4 10071.1 10107.2 12920.6 12947.9 13007.2 13023.5 13068.3 7584.5 7677.3 7718.7 7725.7 7752.0 7376.7 7377.3 7439.9 7441.7 7467.9 4215.6 4251.3 4383.6 4417.5 4440.4 1818.4 1855.0 1855.4 1875.1 1876.9 386.4 393.4 397.5 398.9 402.7 10262.6 10479.5 10490.7 10540.6 10630.5 409.5 419.9 422.6 422.9 423.6 5710.9 5786.6 5830.7 5861.5 5874.8 539443.0 551897.0 552837.0 556998.0 577714.0 77066.0 78056.0 80592.0 81716.6 84817.0 424.9 431.0 432.1 432.5 433.2 9867.6 10209.3 10234.5 14855.1 16174.8 36452.8 36566.8 36760.4 36856.6 37476.6 45211.0 45481.5 46013.8 46873.3 46877.5 8390.9 8773.2 8797.6 8799.7 9077.9 10241.9 10294.0 11966.8 16784.8 17076.2 13902.4 13943.2 14352.8 14482.3 14538.0 14097.5 14099.7 14103.3 14139.5 14626.9 15039.8 15274.3 15332.8 15399.2 15641.6 8764.9 9016.8 9194.8 9198.5 9274.0 9768.3 13006.8 14223.7 14565.6 14629.2 09:13:01 INFO - 2015-11-22 09:13:01,171 DEBUG : BROWSER_OUTPUT: 09:13:01 INFO - 2015-11-22 09:13:01,171 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5161.77 Median:6319.96 stddev:2625.58 (41.5%) stddev-sans-first:2618.67 09:13:01 INFO - 2015-11-22 09:13:01,171 DEBUG : BROWSER_OUTPUT: Values: 1518.5 1694.2 1746.8 1761.6 1775.3 7062.6 7218.9 7271.7 7494.3 7623.4 7484.3 7512.5 7540.8 7559.2 7589.5 2232.2 2247.2 2261.1 2265.0 2266.9 2242.1 2262.2 2283.2 2284.0 2285.8 2163.1 2222.7 2223.3 2223.9 2248.5 2231.1 2239.2 2277.2 2279.6 2283.6 2242.2 2273.0 2274.0 2275.1 2283.8 7401.8 7518.5 7536.1 7536.5 7555.1 4504.0 4532.2 4598.6 4607.5 4610.6 2878.0 2968.3 2972.1 2979.5 2987.5 1008.6 1010.2 1018.5 1045.8 1060.2 9777.2 9816.5 9884.5 9893.3 9931.5 3921.2 3979.3 4021.1 4041.3 4052.5 8038.2 8099.0 8116.0 8133.5 8139.8 4544.7 4545.6 4548.1 4552.9 4554.5 4181.6 4189.3 4193.0 4207.8 4232.9 3411.3 3413.1 3420.1 3420.9 3444.3 1058.6 1070.1 1070.5 1076.9 1094.1 948.3 960.5 1083.9 1142.3 1320.1 6555.8 6556.0 6596.2 6610.5 6612.5 571.6 577.6 584.6 589.3 727.3 5087.6 5181.8 5220.9 5225.0 5251.1 8525.7 8629.5 8677.1 8684.5 8828.0 8508.8 8550.4 8584.8 8614.9 8644.5 6973.9 7018.9 7089.8 7092.6 7139.2 6731.2 6740.4 6790.4 6803.0 6805.6 7668.4 7812.8 7834.5 7854.2 7875.9 8029.0 8051.1 8129.1 8195.8 8276.4 6651.4 6670.2 6731.6 6739.9 6780.6 7233.3 7255.4 7317.2 7328.1 7328.3 6430.8 6799.1 6813.5 6825.0 6978.6 5587.9 6308.4 6765.9 6854.7 6858.7 6441.5 6456.9 6695.2 6796.4 6823.5 6313.1 6313.7 6326.3 6349.3 6349.4 5907.1 5932.0 5966.2 5983.3 6015.2 09:13:01 INFO - 2015-11-22 09:13:01,171 DEBUG : BROWSER_OUTPUT: 09:13:01 INFO - 2015-11-22 09:13:01,171 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5553.45 Median:6376.31 stddev:1740.03 (27.3%) stddev-sans-first:1699.72 09:13:01 INFO - 2015-11-22 09:13:01,171 DEBUG : BROWSER_OUTPUT: Values: 303.8 312.4 313.0 313.4 317.8 6322.4 6339.7 6360.7 6390.0 6469.8 6186.8 6196.1 6235.8 6252.8 6264.8 4740.1 4763.6 4765.9 4768.8 4774.2 4717.5 4735.6 4745.1 4746.5 4748.6 4639.1 4698.2 4713.0 4716.0 4731.2 4685.0 4686.7 4705.2 4720.1 4720.5 4034.6 4045.7 4046.9 4049.6 4054.7 5931.7 5953.3 5964.7 5992.0 6011.6 5390.6 5469.0 5469.3 5482.3 5483.2 6645.4 6652.7 6655.6 6665.4 6668.2 4481.1 4488.4 4493.1 4505.0 4508.5 6789.0 6851.9 6878.4 6895.2 6925.7 4418.0 4431.0 4432.6 4442.4 4443.8 4436.4 4471.1 4473.5 4490.4 4506.2 5313.3 5322.4 5325.1 5342.0 5343.4 6581.2 6674.9 6711.4 6714.4 6724.7 1552.4 1578.6 1585.2 1593.3 1596.4 1037.1 1038.6 1043.2 1055.9 1057.2 6363.2 6394.6 6396.4 6398.7 6424.7 6755.4 6773.3 6836.9 6846.4 6855.5 6231.3 6375.2 6377.5 6384.1 6391.9 3706.3 3712.8 3725.8 3731.0 3732.7 7114.9 7132.9 7147.2 7149.1 7151.2 6947.3 7023.6 7024.2 7025.2 7032.4 7317.3 7333.3 7337.8 7346.4 7354.0 6905.3 6989.1 6990.9 6996.7 7021.9 6801.2 6923.7 6941.5 6952.5 6955.5 7277.9 7301.5 7312.6 7340.1 7352.3 4577.6 4578.8 4589.2 4599.5 4607.4 6832.4 6940.8 6948.4 6950.7 6952.4 6712.8 6716.2 6719.0 6735.7 6789.5 6712.5 6753.9 6762.8 6768.7 6773.3 6517.7 6611.2 6651.9 6659.3 6665.9 6769.6 6815.7 6820.1 6826.3 6826.4 6624.1 6630.2 6644.1 6645.6 6660.1 09:13:01 INFO - 2015-11-22 09:13:01,171 DEBUG : BROWSER_OUTPUT: 09:13:01 INFO - 2015-11-22 09:13:01,172 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13889.98 Median:46872.27 stddev:16050.28 (34.2%) stddev-sans-first:16064.96 09:13:01 INFO - 2015-11-22 09:13:01,173 DEBUG : BROWSER_OUTPUT: Values: 746.5 775.3 786.2 796.9 847.2 13058.5 13268.3 13289.8 13337.9 13343.2 13236.3 13305.1 13320.4 13361.7 13377.7 812.6 824.2 835.7 840.8 840.9 834.4 837.7 840.8 841.3 844.2 861.1 862.8 868.4 869.0 871.6 860.2 864.2 864.6 865.2 869.7 626.8 631.1 632.9 633.5 637.9 13656.1 13699.5 13787.8 13792.6 13824.1 11711.8 11790.6 12002.3 12023.5 12032.9 10284.2 10524.8 10566.6 10785.4 10805.9 3640.7 3710.9 3740.1 3799.1 3839.6 43155.6 43636.0 43684.6 43723.8 43954.6 9365.9 9985.9 10021.0 10215.1 10547.4 17790.0 17896.9 17967.7 17992.6 18004.7 7811.7 7839.4 7889.6 7918.6 8083.4 4513.8 4515.5 4517.3 4575.4 4606.8 2957.2 2958.0 2969.9 2995.8 3003.6 538.3 545.2 545.3 553.3 561.0 626.0 666.5 674.7 679.2 683.0 8454.0 8534.9 8660.8 8667.6 8863.7 493.2 629.6 667.5 667.7 694.5 3888.1 4062.1 4237.9 4281.5 4500.2 58018.7 58877.0 58899.7 58980.7 60324.7 50660.5 51330.7 52919.7 53141.7 53861.5 47348.3 47535.8 47948.3 48180.5 48272.5 8549.7 8662.4 8728.3 8825.9 9067.0 34745.8 34894.0 35379.0 35549.6 35730.8 43208.1 46629.0 46751.0 46993.5 47553.0 10765.2 11266.9 11460.3 11661.0 11724.4 11599.7 11720.1 11959.8 12123.2 12145.9 11468.5 11480.0 11504.5 11761.6 12140.2 11703.6 11731.2 11749.8 11968.7 12268.8 11048.3 11141.5 11342.3 11375.2 11671.7 9519.8 9532.0 9764.8 9906.9 9945.7 9056.1 9369.3 9702.2 9744.2 9791.6 09:13:01 INFO - 2015-11-22 09:13:01,173 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:13:01 INFO - 2015-11-22 09:13:01,173 DEBUG : BROWSER_OUTPUT: 09:13:01 INFO - 2015-11-22 09:13:01,852 INFO : Browser exited with error code: 0 09:13:01 INFO - 2015-11-22 09:13:01,870 INFO : Completed test dromaeo_css (00:18:30) 09:13:01 INFO - 2015-11-22 09:13:01,870 INFO : Starting test kraken 09:13:01 INFO - 2015-11-22 09:13:01,870 DEBUG : operating with platform_type : linux_ 09:13:01 INFO - 2015-11-22 09:13:01,871 INFO : Initialising browser for kraken test... 09:13:01 INFO - 2015-11-22 09:13:01,877 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpm6LCLY/profile http://localhost:53969/getInfo.html 09:13:05 INFO - 2015-11-22 09:13:05,940 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:13:05 INFO - 2015-11-22 09:13:05,940 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:13:05 INFO - 2015-11-22 09:13:05,940 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:13:05 INFO - 2015-11-22 09:13:05,941 DEBUG : BROWSER_OUTPUT: __metrics 09:13:06 INFO - 2015-11-22 09:13:06,904 INFO : Browser initialized. 09:13:06 INFO - 2015-11-22 09:13:06,904 INFO : Running cycle 1/1 for kraken test... 09:13:06 INFO - 2015-11-22 09:13:06,904 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpm6LCLY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:13:18 INFO - 2015-11-22 09:13:18,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 141983744 09:13:18 INFO - 2015-11-22 09:13:18,759 DEBUG : BROWSER_OUTPUT: 09:13:21 INFO - 2015-11-22 09:13:21,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53969/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:21 INFO - 2015-11-22 09:13:21,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 143138816 09:13:21 INFO - 2015-11-22 09:13:21,853 DEBUG : BROWSER_OUTPUT: 09:13:24 INFO - 2015-11-22 09:13:24,450 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53969/tests/kraken/driver.html?testName=audio-dft) 09:13:25 INFO - 2015-11-22 09:13:25,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 142508032 09:13:25 INFO - 2015-11-22 09:13:25,051 DEBUG : BROWSER_OUTPUT: 09:13:27 INFO - 2015-11-22 09:13:27,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53969/tests/kraken/driver.html?testName=audio-fft) 09:13:28 INFO - 2015-11-22 09:13:28,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 136093696 09:13:28 INFO - 2015-11-22 09:13:28,477 DEBUG : BROWSER_OUTPUT: 09:13:30 INFO - 2015-11-22 09:13:30,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53969/tests/kraken/driver.html?testName=audio-oscillator) 09:13:31 INFO - 2015-11-22 09:13:31,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 136400896 09:13:31 INFO - 2015-11-22 09:13:31,096 DEBUG : BROWSER_OUTPUT: 09:13:33 INFO - 2015-11-22 09:13:33,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53969/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:33 INFO - 2015-11-22 09:13:33,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 139767808 09:13:33 INFO - 2015-11-22 09:13:33,887 DEBUG : BROWSER_OUTPUT: 09:13:36 INFO - 2015-11-22 09:13:36,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53969/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:37 INFO - 2015-11-22 09:13:37,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 138801152 09:13:37 INFO - 2015-11-22 09:13:37,444 DEBUG : BROWSER_OUTPUT: 09:13:40 INFO - 2015-11-22 09:13:40,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53969/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:41 INFO - 2015-11-22 09:13:41,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 138743808 09:13:41 INFO - 2015-11-22 09:13:41,456 DEBUG : BROWSER_OUTPUT: 09:13:44 INFO - 2015-11-22 09:13:44,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53969/tests/kraken/driver.html?testName=json-parse-financial) 09:13:44 INFO - 2015-11-22 09:13:44,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 139595776 09:13:44 INFO - 2015-11-22 09:13:44,916 DEBUG : BROWSER_OUTPUT: 09:13:46 INFO - 2015-11-22 09:13:46,504 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53969/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:47 INFO - 2015-11-22 09:13:47,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 139812864 09:13:47 INFO - 2015-11-22 09:13:47,090 DEBUG : BROWSER_OUTPUT: 09:13:48 INFO - 2015-11-22 09:13:48,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53969/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:49 INFO - 2015-11-22 09:13:49,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 138498048 09:13:49 INFO - 2015-11-22 09:13:49,541 DEBUG : BROWSER_OUTPUT: 09:13:51 INFO - 2015-11-22 09:13:51,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53969/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:52 INFO - 2015-11-22 09:13:52,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 140029952 09:13:52 INFO - 2015-11-22 09:13:52,202 DEBUG : BROWSER_OUTPUT: 09:13:54 INFO - 2015-11-22 09:13:54,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53969/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:55 INFO - 2015-11-22 09:13:55,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 140963840 09:13:55 INFO - 2015-11-22 09:13:55,271 DEBUG : BROWSER_OUTPUT: 09:13:57 INFO - 2015-11-22 09:13:57,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53969/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:13:58 INFO - 2015-11-22 09:13:58,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 139730944 09:13:58 INFO - 2015-11-22 09:13:58,463 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,152 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53969/tests/kraken/driver.html?testName=ai-astar) 09:14:00 INFO - 2015-11-22 09:14:00,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 139890688 09:14:00 INFO - 2015-11-22 09:14:00,402 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,403 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:14:00 INFO - 2015-11-22 09:14:00,403 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:14:00 INFO - 2015-11-22 09:14:00,403 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:14:00 INFO - 2015-11-22 09:14:00,403 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:14:00 INFO - 2015-11-22 09:14:00,404 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;106;111;111;113;121;112;111;110;111 09:14:00 INFO - 2015-11-22 09:14:00,404 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;123;146;158;129;146;150;128;166;125 09:14:00 INFO - 2015-11-22 09:14:00,404 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;159;162;162;161;161;164;169;163 09:14:00 INFO - 2015-11-22 09:14:00,405 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;71;74;71;71;142;74;72;71 09:14:00 INFO - 2015-11-22 09:14:00,405 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;141;92;92;94;132;92;92;135 09:14:00 INFO - 2015-11-22 09:14:00,405 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;113;110;110;110;110;109;110;109;110 09:14:00 INFO - 2015-11-22 09:14:00,405 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;146;147;147;149;146;148;146 09:14:00 INFO - 2015-11-22 09:14:00,406 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;97;98;97;96;96;96 09:14:00 INFO - 2015-11-22 09:14:00,406 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;64;63;63;62;62;63;62;59;60 09:14:00 INFO - 2015-11-22 09:14:00,406 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;70;69;78;68;69;69;70 09:14:00 INFO - 2015-11-22 09:14:00,406 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;85;85;87;86;85;89;86;87;87 09:14:00 INFO - 2015-11-22 09:14:00,407 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;122;131;111;122;137;122;127;141;116 09:14:00 INFO - 2015-11-22 09:14:00,407 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;153;150;150;149;145;155;157;150;155 09:14:00 INFO - 2015-11-22 09:14:00,407 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;68;69;67;68;76;68;69;66;68 09:14:00 INFO - 2015-11-22 09:14:00,407 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:14:00 INFO - 2015-11-22 09:14:00,408 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:14:00 INFO - 2015-11-22 09:14:00,408 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,723 09:14:00 INFO - 2015-11-22 09:14:00,408 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:14:00 INFO - 2015-11-22 09:14:00,408 DEBUG : BROWSER_OUTPUT: __startTimestamp1448212440401__endTimestamp 09:14:00 INFO - 2015-11-22 09:14:00,409 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,410 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:14:00 INFO - 2015-11-22 09:14:00,410 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:14:00 INFO - 2015-11-22 09:14:00,410 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,410 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.70 Median:111.00 stddev:3.74 (3.4%) stddev-sans-first:3.96 09:14:00 INFO - 2015-11-22 09:14:00,411 DEBUG : BROWSER_OUTPUT: Values: 111.0 106.0 111.0 111.0 113.0 121.0 112.0 111.0 110.0 111.0 09:14:00 INFO - 2015-11-22 09:14:00,411 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,411 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.80 Median:148.00 stddev:15.50 (10.5%) stddev-sans-first:15.56 09:14:00 INFO - 2015-11-22 09:14:00,411 DEBUG : BROWSER_OUTPUT: Values: 157.0 123.0 146.0 158.0 129.0 146.0 150.0 128.0 166.0 125.0 09:14:00 INFO - 2015-11-22 09:14:00,411 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,411 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:2.67 (1.7%) stddev-sans-first:2.79 09:14:00 INFO - 2015-11-22 09:14:00,411 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 159.0 162.0 162.0 161.0 161.0 164.0 169.0 163.0 09:14:00 INFO - 2015-11-22 09:14:00,412 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,412 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.00 Median:72.00 stddev:22.17 (30.8%) stddev-sans-first:23.37 09:14:00 INFO - 2015-11-22 09:14:00,412 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 71.0 74.0 71.0 71.0 142.0 74.0 72.0 71.0 09:14:00 INFO - 2015-11-22 09:14:00,412 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,412 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.30 Median:92.00 stddev:21.31 (23.2%) stddev-sans-first:21.96 09:14:00 INFO - 2015-11-22 09:14:00,412 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 141.0 92.0 92.0 94.0 132.0 92.0 92.0 135.0 09:14:00 INFO - 2015-11-22 09:14:00,412 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,412 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:1.15 (1.0%) stddev-sans-first:1.17 09:14:00 INFO - 2015-11-22 09:14:00,412 DEBUG : BROWSER_OUTPUT: Values: 109.0 113.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 110.0 09:14:00 INFO - 2015-11-22 09:14:00,412 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,413 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 09:14:00 INFO - 2015-11-22 09:14:00,413 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 146.0 147.0 147.0 149.0 146.0 148.0 146.0 09:14:00 INFO - 2015-11-22 09:14:00,413 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,413 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 09:14:00 INFO - 2015-11-22 09:14:00,413 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 97.0 98.0 97.0 96.0 96.0 96.0 09:14:00 INFO - 2015-11-22 09:14:00,413 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,413 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.10 Median:63.00 stddev:1.52 (2.4%) stddev-sans-first:1.58 09:14:00 INFO - 2015-11-22 09:14:00,413 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 63.0 62.0 62.0 63.0 62.0 59.0 60.0 09:14:00 INFO - 2015-11-22 09:14:00,413 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,413 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:69.50 stddev:2.85 (4.1%) stddev-sans-first:2.99 09:14:00 INFO - 2015-11-22 09:14:00,414 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 70.0 69.0 78.0 68.0 69.0 69.0 70.0 09:14:00 INFO - 2015-11-22 09:14:00,414 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,414 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:1.25 (1.4%) stddev-sans-first:1.32 09:14:00 INFO - 2015-11-22 09:14:00,414 DEBUG : BROWSER_OUTPUT: Values: 86.0 85.0 85.0 87.0 86.0 85.0 89.0 86.0 87.0 87.0 09:14:00 INFO - 2015-11-22 09:14:00,414 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,414 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:124.50 stddev:9.31 (7.5%) stddev-sans-first:9.63 09:14:00 INFO - 2015-11-22 09:14:00,414 DEBUG : BROWSER_OUTPUT: Values: 119.0 122.0 131.0 111.0 122.0 137.0 122.0 127.0 141.0 116.0 09:14:00 INFO - 2015-11-22 09:14:00,414 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,414 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.70 Median:153.00 stddev:3.56 (2.3%) stddev-sans-first:3.75 09:14:00 INFO - 2015-11-22 09:14:00,414 DEBUG : BROWSER_OUTPUT: Values: 153.0 153.0 150.0 150.0 149.0 145.0 155.0 157.0 150.0 155.0 09:14:00 INFO - 2015-11-22 09:14:00,414 DEBUG : BROWSER_OUTPUT: 09:14:00 INFO - 2015-11-22 09:14:00,414 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.50 stddev:2.79 (4.1%) stddev-sans-first:2.86 09:14:00 INFO - 2015-11-22 09:14:00,415 DEBUG : BROWSER_OUTPUT: Values: 71.0 68.0 69.0 67.0 68.0 76.0 68.0 69.0 66.0 68.0 09:14:00 INFO - 2015-11-22 09:14:00,415 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:14:00 INFO - 2015-11-22 09:14:00,415 DEBUG : BROWSER_OUTPUT: 09:14:01 INFO - 2015-11-22 09:14:01,264 INFO : Browser exited with error code: 0 09:14:01 INFO - 2015-11-22 09:14:01,314 INFO : Completed test kraken (00:00:59) 09:14:01 INFO - 2015-11-22 09:14:01,314 INFO : Starting test v8_7 09:14:01 INFO - 2015-11-22 09:14:01,314 DEBUG : operating with platform_type : linux_ 09:14:01 INFO - 2015-11-22 09:14:01,314 INFO : Initialising browser for v8_7 test... 09:14:01 INFO - 2015-11-22 09:14:01,320 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjKAPxI/profile http://localhost:53969/getInfo.html 09:14:05 INFO - 2015-11-22 09:14:05,289 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:14:05 INFO - 2015-11-22 09:14:05,289 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:14:05 INFO - 2015-11-22 09:14:05,289 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:14:05 INFO - 2015-11-22 09:14:05,289 DEBUG : BROWSER_OUTPUT: __metrics 09:14:06 INFO - 2015-11-22 09:14:06,268 INFO : Browser initialized. 09:14:06 INFO - 2015-11-22 09:14:06,268 INFO : Running cycle 1/1 for v8_7 test... 09:14:06 INFO - 2015-11-22 09:14:06,268 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjKAPxI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:14:18 INFO - 2015-11-22 09:14:18,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 141840384 09:14:18 INFO - 2015-11-22 09:14:18,076 DEBUG : BROWSER_OUTPUT: 09:14:39 INFO - 2015-11-22 09:14:39,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53969/tests/v8_7/run.html (next: http://localhost:53969/tests/v8_7/run.html) 09:14:39 INFO - 2015-11-22 09:14:39,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 138731520 09:14:39 INFO - 2015-11-22 09:14:39,691 DEBUG : BROWSER_OUTPUT: 09:14:39 INFO - 2015-11-22 09:14:39,691 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:14:39 INFO - 2015-11-22 09:14:39,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:14:39 INFO - 2015-11-22 09:14:39,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:14:39 INFO - 2015-11-22 09:14:39,692 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:14:39 INFO - 2015-11-22 09:14:39,692 DEBUG : BROWSER_OUTPUT: |0;Richards;189.10741301059002 09:14:39 INFO - 2015-11-22 09:14:39,692 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.42359767891682 09:14:39 INFO - 2015-11-22 09:14:39,693 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.5315315315315 09:14:39 INFO - 2015-11-22 09:14:39,693 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5000 09:14:39 INFO - 2015-11-22 09:14:39,693 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1060.4453870625662 09:14:39 INFO - 2015-11-22 09:14:39,693 DEBUG : BROWSER_OUTPUT: |5;Earley;707.2135785007072 09:14:39 INFO - 2015-11-22 09:14:39,693 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 09:14:39 INFO - 2015-11-22 09:14:39,694 DEBUG : BROWSER_OUTPUT: |7;RegExp;24853.658536585364 09:14:39 INFO - 2015-11-22 09:14:39,694 DEBUG : BROWSER_OUTPUT: |8;Splay;580.3830528148578 09:14:39 INFO - 2015-11-22 09:14:39,694 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 09:14:39 INFO - 2015-11-22 09:14:39,694 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:14:39 INFO - 2015-11-22 09:14:39,694 DEBUG : BROWSER_OUTPUT: __startTimestamp1448212479688__endTimestamp 09:14:39 INFO - 2015-11-22 09:14:39,695 DEBUG : BROWSER_OUTPUT: 09:14:39 INFO - 2015-11-22 09:14:39,695 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:14:39 INFO - 2015-11-22 09:14:39,695 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:14:39 INFO - 2015-11-22 09:14:39,695 DEBUG : BROWSER_OUTPUT: 09:14:39 INFO - 2015-11-22 09:14:39,695 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.11 Median:189.11 stddev:0.00 (0.0%) 09:14:39 INFO - 2015-11-22 09:14:39,696 DEBUG : BROWSER_OUTPUT: Values: 189.1 09:14:39 INFO - 2015-11-22 09:14:39,696 DEBUG : BROWSER_OUTPUT: 09:14:39 INFO - 2015-11-22 09:14:39,696 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.42 Median:193.42 stddev:0.00 (0.0%) 09:14:39 INFO - 2015-11-22 09:14:39,696 DEBUG : BROWSER_OUTPUT: Values: 193.4 09:14:39 INFO - 2015-11-22 09:14:39,696 DEBUG : BROWSER_OUTPUT: 09:14:39 INFO - 2015-11-22 09:14:39,696 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.53 Median:281.53 stddev:0.00 (0.0%) 09:14:39 INFO - 2015-11-22 09:14:39,696 DEBUG : BROWSER_OUTPUT: Values: 281.5 09:14:39 INFO - 2015-11-22 09:14:39,697 DEBUG : BROWSER_OUTPUT: 09:14:39 INFO - 2015-11-22 09:14:39,697 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5000.00 Median:5000.00 stddev:0.00 (0.0%) 09:14:39 INFO - 2015-11-22 09:14:39,697 DEBUG : BROWSER_OUTPUT: Values: 5000.0 09:14:39 INFO - 2015-11-22 09:14:39,697 DEBUG : BROWSER_OUTPUT: 09:14:39 INFO - 2015-11-22 09:14:39,697 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1060.45 Median:1060.45 stddev:0.00 (0.0%) 09:14:39 INFO - 2015-11-22 09:14:39,698 DEBUG : BROWSER_OUTPUT: Values: 1060.4 09:14:39 INFO - 2015-11-22 09:14:39,698 DEBUG : BROWSER_OUTPUT: 09:14:39 INFO - 2015-11-22 09:14:39,698 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:707.21 Median:707.21 stddev:0.00 (0.0%) 09:14:39 INFO - 2015-11-22 09:14:39,698 DEBUG : BROWSER_OUTPUT: Values: 707.2 09:14:39 INFO - 2015-11-22 09:14:39,698 DEBUG : BROWSER_OUTPUT: 09:14:39 INFO - 2015-11-22 09:14:39,698 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 09:14:39 INFO - 2015-11-22 09:14:39,699 DEBUG : BROWSER_OUTPUT: Values: 12120.5 09:14:39 INFO - 2015-11-22 09:14:39,699 DEBUG : BROWSER_OUTPUT: 09:14:39 INFO - 2015-11-22 09:14:39,699 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24853.66 Median:24853.66 stddev:0.00 (0.0%) 09:14:39 INFO - 2015-11-22 09:14:39,699 DEBUG : BROWSER_OUTPUT: Values: 24853.7 09:14:39 INFO - 2015-11-22 09:14:39,699 DEBUG : BROWSER_OUTPUT: 09:14:39 INFO - 2015-11-22 09:14:39,699 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:580.38 Median:580.38 stddev:0.00 (0.0%) 09:14:39 INFO - 2015-11-22 09:14:39,699 DEBUG : BROWSER_OUTPUT: Values: 580.4 09:14:39 INFO - 2015-11-22 09:14:39,699 DEBUG : BROWSER_OUTPUT: 09:14:39 INFO - 2015-11-22 09:14:39,700 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 09:14:39 INFO - 2015-11-22 09:14:39,700 DEBUG : BROWSER_OUTPUT: Values: 4840.6 09:14:39 INFO - 2015-11-22 09:14:39,700 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:14:39 INFO - 2015-11-22 09:14:39,700 DEBUG : BROWSER_OUTPUT: 09:14:40 INFO - 2015-11-22 09:14:40,572 INFO : Browser exited with error code: 0 09:14:40 INFO - 2015-11-22 09:14:40,589 INFO : Completed test v8_7 (00:00:39) 09:14:40 INFO - 2015-11-22 09:14:40,717 INFO : Completed test suite (00:20:08) 09:14:40 INFO - 2015-11-22 09:14:40,717 DEBUG : Working with test: dromaeo_css 09:14:40 INFO - 2015-11-22 09:14:40,717 DEBUG : Generating results file: dromaeo_css 09:14:40 INFO - 2015-11-22 09:14:40,718 DEBUG : Working with test: kraken 09:14:40 INFO - 2015-11-22 09:14:40,718 DEBUG : Generating results file: kraken 09:14:40 INFO - 2015-11-22 09:14:40,718 INFO : javascript benchmark 09:14:40 INFO - 2015-11-22 09:14:40,719 DEBUG : Working with test: v8_7 09:14:40 INFO - 2015-11-22 09:14:40,719 DEBUG : Generating results file: v8_7 09:14:40 INFO - 2015-11-22 09:14:40,719 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:14:40 INFO - 2015-11-22 09:14:40,771 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 09:14:40 INFO - 2015-11-22 09:14:40,771 DEBUG : process_Request line: dromaeo_css 6848.65 graph.html#tests=[[72,63,43]] 09:14:40 INFO - 2015-11-22 09:14:40,771 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:14:40 INFO - 2015-11-22 09:14:40,812 DEBUG : process_Request line: kraken 1518.30 graph.html#tests=[[232,63,43]] 09:14:40 INFO - 2015-11-22 09:14:40,812 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:14:40 INFO - 2015-11-22 09:14:40,844 DEBUG : process_Request line: v8_7 21280.88 graph.html#tests=[[230,63,43]] 09:14:40 INFO - 2015-11-22 09:14:40,845 INFO : javascript benchmark 09:14:40 INFO - 2015-11-22 09:14:40,848 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3244.399786039583, 3277.4100661880866, 3295.6704329567033, 3326.301476689895, 3333.3666603345364, 5260.605454590902, 5456.154296084108, 5479.835604931854, 5481.561475081994, 5483.972580137099, 5260.132078207101, 5393.7033463159605, 5395.325584301962, 5459.12653975364, 5473.644213126154, 4897.045076210149, 4909.263610458424, 4916.410030796309, 4965.3048573199785, 5020.472850350716, 5002.549770520653, 5027.145385284511, 5040.218766091261, 5091.338126043628, 5092.898142037157, 4860.0, 4877.829275975341, 4998.0, 5005.849824505271, 5021.974890125526, 4948.480409557017, 4953.9504604953845, 4954.603631709455, 4956.330895329121, 5020.874478138039, 4840.782164802592, 4949.109160351135, 4955.5044495550155, 4972.229304457815, 5027.4721154279005, 5191.506806853343, 5198.090334191501, 5222.294990176316, 5257.421683614838, 5277.788888444457, 5884.882302353929, 5913.231279933624, 5927.703614819242, 5930.851728706773, 5939.109133629947, 5771.653700777924, 5905.438983296623, 5965.433283838029, 5966.403359664042, 5972.581919265654, 5454.59090568205, 5527.364353099445, 5534.861628459281, 5556.083246264361, 5578.358488773762, 5994.400559944058, 5995.280566332068, 6024.246969128859, 6035.78874739382, 6039.78860739872, 5731.942680573141, 5853.356130825606, 5856.0630299151935, 5860.443257890493, 5880.529557635379, 5848.619839710405, 5916.349201587822, 5917.201177841022, 5937.614055086492, 5971.343152253248, 5836.6646496910025, 5844.736986835603, 5903.380145084704, 5911.231539899872, 5915.053591425351, 5728.799492017843, 5792.189093526909, 5834.5624078194305, 5882.911756323659, 5891.263592050994, 4573.0396616710195, 4577.908441831211, 4584.266517357207, 4610.515895830957, 4611.654125940568, 4061.6750659947725, 4064.065264989069, 4072.572379900127, 4075.694322925792, 4116.91766164675, 5441.047816632074, 5531.308586426697, 5543.251661025791, 5681.488666020078, 5687.459691329317, 5926.407359264125, 5944.405559444108, 5945.227120474397, 5945.346011938684, 5961.850953726105, 5578.24693666358, 5580.776768929279, 5624.184493248456, 5628.521575666115, 5628.549716022709, 5019.071471777733, 5085.0, 5150.0472412603785, 5171.4311425743135, 5215.348081489814, 6097.3292937776805, 6133.172021777003, 6142.324344322032, 6144.2319710036245, 6148.1085242639565, 5749.223854779551, 5934.347221805511, 5939.138824870283, 5947.613405128653, 5950.494207992369, 6021.638701677738, 6054.061620448661, 6098.3414614785315, 6112.74665817949, 6142.385761423822, 5734.0, 5822.155787410717, 5863.2670916135485, 5867.9413205867395, 5878.294604647299, 5766.163906233656, 5888.293404791452, 5936.614120082181, 5966.612170208922, 5966.731497082728, 5748.9425105748405, 5795.884082318415, 5810.128480727924, 5815.505682016907, 5852.122181672783, 5714.771409143587, 5742.626729262584, 5775.133729940542, 5791.102379131242, 5791.131330300489, 5466.207399926909, 5532.972335138298, 5582.692951887685, 5670.461306175906, 5691.601587888974, 5655.038643430709, 5672.886542269214, 5703.657780533182, 5731.283589551306, 5782.190493331022, 5696.772129114789, 5716.828495145152, 5735.283089613798, 5757.712114394348, 5780.277465316835], "unit": "ms", "name": "dojo.html", "value": 5428.677237912262}, {"lowerIsBetter": false, "replicates": [584.4272612839417, 590.4036922708066, 594.3076316091752, 610.3896103896104, 616.6269407008759, 37913.810430947844, 39280.0, 39391.60608393915, 39393.21213575727, 39470.21059578807, 41398.37902431466, 41943.370849437284, 41946.0, 41985.7900710496, 42050.57949420505, 8635.611397487097, 8840.38117331787, 8845.557722113901, 8849.513276769776, 8856.911430885673, 8619.224269815715, 8634.050254472035, 8648.394612377137, 8675.95662021689, 8680.08859069798, 8704.129587041278, 8719.128087191293, 8761.693340733076, 8769.736907892773, 8794.912050879506, 8570.100139485357, 8734.170253825876, 8763.167499087609, 8768.386212965095, 8780.868286975636, 8580.099089595627, 8727.432716873383, 8750.86873696895, 8762.036176020696, 8763.0, 37512.437313440045, 37994.81002594997, 38043.8097809512, 38171.23657526834, 38215.0, 3261.4052116777234, 3388.542546756206, 3396.9490457643155, 3401.897943061712, 3485.7734247273847, 28679.56980645292, 28928.0, 29308.12075637713, 29492.41015179706, 29942.55086173709, 3918.255531449044, 3927.9214415711526, 4031.1333063391216, 4098.938515922264, 4111.5477297497255, 254963.0, 256271.0, 256625.0, 257342.0, 257407.0, 55460.72269638626, 55654.72172639111, 55753.163702544494, 55938.0, 56034.439655602924, 58305.70847145737, 58415.415845840995, 58743.706281468316, 59104.40895591075, 59219.0, 14968.550943471713, 15371.231438428034, 15401.537953861402, 15403.383864645513, 15414.460493882885, 11811.586594469152, 11823.586174484024, 11854.348010859314, 11864.584739534075, 11870.940645296718, 18692.61555363725, 19174.0, 19274.903625481784, 19288.324908628132, 19497.8050219496, 7628.504147230412, 7858.489198202098, 7885.1326354101, 7908.960455197687, 7967.760967170994, 894.141624040915, 938.6104766521953, 977.4233202410612, 980.5048450532578, 1072.6889202131451, 27830.3042423941, 28184.85907570449, 28260.71739282581, 28367.43265134686, 28434.71565284362, 1002.4486532407146, 1047.706642140202, 1054.4674939155677, 1063.2663462211049, 1124.3197865291545, 13969.650758731113, 13978.370973306226, 14163.0, 14176.220307882959, 14306.57080287593, 325633.0, 332742.0, 332745.0, 333991.0, 334016.0, 48988.510114898396, 49082.75458622684, 49447.50552494429, 49627.25559116616, 49789.50210497921, 1295.591888555102, 1311.2853494845333, 1327.4424741608548, 1359.3271330691173, 1359.802828589849, 25966.870165649052, 26382.604260935717, 26820.59769103426, 26973.3256668577, 27213.455730885667, 43406.34890476582, 43439.56560434355, 43511.12977740491, 43702.344464832415, 43801.0, 300555.0, 305199.0, 305283.0, 305516.0, 305755.0, 30340.84829575838, 30588.0, 30743.2314192147, 30748.385032299677, 30835.69164308418, 42869.57130428656, 43103.568964309954, 44141.0, 44182.55817441784, 44262.33606495841, 33010.83494582512, 33343.46005010308, 35784.284314314085, 35862.46206306855, 36412.81793591015, 34697.306053878274, 35178.0, 35619.0, 35877.82061089678, 36187.81906090453, 35333.29333413266, 35336.64663353334, 35659.10852228715, 36278.0, 36435.81782091073, 28771.0, 29220.123396298146, 31181.53227701632, 32630.184245394055, 33056.83471582627, 24673.0, 24757.752422476264, 24871.502569948138, 25012.858990556873, 25140.874295628404], "unit": "ms", "name": "ext.html", "value": 18244.15590425187}, {"lowerIsBetter": false, "replicates": [355.56265793074516, 355.87010741079513, 357.69953239279, 358.9066842620919, 361.4776647744009, 16309.510714678563, 16854.91572542137, 17439.389621363254, 17740.645187096266, 18209.0, 10572.04851563359, 11313.604023859167, 16251.268692908818, 16379.508614741577, 16447.342106315733, 4656.906861862769, 5324.840254792343, 5328.786848526054, 5342.866428339303, 5360.597955153359, 5245.527902488775, 5295.417504074549, 5300.310959575249, 5306.124489459235, 5318.042752304584, 4762.547557981986, 5003.349564556603, 5033.295338652573, 5169.948300516984, 5195.844124676266, 5138.7687554059785, 5148.330717006803, 5162.045021671003, 5164.380274367081, 5195.9480405195845, 5179.249008893727, 5196.818111366084, 5200.505951934598, 5202.869928251786, 5205.0, 12543.372831358396, 12544.310062946533, 12562.560310389092, 15356.539303820791, 19346.709799353022, 1987.5627361980341, 2086.0821238654944, 2142.1645558232303, 2252.819774418059, 2319.1651005637955, 9292.0, 9447.291453141042, 10596.894031059745, 10984.395858227794, 13466.057375983684, 1722.509084910807, 1763.9911800441043, 1794.318159099534, 1810.7012342963396, 1814.6915024445875, 55711.72144139253, 56376.154357685075, 56449.0, 59148.0, 63762.0, 9779.266555008402, 10018.3488073275, 10052.447115408722, 10071.14395276395, 10107.241956853119, 12920.612381628565, 12947.870521294855, 13007.154534955198, 13023.47906083746, 13068.281244531641, 7584.469087163846, 7677.347425468786, 7718.691252349955, 7725.652345644347, 7751.992241008633, 7376.704931802775, 7377.3360397564475, 7439.851202976019, 7441.665125069385, 7467.887981680279, 4215.6205941464805, 4251.277282861921, 4383.561643835591, 4417.536158703354, 4440.3561483585345, 1818.4362847517311, 1855.044652004219, 1855.4248183063294, 1875.1468082022648, 1876.9301498145926, 386.43580372655674, 393.4314914947873, 397.5428257503836, 398.8683734367652, 402.70200051961336, 10262.589496420209, 10479.476026198812, 10490.737731556772, 10540.578376864993, 10630.521626526825, 409.51472505081574, 419.92231437184216, 422.5858658514673, 422.8752518007195, 423.56796068011073, 5710.885782284414, 5786.623869448473, 5830.679312637845, 5861.472467477947, 5874.823755287348, 539443.0, 551897.0, 552837.0, 556998.0, 577714.0, 77066.0, 78056.0, 80592.0, 81716.59141704372, 84816.99999999876, 424.898024474124, 430.9806058727365, 432.08398195825055, 432.54366643191736, 433.22452809470695, 9867.605295788087, 10209.285350025724, 10234.488275586042, 14855.108693478425, 16174.838251617804, 36452.81773591115, 36566.81716591506, 36760.44859327059, 36856.63143368532, 37476.62523374731, 45211.0, 45481.54518454905, 46013.769931151466, 46873.296900547204, 46877.531224687315, 8390.909181806326, 8773.166549177819, 8797.648094076165, 8799.736007919773, 9077.863832042392, 10241.897581024094, 10294.0, 11966.750705174678, 16784.832151678325, 17076.23156957915, 13902.443902243796, 13943.233122178377, 14352.784708229176, 14482.275886205858, 14538.0, 14097.506587269396, 14099.718005639625, 14103.2948352584, 14139.505117320845, 14626.902982276584, 15039.774403384177, 15274.312655930287, 15332.770008450105, 15399.230038497806, 15641.608959775642, 8764.91235087641, 9016.819663606822, 9194.770130746785, 9198.540072996457, 9273.953630231807, 9768.267379946674, 13006.80489792635, 14223.715525689222, 14565.563033109023, 14629.195394253418], "unit": "ms", "name": "jquery.html", "value": 7784.665306057538}, {"lowerIsBetter": false, "replicates": [1518.4913054126866, 1694.2291257477848, 1746.755454236407, 1761.621251430942, 1775.289884046382, 7062.611556364404, 7218.891716624248, 7271.672774725137, 7494.250574942503, 7623.428242881779, 7484.251574842513, 7512.549247045181, 7540.849183016337, 7559.206283340239, 7589.506682065662, 2232.151782322715, 2247.2359397804744, 2261.050358849279, 2265.0373591223747, 2266.9433264168365, 2242.091952759127, 2262.1856131792542, 2283.212291759349, 2283.9885800570974, 2285.7714228577174, 2163.1131236193164, 2222.744384395799, 2223.344113486525, 2223.9332820015343, 2248.4940888300166, 2231.141010710888, 2239.1715065425733, 2277.2257432472875, 2279.623862062758, 2283.6346184610466, 2242.237639202679, 2272.9659055114184, 2274.0, 2275.1354485295483, 2283.828712846543, 7401.814954626124, 7518.473706840468, 7536.095668519758, 7536.5101268417375, 7555.055618047744, 4504.0, 4532.161550113206, 4598.632109431271, 4607.470140933769, 4610.561996610317, 2877.985610071957, 2968.302448924501, 2972.093511478998, 2979.508381117113, 2987.4622567937763, 1008.6469735592557, 1010.2170817616333, 1018.4551265073151, 1045.8169820281496, 1060.151878497199, 9777.217822574248, 9816.509174541316, 9884.456354900478, 9893.258005649534, 9931.503424828801, 3921.1569512554365, 3979.3235150024566, 4021.095253567924, 4041.2927737645796, 4052.452918855976, 8038.236367545074, 8099.028116626043, 8115.959420202861, 8133.471324363897, 8139.79650508742, 4544.6818722689095, 4545.568171023748, 4548.067646132535, 4552.88617784558, 4554.544545545419, 4181.6236538711055, 4189.308764053958, 4192.972721683207, 4207.768572728468, 4232.851850185229, 3411.3177364527196, 3413.061408112739, 3420.0765793236183, 3420.931581368359, 3444.293919746446, 1058.5924419098549, 1070.1331921143899, 1070.4808168038496, 1076.8546246256656, 1094.108301734084, 948.2603569216022, 960.4669408478222, 1083.926912356761, 1142.308903113621, 1320.1353113710536, 6555.80332590023, 6556.049372840911, 6596.241432235354, 6610.504212184105, 6612.471002319803, 571.6198727845936, 577.6043410263983, 584.5528170949227, 589.3399392680226, 727.3381223086966, 5087.567556757717, 5181.792728290901, 5220.92168617471, 5225.007248622749, 5251.081060814342, 8525.65897364111, 8629.482231066157, 8677.088905664941, 8684.522351270742, 8827.955860220658, 8508.829823403497, 8550.358723095793, 8584.828303434022, 8614.913850861536, 8644.481331120152, 6973.93026069743, 7018.859622807618, 7089.7873063808165, 7092.645367731696, 7139.178994415709, 6731.1922569292, 6740.427063699444, 6790.388865002174, 6803.047573339835, 6805.625690587065, 7668.424868135024, 7812.804679883048, 7834.4907581007055, 7854.1753115922, 7875.921240787518, 8028.959855200686, 8051.074126475531, 8129.105798362294, 8195.83608327842, 8276.420650554644, 6651.401373876374, 6670.166229221348, 6731.596104233761, 6739.865202695821, 6780.627065511247, 7233.348998590152, 7255.383292420203, 7317.231690672403, 7328.120625524971, 7328.34044935937, 6430.7749228776765, 6799.11611490503, 6813.488988325995, 6825.0, 6978.581285122909, 5587.916181257203, 6308.369163083655, 6765.8985115224295, 6854.691538880663, 6858.691358888762, 6441.516886233458, 6456.903146452901, 6695.196576410862, 6796.388325050769, 6823.522353435212, 6313.08460273267, 6313.652749098844, 6326.272478664829, 6349.269833968968, 6349.396807303298, 5907.113932910098, 5931.970340148272, 5966.224390829338, 5983.282006159288, 6015.157877897011], "unit": "ms", "name": "mootools.html", "value": 4231.128844791597}, {"lowerIsBetter": false, "replicates": [303.78431313767226, 312.40175064750997, 313.0046452281743, 313.42799391111214, 317.7791434952709, 6322.367763223675, 6339.683015849207, 6360.713767880445, 6390.0, 6469.773557925473, 6186.783462578811, 6196.101565273033, 6235.844103897405, 6252.812415627527, 6264.84337891553, 4740.051989602076, 4763.595094416962, 4765.880852978668, 4768.809247630099, 4774.1645212087915, 4717.504662010491, 4735.573798358147, 4745.050989802036, 4746.501617330183, 4748.620110391178, 4639.072185562884, 4698.177818881699, 4712.976435117836, 4715.976420117895, 4731.219348807443, 4684.953150468486, 4686.742229177394, 4705.223638099709, 4720.055988802219, 4720.504347043546, 4034.616711412411, 4045.656119229869, 4046.919061618751, 4049.5950404959563, 4054.736442131252, 5931.673757943311, 5953.3451320354725, 5964.7315870785915, 5992.0, 6011.57918945674, 5390.595705322116, 5469.042917489423, 5469.288992430958, 5482.2873026506695, 5483.204935284361, 6645.368689974444, 6652.667366631649, 6655.633940133291, 6665.4001139897155, 6668.166479190101, 4481.103779244164, 4488.438945131858, 4493.056458143794, 4505.0, 4508.458984921797, 6788.966055169742, 6851.862962740767, 6878.38094571491, 6895.241523432418, 6925.688344024531, 4418.0, 4431.047324825178, 4432.601065904019, 4442.400275962704, 4443.777811109431, 4436.378906953029, 4471.105778844244, 4473.485549161888, 4490.416245888014, 4506.188886000486, 5313.256144139824, 5322.4411436799355, 5325.121354976385, 5341.985022845647, 5343.385510666245, 6581.210254769362, 6674.899876501856, 6711.395974362331, 6714.422110803957, 6724.697388617426, 1552.3790483806567, 1578.5737850780224, 1585.2311628859993, 1593.3148746039315, 1596.3534768418808, 1037.056278786301, 1038.6416686243233, 1043.2175868098925, 1055.9313644613076, 1057.180684969155, 6363.172787537591, 6394.552381333262, 6396.42432181106, 6398.712057957403, 6424.743010279536, 6755.3582409671, 6773.288804675537, 6836.93163068363, 6846.383825455633, 6855.485838562127, 6231.2522497300615, 6375.171227740364, 6377.457916077093, 6384.106225128486, 6391.936080639227, 3706.29580379727, 3712.832922518493, 3725.832337544817, 3730.973982154929, 3732.664060234592, 7114.857702845914, 7132.930060490968, 7147.1780745214965, 7149.14210294768, 7151.177614574391, 6947.305269473012, 7023.613701246379, 7024.192217894905, 7025.156981162293, 7032.367086962198, 7317.304856038668, 7333.339999400079, 7337.779866604011, 7346.449016323797, 7353.963230183922, 6905.343992320722, 6989.056477375692, 6990.860182796418, 6996.720131194696, 7021.929780702128, 6801.2178599461695, 6923.688434020381, 6941.548799328028, 6952.478564107611, 6955.547889387173, 7277.9272207277245, 7301.52540084914, 7312.634368281459, 7340.11918569775, 7352.301531354513, 4577.588017078346, 4578.793954272132, 4589.151007063704, 4599.494055653942, 4607.44710634726, 6832.385085342343, 6940.757073502403, 6948.444124470131, 6950.652467376712, 6952.374286314256, 6712.765053223114, 6716.1940567130305, 6718.966405167943, 6735.730570777114, 6789.490788190807, 6712.53012289135, 6753.898691519729, 6762.797116086525, 6768.695408706521, 6773.254941956282, 6517.674116294261, 6611.173603299588, 6651.933480665131, 6659.334066593302, 6665.900011499734, 6769.559978601375, 6815.659217039228, 6820.07928929608, 6826.2832402599, 6826.351496607815, 6624.138861947916, 6630.171228596426, 6644.069830223676, 6645.634490103091, 6660.0675905374255], "unit": "ms", "name": "prototype.html", "value": 4965.876477807817}, {"lowerIsBetter": false, "replicates": [746.5371469688794, 775.3215936055951, 786.1980779604806, 796.9163237860024, 847.2163248994686, 13058.477660893564, 13268.270245136513, 13289.800652990212, 13337.933310333434, 13343.199408035513, 13236.272005039718, 13305.06864519484, 13320.40058197381, 13361.732765344686, 13377.665558361046, 812.6424373275769, 824.1799409587439, 835.6615570693879, 840.8276303357796, 840.8822764812932, 834.3825569078869, 837.7109897085496, 840.756180707594, 841.3353450773882, 844.1727107434687, 861.0571424290423, 862.7756783236372, 868.3530769576674, 869.0223498564116, 871.6295574380895, 860.1914200651399, 864.2437866866492, 864.5590748718137, 865.1953683074738, 869.6738722978914, 626.76183050441, 631.1038325577691, 632.8892443822313, 633.5470138850698, 637.9011253255707, 13656.112352697042, 13699.45202191911, 13787.793183102262, 13792.586222413243, 13824.101433406797, 11711.824322635168, 11790.646280611596, 12002.339871307075, 12023.545113193843, 12032.939835300767, 10284.228682848816, 10524.78950420995, 10566.577336906514, 10785.352878827296, 10805.945970270099, 3640.7087433005295, 3710.870119545803, 3740.1023754299044, 3799.145192331731, 3839.596842331543, 43155.56844431578, 43636.0, 43684.56315436837, 43723.78138109289, 43954.56045439537, 9365.906340936639, 9985.850212246822, 10020.99580083986, 10215.13171380441, 10547.367157970546, 17790.0, 17896.9105154476, 17967.73048404275, 17992.640147197246, 18004.729929051075, 7811.726589569338, 7839.412044096715, 7889.605519723991, 7918.564478953713, 8083.393745468996, 4513.842015529506, 4515.503294637587, 4517.344984977226, 4575.405197324327, 4606.792694328763, 2957.157210195084, 2957.955630665542, 2969.8960536381123, 2995.790294679395, 3003.609530761031, 538.2572050570188, 545.1686178577701, 545.2557259340971, 553.3498139685853, 560.9635373700696, 626.0, 666.4568376773011, 674.7233634210048, 679.2121139478181, 682.952193346461, 8454.0, 8534.914650853536, 8660.78348041304, 8667.609957551926, 8863.734087977371, 493.1542404775827, 629.5624540944092, 667.4960404894274, 667.7295695243434, 694.5381321421299, 3888.0862997195636, 4062.126642771759, 4237.936430953539, 4281.464816897887, 4500.234960056799, 58018.709906450196, 58877.0, 58899.70550147307, 58980.7050964751, 60324.69837650783, 50660.493395065576, 51330.74334628303, 52919.735401322745, 53141.73429132907, 53861.46138538564, 47348.28977565339, 47535.811604709466, 47948.28077578839, 48180.5181948183, 48272.51727482751, 8549.743507694779, 8662.393632445668, 8728.258098061737, 8825.867611985954, 9067.0, 34745.826270868485, 34894.0, 35379.0, 35549.64450355567, 35730.821345893106, 43208.135837283706, 46629.0, 46751.0, 46993.53006469891, 47553.0, 10765.246432749633, 11266.94366528162, 11460.312381257152, 11661.0, 11724.355160466257, 11599.6520104397, 11720.120990925545, 11959.820602691141, 12123.151379403356, 12145.939270303592, 11468.541258349906, 11480.024197943269, 11504.482298296429, 11761.588344407905, 12140.15018948665, 11703.648890533297, 11731.183542984101, 11749.823752643888, 11968.700782480508, 12268.754624907631, 11048.337099773718, 11141.498632561392, 11342.319460832376, 11375.20373573842, 11671.708207294885, 9519.76200594963, 9531.952340238255, 9764.755881103029, 9906.900930990598, 9945.651902183388, 9056.139666731913, 9369.297302702189, 9702.175315098013, 9744.220462362851, 9791.608335666779], "unit": "ms", "name": "yui.html", "value": 6369.161669340872}], "name": "dromaeo_css", "value": 6848.649300727506}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 111.0, 111.0, 113.0, 121.0, 112.0, 111.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [157.0, 123.0, 146.0, 158.0, 129.0, 146.0, 150.0, 128.0, 166.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.8}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 159.0, 162.0, 162.0, 161.0, 161.0, 164.0, 169.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 74.0, 71.0, 71.0, 142.0, 74.0, 72.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 141.0, 92.0, 92.0, 94.0, 132.0, 92.0, 92.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 105.3}, {"lowerIsBetter": true, "replicates": [109.0, 113.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 149.0, 146.0, 148.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 97.0, 98.0, 97.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 63.0, 62.0, 62.0, 63.0, 62.0, 59.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 62.1}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 70.0, 69.0, 78.0, 68.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.1}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 85.0, 87.0, 86.0, 85.0, 89.0, 86.0, 87.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [119.0, 122.0, 131.0, 111.0, 122.0, 137.0, 122.0, 127.0, 141.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.8}, {"lowerIsBetter": true, "replicates": [153.0, 153.0, 150.0, 150.0, 149.0, 145.0, 155.0, 157.0, 150.0, 155.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.7}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 69.0, 67.0, 68.0, 76.0, 68.0, 69.0, 66.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1518.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [189.10741301059002], "unit": "score", "name": "Richards", "value": 186.676976}, {"lowerIsBetter": false, "replicates": [193.42359767891682], "unit": "score", "name": "DeltaBlue", "value": 341.83006}, {"lowerIsBetter": false, "replicates": [281.5315315315315], "unit": "score", "name": "Encrypt", "value": 945.4749119999998}, {"lowerIsBetter": false, "replicates": [5000.0], "unit": "score", "name": "Decrypt", "value": 53.23619999999997}, {"lowerIsBetter": false, "replicates": [1060.4453870625662], "unit": "score", "name": "RayTrace", "value": 697.809627}, {"lowerIsBetter": false, "replicates": [707.2135785007072], "unit": "score", "name": "Earley", "value": 942.3786820000003}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [24853.658536585364], "unit": "score", "name": "RegExp", "value": 36.65395976447495}, {"lowerIsBetter": false, "replicates": [580.3830528148578], "unit": "score", "name": "Splay", "value": 140.40899300000004}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21280.87669932215}]} 09:14:40 INFO - RETURN: dromaeo_css: 6848.65 09:14:40 INFO - RETURN: kraken: 1518.30 09:14:40 INFO - RETURN: v8_7: 21280.88 09:14:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21280.88"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1518.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6848.65"}}} 09:14:40 INFO - Return code: 0 09:14:40 INFO - # TBPL SUCCESS # 09:14:40 INFO - Running post-action listener: _resource_record_post_action 09:14:40 INFO - Running post-run listener: _resource_record_post_run 09:14:41 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 24576; Write bytes: 509489152; Read time: 108; Write time: 380212 09:14:41 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 171028480; Read time: 0; Write time: 160456 09:14:42 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 24576; Write bytes: 283705344; Read time: 108; Write time: 133412 09:14:42 INFO - Running post-run listener: _upload_blobber_files 09:14:42 INFO - Blob upload gear active. 09:14:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:14:42 INFO - Copying logs to upload dir... 09:14:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.563625 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-22 09:14:41.489989) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-22 09:14:41.493334) ========= 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=919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010095 build_url: 'https://queue.taskcluster.net/v1/task/cMagpsvDThCzwHuIzJtoZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-22 09:14:41.543902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 09:14:41.544294) ========= 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=919420d7ee4ef147bef0346300000385-1448208997.477569-1123162996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004629 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 09:14:41.593738) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-22 09:14:41.594049) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-22 09:14:41.594404) ========= ========= Total master_lag: 0.33 =========