builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1448031325.47 results: success (0) buildid: 20151120043002 builduid: 24682f083fc94014a6d1965e450e1312 revision: ec628289d8b4ed310463a0729c3e60a7798dfcac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:25.466568) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:25.466993) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:25.467304) ========= 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=d6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006769 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:25.487954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:25.488266) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:25.501322) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:25.501634) ========= 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=d6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004619 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:25.551103) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:25.551411) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:25.551778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:25.552062) ========= 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=d6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 06:55:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.4M=0s 2015-11-20 06:55:25 (40.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185582 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:25.749236) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:25.749529) ========= 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=d6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019444 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:25.798927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 06:55:25.799279) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ec628289d8b4ed310463a0729c3e60a7798dfcac --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ec628289d8b4ed310463a0729c3e60a7798dfcac --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=d6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 06:55:26,032 truncating revision to first 12 chars 2015-11-20 06:55:26,032 Setting DEBUG logging. 2015-11-20 06:55:26,032 attempt 1/10 2015-11-20 06:55:26,032 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ec628289d8b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 06:55:27,354 unpacking tar archive at: mozilla-central-ec628289d8b4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.611762 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 06:55:27.424197) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:27.424556) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:27.434521) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:27.434806) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 06:55:27.435249) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-20 06:55:27.435570) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:55:27 INFO - MultiFileLogger online at 20151120 06:55:27 in /builds/slave/test-pgo 06:55:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:55:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:55:27 INFO - {'append_to_log': False, 06:55:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:55:27 INFO - 'blob_upload_branch': 'Firefox', 06:55:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:55:27 INFO - 'branch': 'Firefox', 06:55:27 INFO - 'buildbot_json_path': 'buildprops.json', 06:55:27 INFO - 'config_files': ('talos/linux_config.py',), 06:55:27 INFO - 'default_actions': ('clobber', 06:55:27 INFO - 'read-buildbot-config', 06:55:27 INFO - 'download-and-extract', 06:55:27 INFO - 'populate-webroot', 06:55:27 INFO - 'create-virtualenv', 06:55:27 INFO - 'install', 06:55:27 INFO - 'run-tests'), 06:55:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:55:27 INFO - 'download_minidump_stackwalk': True, 06:55:27 INFO - 'download_symbols': 'ondemand', 06:55:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:55:27 INFO - 'tooltool.py': '/tools/tooltool.py', 06:55:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:55:27 INFO - '/tools/misc-python/virtualenv.py')}, 06:55:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:55:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:55:27 INFO - 'installer_path': 'installer.exe', 06:55:27 INFO - 'log_level': 'info', 06:55:27 INFO - 'log_name': 'talos', 06:55:27 INFO - 'log_to_console': True, 06:55:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:55:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:55:27 INFO - 'opt_config_files': (), 06:55:27 INFO - 'pip_index': False, 06:55:27 INFO - 'sps_profile': False, 06:55:27 INFO - 'sps_profile_interval': 0, 06:55:27 INFO - 'suite': 'dromaeojs', 06:55:27 INFO - 'system_bits': '64', 06:55:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:55:27 INFO - 'title': 'talos-linux64-ix-016', 06:55:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:55:27 INFO - 'use_talos_json': True, 06:55:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:55:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:55:27 INFO - 'work_dir': 'build'} 06:55:27 INFO - ##### 06:55:27 INFO - ##### Running clobber step. 06:55:27 INFO - ##### 06:55:27 INFO - Running pre-action listener: _resource_record_pre_action 06:55:27 INFO - Running main action method: clobber 06:55:27 INFO - rmtree: /builds/slave/test-pgo/build 06:55:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:55:28 INFO - Running post-action listener: _resource_record_post_action 06:55:28 INFO - ##### 06:55:28 INFO - ##### Running read-buildbot-config step. 06:55:28 INFO - ##### 06:55:28 INFO - Running pre-action listener: _resource_record_pre_action 06:55:28 INFO - Running main action method: read_buildbot_config 06:55:28 INFO - Using buildbot properties: 06:55:28 INFO - { 06:55:28 INFO - "properties": { 06:55:28 INFO - "buildnumber": 571, 06:55:28 INFO - "product": "firefox", 06:55:28 INFO - "script_repo_revision": "production", 06:55:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:55:28 INFO - "repository": "", 06:55:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:55:28 INFO - "buildid": "20151120043002", 06:55:28 INFO - "slavename": "talos-linux64-ix-016", 06:55:28 INFO - "pgo_build": "True", 06:55:28 INFO - "basedir": "/builds/slave/test-pgo", 06:55:28 INFO - "project": "", 06:55:28 INFO - "platform": "ubuntu64_hw", 06:55:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:55:28 INFO - "slavebuilddir": "test", 06:55:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:55:28 INFO - "branch": "mozilla-central", 06:55:28 INFO - "repo_path": "mozilla-central", 06:55:28 INFO - "stage_platform": "linux64-pgo", 06:55:28 INFO - "builduid": "24682f083fc94014a6d1965e450e1312", 06:55:28 INFO - "revision": "ec628289d8b4ed310463a0729c3e60a7798dfcac" 06:55:28 INFO - }, 06:55:28 INFO - "sourcestamp": { 06:55:28 INFO - "repository": "", 06:55:28 INFO - "hasPatch": false, 06:55:28 INFO - "project": "", 06:55:28 INFO - "branch": "mozilla-central-linux64-pgo-talos", 06:55:28 INFO - "changes": [ 06:55:28 INFO - { 06:55:28 INFO - "category": null, 06:55:28 INFO - "files": [ 06:55:28 INFO - { 06:55:28 INFO - "url": null, 06:55:28 INFO - "name": "https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:55:28 INFO - } 06:55:28 INFO - ], 06:55:28 INFO - "repository": "", 06:55:28 INFO - "rev": "ec628289d8b4ed310463a0729c3e60a7798dfcac", 06:55:28 INFO - "who": "sendchange", 06:55:28 INFO - "when": 1448031271, 06:55:28 INFO - "number": 6688676, 06:55:28 INFO - "comments": "", 06:55:28 INFO - "project": "", 06:55:28 INFO - "at": "Fri 20 Nov 2015 06:54:31", 06:55:28 INFO - "branch": "mozilla-central-linux64-pgo-talos", 06:55:28 INFO - "revlink": "", 06:55:28 INFO - "properties": [ 06:55:28 INFO - [ 06:55:28 INFO - "buildid", 06:55:28 INFO - "20151120043002", 06:55:28 INFO - "Change" 06:55:28 INFO - ], 06:55:28 INFO - [ 06:55:28 INFO - "builduid", 06:55:28 INFO - "24682f083fc94014a6d1965e450e1312", 06:55:28 INFO - "Change" 06:55:28 INFO - ], 06:55:28 INFO - [ 06:55:28 INFO - "pgo_build", 06:55:28 INFO - "True", 06:55:28 INFO - "Change" 06:55:28 INFO - ] 06:55:28 INFO - ], 06:55:28 INFO - "revision": "ec628289d8b4ed310463a0729c3e60a7798dfcac" 06:55:28 INFO - } 06:55:28 INFO - ], 06:55:28 INFO - "revision": "ec628289d8b4ed310463a0729c3e60a7798dfcac" 06:55:28 INFO - } 06:55:28 INFO - } 06:55:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:55:28 INFO - Running post-action listener: _resource_record_post_action 06:55:28 INFO - ##### 06:55:28 INFO - ##### Running download-and-extract step. 06:55:28 INFO - ##### 06:55:28 INFO - Running pre-action listener: _resource_record_pre_action 06:55:28 INFO - Running main action method: download_and_extract 06:55:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:28 INFO - https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:55:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/test_packages.json 06:55:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/test_packages.json 06:55:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:55:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:55:28 INFO - Downloaded 1302 bytes. 06:55:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:55:28 INFO - Using the following test package requirements: 06:55:28 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:55:28 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:55:28 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:28 INFO - u'jsshell-linux-x86_64.zip'], 06:55:28 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:55:28 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:55:28 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:55:28 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:55:28 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:55:28 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:55:28 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:55:28 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:28 INFO - https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:55:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:55:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:55:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 06:55:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 06:55:29 INFO - Downloaded 22524710 bytes. 06:55:29 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 06:55:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:55:29 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 06:55:30 INFO - Return code: 0 06:55:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:30 INFO - https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:55:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:55:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:55:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 06:55:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 06:55:34 INFO - Downloaded 22524710 bytes. 06:55:34 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 06:55:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:55:34 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 06:55:35 INFO - Return code: 0 06:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:35 INFO - https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:55:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:55:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:55:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 06:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 06:55:37 INFO - Downloaded 11130997 bytes. 06:55:37 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 06:55:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:55:37 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 06:55:37 INFO - Return code: 0 06:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:37 INFO - https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:55:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:55:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:55:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 06:55:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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 06:55:39 INFO - Downloaded 57353019 bytes. 06:55:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:55:39 INFO - mkdir: /builds/slave/test-pgo/properties 06:55:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:55:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:55:39 INFO - Contents: 06:55:39 INFO - build_url:https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:55:39 INFO - Running post-action listener: _resource_record_post_action 06:55:39 INFO - Running post-action listener: set_extra_try_arguments 06:55:39 INFO - ##### 06:55:39 INFO - ##### Running populate-webroot step. 06:55:39 INFO - ##### 06:55:39 INFO - Running pre-action listener: _resource_record_pre_action 06:55:39 INFO - Running main action method: populate_webroot 06:55:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:55:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:55:39 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:55:39 INFO - '../fennec_ids.txt'], 06:55:39 INFO - 'tests': ['tcheck2']}, 06:55:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:55:39 INFO - '--tppagecycles', 06:55:39 INFO - '7'], 06:55:39 INFO - 'tests': ['tsvgm']}}, 06:55:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:55:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:55:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:55:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:55:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:55:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:55:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:39 INFO - 'talos_options': ['--e10s'], 06:55:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:39 INFO - 'tests': ['damp', 'tps']}, 06:55:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:39 INFO - 'talos_options': ['--e10s'], 06:55:39 INFO - 'tests': ['damp', 'tps']}, 06:55:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:55:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:55:39 INFO - 'other': {'tests': ['a11yr', 06:55:39 INFO - 'ts_paint', 06:55:39 INFO - 'tpaint', 06:55:39 INFO - 'sessionrestore', 06:55:39 INFO - 'sessionrestore_no_auto_restore']}, 06:55:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:55:39 INFO - 'tests': ['a11yr', 06:55:39 INFO - 'ts_paint', 06:55:39 INFO - 'tpaint', 06:55:39 INFO - 'sessionrestore', 06:55:39 INFO - 'sessionrestore_no_auto_restore']}, 06:55:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:55:39 INFO - 'tests': ['a11yr', 06:55:39 INFO - 'ts_paint', 06:55:39 INFO - 'tpaint', 06:55:39 INFO - 'sessionrestore', 06:55:39 INFO - 'sessionrestore_no_auto_restore']}, 06:55:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:55:39 INFO - 'tests': ['a11yr', 06:55:39 INFO - 'ts_paint', 06:55:39 INFO - 'tpaint', 06:55:39 INFO - 'sessionrestore', 06:55:39 INFO - 'sessionrestore_no_auto_restore']}, 06:55:39 INFO - 'other_l64': {'tests': ['a11yr', 06:55:39 INFO - 'ts_paint', 06:55:39 INFO - 'tpaint', 06:55:39 INFO - 'sessionrestore', 06:55:39 INFO - 'sessionrestore_no_auto_restore']}, 06:55:39 INFO - 'other_nol64': {'tests': ['a11yr', 06:55:39 INFO - 'ts_paint', 06:55:39 INFO - 'tpaint', 06:55:39 INFO - 'sessionrestore', 06:55:39 INFO - 'sessionrestore_no_auto_restore']}, 06:55:39 INFO - 'svgr': {'tests': ['tsvgx', 06:55:39 INFO - 'tsvgr_opacity', 06:55:39 INFO - 'tart', 06:55:39 INFO - 'tscrollx', 06:55:39 INFO - 'cart']}, 06:55:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:55:39 INFO - 'tests': ['tsvgx', 06:55:39 INFO - 'tsvgr_opacity', 06:55:39 INFO - 'tart', 06:55:39 INFO - 'tscrollx', 06:55:39 INFO - 'cart']}, 06:55:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:39 INFO - 'tests': ['tp5o']}, 06:55:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:39 INFO - 'talos_options': ['--e10s'], 06:55:39 INFO - 'tests': ['tp5o']}, 06:55:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:39 INFO - 'talos_options': ['--xperf_path', 06:55:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:39 INFO - 'tests': ['tp5n']}, 06:55:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:39 INFO - 'talos_options': ['--e10s', 06:55:39 INFO - '--xperf_path', 06:55:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:39 INFO - 'tests': ['tp5n']}}, 06:55:39 INFO - 'talos.zip': {'path': '', 06:55:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:55:39 INFO - Running post-action listener: _resource_record_post_action 06:55:39 INFO - ##### 06:55:39 INFO - ##### Running create-virtualenv step. 06:55:39 INFO - ##### 06:55:39 INFO - Running pre-action listener: _resource_record_pre_action 06:55:39 INFO - Running main action method: create_virtualenv 06:55:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:55:39 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 06:55:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:55:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:55:39 INFO - Using real prefix '/usr' 06:55:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:55:39 INFO - Installing distribute.............................................................................................................................................................................................done. 06:55:41 INFO - Installing pip.................done. 06:55:41 INFO - Return code: 0 06:55:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:41 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 0x7f1a2155cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23836e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a90>, '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 0x240bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c2e0>, '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': 'd6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279', '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 06:55:41 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 06:55:41 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 06:55:41 INFO - Using env: {'DISPLAY': ':0', 06:55:41 INFO - 'HOME': '/home/cltbld', 06:55:41 INFO - 'LANG': 'en_US.UTF-8', 06:55:41 INFO - 'LANGUAGE': 'en_US:en', 06:55:41 INFO - 'LOGNAME': 'cltbld', 06:55:41 INFO - 'MAIL': '/var/mail/cltbld', 06:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:41 INFO - 'MOZ_NO_REMOTE': '1', 06:55:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:41 INFO - 'NO_EM_RESTART': '1', 06:55:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:55:41 INFO - 'PWD': '/builds/slave/test-pgo', 06:55:41 INFO - 'SHELL': '/bin/bash', 06:55:41 INFO - 'SHLVL': '1', 06:55:41 INFO - 'TERM': 'linux', 06:55:41 INFO - 'TMOUT': '86400', 06:55:41 INFO - 'USER': 'cltbld', 06:55:41 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279', 06:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:41 INFO - '_': '/tools/buildbot/bin/python'} 06:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:55:42 INFO - Cleaning up... 06:55:42 INFO - Return code: 0 06:55:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:42 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 0x7f1a2155cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23836e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a90>, '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 0x240bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c2e0>, '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': 'd6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279', '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 06:55:42 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 06:55:42 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 06:55:42 INFO - Using env: {'DISPLAY': ':0', 06:55:42 INFO - 'HOME': '/home/cltbld', 06:55:42 INFO - 'LANG': 'en_US.UTF-8', 06:55:42 INFO - 'LANGUAGE': 'en_US:en', 06:55:42 INFO - 'LOGNAME': 'cltbld', 06:55:42 INFO - 'MAIL': '/var/mail/cltbld', 06:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:42 INFO - 'MOZ_NO_REMOTE': '1', 06:55:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:42 INFO - 'NO_EM_RESTART': '1', 06:55:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:55:42 INFO - 'PWD': '/builds/slave/test-pgo', 06:55:42 INFO - 'SHELL': '/bin/bash', 06:55:42 INFO - 'SHLVL': '1', 06:55:42 INFO - 'TERM': 'linux', 06:55:42 INFO - 'TMOUT': '86400', 06:55:42 INFO - 'USER': 'cltbld', 06:55:42 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279', 06:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:42 INFO - '_': '/tools/buildbot/bin/python'} 06:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:42 INFO - Downloading/unpacking psutil>=0.7.1 06:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:44 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:55:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:55:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:55:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:44 INFO - Installing collected packages: psutil 06:55:44 INFO - Running setup.py install for psutil 06:55:44 INFO - building 'psutil._psutil_linux' extension 06:55:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:55:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:55:44 INFO - building 'psutil._psutil_posix' extension 06:55:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:55:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:55:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:44 INFO - Successfully installed psutil 06:55:44 INFO - Cleaning up... 06:55:44 INFO - Return code: 0 06:55:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:44 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 0x7f1a2155cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23836e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a90>, '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 0x240bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c2e0>, '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': 'd6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279', '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 06:55:44 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 06:55:44 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 06:55:44 INFO - Using env: {'DISPLAY': ':0', 06:55:44 INFO - 'HOME': '/home/cltbld', 06:55:44 INFO - 'LANG': 'en_US.UTF-8', 06:55:44 INFO - 'LANGUAGE': 'en_US:en', 06:55:44 INFO - 'LOGNAME': 'cltbld', 06:55:44 INFO - 'MAIL': '/var/mail/cltbld', 06:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:44 INFO - 'MOZ_NO_REMOTE': '1', 06:55:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:44 INFO - 'NO_EM_RESTART': '1', 06:55:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:55:44 INFO - 'PWD': '/builds/slave/test-pgo', 06:55:44 INFO - 'SHELL': '/bin/bash', 06:55:44 INFO - 'SHLVL': '1', 06:55:44 INFO - 'TERM': 'linux', 06:55:44 INFO - 'TMOUT': '86400', 06:55:44 INFO - 'USER': 'cltbld', 06:55:44 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279', 06:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:44 INFO - '_': '/tools/buildbot/bin/python'} 06:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:55:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:55:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:55:46 INFO - Installing collected packages: mozsystemmonitor 06:55:46 INFO - Running setup.py install for mozsystemmonitor 06:55:46 INFO - Successfully installed mozsystemmonitor 06:55:46 INFO - Cleaning up... 06:55:46 INFO - Return code: 0 06:55:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:46 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 0x7f1a2155cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23836e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a90>, '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 0x240bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c2e0>, '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': 'd6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279', '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 06:55:46 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 06:55:46 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 06:55:46 INFO - Using env: {'DISPLAY': ':0', 06:55:46 INFO - 'HOME': '/home/cltbld', 06:55:46 INFO - 'LANG': 'en_US.UTF-8', 06:55:46 INFO - 'LANGUAGE': 'en_US:en', 06:55:46 INFO - 'LOGNAME': 'cltbld', 06:55:46 INFO - 'MAIL': '/var/mail/cltbld', 06:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:46 INFO - 'MOZ_NO_REMOTE': '1', 06:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:46 INFO - 'NO_EM_RESTART': '1', 06:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:55:46 INFO - 'PWD': '/builds/slave/test-pgo', 06:55:46 INFO - 'SHELL': '/bin/bash', 06:55:46 INFO - 'SHLVL': '1', 06:55:46 INFO - 'TERM': 'linux', 06:55:46 INFO - 'TMOUT': '86400', 06:55:46 INFO - 'USER': 'cltbld', 06:55:46 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279', 06:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:46 INFO - '_': '/tools/buildbot/bin/python'} 06:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:46 INFO - Downloading/unpacking blobuploader==1.2.4 06:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:48 INFO - Downloading blobuploader-1.2.4.tar.gz 06:55:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:55:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:55:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:55:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:55:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:49 INFO - Downloading docopt-0.6.1.tar.gz 06:55:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:55:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:55:49 INFO - Installing collected packages: blobuploader, requests, docopt 06:55:49 INFO - Running setup.py install for blobuploader 06:55:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:55:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:55:49 INFO - Running setup.py install for requests 06:55:49 INFO - Running setup.py install for docopt 06:55:49 INFO - Successfully installed blobuploader requests docopt 06:55:49 INFO - Cleaning up... 06:55:49 INFO - Return code: 0 06:55:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:49 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 0x7f1a2155cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23836e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a90>, '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 0x240bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c2e0>, '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': 'd6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279', '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 06:55:49 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 06:55:49 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 06:55:49 INFO - Using env: {'DISPLAY': ':0', 06:55:49 INFO - 'HOME': '/home/cltbld', 06:55:49 INFO - 'LANG': 'en_US.UTF-8', 06:55:49 INFO - 'LANGUAGE': 'en_US:en', 06:55:49 INFO - 'LOGNAME': 'cltbld', 06:55:49 INFO - 'MAIL': '/var/mail/cltbld', 06:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:49 INFO - 'MOZ_NO_REMOTE': '1', 06:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:49 INFO - 'NO_EM_RESTART': '1', 06:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:55:49 INFO - 'PWD': '/builds/slave/test-pgo', 06:55:49 INFO - 'SHELL': '/bin/bash', 06:55:49 INFO - 'SHLVL': '1', 06:55:49 INFO - 'TERM': 'linux', 06:55:49 INFO - 'TMOUT': '86400', 06:55:49 INFO - 'USER': 'cltbld', 06:55:49 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279', 06:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:49 INFO - '_': '/tools/buildbot/bin/python'} 06:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:55:50 INFO - Running setup.py (path:/tmp/pip-T_heTE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:55:50 INFO - Running setup.py (path:/tmp/pip-SVc0BY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:55:50 INFO - Running setup.py (path:/tmp/pip-xd35hF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:55:50 INFO - Running setup.py (path:/tmp/pip-zGGVH_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:55:50 INFO - Running setup.py (path:/tmp/pip-16hi0s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:55:50 INFO - Running setup.py (path:/tmp/pip-iGQfIA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:55:50 INFO - Running setup.py (path:/tmp/pip-f328Ly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:55:50 INFO - Running setup.py (path:/tmp/pip-jmEEHn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:55:50 INFO - Running setup.py (path:/tmp/pip-26EuQp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:55:50 INFO - Running setup.py (path:/tmp/pip-2e0eNC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:55:50 INFO - Running setup.py (path:/tmp/pip-hnYtDv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:55:50 INFO - Running setup.py (path:/tmp/pip-WP0DnK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:55:51 INFO - Running setup.py (path:/tmp/pip-yGZIHs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:55:51 INFO - Running setup.py (path:/tmp/pip-ZDrK71-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:55:51 INFO - Running setup.py (path:/tmp/pip-vksY50-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:55:51 INFO - Running setup.py (path:/tmp/pip-1heIq4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:55:51 INFO - Running setup.py (path:/tmp/pip-SUjBx3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:55:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:55:51 INFO - Running setup.py install for manifestparser 06:55:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:55:51 INFO - Running setup.py install for mozcrash 06:55:51 INFO - Running setup.py install for mozdebug 06:55:51 INFO - Running setup.py install for mozdevice 06:55:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:55:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:55:51 INFO - Running setup.py install for mozfile 06:55:51 INFO - Running setup.py install for mozhttpd 06:55:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:55:51 INFO - Running setup.py install for mozinfo 06:55:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:55:52 INFO - Running setup.py install for mozInstall 06:55:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:55:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:55:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:55:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:55:52 INFO - Running setup.py install for mozleak 06:55:52 INFO - Running setup.py install for mozlog 06:55:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:55:52 INFO - Running setup.py install for moznetwork 06:55:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:55:52 INFO - Running setup.py install for mozprocess 06:55:52 INFO - Running setup.py install for mozprofile 06:55:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:55:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:55:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:55:52 INFO - Running setup.py install for mozrunner 06:55:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:55:52 INFO - Running setup.py install for mozscreenshot 06:55:52 INFO - Running setup.py install for moztest 06:55:53 INFO - Running setup.py install for mozversion 06:55:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:55:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:55:53 INFO - Cleaning up... 06:55:53 INFO - Return code: 0 06:55:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:53 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 0x7f1a2155cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23836e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a90>, '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 0x240bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c2e0>, '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': 'd6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279', '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 06:55:53 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 06:55:53 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 06:55:53 INFO - Using env: {'DISPLAY': ':0', 06:55:53 INFO - 'HOME': '/home/cltbld', 06:55:53 INFO - 'LANG': 'en_US.UTF-8', 06:55:53 INFO - 'LANGUAGE': 'en_US:en', 06:55:53 INFO - 'LOGNAME': 'cltbld', 06:55:53 INFO - 'MAIL': '/var/mail/cltbld', 06:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:53 INFO - 'MOZ_NO_REMOTE': '1', 06:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:53 INFO - 'NO_EM_RESTART': '1', 06:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:55:53 INFO - 'PWD': '/builds/slave/test-pgo', 06:55:53 INFO - 'SHELL': '/bin/bash', 06:55:53 INFO - 'SHLVL': '1', 06:55:53 INFO - 'TERM': 'linux', 06:55:53 INFO - 'TMOUT': '86400', 06:55:53 INFO - 'USER': 'cltbld', 06:55:53 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279', 06:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:53 INFO - '_': '/tools/buildbot/bin/python'} 06:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:55:53 INFO - Running setup.py (path:/tmp/pip-AOZBS9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:55:53 INFO - Running setup.py (path:/tmp/pip-Oo2rN1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:55:53 INFO - Running setup.py (path:/tmp/pip-0xM4IN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:55:53 INFO - Running setup.py (path:/tmp/pip-wRgXJy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:55:53 INFO - Running setup.py (path:/tmp/pip-qAP78L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:55:53 INFO - Running setup.py (path:/tmp/pip-D1hk4c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:55:53 INFO - Running setup.py (path:/tmp/pip-BpskX4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:55:53 INFO - Running setup.py (path:/tmp/pip-_VpxkE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:55:53 INFO - Running setup.py (path:/tmp/pip-aj64j2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:55:54 INFO - Running setup.py (path:/tmp/pip-7wAPXE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 06:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:55:54 INFO - Running setup.py (path:/tmp/pip-qlIBDC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:55:54 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)) 06:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:55:54 INFO - Running setup.py (path:/tmp/pip-6ZWfy8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:55:54 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)) 06:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:55:54 INFO - Running setup.py (path:/tmp/pip-xWhCe6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:55:54 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)) 06:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:55:54 INFO - Running setup.py (path:/tmp/pip-H3ziWM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:55:54 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)) 06:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:55:54 INFO - Running setup.py (path:/tmp/pip-8qXBGx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:55:54 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)) 06:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:55:54 INFO - Running setup.py (path:/tmp/pip-BBr5KL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:55:54 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)) 06:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:55:54 INFO - Running setup.py (path:/tmp/pip-RN794x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:55:54 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)) 06:55:54 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)) 06:55:54 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)) 06:55:54 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)) 06:55:54 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)) 06:55:54 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)) 06:55:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:56 INFO - Downloading blessings-1.5.1.tar.gz 06:55:56 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 06:55:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:55:56 INFO - Installing collected packages: blessings 06:55:56 INFO - Running setup.py install for blessings 06:55:56 INFO - Successfully installed blessings 06:55:56 INFO - Cleaning up... 06:55:56 INFO - Return code: 0 06:55:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:55:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:55:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:55:56 INFO - Reading from file tmpfile_stdout 06:55:56 INFO - Current package versions: 06:55:56 INFO - argparse == 1.2.1 06:55:56 INFO - blessings == 1.5.1 06:55:56 INFO - blobuploader == 1.2.4 06:55:56 INFO - docopt == 0.6.1 06:55:56 INFO - manifestparser == 1.1 06:55:56 INFO - mozInstall == 1.12 06:55:56 INFO - mozcrash == 0.16 06:55:56 INFO - mozdebug == 0.1 06:55:56 INFO - mozdevice == 0.47 06:55:56 INFO - mozfile == 1.2 06:55:56 INFO - mozhttpd == 0.7 06:55:56 INFO - mozinfo == 0.9 06:55:56 INFO - mozleak == 0.1 06:55:56 INFO - mozlog == 3.0 06:55:56 INFO - moznetwork == 0.27 06:55:56 INFO - mozprocess == 0.22 06:55:56 INFO - mozprofile == 0.27 06:55:56 INFO - mozrunner == 6.11 06:55:56 INFO - mozscreenshot == 0.1 06:55:56 INFO - mozsystemmonitor == 0.0 06:55:56 INFO - moztest == 0.7 06:55:56 INFO - mozversion == 1.4 06:55:56 INFO - psutil == 3.1.1 06:55:56 INFO - requests == 1.2.3 06:55:56 INFO - wsgiref == 0.1.2 06:55:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:56 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 0x7f1a2155cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23836e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9a90>, '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 0x240bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c2e0>, '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': 'd6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279', '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 06:55:56 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 06:55:56 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 06:55:56 INFO - Using env: {'DISPLAY': ':0', 06:55:56 INFO - 'HOME': '/home/cltbld', 06:55:56 INFO - 'LANG': 'en_US.UTF-8', 06:55:56 INFO - 'LANGUAGE': 'en_US:en', 06:55:56 INFO - 'LOGNAME': 'cltbld', 06:55:56 INFO - 'MAIL': '/var/mail/cltbld', 06:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:56 INFO - 'MOZ_NO_REMOTE': '1', 06:55:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:56 INFO - 'NO_EM_RESTART': '1', 06:55:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:55:56 INFO - 'PWD': '/builds/slave/test-pgo', 06:55:56 INFO - 'SHELL': '/bin/bash', 06:55:56 INFO - 'SHLVL': '1', 06:55:56 INFO - 'TERM': 'linux', 06:55:56 INFO - 'TMOUT': '86400', 06:55:56 INFO - 'USER': 'cltbld', 06:55:56 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279', 06:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:56 INFO - '_': '/tools/buildbot/bin/python'} 06:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 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)) 06:55:56 INFO - Cleaning up... 06:55:56 INFO - Return code: 0 06:55:56 INFO - Running post-action listener: _resource_record_post_action 06:55:56 INFO - Running post-action listener: _start_resource_monitoring 06:55:56 INFO - Starting resource monitoring. 06:55:56 INFO - ##### 06:55:56 INFO - ##### Running install step. 06:55:56 INFO - ##### 06:55:56 INFO - Running pre-action listener: _resource_record_pre_action 06:55:56 INFO - Running main action method: install 06:55:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:55:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:55:57 INFO - Reading from file tmpfile_stdout 06:55:57 INFO - Detecting whether we're running mozinstall >=1.0... 06:55:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:55:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:55:57 INFO - Reading from file tmpfile_stdout 06:55:57 INFO - Output received: 06:55:57 INFO - Usage: mozinstall [options] installer 06:55:57 INFO - Options: 06:55:57 INFO - -h, --help show this help message and exit 06:55:57 INFO - -d DEST, --destination=DEST 06:55:57 INFO - Directory to install application into. [default: 06:55:57 INFO - "/builds/slave/test-pgo"] 06:55:57 INFO - --app=APP Application being installed. [default: firefox] 06:55:57 INFO - mkdir: /builds/slave/test-pgo/build/application 06:55:57 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'] 06:55:57 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 06:56:12 INFO - Reading from file tmpfile_stdout 06:56:12 INFO - Output received: 06:56:12 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:56:12 INFO - Running post-action listener: _resource_record_post_action 06:56:12 INFO - ##### 06:56:12 INFO - ##### Running run-tests step. 06:56:12 INFO - ##### 06:56:12 INFO - Running pre-action listener: _resource_record_pre_action 06:56:12 INFO - Running main action method: run_tests 06:56:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:56:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:56:12 INFO - Python 2.7.3 06:56:12 INFO - Return code: 0 06:56:12 INFO - grabbing minidump binary from tooltool 06:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:12 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 0x23b9a90>, '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 0x240bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:56:12 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 06:56:12 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 06:56:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:56:12 INFO - Return code: 0 06:56:12 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:56:12 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:56:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:56:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:56:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:56:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:56:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost 06:56:12 INFO - Using env: {'DISPLAY': ':0', 06:56:12 INFO - 'HOME': '/home/cltbld', 06:56:12 INFO - 'LANG': 'en_US.UTF-8', 06:56:12 INFO - 'LANGUAGE': 'en_US:en', 06:56:12 INFO - 'LOGNAME': 'cltbld', 06:56:12 INFO - 'MAIL': '/var/mail/cltbld', 06:56:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:56:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:12 INFO - 'MOZ_NO_REMOTE': '1', 06:56:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:56:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:12 INFO - 'NO_EM_RESTART': '1', 06:56:12 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:56:12 INFO - 'PWD': '/builds/slave/test-pgo', 06:56:12 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:56:12 INFO - 'SHELL': '/bin/bash', 06:56:12 INFO - 'SHLVL': '1', 06:56:12 INFO - 'TERM': 'linux', 06:56:12 INFO - 'TMOUT': '86400', 06:56:12 INFO - 'USER': 'cltbld', 06:56:12 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279', 06:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:12 INFO - '_': '/tools/buildbot/bin/python'} 06:56:12 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] with output_timeout 3600 06:56:12 INFO - mozversion INFO | application_buildid: 20151120043002 06:56:12 INFO - mozversion INFO | application_changeset: ec628289d8b4ed310463a0729c3e60a7798dfcac 06:56:12 INFO - mozversion INFO | application_display_name: Nightly 06:56:12 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:56:12 INFO - mozversion INFO | application_name: Firefox 06:56:12 INFO - mozversion INFO | application_remotingname: firefox 06:56:12 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 06:56:12 INFO - mozversion INFO | application_vendor: Mozilla 06:56:12 INFO - mozversion INFO | application_version: 45.0a1 06:56:12 INFO - mozversion INFO | platform_buildid: 20151120043002 06:56:12 INFO - mozversion INFO | platform_changeset: ec628289d8b4ed310463a0729c3e60a7798dfcac 06:56:12 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 06:56:12 INFO - mozversion INFO | platform_version: 45.0a1 06:56:12 INFO - 2015-11-20 06:56:12,375 DEBUG : using testdate: 1448031372 06:56:12 INFO - 2015-11-20 06:56:12,375 DEBUG : actual date: 1448031372 06:56:12 INFO - 2015-11-20 06:56:12,383 INFO : starting webserver on 'localhost:58267' 06:56:12 INFO - 2015-11-20 06:56:12,384 INFO : Starting test suite talos-linux64-ix-016 06:56:12 INFO - 2015-11-20 06:56:12,384 INFO : Starting test dromaeo_css 06:56:12 INFO - 2015-11-20 06:56:12,384 DEBUG : operating with platform_type : linux_ 06:56:12 INFO - 2015-11-20 06:56:12,384 INFO : Initialising browser for dromaeo_css test... 06:56:12 INFO - 2015-11-20 06:56:12,391 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2WvaMS/profile http://localhost:58267/getInfo.html 06:56:16 INFO - 2015-11-20 06:56:16,661 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:56:16 INFO - 2015-11-20 06:56:16,661 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:56:16 INFO - 2015-11-20 06:56:16,661 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:56:16 INFO - 2015-11-20 06:56:16,661 DEBUG : BROWSER_OUTPUT: __metrics 06:56:16 INFO - 2015-11-20 06:56:16,810 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:56:17 INFO - 2015-11-20 06:56:17,961 INFO : Browser initialized. 06:56:17 INFO - 2015-11-20 06:56:17,962 INFO : Running cycle 1/1 for dromaeo_css test... 06:56:17 INFO - 2015-11-20 06:56:17,962 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2WvaMS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:56:29 INFO - 2015-11-20 06:56:29,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 142159872 06:56:29 INFO - 2015-11-20 06:56:29,742 DEBUG : BROWSER_OUTPUT: 06:57:21 INFO - 2015-11-20 06:57:21,331 DEBUG : BROWSER_OUTPUT: 1448031441329 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:59:30 INFO - 2015-11-20 06:59:30,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58267/tests/dromaeo/cssquery-ext.html) 06:59:30 INFO - 2015-11-20 06:59:30,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 239071232 06:59:30 INFO - 2015-11-20 06:59:30,989 DEBUG : BROWSER_OUTPUT: 07:02:33 INFO - 2015-11-20 07:02:33,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/dromaeo/cssquery-ext.html (next: http://localhost:58267/tests/dromaeo/cssquery-jquery.html) 07:02:33 INFO - 2015-11-20 07:02:33,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 216178688 07:02:33 INFO - 2015-11-20 07:02:33,827 DEBUG : BROWSER_OUTPUT: 07:05:35 INFO - 2015-11-20 07:05:35,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58267/tests/dromaeo/cssquery-mootools.html) 07:05:36 INFO - 2015-11-20 07:05:36,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 212246528 07:05:36 INFO - 2015-11-20 07:05:36,297 DEBUG : BROWSER_OUTPUT: 07:08:38 INFO - 2015-11-20 07:08:38,154 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58267/tests/dromaeo/cssquery-prototype.html) 07:08:38 INFO - 2015-11-20 07:08:38,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 198672384 07:08:38 INFO - 2015-11-20 07:08:38,722 DEBUG : BROWSER_OUTPUT: 07:11:41 INFO - 2015-11-20 07:11:41,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58267/tests/dromaeo/cssquery-yui.html) 07:11:41 INFO - 2015-11-20 07:11:41,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 201662464 07:11:41 INFO - 2015-11-20 07:11:41,675 DEBUG : BROWSER_OUTPUT: 07:14:44 INFO - 2015-11-20 07:14:44,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/dromaeo/cssquery-yui.html (next: http://localhost:58267/tests/dromaeo/cssquery-dojo.html) 07:14:44 INFO - 2015-11-20 07:14:44,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 211980288 07:14:44 INFO - 2015-11-20 07:14:44,326 DEBUG : BROWSER_OUTPUT: 07:14:44 INFO - 2015-11-20 07:14:44,326 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:14:44 INFO - 2015-11-20 07:14:44,327 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:14:44 INFO - 2015-11-20 07:14:44,327 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:14:44 INFO - 2015-11-20 07:14:44,327 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:14:44 INFO - 2015-11-20 07:14:44,328 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3192.4892017277234;3261.7390608751302;3303.966960330396;3315.287213249151;3333.7833040852333;5277.234800953869;5418.83743487695;5474.589405794566;5476.507114359707;5485.09495933171;5362.785488580452;5376.731163441832;5424.755885985131;5451.836444906659;5513.2005859150395;4887.364642596466;4960.900781984358;5021.221710634857;5029;5037.94203217323;4852.805887764485;5065.898682026357;5068.493150684921;5087.414947281054;5133.3326667533165;4918.655694101397;4933.284673722326;4999.500049994971;5015.874603134915;5036.949630503685;5024.296598476216;5044.697318160922;5047.722375269359;5057.974710126463;5092.821751238689;4805.471398146201;4942.975285123552;4990.800367985276;5000;5017.67385119966;5279.762410691528;5349.866253343697;5352.090144675414;5372.328458942632;5390.326209223847;5911.083782013752;5925.822225333247;5928.851778705523;5928.940710592882;5931.851703707399;5652.943470565283;5785.855353616151;5847.8245652630485;5947.137665038588;5964.522838172936;5566.471185237396;5567.053600887859;5570.442955704397;5572.832815015516;5591.440855914376;5981.132735753292;5990.011648078105;6001.729922153513;6003.729832157564;6030.30651475086;5616.85957851057;5696.601237913306;5736.741846616912;5832;5851.61964472308;5922.555808314393;5932.466078052996;5946.554008449383;5950.077737950624;5958.6722730249385;5849.649021058665;5871;5931.466168044896;5933.376995415506;5937.168796368512;5723.484886360247;5749.597528172988;5815.127730840408;5825.650460972355;5876.882462350729;4532.909341813145;4567.81728730847;4574.931376029363;4591.288350305708;4621.792019359137;3963.8018099095507;4064.5935406459116;4068.6948478864206;4074.0425999890003;4117;5445.128779395278;5475.4250803665045;5502.889942201134;5549.5837812163445;5580.218769372291;5926.496247818984;5931.347551769302;5931.555133365015;5935.881282374328;5957.523398128139;5397.649152805055;5617.578681598897;5620.381758006616;5621.578381621394;5628.634138780966;4867.732274724854;4901.828436004794;4946.109700253917;5053.090443720165;5080.339555857715;6095.299040610386;6095.8476038098515;6097.054956481752;6104.26748790148;6109.14471973924;5769.826905192851;5827.24245848037;5880.970595146997;5889.617174883619;5895.233619629421;6021.42796434338;6032.1856549365275;6037.939620603738;6131.325554188947;6145.600535965148;5723.484886360247;5757.107648314518;5758.1362795581;5760.855978600569;5860.794872179454;5800.7099645018425;5829.446202610745;5834.562407819515;5836.066229403275;5860.619059761102;5728.112142617901;5781.392953739797;5876.6180198286975;5885.117232415172;5916.970415147896;5699.943000569941;5700.486956173964;5702.287214098238;5707.486326230659;5720.313562372542;5514.834554963358;5608.6073974821375;5610.410906854721;5621.887562248814;5629.183768353648;5751.1373294006235;5825.2135961644635;5867.853303667272;5878.265216847894;5883.352831188651;5603.38362780102;5676.659400435987;5724.79963201286;5729.512991395778;5738 07:14:44 INFO - 2015-11-20 07:14:44,330 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.4039578529524;590.592491181085;596.8418369132181;618.251915182629;672.5493919074216;30612.010219335756;31558.68441315592;31603;31617.36765264696;31621.525677114834;32764.836175819146;33216.501752473734;38179.42730859039;38416.61583384165;38428.80785596075;8712.477251364922;8786.912130878673;8795;8886;8891;7699.307062364386;8644.913550864505;8737.563121843914;8769.123087691212;8781.473111613324;7647.847043059135;10425.322354046963;10591.25861189717;10623.57505699771;10674.306170098958;10190.64332748354;10326.48367581618;10337.793244135113;10345.120664743506;10354.741131471697;7720.53676779395;7964.721234756756;10143.644972426004;10301.74245643865;10400.531976061095;38752.80623596864;39184;39235.80382098071;39255.60744392548;39285;3110.906672799797;3123.9687603123907;3129.8278594677286;3135.843207839599;3839.905626896349;29133.271668208254;30503.847480762677;30666.23334416635;30678.38643227123;30825;3567.9821600892087;3606.353005709716;3623.8188090595363;3693.6121707220623;3755.6432138946757;268931;269824;269903;271349.64325178444;271480;56193.71903140458;56634.716826415606;56665;56671.716641417355;56777;59554;59575;59584.70207648934;59625.40374596285;59642.40357596368;14981.101133932;15462.690746185239;15507.069575825486;15516.922415388077;15525.456609018856;11795.941020295015;11838.585649502225;11839.822402663967;11842.171048026728;11865.5847045353;18412.539686507676;18749.250029998646;18941.90529047346;19011.714824277646;19033.95313257784;7571.886421703679;7794.103678077094;7837.49056311338;7932.206779322021;7957.084935232407;953.713885834247;1022.2997246885907;1058.9311694739818;1112.2825777373548;1123.095907794217;28269.43461130807;28478;28582.857085714437;28604.713952860206;28645.427091458056;874.3180319350917;1004.3521928356315;1015.4719545836272;1068.273573969708;1145.0839328537138;13792.655183620289;14201.23622628795;14257.21585312797;14361.85638143626;14427.35076921541;328045;332464;333489;335559;335931;51805.48194518082;52005.479945200066;52152.47847521476;52341.7382913083;52367;1188.506769690586;1202.8857258560422;1311.8556958734723;1314.106407642812;1320.795276732108;28792.424151516432;29794.404111917207;29879.850600747726;29968;30497;42450.575494245895;42839.78580107079;46769.53230467652;47430.76284618555;47584.52415475939;319569;323149;323945;325163;325409;41278.41121728524;41500.37749433701;42008.78995605002;42082.368764467945;42126.36810447784;43933.56066439295;44305.778471107435;44401.11197776091;44786.3282050763;45166.548334516236;37992.240155197294;38631.03422414462;38882.80558597189;41787.1642567153;42443.7877810609;40491;41136.58863411447;41448.792756036026;41496;42702.57297426986;36940.81529592335;36999.63000369962;37301;41038.38442423306;41552.58447415487;32796.508052378755;34363.31273374568;34715.91704497738;34983.475247870796;35374.40132782722;26249.606255906558;26478.735212647625;26591.7340826597;26722.46555068849;26748.732512675404 07:14:44 INFO - 2015-11-20 07:14:44,333 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.35316430425235;360.44491483115985;363.3387235231878;364.50427418710547;367.1793541434891;14304.284785760696;14339.71320573588;16434.34262629495;17235.655286894256;18078.276868925244;10746.408947507884;11019.724506887333;16257.268422920968;16714;16735.246913888874;4293.742375457475;4889.315495830587;4896.069746748107;4896.338994235786;4897.33885925399;3784.8107594620296;3899.415087736848;4835.032993401316;4875.268709693539;5055.646104772649;5203.635745497817;5219;5229.7385130743505;5238.05714971305;5239.318888544484;5231.790728370861;5240.34495688039;5290.1800220965615;5491.313585801775;5493.176023596453;5276.103062479349;5283.947160528384;5292.497212764782;5293.86765330866;5297.576193904517;12495.812562811565;12715.491380344774;16450.67098658032;18716.157772900253;19441.611167776708;2011.2859934723256;2028.6449871272468;2101.1070295124664;2175.282156888223;2239.317008312464;9173.58718857653;9228.723138305795;9321.067893210624;9359.812803743887;9382.85925711115;1774.0774797105562;1812.664657038452;1816.6275913437846;1845.3172326239244;1900.0404795578145;59981.40018599802;62202.68898655478;62514.374856251765;64030.679846600935;64087;10002.199824014062;10023.69928902134;10128.493575321352;10144.543495542719;10157.94921025405;13347.06570540053;13473.461061557624;13480.5281815136;13514.729705405836;13517.188968661714;7158.391536719437;7220;7358.484906056525;7384.076990376203;7440.2931721486375;7059.7529086482755;7110;7129.073220481304;7197.748078817216;7204.9639751800905;4316.568343165721;4343.782810859508;4357.085012147421;4373.934390984138;4428.535003824552;1716.9484915452556;1756.1745979389666;1774.609585891102;1783.1530023239118;1844.9169787359601;901.4681338010605;906.8141031088611;926.5737760630186;981.3719219699398;998.7253505285959;16102.75845862313;16196.67606647884;16391.541268809775;16610.50168494947;16844;804.2882049386335;834.8497270491248;875.6366108065082;942.189716843514;946.9100435458621;8761.167689069529;9061.818763624822;9121.31590130743;9131;9266.305027122993;414914;457027;485791.707704842;502036;504862;81269.59365203136;82408.17591824006;82700.17299827046;83450;83644.58177709073;1109.7891400633853;1158.803003489392;1164.3537836500655;1177.664365655801;1180.6753142885775;15010.324535395715;15096.39614415411;15370.615734606725;15382.923085384502;15561.610959725645;34365;34738.65261347354;34755.60977560869;34974;35908.820455897556;46687.29969050535;46965;47914.760426197645;49725.502744973535;49909.75045124751;9441.669541566012;9544.95227523858;9651.855222171813;9676.467794271382;9677.854832177381;11330.490127944098;16729.665406692042;16762.916185418995;17000.149992500574;17595.648087038444;13405.396757146147;13658.726825463236;13811.378487968266;13960.2321872298;14244.715105698035;13769.380377882819;13816.516421925184;13940.58178254654;14032.789508157182;14307.57077287683;11593.420328983686;12009.692414202631;12254.938725306316;13986.44054237819;14194.43222271139;8731.563421828756;9121.407108537924;9562.856557151787;9638.42169469834;9743.220542356452;9103.544822758968;9189.081091890757;9322.254219662547;13581.592552223448;14418.279086045866 07:14:44 INFO - 2015-11-20 07:14:44,333 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1319.076646347557;1448.5219877440445;1454.5054681408321;1472.4772705689486;1478.5180898982894;6702.865942681149;7743.186965368633;7827.569483678395;7836.8824467632885;7840.1767814379455;7620.085589729227;7661.387089032878;7666.578338191397;7688.308052275294;7727.188645192258;1993.7806841247452;2057.5164836263466;2254.0532976150057;2282.1441959265276;2305.3890718959487;2308.319045881469;2314.0512389920136;2315;2315.918942837001;2317.06159005603;2210.7899749523767;2282.3723476044056;2282.4636210490603;2284.5088306014204;2287.1994801819314;2033.6237796007786;2084.562241929189;2227.231605096239;2259.1641092795608;2260.762619924917;2286.211257116292;2287.2223444028946;2313.097891822191;2318.142287353673;2324.2097686786574;7595.734149304748;7628.0846298443985;7636.7327143550265;7646.235376462365;7650.617469126577;4547.340635607851;4634.050019745944;4639.396878405786;4652.999605084923;4653.767311634439;3015.6079709637825;3060.8775648974015;3061.9693803062128;3082.7996180248438;3136.54520094585;1044.102072217892;1055.2824079625852;1062.6811956413046;1063.2663462211126;1084.6474895658864;10514.369137851754;10549.367037977823;10669.893301066968;10682.946585267024;10699.572017119306;4269.765162916007;4271.060366719316;4346.8043938022865;4350.390945267665;4415.315626077963;8657.393982421296;8793.648254069894;8796.8680469793;8801.07588703177;8808.47149171039;4722.055588882237;4731.952680473151;4749.976250118727;4750.572448479654;4756.6908150970075;4328.956710432918;4343.804528796211;4345.435093437896;4347.434833471629;4348.478182618042;3519;3524.8942531724088;3533.840977156034;3544.326577950181;3567.7859328440377;1105.8451816745662;1117.1286396610656;1121.433675993618;1135.8807325230896;1143.7140714821294;1315.1385842273326;1329.913555618901;1335.0721248732232;1351.290572449472;1354.4446776821653;7129.14450265961;7298.087739032621;7298.781036568911;7381.741639042608;7390.260973902567;1042.4266653340633;1057.534684738728;1108.9168312376603;1112.0991996482712;1128.8936841894988;5709.82870513877;5728.828135155952;5746.396628354046;5756.136579513107;5761.971190144022;9054.909450905538;9104.726858194264;9303.34876558648;9308.650245714334;9325.347225694137;9218.63125474987;9270.119338662817;9284.814303714023;9285.25717942563;9288.90711092894;7044.36600705939;7216.170140433812;7237.131544214622;7314.817129571803;7364.96317518409;7254.637268136466;7301.050863387725;7306.305900939402;7307.378872795872;7312;7930.682772689028;8173.060098088796;8274.213949674771;8285.62714677853;8308.044574873968;8335.458195217292;8503.74488765338;8512.659493620433;8650.956745216234;8676.219140277406;6597.439217666552;6742.123523941857;6744.527883048336;6753.561018533779;6936.930630693831;7364.484486086137;7407;7408.851822963618;7409.37020353276;7412.888806667796;5999.340072591924;6883.346082122191;7079.929200708133;7215.963920180366;7244.130704315305;6929.653517324013;6984.7206111757;7010.26392228829;7105.32499412555;7107.168754283803;7019.929800701928;7099.716011359487;7108.431325494052;7112.217656057933;7115.324044215791;6492.383223593751;6503.577267477599;6512.739490420519;6513.478921686159;6519.250286217146;6514.250861151028;6554.868902622016;6593.472522198309;6643.7674681385915;6650.767223147167 07:14:44 INFO - 2015-11-20 07:14:44,334 DEBUG : BROWSER_OUTPUT: |4;prototype.html;328.5564487941279;331.61698238534484;333.6130089096648;334.48322341981634;337.35901786605444;6111.419415155564;6114.663693496856;6145.8770824583535;6148.692565371724;6155.846103847401;5730.36965933747;5863.648181109136;5912.704364781765;6015.639061656304;6021;4599.586037256646;4608.423947006624;4612.238980568202;4623.006053698463;4627.3521706961055;4419.73481591104;4593.655475839309;4605.815767369301;4617.8152873885;4630.583247507724;4438.800253988562;4464.084862603175;4569.4516658001085;4575.336576196466;4579.152856721501;4542.295944128666;4561.407017087774;4562.726236425825;4562.749048802315;4562.977185114053;3990.2817492851277;4019.537753158395;4021.678265738734;4021.9396709049097;4023.1752490739623;5554.750036248379;5668.206451096849;5675.34733505648;5682.54539636828;5688.374278829326;5257.579393648499;5259.737013149327;5265.420803711589;5274.789008439696;5275.86810329741;6413.7434502619835;6417.454516366114;6423.582467139621;6425.807225783234;6430.678466076677;4352.630026447756;4353.08585197109;4355.194289056503;4358.411614432042;4370.825166993316;6540.771073012422;6605.240397354318;6652.3680250375655;6653.60078395293;6662.400383965466;4520.660950428731;4526.524714904887;4527.705699129546;4530.433695788027;4530.750808705487;4573.56551127649;4576.8626941191815;4577.473590537064;4577.565131312586;4587.6788624795945;5306.7611957462;5307.28351672527;5315.548178404802;5322.494363035506;5323.574114070865;6336.271328797156;6434.517411194179;6458.838529036718;6466.062420948936;6468.3855033771715;1605.229489844881;1617.4258138360713;1620.5057457475584;1620.5867503786694;1620.8460196281335;1051.784384201237;1053.6154303679102;1060.6128763001602;1068.5351871935734;1072.2279958429917;6249.187605611332;6253.593516421418;6254.093156492374;6260.154879091356;6261.812145635638;6440.291567927524;6658.533902626867;6660.533762636569;6663.20041595002;6667.399934005963;6147.44672979434;6171.13604095427;6266.717997690115;6268.811935641938;6281.811545653638;3546.078019714893;3599.460080987873;3599.784012959231;3602.2615363850346;3607.7294202934886;6784.08414863987;6938.098047253926;6941.0629565009085;6966.303369663095;6969.05917701114;6891.207511136183;6892.517523773287;6896.862062758717;6903;6915.101036865276;6927.930720692729;6939;6942.826429339307;6946.722131114699;6953.860922781516;6569.441597464269;6680.832979175365;6698.330166983263;6707.631080290631;6711.094002309821;6633.469322454289;6636.435902948304;6640.468762499085;6641.667916604247;6646.1027761253545;6891.897296432547;6934.341237582422;6941.062956500808;6941.3058694132205;6944.618046007518;4397;4493.59557639814;4494.280915053576;4496.190685676479;4501.18978583858;6699.196096468455;6708.899366509604;6718.0594716738715;6721.798346049626;6722.193336799615;6462.547621666627;6465.450436712744;6466.838329041811;6475.611463312216;6478.546501744832;6356.872862542816;6499.122618446639;6502.122213501306;6503.057056726842;6508.088867558451;6391.648459334781;6391.9041214380895;6396.10454536356;6400.327965563549;6400.42396184327;6482.124913136855;6486.286508484157;6536.8365790855605;6553;6556.672166391757;6231.2834024086;6374.458171055327;6374.681265936777;6385.87228255423;6415.807525774234 07:14:44 INFO - 2015-11-20 07:14:44,336 DEBUG : BROWSER_OUTPUT: |5;yui.html;757.9696812127515;827.6813426830672;844.1389782421926;844.94085414021;881.2597418168739;12853.357332133392;13110.672233194175;13117.54088606899;13135.211887286758;13135.868641313584;12546.059045571596;12621.495140194382;12624.81062784059;12646.30445325509;12654.05094617905;783.7962129846253;815.384384789486;817.3175398542195;818.8403261364007;822.7943014246439;821.8150916043872;830.900291964965;832.1221111727125;834.4784509681449;835.8286551256978;862.7153039496982;867.6312567158964;870.8476016697084;873.7204094689702;875.4528419737663;865.0743704236501;865.3942240431692;865.9783505412383;866.8569686001803;868.7176667583061;628.8019273928697;635.0474288567149;635.4344633276388;635.7838334966087;635.8696467224208;12615.495380184782;12664.240145591293;12744.299063551502;12758.936205318914;12819.551315703906;11311.490982905789;12126.939365303206;12217.877821221762;12291.56979505713;12320.365224295285;9970.850437243447;10140.188784897264;10157.949210253975;10208.234382421273;10281.485925703684;3510.701590364822;3601.891943241707;3606.4229723244416;3726.142987112979;3727.9627203727887;38714.41928371077;39852.402213966816;40699.186016279506;40746.79626601878;48218.51781482175;9711.902880971242;9812.264080194014;9844.507774611384;9868.901310986797;9938.503074846229;17201.483955481355;17214.31142754301;17254.137293135544;17280.567985800204;17287.827121728875;7138.9286107139305;7154.177269614061;7322.121345438475;7335.376492998048;7703.537787732642;4099.487564054493;4182.1844740275965;4271.508776490681;4336.934945975813;4348.9997300621035;3105.6428510721557;3145.418097651942;3149.1969547765175;3149.9685003150134;3151.322465669892;566.6481422673822;581.9010768169421;587.7149582452507;589.1986897818963;596.3023262782555;481.78078974067415;558.5587385965123;568.4486048532916;642.0882347067176;657.5035847934779;7760.883586746203;7927.5243485391065;8007.199280071946;8027.759167224993;8267.503949763033;647.9838004049936;651.941325280727;658.0754040573003;658.1838520234875;660.6663634864459;3635.654612811779;3799.886003419902;3869.6517313441927;3887.475190849256;3927.23418933311;54327.72836135873;54553.45446545563;54625.45374546283;56492;58452;48970.755146224044;49538.25692614614;50054.74972625114;50239.74880125576;50344.49655503471;40100.598994009684;41446.79276603598;46726.76636616863;47155.5284447158;47525.28712069322;7941.563214023284;8141.715039973573;8321.750347489586;8399.95800020996;8408.117147699648;34172.82913585416;34646.13384665403;35060.649393506756;35386.823065884506;35864.28271434609;42995.3550696746;43419.34870977001;45634.31548526841;45930;46206.537934620224;10796.838047429452;10841.620543280947;11001.669949901516;11048.337099774039;11091.611793587186;11367.602133925273;11502.712432188928;11568.652940411801;11584.536618535165;11619.302841829518;10761.784764304826;10986.450677465935;11034;11048.889511104786;11057.281276716987;11316.26444281119;11371.943140284577;11452.3701196435;11458.598949036743;11477.598284060017;10820.296680715728;10870.293430926964;10902.836457452986;10997.670069897917;11036.5033573491;9314.673986410444;9363.906360936304;9517.904820951702;9594.66418675343;9670.661526846527;8977.16265739998;9091.90908090937;9388.812223755624;9477.099675530813;9675.129238368581 07:14:44 INFO - 2015-11-20 07:14:44,336 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:14:44 INFO - 2015-11-20 07:14:44,336 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:14:44 INFO - 2015-11-20 07:14:44,336 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,737 07:14:44 INFO - 2015-11-20 07:14:44,336 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:14:44 INFO - 2015-11-20 07:14:44,336 DEBUG : BROWSER_OUTPUT: __startTimestamp1448032484324__endTimestamp 07:14:44 INFO - 2015-11-20 07:14:44,336 DEBUG : BROWSER_OUTPUT: 07:14:44 INFO - 2015-11-20 07:14:44,336 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:14:44 INFO - 2015-11-20 07:14:44,337 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:14:44 INFO - 2015-11-20 07:14:44,337 DEBUG : BROWSER_OUTPUT: 07:14:44 INFO - 2015-11-20 07:14:44,337 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5459.57 Median:5652.94 stddev:605.71 (10.7%) stddev-sans-first:580.87 07:14:44 INFO - 2015-11-20 07:14:44,337 DEBUG : BROWSER_OUTPUT: Values: 3192.5 3261.7 3304.0 3315.3 3333.8 5277.2 5418.8 5474.6 5476.5 5485.1 5362.8 5376.7 5424.8 5451.8 5513.2 4887.4 4960.9 5021.2 5029.0 5037.9 4852.8 5065.9 5068.5 5087.4 5133.3 4918.7 4933.3 4999.5 5015.9 5036.9 5024.3 5044.7 5047.7 5058.0 5092.8 4805.5 4943.0 4990.8 5000.0 5017.7 5279.8 5349.9 5352.1 5372.3 5390.3 5911.1 5925.8 5928.9 5928.9 5931.9 5652.9 5785.9 5847.8 5947.1 5964.5 5566.5 5567.1 5570.4 5572.8 5591.4 5981.1 5990.0 6001.7 6003.7 6030.3 5616.9 5696.6 5736.7 5832.0 5851.6 5922.6 5932.5 5946.6 5950.1 5958.7 5849.6 5871.0 5931.5 5933.4 5937.2 5723.5 5749.6 5815.1 5825.7 5876.9 4532.9 4567.8 4574.9 4591.3 4621.8 3963.8 4064.6 4068.7 4074.0 4117.0 5445.1 5475.4 5502.9 5549.6 5580.2 5926.5 5931.3 5931.6 5935.9 5957.5 5397.6 5617.6 5620.4 5621.6 5628.6 4867.7 4901.8 4946.1 5053.1 5080.3 6095.3 6095.8 6097.1 6104.3 6109.1 5769.8 5827.2 5881.0 5889.6 5895.2 6021.4 6032.2 6037.9 6131.3 6145.6 5723.5 5757.1 5758.1 5760.9 5860.8 5800.7 5829.4 5834.6 5836.1 5860.6 5728.1 5781.4 5876.6 5885.1 5917.0 5699.9 5700.5 5702.3 5707.5 5720.3 5514.8 5608.6 5610.4 5621.9 5629.2 5751.1 5825.2 5867.9 5878.3 5883.4 5603.4 5676.7 5724.8 5729.5 5738.0 07:14:44 INFO - 2015-11-20 07:14:44,337 DEBUG : BROWSER_OUTPUT: 07:14:44 INFO - 2015-11-20 07:14:44,337 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48038.58 Median:335745.00 stddev:81103.44 (24.2%) stddev-sans-first:81252.61 07:14:44 INFO - 2015-11-20 07:14:44,337 DEBUG : BROWSER_OUTPUT: Values: 560.4 590.6 596.8 618.3 672.5 30612.0 31558.7 31603.0 31617.4 31621.5 32764.8 33216.5 38179.4 38416.6 38428.8 8712.5 8786.9 8795.0 8886.0 8891.0 7699.3 8644.9 8737.6 8769.1 8781.5 7647.8 10425.3 10591.3 10623.6 10674.3 10190.6 10326.5 10337.8 10345.1 10354.7 7720.5 7964.7 10143.6 10301.7 10400.5 38752.8 39184.0 39235.8 39255.6 39285.0 3110.9 3124.0 3129.8 3135.8 3839.9 29133.3 30503.8 30666.2 30678.4 30825.0 3568.0 3606.4 3623.8 3693.6 3755.6 268931.0 269824.0 269903.0 271349.6 271480.0 56193.7 56634.7 56665.0 56671.7 56777.0 59554.0 59575.0 59584.7 59625.4 59642.4 14981.1 15462.7 15507.1 15516.9 15525.5 11795.9 11838.6 11839.8 11842.2 11865.6 18412.5 18749.3 18941.9 19011.7 19034.0 7571.9 7794.1 7837.5 7932.2 7957.1 953.7 1022.3 1058.9 1112.3 1123.1 28269.4 28478.0 28582.9 28604.7 28645.4 874.3 1004.4 1015.5 1068.3 1145.1 13792.7 14201.2 14257.2 14361.9 14427.4 328045.0 332464.0 333489.0 335559.0 335931.0 51805.5 52005.5 52152.5 52341.7 52367.0 1188.5 1202.9 1311.9 1314.1 1320.8 28792.4 29794.4 29879.9 29968.0 30497.0 42450.6 42839.8 46769.5 47430.8 47584.5 319569.0 323149.0 323945.0 325163.0 325409.0 41278.4 41500.4 42008.8 42082.4 42126.4 43933.6 44305.8 44401.1 44786.3 45166.5 37992.2 38631.0 38882.8 41787.2 42443.8 40491.0 41136.6 41448.8 41496.0 42702.6 36940.8 36999.6 37301.0 41038.4 41552.6 32796.5 34363.3 34715.9 34983.5 35374.4 26249.6 26478.7 26591.7 26722.5 26748.7 07:14:44 INFO - 2015-11-20 07:14:44,337 DEBUG : BROWSER_OUTPUT: 07:14:44 INFO - 2015-11-20 07:14:44,338 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26691.97 Median:4305.16 stddev:77769.48 (1806.4%) stddev-sans-first:77962.51 07:14:44 INFO - 2015-11-20 07:14:44,339 DEBUG : BROWSER_OUTPUT: Values: 359.4 360.4 363.3 364.5 367.2 14304.3 14339.7 16434.3 17235.7 18078.3 10746.4 11019.7 16257.3 16714.0 16735.2 4293.7 4889.3 4896.1 4896.3 4897.3 3784.8 3899.4 4835.0 4875.3 5055.6 5203.6 5219.0 5229.7 5238.1 5239.3 5231.8 5240.3 5290.2 5491.3 5493.2 5276.1 5283.9 5292.5 5293.9 5297.6 12495.8 12715.5 16450.7 18716.2 19441.6 2011.3 2028.6 2101.1 2175.3 2239.3 9173.6 9228.7 9321.1 9359.8 9382.9 1774.1 1812.7 1816.6 1845.3 1900.0 59981.4 62202.7 62514.4 64030.7 64087.0 10002.2 10023.7 10128.5 10144.5 10157.9 13347.1 13473.5 13480.5 13514.7 13517.2 7158.4 7220.0 7358.5 7384.1 7440.3 7059.8 7110.0 7129.1 7197.7 7205.0 4316.6 4343.8 4357.1 4373.9 4428.5 1716.9 1756.2 1774.6 1783.2 1844.9 901.5 906.8 926.6 981.4 998.7 16102.8 16196.7 16391.5 16610.5 16844.0 804.3 834.8 875.6 942.2 946.9 8761.2 9061.8 9121.3 9131.0 9266.3 414914.0 457027.0 485791.7 502036.0 504862.0 81269.6 82408.2 82700.2 83450.0 83644.6 1109.8 1158.8 1164.4 1177.7 1180.7 15010.3 15096.4 15370.6 15382.9 15561.6 34365.0 34738.7 34755.6 34974.0 35908.8 46687.3 46965.0 47914.8 49725.5 49909.8 9441.7 9545.0 9651.9 9676.5 9677.9 11330.5 16729.7 16762.9 17000.1 17595.6 13405.4 13658.7 13811.4 13960.2 14244.7 13769.4 13816.5 13940.6 14032.8 14307.6 11593.4 12009.7 12254.9 13986.4 14194.4 8731.6 9121.4 9562.9 9638.4 9743.2 9103.5 9189.1 9322.3 13581.6 14418.3 07:14:44 INFO - 2015-11-20 07:14:44,339 DEBUG : BROWSER_OUTPUT: 07:14:44 INFO - 2015-11-20 07:14:44,339 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5424.41 Median:6245.86 stddev:2786.55 (44.6%) stddev-sans-first:2777.28 07:14:44 INFO - 2015-11-20 07:14:44,339 DEBUG : BROWSER_OUTPUT: Values: 1319.1 1448.5 1454.5 1472.5 1478.5 6702.9 7743.2 7827.6 7836.9 7840.2 7620.1 7661.4 7666.6 7688.3 7727.2 1993.8 2057.5 2254.1 2282.1 2305.4 2308.3 2314.1 2315.0 2315.9 2317.1 2210.8 2282.4 2282.5 2284.5 2287.2 2033.6 2084.6 2227.2 2259.2 2260.8 2286.2 2287.2 2313.1 2318.1 2324.2 7595.7 7628.1 7636.7 7646.2 7650.6 4547.3 4634.1 4639.4 4653.0 4653.8 3015.6 3060.9 3062.0 3082.8 3136.5 1044.1 1055.3 1062.7 1063.3 1084.6 10514.4 10549.4 10669.9 10682.9 10699.6 4269.8 4271.1 4346.8 4350.4 4415.3 8657.4 8793.6 8796.9 8801.1 8808.5 4722.1 4732.0 4750.0 4750.6 4756.7 4329.0 4343.8 4345.4 4347.4 4348.5 3519.0 3524.9 3533.8 3544.3 3567.8 1105.8 1117.1 1121.4 1135.9 1143.7 1315.1 1329.9 1335.1 1351.3 1354.4 7129.1 7298.1 7298.8 7381.7 7390.3 1042.4 1057.5 1108.9 1112.1 1128.9 5709.8 5728.8 5746.4 5756.1 5762.0 9054.9 9104.7 9303.3 9308.7 9325.3 9218.6 9270.1 9284.8 9285.3 9288.9 7044.4 7216.2 7237.1 7314.8 7365.0 7254.6 7301.1 7306.3 7307.4 7312.0 7930.7 8173.1 8274.2 8285.6 8308.0 8335.5 8503.7 8512.7 8651.0 8676.2 6597.4 6742.1 6744.5 6753.6 6936.9 7364.5 7407.0 7408.9 7409.4 7412.9 5999.3 6883.3 7079.9 7216.0 7244.1 6929.7 6984.7 7010.3 7105.3 7107.2 7019.9 7099.7 7108.4 7112.2 7115.3 6492.4 6503.6 6512.7 6513.5 6519.3 6514.3 6554.9 6593.5 6643.8 6650.8 07:14:44 INFO - 2015-11-20 07:14:44,339 DEBUG : BROWSER_OUTPUT: 07:14:44 INFO - 2015-11-20 07:14:44,339 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5378.51 Median:6163.49 stddev:1647.89 (26.7%) stddev-sans-first:1608.33 07:14:44 INFO - 2015-11-20 07:14:44,339 DEBUG : BROWSER_OUTPUT: Values: 328.6 331.6 333.6 334.5 337.4 6111.4 6114.7 6145.9 6148.7 6155.8 5730.4 5863.6 5912.7 6015.6 6021.0 4599.6 4608.4 4612.2 4623.0 4627.4 4419.7 4593.7 4605.8 4617.8 4630.6 4438.8 4464.1 4569.5 4575.3 4579.2 4542.3 4561.4 4562.7 4562.7 4563.0 3990.3 4019.5 4021.7 4021.9 4023.2 5554.8 5668.2 5675.3 5682.5 5688.4 5257.6 5259.7 5265.4 5274.8 5275.9 6413.7 6417.5 6423.6 6425.8 6430.7 4352.6 4353.1 4355.2 4358.4 4370.8 6540.8 6605.2 6652.4 6653.6 6662.4 4520.7 4526.5 4527.7 4530.4 4530.8 4573.6 4576.9 4577.5 4577.6 4587.7 5306.8 5307.3 5315.5 5322.5 5323.6 6336.3 6434.5 6458.8 6466.1 6468.4 1605.2 1617.4 1620.5 1620.6 1620.8 1051.8 1053.6 1060.6 1068.5 1072.2 6249.2 6253.6 6254.1 6260.2 6261.8 6440.3 6658.5 6660.5 6663.2 6667.4 6147.4 6171.1 6266.7 6268.8 6281.8 3546.1 3599.5 3599.8 3602.3 3607.7 6784.1 6938.1 6941.1 6966.3 6969.1 6891.2 6892.5 6896.9 6903.0 6915.1 6927.9 6939.0 6942.8 6946.7 6953.9 6569.4 6680.8 6698.3 6707.6 6711.1 6633.5 6636.4 6640.5 6641.7 6646.1 6891.9 6934.3 6941.1 6941.3 6944.6 4397.0 4493.6 4494.3 4496.2 4501.2 6699.2 6708.9 6718.1 6721.8 6722.2 6462.5 6465.5 6466.8 6475.6 6478.5 6356.9 6499.1 6502.1 6503.1 6508.1 6391.6 6391.9 6396.1 6400.3 6400.4 6482.1 6486.3 6536.8 6553.0 6556.7 6231.3 6374.5 6374.7 6385.9 6415.8 07:14:44 INFO - 2015-11-20 07:14:44,340 DEBUG : BROWSER_OUTPUT: 07:14:44 INFO - 2015-11-20 07:14:44,340 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13306.11 Median:46941.15 stddev:15297.93 (32.6%) stddev-sans-first:15311.82 07:14:44 INFO - 2015-11-20 07:14:44,341 DEBUG : BROWSER_OUTPUT: Values: 758.0 827.7 844.1 844.9 881.3 12853.4 13110.7 13117.5 13135.2 13135.9 12546.1 12621.5 12624.8 12646.3 12654.1 783.8 815.4 817.3 818.8 822.8 821.8 830.9 832.1 834.5 835.8 862.7 867.6 870.8 873.7 875.5 865.1 865.4 866.0 866.9 868.7 628.8 635.0 635.4 635.8 635.9 12615.5 12664.2 12744.3 12758.9 12819.6 11311.5 12126.9 12217.9 12291.6 12320.4 9970.9 10140.2 10157.9 10208.2 10281.5 3510.7 3601.9 3606.4 3726.1 3728.0 38714.4 39852.4 40699.2 40746.8 48218.5 9711.9 9812.3 9844.5 9868.9 9938.5 17201.5 17214.3 17254.1 17280.6 17287.8 7138.9 7154.2 7322.1 7335.4 7703.5 4099.5 4182.2 4271.5 4336.9 4349.0 3105.6 3145.4 3149.2 3150.0 3151.3 566.6 581.9 587.7 589.2 596.3 481.8 558.6 568.4 642.1 657.5 7760.9 7927.5 8007.2 8027.8 8267.5 648.0 651.9 658.1 658.2 660.7 3635.7 3799.9 3869.7 3887.5 3927.2 54327.7 54553.5 54625.5 56492.0 58452.0 48970.8 49538.3 50054.7 50239.7 50344.5 40100.6 41446.8 46726.8 47155.5 47525.3 7941.6 8141.7 8321.8 8400.0 8408.1 34172.8 34646.1 35060.6 35386.8 35864.3 42995.4 43419.3 45634.3 45930.0 46206.5 10796.8 10841.6 11001.7 11048.3 11091.6 11367.6 11502.7 11568.7 11584.5 11619.3 10761.8 10986.5 11034.0 11048.9 11057.3 11316.3 11371.9 11452.4 11458.6 11477.6 10820.3 10870.3 10902.8 10997.7 11036.5 9314.7 9363.9 9517.9 9594.7 9670.7 8977.2 9091.9 9388.8 9477.1 9675.1 07:14:44 INFO - 2015-11-20 07:14:44,341 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:14:44 INFO - 2015-11-20 07:14:44,341 DEBUG : BROWSER_OUTPUT: 07:14:44 INFO - 2015-11-20 07:14:44,957 INFO : Browser exited with error code: 0 07:14:44 INFO - 2015-11-20 07:14:44,976 INFO : Completed test dromaeo_css (00:18:32) 07:14:44 INFO - 2015-11-20 07:14:44,976 INFO : Starting test kraken 07:14:44 INFO - 2015-11-20 07:14:44,976 DEBUG : operating with platform_type : linux_ 07:14:44 INFO - 2015-11-20 07:14:44,976 INFO : Initialising browser for kraken test... 07:14:44 INFO - 2015-11-20 07:14:44,982 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpn78yd2/profile http://localhost:58267/getInfo.html 07:14:48 INFO - 2015-11-20 07:14:48,693 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:14:48 INFO - 2015-11-20 07:14:48,693 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:14:48 INFO - 2015-11-20 07:14:48,693 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:14:48 INFO - 2015-11-20 07:14:48,694 DEBUG : BROWSER_OUTPUT: __metrics 07:14:48 INFO - 2015-11-20 07:14:48,770 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:14:50 INFO - 2015-11-20 07:14:50,003 INFO : Browser initialized. 07:14:50 INFO - 2015-11-20 07:14:50,003 INFO : Running cycle 1/1 for kraken test... 07:14:50 INFO - 2015-11-20 07:14:50,003 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpn78yd2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:15:01 INFO - 2015-11-20 07:15:01,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 141471744 07:15:01 INFO - 2015-11-20 07:15:01,750 DEBUG : BROWSER_OUTPUT: 07:15:04 INFO - 2015-11-20 07:15:04,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58267/tests/kraken/driver.html?testName=audio-beat-detection) 07:15:04 INFO - 2015-11-20 07:15:04,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 177623040 07:15:04 INFO - 2015-11-20 07:15:04,819 DEBUG : BROWSER_OUTPUT: 07:15:07 INFO - 2015-11-20 07:15:07,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58267/tests/kraken/driver.html?testName=audio-dft) 07:15:07 INFO - 2015-11-20 07:15:07,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 167899136 07:15:07 INFO - 2015-11-20 07:15:07,981 DEBUG : BROWSER_OUTPUT: 07:15:10 INFO - 2015-11-20 07:15:10,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58267/tests/kraken/driver.html?testName=audio-fft) 07:15:11 INFO - 2015-11-20 07:15:11,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 151814144 07:15:11 INFO - 2015-11-20 07:15:11,453 DEBUG : BROWSER_OUTPUT: 07:15:13 INFO - 2015-11-20 07:15:13,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58267/tests/kraken/driver.html?testName=audio-oscillator) 07:15:13 INFO - 2015-11-20 07:15:13,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 153067520 07:15:13 INFO - 2015-11-20 07:15:13,975 DEBUG : BROWSER_OUTPUT: 07:15:16 INFO - 2015-11-20 07:15:16,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:15:16 INFO - 2015-11-20 07:15:16,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 155983872 07:15:16 INFO - 2015-11-20 07:15:16,690 DEBUG : BROWSER_OUTPUT: 07:15:19 INFO - 2015-11-20 07:15:19,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58267/tests/kraken/driver.html?testName=imaging-darkroom) 07:15:20 INFO - 2015-11-20 07:15:20,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 156884992 07:15:20 INFO - 2015-11-20 07:15:20,190 DEBUG : BROWSER_OUTPUT: 07:15:23 INFO - 2015-11-20 07:15:23,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58267/tests/kraken/driver.html?testName=imaging-desaturate) 07:15:24 INFO - 2015-11-20 07:15:24,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 157437952 07:15:24 INFO - 2015-11-20 07:15:24,135 DEBUG : BROWSER_OUTPUT: 07:15:26 INFO - 2015-11-20 07:15:26,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58267/tests/kraken/driver.html?testName=json-parse-financial) 07:15:27 INFO - 2015-11-20 07:15:27,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 157929472 07:15:27 INFO - 2015-11-20 07:15:27,482 DEBUG : BROWSER_OUTPUT: 07:15:29 INFO - 2015-11-20 07:15:29,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:15:29 INFO - 2015-11-20 07:15:29,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 168542208 07:15:29 INFO - 2015-11-20 07:15:29,657 DEBUG : BROWSER_OUTPUT: 07:15:31 INFO - 2015-11-20 07:15:31,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58267/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:15:32 INFO - 2015-11-20 07:15:32,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 166948864 07:15:32 INFO - 2015-11-20 07:15:32,063 DEBUG : BROWSER_OUTPUT: 07:15:34 INFO - 2015-11-20 07:15:34,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:15:34 INFO - 2015-11-20 07:15:34,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 169697280 07:15:34 INFO - 2015-11-20 07:15:34,681 DEBUG : BROWSER_OUTPUT: 07:15:37 INFO - 2015-11-20 07:15:37,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:15:37 INFO - 2015-11-20 07:15:37,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 176214016 07:15:37 INFO - 2015-11-20 07:15:37,682 DEBUG : BROWSER_OUTPUT: 07:15:40 INFO - 2015-11-20 07:15:40,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:15:40 INFO - 2015-11-20 07:15:40,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 172773376 07:15:40 INFO - 2015-11-20 07:15:40,790 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,492 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58267/tests/kraken/driver.html?testName=ai-astar) 07:15:42 INFO - 2015-11-20 07:15:42,742 DEBUG : BROWSER_OUTPUT: RSS: Main: 230563840 07:15:42 INFO - 2015-11-20 07:15:42,742 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,743 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:15:42 INFO - 2015-11-20 07:15:42,743 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:15:42 INFO - 2015-11-20 07:15:42,743 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:15:42 INFO - 2015-11-20 07:15:42,743 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:15:42 INFO - 2015-11-20 07:15:42,744 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;104;109;109;109;98;110;109;106 07:15:42 INFO - 2015-11-20 07:15:42,744 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;126;152;163;132;151;161;124;162;125 07:15:42 INFO - 2015-11-20 07:15:42,744 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;162;160;162;161;160;163;163;164 07:15:42 INFO - 2015-11-20 07:15:42,745 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;73;90;72;71;73;116;91;72 07:15:42 INFO - 2015-11-20 07:15:42,745 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;137;90;91;91;146;89;91;145 07:15:42 INFO - 2015-11-20 07:15:42,745 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;109;110;110;109;110;110;110 07:15:42 INFO - 2015-11-20 07:15:42,745 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;146;147;146;145;146;145;145 07:15:42 INFO - 2015-11-20 07:15:42,746 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;95 07:15:42 INFO - 2015-11-20 07:15:42,746 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;63;63;62;64;64;68;71;59;61 07:15:42 INFO - 2015-11-20 07:15:42,746 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;70;69;70;72;70;69;69;70 07:15:42 INFO - 2015-11-20 07:15:42,746 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;85;83;93;83;84;84;85;85 07:15:42 INFO - 2015-11-20 07:15:42,747 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;129;116;115;125;130;114;130;114;115 07:15:42 INFO - 2015-11-20 07:15:42,747 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;154;154;150;150;137;148;147;148;138 07:15:42 INFO - 2015-11-20 07:15:42,747 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;68;69;68;68;68;69;65;67;69 07:15:42 INFO - 2015-11-20 07:15:42,747 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:15:42 INFO - 2015-11-20 07:15:42,747 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:15:42 INFO - 2015-11-20 07:15:42,748 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,919 07:15:42 INFO - 2015-11-20 07:15:42,748 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:15:42 INFO - 2015-11-20 07:15:42,748 DEBUG : BROWSER_OUTPUT: __startTimestamp1448032542741__endTimestamp 07:15:42 INFO - 2015-11-20 07:15:42,748 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,749 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:15:42 INFO - 2015-11-20 07:15:42,749 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:15:42 INFO - 2015-11-20 07:15:42,749 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,749 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.10 Median:109.00 stddev:3.67 (3.4%) stddev-sans-first:3.87 07:15:42 INFO - 2015-11-20 07:15:42,749 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 104.0 109.0 109.0 109.0 98.0 110.0 109.0 106.0 07:15:42 INFO - 2015-11-20 07:15:42,750 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,750 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.00 Median:153.00 stddev:16.35 (10.7%) stddev-sans-first:17.01 07:15:42 INFO - 2015-11-20 07:15:42,750 DEBUG : BROWSER_OUTPUT: Values: 154.0 126.0 152.0 163.0 132.0 151.0 161.0 124.0 162.0 125.0 07:15:42 INFO - 2015-11-20 07:15:42,750 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,750 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:1.37 (0.8%) stddev-sans-first:1.39 07:15:42 INFO - 2015-11-20 07:15:42,751 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 162.0 160.0 162.0 161.0 160.0 163.0 163.0 164.0 07:15:42 INFO - 2015-11-20 07:15:42,751 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,752 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.30 Median:73.00 stddev:14.67 (20.1%) stddev-sans-first:15.32 07:15:42 INFO - 2015-11-20 07:15:42,752 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 90.0 72.0 71.0 73.0 116.0 91.0 72.0 07:15:42 INFO - 2015-11-20 07:15:42,752 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,752 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:90.50 stddev:25.35 (28.0%) stddev-sans-first:26.21 07:15:42 INFO - 2015-11-20 07:15:42,752 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 137.0 90.0 91.0 91.0 146.0 89.0 91.0 145.0 07:15:42 INFO - 2015-11-20 07:15:42,752 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,752 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 07:15:42 INFO - 2015-11-20 07:15:42,752 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 110.0 07:15:42 INFO - 2015-11-20 07:15:42,752 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,753 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 07:15:42 INFO - 2015-11-20 07:15:42,753 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 146.0 147.0 146.0 145.0 146.0 145.0 145.0 07:15:42 INFO - 2015-11-20 07:15:42,753 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,753 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:15:42 INFO - 2015-11-20 07:15:42,753 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 07:15:42 INFO - 2015-11-20 07:15:42,753 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,753 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.80 Median:63.50 stddev:3.43 (5.4%) stddev-sans-first:3.62 07:15:42 INFO - 2015-11-20 07:15:42,753 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 63.0 62.0 64.0 64.0 68.0 71.0 59.0 61.0 07:15:42 INFO - 2015-11-20 07:15:42,753 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,754 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:1.07 (1.5%) stddev-sans-first:0.97 07:15:42 INFO - 2015-11-20 07:15:42,754 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 70.0 69.0 70.0 72.0 70.0 69.0 69.0 70.0 07:15:42 INFO - 2015-11-20 07:15:42,754 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,754 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.50 stddev:3.05 (3.6%) stddev-sans-first:3.06 07:15:42 INFO - 2015-11-20 07:15:42,754 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 85.0 83.0 93.0 83.0 84.0 84.0 85.0 85.0 07:15:42 INFO - 2015-11-20 07:15:42,754 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,754 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:123.00 stddev:6.97 (5.7%) stddev-sans-first:7.39 07:15:42 INFO - 2015-11-20 07:15:42,754 DEBUG : BROWSER_OUTPUT: Values: 121.0 129.0 116.0 115.0 125.0 130.0 114.0 130.0 114.0 115.0 07:15:42 INFO - 2015-11-20 07:15:42,754 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,755 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.10 Median:149.00 stddev:5.80 (3.9%) stddev-sans-first:6.10 07:15:42 INFO - 2015-11-20 07:15:42,755 DEBUG : BROWSER_OUTPUT: Values: 145.0 154.0 154.0 150.0 150.0 137.0 148.0 147.0 148.0 138.0 07:15:42 INFO - 2015-11-20 07:15:42,755 DEBUG : BROWSER_OUTPUT: 07:15:42 INFO - 2015-11-20 07:15:42,755 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:1.37 (2.0%) stddev-sans-first:1.27 07:15:42 INFO - 2015-11-20 07:15:42,755 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 69.0 68.0 68.0 68.0 69.0 65.0 67.0 69.0 07:15:42 INFO - 2015-11-20 07:15:42,755 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:15:42 INFO - 2015-11-20 07:15:42,755 DEBUG : BROWSER_OUTPUT: 07:15:43 INFO - 2015-11-20 07:15:43,597 INFO : Browser exited with error code: 0 07:15:43 INFO - 2015-11-20 07:15:43,651 INFO : Completed test kraken (00:00:58) 07:15:43 INFO - 2015-11-20 07:15:43,651 INFO : Starting test v8_7 07:15:43 INFO - 2015-11-20 07:15:43,651 DEBUG : operating with platform_type : linux_ 07:15:43 INFO - 2015-11-20 07:15:43,651 INFO : Initialising browser for v8_7 test... 07:15:43 INFO - 2015-11-20 07:15:43,657 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwMDm8K/profile http://localhost:58267/getInfo.html 07:15:47 INFO - 2015-11-20 07:15:47,391 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:15:47 INFO - 2015-11-20 07:15:47,391 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:15:47 INFO - 2015-11-20 07:15:47,391 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:15:47 INFO - 2015-11-20 07:15:47,391 DEBUG : BROWSER_OUTPUT: __metrics 07:15:47 INFO - 2015-11-20 07:15:47,516 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:15:48 INFO - 2015-11-20 07:15:48,628 INFO : Browser initialized. 07:15:48 INFO - 2015-11-20 07:15:48,628 INFO : Running cycle 1/1 for v8_7 test... 07:15:48 INFO - 2015-11-20 07:15:48,628 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwMDm8K/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:16:00 INFO - 2015-11-20 07:16:00,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 142360576 07:16:00 INFO - 2015-11-20 07:16:00,413 DEBUG : BROWSER_OUTPUT: 07:16:21 INFO - 2015-11-20 07:16:21,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58267/tests/v8_7/run.html (next: http://localhost:58267/tests/v8_7/run.html) 07:16:22 INFO - 2015-11-20 07:16:22,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 608595968 07:16:22 INFO - 2015-11-20 07:16:22,051 DEBUG : BROWSER_OUTPUT: 07:16:22 INFO - 2015-11-20 07:16:22,051 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:16:22 INFO - 2015-11-20 07:16:22,051 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:16:22 INFO - 2015-11-20 07:16:22,052 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:16:22 INFO - 2015-11-20 07:16:22,052 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:16:22 INFO - 2015-11-20 07:16:22,052 DEBUG : BROWSER_OUTPUT: |0;Richards;164.06890894175552 07:16:22 INFO - 2015-11-20 07:16:22,052 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.98642095053347 07:16:22 INFO - 2015-11-20 07:16:22,052 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.46959748786753 07:16:22 INFO - 2015-11-20 07:16:22,052 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025.125628140703 07:16:22 INFO - 2015-11-20 07:16:22,053 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1113.4593993325918 07:16:22 INFO - 2015-11-20 07:16:22,053 DEBUG : BROWSER_OUTPUT: |5;Earley;777.1739130434783 07:16:22 INFO - 2015-11-20 07:16:22,053 DEBUG : BROWSER_OUTPUT: |6;Boyer;11894.117647058823 07:16:22 INFO - 2015-11-20 07:16:22,053 DEBUG : BROWSER_OUTPUT: |7;RegExp;27944.444444444445 07:16:22 INFO - 2015-11-20 07:16:22,053 DEBUG : BROWSER_OUTPUT: |8;Splay;659.4202898550725 07:16:22 INFO - 2015-11-20 07:16:22,054 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 07:16:22 INFO - 2015-11-20 07:16:22,054 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:16:22 INFO - 2015-11-20 07:16:22,054 DEBUG : BROWSER_OUTPUT: __startTimestamp1448032582050__endTimestamp 07:16:22 INFO - 2015-11-20 07:16:22,054 DEBUG : BROWSER_OUTPUT: 07:16:22 INFO - 2015-11-20 07:16:22,054 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:16:22 INFO - 2015-11-20 07:16:22,056 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:16:22 INFO - 2015-11-20 07:16:22,056 DEBUG : BROWSER_OUTPUT: 07:16:22 INFO - 2015-11-20 07:16:22,056 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.07 Median:164.07 stddev:0.00 (0.0%) 07:16:22 INFO - 2015-11-20 07:16:22,056 DEBUG : BROWSER_OUTPUT: Values: 164.1 07:16:22 INFO - 2015-11-20 07:16:22,056 DEBUG : BROWSER_OUTPUT: 07:16:22 INFO - 2015-11-20 07:16:22,056 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.99 Median:193.99 stddev:0.00 (0.0%) 07:16:22 INFO - 2015-11-20 07:16:22,056 DEBUG : BROWSER_OUTPUT: Values: 194.0 07:16:22 INFO - 2015-11-20 07:16:22,056 DEBUG : BROWSER_OUTPUT: 07:16:22 INFO - 2015-11-20 07:16:22,057 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.47 Median:285.47 stddev:0.00 (0.0%) 07:16:22 INFO - 2015-11-20 07:16:22,057 DEBUG : BROWSER_OUTPUT: Values: 285.5 07:16:22 INFO - 2015-11-20 07:16:22,057 DEBUG : BROWSER_OUTPUT: 07:16:22 INFO - 2015-11-20 07:16:22,057 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.13 Median:5025.13 stddev:0.00 (0.0%) 07:16:22 INFO - 2015-11-20 07:16:22,057 DEBUG : BROWSER_OUTPUT: Values: 5025.1 07:16:22 INFO - 2015-11-20 07:16:22,057 DEBUG : BROWSER_OUTPUT: 07:16:22 INFO - 2015-11-20 07:16:22,057 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1113.46 Median:1113.46 stddev:0.00 (0.0%) 07:16:22 INFO - 2015-11-20 07:16:22,058 DEBUG : BROWSER_OUTPUT: Values: 1113.5 07:16:22 INFO - 2015-11-20 07:16:22,058 DEBUG : BROWSER_OUTPUT: 07:16:22 INFO - 2015-11-20 07:16:22,058 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:777.17 Median:777.17 stddev:0.00 (0.0%) 07:16:22 INFO - 2015-11-20 07:16:22,058 DEBUG : BROWSER_OUTPUT: Values: 777.2 07:16:22 INFO - 2015-11-20 07:16:22,058 DEBUG : BROWSER_OUTPUT: 07:16:22 INFO - 2015-11-20 07:16:22,058 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11894.12 Median:11894.12 stddev:0.00 (0.0%) 07:16:22 INFO - 2015-11-20 07:16:22,058 DEBUG : BROWSER_OUTPUT: Values: 11894.1 07:16:22 INFO - 2015-11-20 07:16:22,059 DEBUG : BROWSER_OUTPUT: 07:16:22 INFO - 2015-11-20 07:16:22,059 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27944.44 Median:27944.44 stddev:0.00 (0.0%) 07:16:22 INFO - 2015-11-20 07:16:22,059 DEBUG : BROWSER_OUTPUT: Values: 27944.4 07:16:22 INFO - 2015-11-20 07:16:22,059 DEBUG : BROWSER_OUTPUT: 07:16:22 INFO - 2015-11-20 07:16:22,059 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:659.42 Median:659.42 stddev:0.00 (0.0%) 07:16:22 INFO - 2015-11-20 07:16:22,059 DEBUG : BROWSER_OUTPUT: Values: 659.4 07:16:22 INFO - 2015-11-20 07:16:22,059 DEBUG : BROWSER_OUTPUT: 07:16:22 INFO - 2015-11-20 07:16:22,059 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 07:16:22 INFO - 2015-11-20 07:16:22,060 DEBUG : BROWSER_OUTPUT: Values: 4830.9 07:16:22 INFO - 2015-11-20 07:16:22,060 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:16:22 INFO - 2015-11-20 07:16:22,060 DEBUG : BROWSER_OUTPUT: 07:16:22 INFO - 2015-11-20 07:16:22,941 INFO : Browser exited with error code: 0 07:16:22 INFO - 2015-11-20 07:16:22,954 INFO : Completed test v8_7 (00:00:39) 07:16:23 INFO - 2015-11-20 07:16:23,065 INFO : Completed test suite (00:20:10) 07:16:23 INFO - 2015-11-20 07:16:23,065 DEBUG : Working with test: dromaeo_css 07:16:23 INFO - 2015-11-20 07:16:23,066 DEBUG : Generating results file: dromaeo_css 07:16:23 INFO - 2015-11-20 07:16:23,067 DEBUG : Working with test: kraken 07:16:23 INFO - 2015-11-20 07:16:23,067 DEBUG : Generating results file: kraken 07:16:23 INFO - 2015-11-20 07:16:23,067 INFO : javascript benchmark 07:16:23 INFO - 2015-11-20 07:16:23,067 DEBUG : Working with test: v8_7 07:16:23 INFO - 2015-11-20 07:16:23,067 DEBUG : Generating results file: v8_7 07:16:23 INFO - 2015-11-20 07:16:23,068 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:16:23 INFO - 2015-11-20 07:16:23,129 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:16:23 INFO - 2015-11-20 07:16:23,129 DEBUG : process_Request line: dromaeo_css 6984.18 graph.html#tests=[[72,1,35]] 07:16:23 INFO - 2015-11-20 07:16:23,129 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:16:23 INFO - 2015-11-20 07:16:23,174 DEBUG : process_Request line: kraken 1505.10 graph.html#tests=[[232,1,35]] 07:16:23 INFO - 2015-11-20 07:16:23,174 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:16:23 INFO - 2015-11-20 07:16:23,205 DEBUG : process_Request line: v8_7 20766.70 graph.html#tests=[[230,1,35]] 07:16:23 INFO - 2015-11-20 07:16:23,206 INFO : javascript benchmark 07:16:23 INFO - 2015-11-20 07:16:23,210 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3192.4892017277234, 3261.7390608751302, 3303.966960330396, 3315.287213249151, 3333.7833040852333, 5277.234800953869, 5418.83743487695, 5474.589405794566, 5476.507114359707, 5485.09495933171, 5362.785488580452, 5376.731163441832, 5424.755885985131, 5451.836444906659, 5513.2005859150395, 4887.364642596466, 4960.900781984358, 5021.221710634857, 5029.0, 5037.94203217323, 4852.805887764485, 5065.898682026357, 5068.493150684921, 5087.414947281054, 5133.3326667533165, 4918.655694101397, 4933.284673722326, 4999.500049994971, 5015.874603134915, 5036.949630503685, 5024.296598476216, 5044.697318160922, 5047.722375269359, 5057.974710126463, 5092.821751238689, 4805.471398146201, 4942.975285123552, 4990.800367985276, 5000.0, 5017.67385119966, 5279.762410691528, 5349.866253343697, 5352.090144675414, 5372.328458942632, 5390.326209223847, 5911.083782013752, 5925.822225333247, 5928.851778705523, 5928.940710592882, 5931.851703707399, 5652.943470565283, 5785.855353616151, 5847.8245652630485, 5947.137665038588, 5964.522838172936, 5566.471185237396, 5567.053600887859, 5570.442955704397, 5572.832815015516, 5591.440855914376, 5981.132735753292, 5990.011648078105, 6001.729922153513, 6003.729832157564, 6030.30651475086, 5616.85957851057, 5696.601237913306, 5736.741846616912, 5832.0, 5851.61964472308, 5922.555808314393, 5932.466078052996, 5946.554008449383, 5950.077737950624, 5958.6722730249385, 5849.649021058665, 5871.0, 5931.466168044896, 5933.376995415506, 5937.168796368512, 5723.484886360247, 5749.597528172988, 5815.127730840408, 5825.650460972355, 5876.882462350729, 4532.909341813145, 4567.81728730847, 4574.931376029363, 4591.288350305708, 4621.792019359137, 3963.8018099095507, 4064.5935406459116, 4068.6948478864206, 4074.0425999890003, 4117.0, 5445.128779395278, 5475.4250803665045, 5502.889942201134, 5549.5837812163445, 5580.218769372291, 5926.496247818984, 5931.347551769302, 5931.555133365015, 5935.881282374328, 5957.523398128139, 5397.649152805055, 5617.578681598897, 5620.381758006616, 5621.578381621394, 5628.634138780966, 4867.732274724854, 4901.828436004794, 4946.109700253917, 5053.090443720165, 5080.339555857715, 6095.299040610386, 6095.8476038098515, 6097.054956481752, 6104.26748790148, 6109.14471973924, 5769.826905192851, 5827.24245848037, 5880.970595146997, 5889.617174883619, 5895.233619629421, 6021.42796434338, 6032.1856549365275, 6037.939620603738, 6131.325554188947, 6145.600535965148, 5723.484886360247, 5757.107648314518, 5758.1362795581, 5760.855978600569, 5860.794872179454, 5800.7099645018425, 5829.446202610745, 5834.562407819515, 5836.066229403275, 5860.619059761102, 5728.112142617901, 5781.392953739797, 5876.6180198286975, 5885.117232415172, 5916.970415147896, 5699.943000569941, 5700.486956173964, 5702.287214098238, 5707.486326230659, 5720.313562372542, 5514.834554963358, 5608.6073974821375, 5610.410906854721, 5621.887562248814, 5629.183768353648, 5751.1373294006235, 5825.2135961644635, 5867.853303667272, 5878.265216847894, 5883.352831188651, 5603.38362780102, 5676.659400435987, 5724.79963201286, 5729.512991395778, 5738.0], "unit": "ms", "name": "dojo.html", "value": 5420.364136323032}, {"lowerIsBetter": false, "replicates": [560.4039578529524, 590.592491181085, 596.8418369132181, 618.251915182629, 672.5493919074216, 30612.010219335756, 31558.68441315592, 31603.0, 31617.36765264696, 31621.525677114834, 32764.836175819146, 33216.501752473734, 38179.42730859039, 38416.61583384165, 38428.80785596075, 8712.477251364922, 8786.912130878673, 8795.0, 8886.0, 8891.0, 7699.307062364386, 8644.913550864505, 8737.563121843914, 8769.123087691212, 8781.473111613324, 7647.847043059135, 10425.322354046963, 10591.25861189717, 10623.57505699771, 10674.306170098958, 10190.64332748354, 10326.48367581618, 10337.793244135113, 10345.120664743506, 10354.741131471697, 7720.53676779395, 7964.721234756756, 10143.644972426004, 10301.74245643865, 10400.531976061095, 38752.80623596864, 39184.0, 39235.80382098071, 39255.60744392548, 39285.0, 3110.906672799797, 3123.9687603123907, 3129.8278594677286, 3135.843207839599, 3839.905626896349, 29133.271668208254, 30503.847480762677, 30666.23334416635, 30678.38643227123, 30825.0, 3567.9821600892087, 3606.353005709716, 3623.8188090595363, 3693.6121707220623, 3755.6432138946757, 268931.0, 269824.0, 269903.0, 271349.64325178444, 271480.0, 56193.71903140458, 56634.716826415606, 56665.0, 56671.716641417355, 56777.0, 59554.0, 59575.0, 59584.70207648934, 59625.40374596285, 59642.40357596368, 14981.101133932, 15462.690746185239, 15507.069575825486, 15516.922415388077, 15525.456609018856, 11795.941020295015, 11838.585649502225, 11839.822402663967, 11842.171048026728, 11865.5847045353, 18412.539686507676, 18749.250029998646, 18941.90529047346, 19011.714824277646, 19033.95313257784, 7571.886421703679, 7794.103678077094, 7837.49056311338, 7932.206779322021, 7957.084935232407, 953.713885834247, 1022.2997246885907, 1058.9311694739818, 1112.2825777373548, 1123.095907794217, 28269.43461130807, 28478.0, 28582.857085714437, 28604.713952860206, 28645.427091458056, 874.3180319350917, 1004.3521928356315, 1015.4719545836272, 1068.273573969708, 1145.0839328537138, 13792.655183620289, 14201.23622628795, 14257.21585312797, 14361.85638143626, 14427.35076921541, 328045.0, 332464.0, 333489.0, 335559.0, 335931.0, 51805.48194518082, 52005.479945200066, 52152.47847521476, 52341.7382913083, 52367.0, 1188.506769690586, 1202.8857258560422, 1311.8556958734723, 1314.106407642812, 1320.795276732108, 28792.424151516432, 29794.404111917207, 29879.850600747726, 29968.0, 30497.0, 42450.575494245895, 42839.78580107079, 46769.53230467652, 47430.76284618555, 47584.52415475939, 319569.0, 323149.0, 323945.0, 325163.0, 325409.0, 41278.41121728524, 41500.37749433701, 42008.78995605002, 42082.368764467945, 42126.36810447784, 43933.56066439295, 44305.778471107435, 44401.11197776091, 44786.3282050763, 45166.548334516236, 37992.240155197294, 38631.03422414462, 38882.80558597189, 41787.1642567153, 42443.7877810609, 40491.0, 41136.58863411447, 41448.792756036026, 41496.0, 42702.57297426986, 36940.81529592335, 36999.63000369962, 37301.0, 41038.38442423306, 41552.58447415487, 32796.508052378755, 34363.31273374568, 34715.91704497738, 34983.475247870796, 35374.40132782722, 26249.606255906558, 26478.735212647625, 26591.7340826597, 26722.46555068849, 26748.732512675404], "unit": "ms", "name": "ext.html", "value": 18837.69775017352}, {"lowerIsBetter": false, "replicates": [359.35316430425235, 360.44491483115985, 363.3387235231878, 364.50427418710547, 367.1793541434891, 14304.284785760696, 14339.71320573588, 16434.34262629495, 17235.655286894256, 18078.276868925244, 10746.408947507884, 11019.724506887333, 16257.268422920968, 16714.0, 16735.246913888874, 4293.742375457475, 4889.315495830587, 4896.069746748107, 4896.338994235786, 4897.33885925399, 3784.8107594620296, 3899.415087736848, 4835.032993401316, 4875.268709693539, 5055.646104772649, 5203.635745497817, 5219.0, 5229.7385130743505, 5238.05714971305, 5239.318888544484, 5231.790728370861, 5240.34495688039, 5290.1800220965615, 5491.313585801775, 5493.176023596453, 5276.103062479349, 5283.947160528384, 5292.497212764782, 5293.86765330866, 5297.576193904517, 12495.812562811565, 12715.491380344774, 16450.67098658032, 18716.157772900253, 19441.611167776708, 2011.2859934723256, 2028.6449871272468, 2101.1070295124664, 2175.282156888223, 2239.317008312464, 9173.58718857653, 9228.723138305795, 9321.067893210624, 9359.812803743887, 9382.85925711115, 1774.0774797105562, 1812.664657038452, 1816.6275913437846, 1845.3172326239244, 1900.0404795578145, 59981.40018599802, 62202.68898655478, 62514.374856251765, 64030.679846600935, 64087.0, 10002.199824014062, 10023.69928902134, 10128.493575321352, 10144.543495542719, 10157.94921025405, 13347.06570540053, 13473.461061557624, 13480.5281815136, 13514.729705405836, 13517.188968661714, 7158.391536719437, 7220.0, 7358.484906056525, 7384.076990376203, 7440.2931721486375, 7059.7529086482755, 7110.0, 7129.073220481304, 7197.748078817216, 7204.9639751800905, 4316.568343165721, 4343.782810859508, 4357.085012147421, 4373.934390984138, 4428.535003824552, 1716.9484915452556, 1756.1745979389666, 1774.609585891102, 1783.1530023239118, 1844.9169787359601, 901.4681338010605, 906.8141031088611, 926.5737760630186, 981.3719219699398, 998.7253505285959, 16102.75845862313, 16196.67606647884, 16391.541268809775, 16610.50168494947, 16844.0, 804.2882049386335, 834.8497270491248, 875.6366108065082, 942.189716843514, 946.9100435458621, 8761.167689069529, 9061.818763624822, 9121.31590130743, 9131.0, 9266.305027122993, 414914.0, 457027.0, 485791.707704842, 502036.0, 504862.0, 81269.59365203136, 82408.17591824006, 82700.17299827046, 83450.0, 83644.58177709073, 1109.7891400633853, 1158.803003489392, 1164.3537836500655, 1177.664365655801, 1180.6753142885775, 15010.324535395715, 15096.39614415411, 15370.615734606725, 15382.923085384502, 15561.610959725645, 34365.0, 34738.65261347354, 34755.60977560869, 34974.0, 35908.820455897556, 46687.29969050535, 46965.0, 47914.760426197645, 49725.502744973535, 49909.75045124751, 9441.669541566012, 9544.95227523858, 9651.855222171813, 9676.467794271382, 9677.854832177381, 11330.490127944098, 16729.665406692042, 16762.916185418995, 17000.149992500574, 17595.648087038444, 13405.396757146147, 13658.726825463236, 13811.378487968266, 13960.2321872298, 14244.715105698035, 13769.380377882819, 13816.516421925184, 13940.58178254654, 14032.789508157182, 14307.57077287683, 11593.420328983686, 12009.692414202631, 12254.938725306316, 13986.44054237819, 14194.43222271139, 8731.563421828756, 9121.407108537924, 9562.856557151787, 9638.42169469834, 9743.220542356452, 9103.544822758968, 9189.081091890757, 9322.254219662547, 13581.592552223448, 14418.279086045866], "unit": "ms", "name": "jquery.html", "value": 8507.572539415625}, {"lowerIsBetter": false, "replicates": [1319.076646347557, 1448.5219877440445, 1454.5054681408321, 1472.4772705689486, 1478.5180898982894, 6702.865942681149, 7743.186965368633, 7827.569483678395, 7836.8824467632885, 7840.1767814379455, 7620.085589729227, 7661.387089032878, 7666.578338191397, 7688.308052275294, 7727.188645192258, 1993.7806841247452, 2057.5164836263466, 2254.0532976150057, 2282.1441959265276, 2305.3890718959487, 2308.319045881469, 2314.0512389920136, 2315.0, 2315.918942837001, 2317.06159005603, 2210.7899749523767, 2282.3723476044056, 2282.4636210490603, 2284.5088306014204, 2287.1994801819314, 2033.6237796007786, 2084.562241929189, 2227.231605096239, 2259.1641092795608, 2260.762619924917, 2286.211257116292, 2287.2223444028946, 2313.097891822191, 2318.142287353673, 2324.2097686786574, 7595.734149304748, 7628.0846298443985, 7636.7327143550265, 7646.235376462365, 7650.617469126577, 4547.340635607851, 4634.050019745944, 4639.396878405786, 4652.999605084923, 4653.767311634439, 3015.6079709637825, 3060.8775648974015, 3061.9693803062128, 3082.7996180248438, 3136.54520094585, 1044.102072217892, 1055.2824079625852, 1062.6811956413046, 1063.2663462211126, 1084.6474895658864, 10514.369137851754, 10549.367037977823, 10669.893301066968, 10682.946585267024, 10699.572017119306, 4269.765162916007, 4271.060366719316, 4346.8043938022865, 4350.390945267665, 4415.315626077963, 8657.393982421296, 8793.648254069894, 8796.8680469793, 8801.07588703177, 8808.47149171039, 4722.055588882237, 4731.952680473151, 4749.976250118727, 4750.572448479654, 4756.6908150970075, 4328.956710432918, 4343.804528796211, 4345.435093437896, 4347.434833471629, 4348.478182618042, 3519.0, 3524.8942531724088, 3533.840977156034, 3544.326577950181, 3567.7859328440377, 1105.8451816745662, 1117.1286396610656, 1121.433675993618, 1135.8807325230896, 1143.7140714821294, 1315.1385842273326, 1329.913555618901, 1335.0721248732232, 1351.290572449472, 1354.4446776821653, 7129.14450265961, 7298.087739032621, 7298.781036568911, 7381.741639042608, 7390.260973902567, 1042.4266653340633, 1057.534684738728, 1108.9168312376603, 1112.0991996482712, 1128.8936841894988, 5709.82870513877, 5728.828135155952, 5746.396628354046, 5756.136579513107, 5761.971190144022, 9054.909450905538, 9104.726858194264, 9303.34876558648, 9308.650245714334, 9325.347225694137, 9218.63125474987, 9270.119338662817, 9284.814303714023, 9285.25717942563, 9288.90711092894, 7044.36600705939, 7216.170140433812, 7237.131544214622, 7314.817129571803, 7364.96317518409, 7254.637268136466, 7301.050863387725, 7306.305900939402, 7307.378872795872, 7312.0, 7930.682772689028, 8173.060098088796, 8274.213949674771, 8285.62714677853, 8308.044574873968, 8335.458195217292, 8503.74488765338, 8512.659493620433, 8650.956745216234, 8676.219140277406, 6597.439217666552, 6742.123523941857, 6744.527883048336, 6753.561018533779, 6936.930630693831, 7364.484486086137, 7407.0, 7408.851822963618, 7409.37020353276, 7412.888806667796, 5999.340072591924, 6883.346082122191, 7079.929200708133, 7215.963920180366, 7244.130704315305, 6929.653517324013, 6984.7206111757, 7010.26392228829, 7105.32499412555, 7107.168754283803, 7019.929800701928, 7099.716011359487, 7108.431325494052, 7112.217656057933, 7115.324044215791, 6492.383223593751, 6503.577267477599, 6512.739490420519, 6513.478921686159, 6519.250286217146, 6514.250861151028, 6554.868902622016, 6593.472522198309, 6643.7674681385915, 6650.767223147167], "unit": "ms", "name": "mootools.html", "value": 4470.774708001697}, {"lowerIsBetter": false, "replicates": [328.5564487941279, 331.61698238534484, 333.6130089096648, 334.48322341981634, 337.35901786605444, 6111.419415155564, 6114.663693496856, 6145.8770824583535, 6148.692565371724, 6155.846103847401, 5730.36965933747, 5863.648181109136, 5912.704364781765, 6015.639061656304, 6021.0, 4599.586037256646, 4608.423947006624, 4612.238980568202, 4623.006053698463, 4627.3521706961055, 4419.73481591104, 4593.655475839309, 4605.815767369301, 4617.8152873885, 4630.583247507724, 4438.800253988562, 4464.084862603175, 4569.4516658001085, 4575.336576196466, 4579.152856721501, 4542.295944128666, 4561.407017087774, 4562.726236425825, 4562.749048802315, 4562.977185114053, 3990.2817492851277, 4019.537753158395, 4021.678265738734, 4021.9396709049097, 4023.1752490739623, 5554.750036248379, 5668.206451096849, 5675.34733505648, 5682.54539636828, 5688.374278829326, 5257.579393648499, 5259.737013149327, 5265.420803711589, 5274.789008439696, 5275.86810329741, 6413.7434502619835, 6417.454516366114, 6423.582467139621, 6425.807225783234, 6430.678466076677, 4352.630026447756, 4353.08585197109, 4355.194289056503, 4358.411614432042, 4370.825166993316, 6540.771073012422, 6605.240397354318, 6652.3680250375655, 6653.60078395293, 6662.400383965466, 4520.660950428731, 4526.524714904887, 4527.705699129546, 4530.433695788027, 4530.750808705487, 4573.56551127649, 4576.8626941191815, 4577.473590537064, 4577.565131312586, 4587.6788624795945, 5306.7611957462, 5307.28351672527, 5315.548178404802, 5322.494363035506, 5323.574114070865, 6336.271328797156, 6434.517411194179, 6458.838529036718, 6466.062420948936, 6468.3855033771715, 1605.229489844881, 1617.4258138360713, 1620.5057457475584, 1620.5867503786694, 1620.8460196281335, 1051.784384201237, 1053.6154303679102, 1060.6128763001602, 1068.5351871935734, 1072.2279958429917, 6249.187605611332, 6253.593516421418, 6254.093156492374, 6260.154879091356, 6261.812145635638, 6440.291567927524, 6658.533902626867, 6660.533762636569, 6663.20041595002, 6667.399934005963, 6147.44672979434, 6171.13604095427, 6266.717997690115, 6268.811935641938, 6281.811545653638, 3546.078019714893, 3599.460080987873, 3599.784012959231, 3602.2615363850346, 3607.7294202934886, 6784.08414863987, 6938.098047253926, 6941.0629565009085, 6966.303369663095, 6969.05917701114, 6891.207511136183, 6892.517523773287, 6896.862062758717, 6903.0, 6915.101036865276, 6927.930720692729, 6939.0, 6942.826429339307, 6946.722131114699, 6953.860922781516, 6569.441597464269, 6680.832979175365, 6698.330166983263, 6707.631080290631, 6711.094002309821, 6633.469322454289, 6636.435902948304, 6640.468762499085, 6641.667916604247, 6646.1027761253545, 6891.897296432547, 6934.341237582422, 6941.062956500808, 6941.3058694132205, 6944.618046007518, 4397.0, 4493.59557639814, 4494.280915053576, 4496.190685676479, 4501.18978583858, 6699.196096468455, 6708.899366509604, 6718.0594716738715, 6721.798346049626, 6722.193336799615, 6462.547621666627, 6465.450436712744, 6466.838329041811, 6475.611463312216, 6478.546501744832, 6356.872862542816, 6499.122618446639, 6502.122213501306, 6503.057056726842, 6508.088867558451, 6391.648459334781, 6391.9041214380895, 6396.10454536356, 6400.327965563549, 6400.42396184327, 6482.124913136855, 6486.286508484157, 6536.8365790855605, 6553.0, 6556.672166391757, 6231.2834024086, 6374.458171055327, 6374.681265936777, 6385.87228255423, 6415.807525774234], "unit": "ms", "name": "prototype.html", "value": 4838.7708132390335}, {"lowerIsBetter": false, "replicates": [757.9696812127515, 827.6813426830672, 844.1389782421926, 844.94085414021, 881.2597418168739, 12853.357332133392, 13110.672233194175, 13117.54088606899, 13135.211887286758, 13135.868641313584, 12546.059045571596, 12621.495140194382, 12624.81062784059, 12646.30445325509, 12654.05094617905, 783.7962129846253, 815.384384789486, 817.3175398542195, 818.8403261364007, 822.7943014246439, 821.8150916043872, 830.900291964965, 832.1221111727125, 834.4784509681449, 835.8286551256978, 862.7153039496982, 867.6312567158964, 870.8476016697084, 873.7204094689702, 875.4528419737663, 865.0743704236501, 865.3942240431692, 865.9783505412383, 866.8569686001803, 868.7176667583061, 628.8019273928697, 635.0474288567149, 635.4344633276388, 635.7838334966087, 635.8696467224208, 12615.495380184782, 12664.240145591293, 12744.299063551502, 12758.936205318914, 12819.551315703906, 11311.490982905789, 12126.939365303206, 12217.877821221762, 12291.56979505713, 12320.365224295285, 9970.850437243447, 10140.188784897264, 10157.949210253975, 10208.234382421273, 10281.485925703684, 3510.701590364822, 3601.891943241707, 3606.4229723244416, 3726.142987112979, 3727.9627203727887, 38714.41928371077, 39852.402213966816, 40699.186016279506, 40746.79626601878, 48218.51781482175, 9711.902880971242, 9812.264080194014, 9844.507774611384, 9868.901310986797, 9938.503074846229, 17201.483955481355, 17214.31142754301, 17254.137293135544, 17280.567985800204, 17287.827121728875, 7138.9286107139305, 7154.177269614061, 7322.121345438475, 7335.376492998048, 7703.537787732642, 4099.487564054493, 4182.1844740275965, 4271.508776490681, 4336.934945975813, 4348.9997300621035, 3105.6428510721557, 3145.418097651942, 3149.1969547765175, 3149.9685003150134, 3151.322465669892, 566.6481422673822, 581.9010768169421, 587.7149582452507, 589.1986897818963, 596.3023262782555, 481.78078974067415, 558.5587385965123, 568.4486048532916, 642.0882347067176, 657.5035847934779, 7760.883586746203, 7927.5243485391065, 8007.199280071946, 8027.759167224993, 8267.503949763033, 647.9838004049936, 651.941325280727, 658.0754040573003, 658.1838520234875, 660.6663634864459, 3635.654612811779, 3799.886003419902, 3869.6517313441927, 3887.475190849256, 3927.23418933311, 54327.72836135873, 54553.45446545563, 54625.45374546283, 56492.0, 58452.0, 48970.755146224044, 49538.25692614614, 50054.74972625114, 50239.74880125576, 50344.49655503471, 40100.598994009684, 41446.79276603598, 46726.76636616863, 47155.5284447158, 47525.28712069322, 7941.563214023284, 8141.715039973573, 8321.750347489586, 8399.95800020996, 8408.117147699648, 34172.82913585416, 34646.13384665403, 35060.649393506756, 35386.823065884506, 35864.28271434609, 42995.3550696746, 43419.34870977001, 45634.31548526841, 45930.0, 46206.537934620224, 10796.838047429452, 10841.620543280947, 11001.669949901516, 11048.337099774039, 11091.611793587186, 11367.602133925273, 11502.712432188928, 11568.652940411801, 11584.536618535165, 11619.302841829518, 10761.784764304826, 10986.450677465935, 11034.0, 11048.889511104786, 11057.281276716987, 11316.26444281119, 11371.943140284577, 11452.3701196435, 11458.598949036743, 11477.598284060017, 10820.296680715728, 10870.293430926964, 10902.836457452986, 10997.670069897917, 11036.5033573491, 9314.673986410444, 9363.906360936304, 9517.904820951702, 9594.66418675343, 9670.661526846527, 8977.16265739998, 9091.90908090937, 9388.812223755624, 9477.099675530813, 9675.129238368581], "unit": "ms", "name": "yui.html", "value": 6175.544331968665}], "name": "dromaeo_css", "value": 6984.182213582806}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 104.0, 109.0, 109.0, 109.0, 98.0, 110.0, 109.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 107.1}, {"lowerIsBetter": true, "replicates": [154.0, 126.0, 152.0, 163.0, 132.0, 151.0, 161.0, 124.0, 162.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 162.0, 160.0, 162.0, 161.0, 160.0, 163.0, 163.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 90.0, 72.0, 71.0, 73.0, 116.0, 91.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 137.0, 90.0, 91.0, 91.0, 146.0, 89.0, 91.0, 145.0], "unit": "ms", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 147.0, 146.0, 145.0, 146.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 62.0, 64.0, 64.0, 68.0, 71.0, 59.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 63.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 69.0, 70.0, 72.0, 70.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 85.0, 83.0, 93.0, 83.0, 84.0, 84.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [121.0, 129.0, 116.0, 115.0, 125.0, 130.0, 114.0, 130.0, 114.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [145.0, 154.0, 154.0, 150.0, 150.0, 137.0, 148.0, 147.0, 148.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.1}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 69.0, 68.0, 68.0, 68.0, 69.0, 65.0, 67.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1505.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.06890894175552], "unit": "score", "name": "Richards", "value": 215.16568999999998}, {"lowerIsBetter": false, "replicates": [193.98642095053347], "unit": "score", "name": "DeltaBlue", "value": 340.8382899999999}, {"lowerIsBetter": false, "replicates": [285.46959748786753], "unit": "score", "name": "Encrypt", "value": 932.4320429999997}, {"lowerIsBetter": false, "replicates": [5025.125628140703], "unit": "score", "name": "Decrypt", "value": 52.970019}, {"lowerIsBetter": false, "replicates": [1113.4593993325918], "unit": "score", "name": "RayTrace", "value": 664.5855254745252}, {"lowerIsBetter": false, "replicates": [777.1739130434783], "unit": "score", "name": "Earley", "value": 857.5467972027974}, {"lowerIsBetter": false, "replicates": [11894.117647058823], "unit": "score", "name": "Boyer", "value": 56.0329920870425}, {"lowerIsBetter": false, "replicates": [27944.444444444445], "unit": "score", "name": "RegExp", "value": 32.59986083499008}, {"lowerIsBetter": false, "replicates": [659.4202898550725], "unit": "score", "name": "Splay", "value": 123.57975824175821}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20766.698601491375}]} 07:16:23 INFO - RETURN: dromaeo_css: 6984.18 07:16:23 INFO - RETURN: kraken: 1505.10 07:16:23 INFO - RETURN: v8_7: 20766.70 07:16:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20766.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1505.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6984.18"}}} 07:16:23 INFO - Return code: 0 07:16:23 INFO - # TBPL SUCCESS # 07:16:23 INFO - Running post-action listener: _resource_record_post_action 07:16:23 INFO - Running post-run listener: _resource_record_post_run 07:16:24 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509280256; Read time: 68; Write time: 455864 07:16:24 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 137965568; Read time: 0; Write time: 238624 07:16:24 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 287105024; Read time: 0; Write time: 163200 07:16:24 INFO - Running post-run listener: _upload_blobber_files 07:16:24 INFO - Blob upload gear active. 07:16:24 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:16:24 INFO - Copying logs to upload dir... 07:16:24 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.759562 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-20 07:16:24.217287) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 07:16:24.220510) ========= 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=d6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010075 build_url: 'https://queue.taskcluster.net/v1/task/WLHn9DQKRpeCg_SeB5s16Q/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-20 07:16:24.272329) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:16:24.272647) ========= 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=d6a7e047ef025f707024e163000001c3-1448031046.984822-1295283279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:16:24.322086) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 07:16:24.322420) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 07:16:24.322727) ========= ========= Total master_lag: 0.22 =========