builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1448069135.18 results: success (0) buildid: 20151120143004 builduid: c911a6e67f5543188ec7c293e255b8c1 revision: e75cf58a362650b61c8b8f73b01ddcf931482cd1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:35.185200) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:35.185967) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:35.186311) ========= 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=a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006650 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:35.208028) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:35.208387) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:35.222199) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:35.222690) ========= 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=a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004687 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:35.272270) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:35.272636) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:35.273068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:35.273358) ========= 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=a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 17:25:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2015-11-20 17:25:35 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111589 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:35.397854) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:35.398186) ========= 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=a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022451 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:35.448144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 17:25:35.448498) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev e75cf58a362650b61c8b8f73b01ddcf931482cd1 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev e75cf58a362650b61c8b8f73b01ddcf931482cd1 --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=a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 17:25:35,701 truncating revision to first 12 chars 2015-11-20 17:25:35,701 Setting DEBUG logging. 2015-11-20 17:25:35,701 attempt 1/10 2015-11-20 17:25:35,701 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/e75cf58a3626?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 17:25:36,580 unpacking tar archive at: b2g-inbound-e75cf58a3626/testing/mozharness/ program finished with exit code 0 elapsedTime=1.174318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 17:25:36.635596) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:36.635905) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:36.645290) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:36.645553) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 17:25:36.645935) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-20 17:25:36.646238) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:25:36 INFO - MultiFileLogger online at 20151120 17:25:36 in /builds/slave/test-pgo 17:25:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 17:25:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:25:36 INFO - {'append_to_log': False, 17:25:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:25:36 INFO - 'blob_upload_branch': 'B2G-Inbound', 17:25:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:25:36 INFO - 'branch': 'B2G-Inbound', 17:25:36 INFO - 'buildbot_json_path': 'buildprops.json', 17:25:36 INFO - 'config_files': ('talos/linux_config.py',), 17:25:36 INFO - 'default_actions': ('clobber', 17:25:36 INFO - 'read-buildbot-config', 17:25:36 INFO - 'download-and-extract', 17:25:36 INFO - 'populate-webroot', 17:25:36 INFO - 'create-virtualenv', 17:25:36 INFO - 'install', 17:25:36 INFO - 'run-tests'), 17:25:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:25:36 INFO - 'download_minidump_stackwalk': True, 17:25:36 INFO - 'download_symbols': 'ondemand', 17:25:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:25:36 INFO - 'tooltool.py': '/tools/tooltool.py', 17:25:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:25:36 INFO - '/tools/misc-python/virtualenv.py')}, 17:25:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:25:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:25:36 INFO - 'installer_path': 'installer.exe', 17:25:36 INFO - 'log_level': 'info', 17:25:36 INFO - 'log_name': 'talos', 17:25:36 INFO - 'log_to_console': True, 17:25:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:25:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:25:36 INFO - 'opt_config_files': (), 17:25:36 INFO - 'pip_index': False, 17:25:36 INFO - 'sps_profile': False, 17:25:36 INFO - 'sps_profile_interval': 0, 17:25:36 INFO - 'suite': 'dromaeojs', 17:25:36 INFO - 'system_bits': '64', 17:25:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:25:36 INFO - 'title': 'talos-linux64-ix-031', 17:25:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:25:36 INFO - 'use_talos_json': True, 17:25:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:25:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:25:36 INFO - 'work_dir': 'build'} 17:25:36 INFO - ##### 17:25:36 INFO - ##### Running clobber step. 17:25:36 INFO - ##### 17:25:36 INFO - Running pre-action listener: _resource_record_pre_action 17:25:36 INFO - Running main action method: clobber 17:25:36 INFO - rmtree: /builds/slave/test-pgo/build 17:25:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:25:37 INFO - Running post-action listener: _resource_record_post_action 17:25:37 INFO - ##### 17:25:37 INFO - ##### Running read-buildbot-config step. 17:25:37 INFO - ##### 17:25:37 INFO - Running pre-action listener: _resource_record_pre_action 17:25:37 INFO - Running main action method: read_buildbot_config 17:25:37 INFO - Using buildbot properties: 17:25:37 INFO - { 17:25:37 INFO - "properties": { 17:25:37 INFO - "buildnumber": 987, 17:25:37 INFO - "product": "firefox", 17:25:37 INFO - "script_repo_revision": "production", 17:25:37 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 17:25:37 INFO - "repository": "", 17:25:37 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 17:25:37 INFO - "buildid": "20151120143004", 17:25:37 INFO - "slavename": "talos-linux64-ix-031", 17:25:37 INFO - "pgo_build": "True", 17:25:37 INFO - "basedir": "/builds/slave/test-pgo", 17:25:37 INFO - "project": "", 17:25:37 INFO - "platform": "ubuntu64_hw", 17:25:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:25:37 INFO - "slavebuilddir": "test", 17:25:37 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 17:25:37 INFO - "branch": "b2g-inbound", 17:25:37 INFO - "repo_path": "integration/b2g-inbound", 17:25:37 INFO - "stage_platform": "linux64-pgo", 17:25:37 INFO - "builduid": "c911a6e67f5543188ec7c293e255b8c1", 17:25:37 INFO - "revision": "e75cf58a362650b61c8b8f73b01ddcf931482cd1" 17:25:37 INFO - }, 17:25:37 INFO - "sourcestamp": { 17:25:37 INFO - "repository": "", 17:25:37 INFO - "hasPatch": false, 17:25:37 INFO - "project": "", 17:25:37 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 17:25:37 INFO - "changes": [ 17:25:37 INFO - { 17:25:37 INFO - "category": null, 17:25:37 INFO - "files": [ 17:25:37 INFO - { 17:25:37 INFO - "url": null, 17:25:37 INFO - "name": "https://queue.taskcluster.net/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 17:25:37 INFO - } 17:25:37 INFO - ], 17:25:37 INFO - "repository": "", 17:25:37 INFO - "rev": "e75cf58a362650b61c8b8f73b01ddcf931482cd1", 17:25:37 INFO - "who": "sendchange", 17:25:37 INFO - "when": 1448069092, 17:25:37 INFO - "number": 6691571, 17:25:37 INFO - "comments": "", 17:25:37 INFO - "project": "", 17:25:37 INFO - "at": "Fri 20 Nov 2015 17:24:52", 17:25:37 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 17:25:37 INFO - "revlink": "", 17:25:37 INFO - "properties": [ 17:25:37 INFO - [ 17:25:37 INFO - "buildid", 17:25:37 INFO - "20151120143004", 17:25:37 INFO - "Change" 17:25:37 INFO - ], 17:25:37 INFO - [ 17:25:37 INFO - "builduid", 17:25:37 INFO - "c911a6e67f5543188ec7c293e255b8c1", 17:25:37 INFO - "Change" 17:25:37 INFO - ], 17:25:37 INFO - [ 17:25:37 INFO - "pgo_build", 17:25:37 INFO - "True", 17:25:37 INFO - "Change" 17:25:37 INFO - ] 17:25:37 INFO - ], 17:25:37 INFO - "revision": "e75cf58a362650b61c8b8f73b01ddcf931482cd1" 17:25:37 INFO - } 17:25:37 INFO - ], 17:25:37 INFO - "revision": "e75cf58a362650b61c8b8f73b01ddcf931482cd1" 17:25:37 INFO - } 17:25:37 INFO - } 17:25:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 17:25:37 INFO - Running post-action listener: _resource_record_post_action 17:25:37 INFO - ##### 17:25:37 INFO - ##### Running download-and-extract step. 17:25:37 INFO - ##### 17:25:37 INFO - Running pre-action listener: _resource_record_pre_action 17:25:37 INFO - Running main action method: download_and_extract 17:25:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:25: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')]} 17:25:37 INFO - https://queue.taskcluster.net/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:25:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/test_packages.json 17:25:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/test_packages.json 17:25:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:25:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:25:38 INFO - Downloaded 1302 bytes. 17:25:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:25:38 INFO - Using the following test package requirements: 17:25:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:25:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:38 INFO - u'jsshell-linux-x86_64.zip'], 17:25:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:25:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:25:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:25:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:25:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:25:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:25:38 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')]} 17:25:38 INFO - https://queue.taskcluster.net/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:25:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:25:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:25:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/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 17:25:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/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 17:25:39 INFO - Downloaded 22526045 bytes. 17:25:39 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 17:25:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:25:39 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 17:25:40 INFO - Return code: 0 17:25:40 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 17:25:40 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')]} 17:25:40 INFO - https://queue.taskcluster.net/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:25:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:25:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:25:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/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 17:25:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/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 17:25:42 INFO - Downloaded 22526045 bytes. 17:25:42 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 17:25:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:25:42 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 17:25:43 INFO - Return code: 0 17:25:43 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')]} 17:25:43 INFO - https://queue.taskcluster.net/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:25:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:25:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:25:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/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 17:25:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/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 17:25:45 INFO - Downloaded 11130997 bytes. 17:25:45 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 17:25:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:25:45 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 17:25:45 INFO - Return code: 0 17:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:45 INFO - https://queue.taskcluster.net/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:25:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:25:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:25:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/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 17:25:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0j9pKhSnSCCZUvr0es3rNQ/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 17:25:47 INFO - Downloaded 57347123 bytes. 17:25:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:25:47 INFO - mkdir: /builds/slave/test-pgo/properties 17:25:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:25:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:25:47 INFO - Contents: 17:25:47 INFO - build_url:https://queue.taskcluster.net/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:25:47 INFO - Running post-action listener: _resource_record_post_action 17:25:47 INFO - Running post-action listener: set_extra_try_arguments 17:25:47 INFO - ##### 17:25:47 INFO - ##### Running populate-webroot step. 17:25:47 INFO - ##### 17:25:47 INFO - Running pre-action listener: _resource_record_pre_action 17:25:47 INFO - Running main action method: populate_webroot 17:25:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:25:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:25:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:25:47 INFO - '../fennec_ids.txt'], 17:25:47 INFO - 'tests': ['tcheck2']}, 17:25:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:25:47 INFO - '--tppagecycles', 17:25:47 INFO - '7'], 17:25:47 INFO - 'tests': ['tsvgm']}}, 17:25:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:25:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:25:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:25:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:25:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:25:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:25:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:25:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:47 INFO - 'talos_options': ['--e10s'], 17:25:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:25:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:48 INFO - 'tests': ['damp', 'tps']}, 17:25:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:48 INFO - 'talos_options': ['--e10s'], 17:25:48 INFO - 'tests': ['damp', 'tps']}, 17:25:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:25:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:25:48 INFO - 'other': {'tests': ['a11yr', 17:25:48 INFO - 'ts_paint', 17:25:48 INFO - 'tpaint', 17:25:48 INFO - 'sessionrestore', 17:25:48 INFO - 'sessionrestore_no_auto_restore']}, 17:25:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:25:48 INFO - 'tests': ['a11yr', 17:25:48 INFO - 'ts_paint', 17:25:48 INFO - 'tpaint', 17:25:48 INFO - 'sessionrestore', 17:25:48 INFO - 'sessionrestore_no_auto_restore']}, 17:25:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:25:48 INFO - 'tests': ['a11yr', 17:25:48 INFO - 'ts_paint', 17:25:48 INFO - 'tpaint', 17:25:48 INFO - 'sessionrestore', 17:25:48 INFO - 'sessionrestore_no_auto_restore']}, 17:25:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:25:48 INFO - 'tests': ['a11yr', 17:25:48 INFO - 'ts_paint', 17:25:48 INFO - 'tpaint', 17:25:48 INFO - 'sessionrestore', 17:25:48 INFO - 'sessionrestore_no_auto_restore']}, 17:25:48 INFO - 'other_l64': {'tests': ['a11yr', 17:25:48 INFO - 'ts_paint', 17:25:48 INFO - 'tpaint', 17:25:48 INFO - 'sessionrestore', 17:25:48 INFO - 'sessionrestore_no_auto_restore']}, 17:25:48 INFO - 'other_nol64': {'tests': ['a11yr', 17:25:48 INFO - 'ts_paint', 17:25:48 INFO - 'tpaint', 17:25:48 INFO - 'sessionrestore', 17:25:48 INFO - 'sessionrestore_no_auto_restore']}, 17:25:48 INFO - 'svgr': {'tests': ['tsvgx', 17:25:48 INFO - 'tsvgr_opacity', 17:25:48 INFO - 'tart', 17:25:48 INFO - 'tscrollx', 17:25:48 INFO - 'cart']}, 17:25:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:25:48 INFO - 'tests': ['tsvgx', 17:25:48 INFO - 'tsvgr_opacity', 17:25:48 INFO - 'tart', 17:25:48 INFO - 'tscrollx', 17:25:48 INFO - 'cart']}, 17:25:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:48 INFO - 'tests': ['tp5o']}, 17:25:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:48 INFO - 'talos_options': ['--e10s'], 17:25:48 INFO - 'tests': ['tp5o']}, 17:25:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:48 INFO - 'talos_options': ['--xperf_path', 17:25:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:25:48 INFO - 'tests': ['tp5n']}, 17:25:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:48 INFO - 'talos_options': ['--e10s', 17:25:48 INFO - '--xperf_path', 17:25:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:25:48 INFO - 'tests': ['tp5n']}}, 17:25:48 INFO - 'talos.zip': {'path': '', 17:25:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:25:48 INFO - Running post-action listener: _resource_record_post_action 17:25:48 INFO - ##### 17:25:48 INFO - ##### Running create-virtualenv step. 17:25:48 INFO - ##### 17:25:48 INFO - Running pre-action listener: _resource_record_pre_action 17:25:48 INFO - Running main action method: create_virtualenv 17:25:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:25:48 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 17:25:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:25:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:25:48 INFO - Using real prefix '/usr' 17:25:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:25:48 INFO - Installing distribute.............................................................................................................................................................................................done. 17:25:50 INFO - Installing pip.................done. 17:25:50 INFO - Return code: 0 17:25:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:50 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 0x7f55fac6fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26af7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d70>, '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 0x26f4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f4fb0>, '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': 'a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129', '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 17:25:50 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 17:25:50 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 17:25:50 INFO - Using env: {'DISPLAY': ':0', 17:25:50 INFO - 'HOME': '/home/cltbld', 17:25:50 INFO - 'LANG': 'en_US.UTF-8', 17:25:50 INFO - 'LANGUAGE': 'en_US:en', 17:25:50 INFO - 'LOGNAME': 'cltbld', 17:25:50 INFO - 'MAIL': '/var/mail/cltbld', 17:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:50 INFO - 'MOZ_NO_REMOTE': '1', 17:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:50 INFO - 'NO_EM_RESTART': '1', 17:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:50 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:50 INFO - 'SHELL': '/bin/bash', 17:25:50 INFO - 'SHLVL': '1', 17:25:50 INFO - 'TERM': 'linux', 17:25:50 INFO - 'TMOUT': '86400', 17:25:50 INFO - 'USER': 'cltbld', 17:25:50 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129', 17:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:50 INFO - '_': '/tools/buildbot/bin/python'} 17:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:50 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 17:25:50 INFO - Cleaning up... 17:25:50 INFO - Return code: 0 17:25:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:50 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 0x7f55fac6fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26af7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d70>, '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 0x26f4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f4fb0>, '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': 'a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129', '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 17:25:50 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 17:25:50 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 17:25:50 INFO - Using env: {'DISPLAY': ':0', 17:25:50 INFO - 'HOME': '/home/cltbld', 17:25:50 INFO - 'LANG': 'en_US.UTF-8', 17:25:50 INFO - 'LANGUAGE': 'en_US:en', 17:25:50 INFO - 'LOGNAME': 'cltbld', 17:25:50 INFO - 'MAIL': '/var/mail/cltbld', 17:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:50 INFO - 'MOZ_NO_REMOTE': '1', 17:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:50 INFO - 'NO_EM_RESTART': '1', 17:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:50 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:50 INFO - 'SHELL': '/bin/bash', 17:25:50 INFO - 'SHLVL': '1', 17:25:50 INFO - 'TERM': 'linux', 17:25:50 INFO - 'TMOUT': '86400', 17:25:50 INFO - 'USER': 'cltbld', 17:25:50 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129', 17:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:50 INFO - '_': '/tools/buildbot/bin/python'} 17:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:51 INFO - Downloading/unpacking psutil>=0.7.1 17:25:51 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 17:25:51 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 17:25:51 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 17:25:51 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 17:25:51 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 17:25:51 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 17:25:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 17:25:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:25:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:25:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:52 INFO - Installing collected packages: psutil 17:25:52 INFO - Running setup.py install for psutil 17:25:52 INFO - building 'psutil._psutil_linux' extension 17:25:52 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 17:25:53 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 17:25:53 INFO - building 'psutil._psutil_posix' extension 17:25:53 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 17:25:53 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 17:25:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:53 INFO - Successfully installed psutil 17:25:53 INFO - Cleaning up... 17:25:53 INFO - Return code: 0 17:25:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:25: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')]} 17:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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', '--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 0x7f55fac6fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26af7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d70>, '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 0x26f4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f4fb0>, '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': 'a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129', '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 17:25:53 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 17:25:53 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 17:25:53 INFO - Using env: {'DISPLAY': ':0', 17:25:53 INFO - 'HOME': '/home/cltbld', 17:25:53 INFO - 'LANG': 'en_US.UTF-8', 17:25:53 INFO - 'LANGUAGE': 'en_US:en', 17:25:53 INFO - 'LOGNAME': 'cltbld', 17:25:53 INFO - 'MAIL': '/var/mail/cltbld', 17:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:53 INFO - 'MOZ_NO_REMOTE': '1', 17:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:53 INFO - 'NO_EM_RESTART': '1', 17:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:53 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:53 INFO - 'SHELL': '/bin/bash', 17:25:53 INFO - 'SHLVL': '1', 17:25:53 INFO - 'TERM': 'linux', 17:25:53 INFO - 'TMOUT': '86400', 17:25:53 INFO - 'USER': 'cltbld', 17:25:53 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129', 17:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:53 INFO - '_': '/tools/buildbot/bin/python'} 17:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:25:53 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 17:25:53 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 17:25:53 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 17:25:53 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 17:25:53 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 17:25:53 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 17:25:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:25:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:25:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:25:55 INFO - Installing collected packages: mozsystemmonitor 17:25:55 INFO - Running setup.py install for mozsystemmonitor 17:25:55 INFO - Successfully installed mozsystemmonitor 17:25:55 INFO - Cleaning up... 17:25:55 INFO - Return code: 0 17:25:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:55 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 0x7f55fac6fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26af7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d70>, '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 0x26f4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f4fb0>, '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': 'a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129', '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 17:25:55 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 17:25:55 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 17:25:55 INFO - Using env: {'DISPLAY': ':0', 17:25:55 INFO - 'HOME': '/home/cltbld', 17:25:55 INFO - 'LANG': 'en_US.UTF-8', 17:25:55 INFO - 'LANGUAGE': 'en_US:en', 17:25:55 INFO - 'LOGNAME': 'cltbld', 17:25:55 INFO - 'MAIL': '/var/mail/cltbld', 17:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:55 INFO - 'MOZ_NO_REMOTE': '1', 17:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:55 INFO - 'NO_EM_RESTART': '1', 17:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:55 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:55 INFO - 'SHELL': '/bin/bash', 17:25:55 INFO - 'SHLVL': '1', 17:25:55 INFO - 'TERM': 'linux', 17:25:55 INFO - 'TMOUT': '86400', 17:25:55 INFO - 'USER': 'cltbld', 17:25:55 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129', 17:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:55 INFO - '_': '/tools/buildbot/bin/python'} 17:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:55 INFO - Downloading/unpacking blobuploader==1.2.4 17:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:57 INFO - Downloading blobuploader-1.2.4.tar.gz 17:25:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:25:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:25:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:25:57 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 17:25:57 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 17:25:57 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 17:25:57 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 17:25:57 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 17:25:57 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 17:25:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:25:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:25:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:25:57 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 17:25:57 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 17:25:57 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 17:25:57 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 17:25:57 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 17:25:57 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 17:25:57 INFO - Downloading docopt-0.6.1.tar.gz 17:25:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:25:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:25:57 INFO - Installing collected packages: blobuploader, requests, docopt 17:25:57 INFO - Running setup.py install for blobuploader 17:25:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:25:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:25:58 INFO - Running setup.py install for requests 17:25:58 INFO - Running setup.py install for docopt 17:25:58 INFO - Successfully installed blobuploader requests docopt 17:25:58 INFO - Cleaning up... 17:25:58 INFO - Return code: 0 17:25:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:58 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 0x7f55fac6fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26af7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d70>, '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 0x26f4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f4fb0>, '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': 'a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129', '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 17:25:58 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 17:25:58 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 17:25:58 INFO - Using env: {'DISPLAY': ':0', 17:25:58 INFO - 'HOME': '/home/cltbld', 17:25:58 INFO - 'LANG': 'en_US.UTF-8', 17:25:58 INFO - 'LANGUAGE': 'en_US:en', 17:25:58 INFO - 'LOGNAME': 'cltbld', 17:25:58 INFO - 'MAIL': '/var/mail/cltbld', 17:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:58 INFO - 'MOZ_NO_REMOTE': '1', 17:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:58 INFO - 'NO_EM_RESTART': '1', 17:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:58 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:58 INFO - 'SHELL': '/bin/bash', 17:25:58 INFO - 'SHLVL': '1', 17:25:58 INFO - 'TERM': 'linux', 17:25:58 INFO - 'TMOUT': '86400', 17:25:58 INFO - 'USER': 'cltbld', 17:25:58 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129', 17:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:58 INFO - '_': '/tools/buildbot/bin/python'} 17:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:25:58 INFO - Running setup.py (path:/tmp/pip-cCP5wR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:25:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:25:58 INFO - Running setup.py (path:/tmp/pip-bsC5iH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:25:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:25:58 INFO - Running setup.py (path:/tmp/pip-qhBMDG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:25:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:25:59 INFO - Running setup.py (path:/tmp/pip-noavu6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:25:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:25:59 INFO - Running setup.py (path:/tmp/pip-gXQbCc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:25:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:25:59 INFO - Running setup.py (path:/tmp/pip-xLT4Zb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:25:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:25:59 INFO - Running setup.py (path:/tmp/pip-CGN2Gu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:25:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:25:59 INFO - Running setup.py (path:/tmp/pip-5leI_0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:25:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:25:59 INFO - Running setup.py (path:/tmp/pip-n3nlNc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:25:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:25:59 INFO - Running setup.py (path:/tmp/pip-Wbqckd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:25:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:25:59 INFO - Running setup.py (path:/tmp/pip-J7hxNn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:25:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:25:59 INFO - Running setup.py (path:/tmp/pip-AtFzs7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:25:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:25:59 INFO - Running setup.py (path:/tmp/pip-Utiev9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:25:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:25:59 INFO - Running setup.py (path:/tmp/pip-s73MiZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:25:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:25:59 INFO - Running setup.py (path:/tmp/pip-QSrwN9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:25:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:25:59 INFO - Running setup.py (path:/tmp/pip-AOxDtQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:25:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:25:59 INFO - Running setup.py (path:/tmp/pip-65wSWK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:25:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:25:59 INFO - Running setup.py install for manifestparser 17:26:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:26:00 INFO - Running setup.py install for mozcrash 17:26:00 INFO - Running setup.py install for mozdebug 17:26:00 INFO - Running setup.py install for mozdevice 17:26:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:26:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:26:00 INFO - Running setup.py install for mozfile 17:26:00 INFO - Running setup.py install for mozhttpd 17:26:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:26:00 INFO - Running setup.py install for mozinfo 17:26:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:26:00 INFO - Running setup.py install for mozInstall 17:26:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:26:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:26:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:26:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:26:00 INFO - Running setup.py install for mozleak 17:26:00 INFO - Running setup.py install for mozlog 17:26:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:26:01 INFO - Running setup.py install for moznetwork 17:26:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:26:01 INFO - Running setup.py install for mozprocess 17:26:01 INFO - Running setup.py install for mozprofile 17:26:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:26:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:26:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:26:01 INFO - Running setup.py install for mozrunner 17:26:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:26:01 INFO - Running setup.py install for mozscreenshot 17:26:01 INFO - Running setup.py install for moztest 17:26:01 INFO - Running setup.py install for mozversion 17:26:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:26:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:26:01 INFO - Cleaning up... 17:26:01 INFO - Return code: 0 17:26:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f55fac6fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26af7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d70>, '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 0x26f4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f4fb0>, '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': 'a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129', '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 17:26:01 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 17:26:01 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 17:26:01 INFO - Using env: {'DISPLAY': ':0', 17:26:01 INFO - 'HOME': '/home/cltbld', 17:26:01 INFO - 'LANG': 'en_US.UTF-8', 17:26:01 INFO - 'LANGUAGE': 'en_US:en', 17:26:01 INFO - 'LOGNAME': 'cltbld', 17:26:01 INFO - 'MAIL': '/var/mail/cltbld', 17:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:01 INFO - 'MOZ_NO_REMOTE': '1', 17:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:01 INFO - 'NO_EM_RESTART': '1', 17:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:01 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:01 INFO - 'SHELL': '/bin/bash', 17:26:01 INFO - 'SHLVL': '1', 17:26:01 INFO - 'TERM': 'linux', 17:26:01 INFO - 'TMOUT': '86400', 17:26:01 INFO - 'USER': 'cltbld', 17:26:01 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129', 17:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:01 INFO - '_': '/tools/buildbot/bin/python'} 17:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:26:01 INFO - Running setup.py (path:/tmp/pip-LKrlY1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:26:02 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)) 17:26:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:26:02 INFO - Running setup.py (path:/tmp/pip-s_gtWW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:26:02 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)) 17:26:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:26:02 INFO - Running setup.py (path:/tmp/pip-aFKeHV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:26:02 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)) 17:26:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:26:02 INFO - Running setup.py (path:/tmp/pip-J7L5Oy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:26:02 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)) 17:26:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:26:02 INFO - Running setup.py (path:/tmp/pip-7yXutF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:26:02 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)) 17:26:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:26:02 INFO - Running setup.py (path:/tmp/pip-gt3Pmu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:26:02 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)) 17:26:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:26:02 INFO - Running setup.py (path:/tmp/pip-CKY3y2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:26:02 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)) 17:26:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:26:02 INFO - Running setup.py (path:/tmp/pip-74r9KB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:26:02 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)) 17:26:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:26:02 INFO - Running setup.py (path:/tmp/pip-6YsUNh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:26:02 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)) 17:26:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:26:02 INFO - Running setup.py (path:/tmp/pip-N9Trg1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:26:02 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)) 17:26:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:26:02 INFO - Running setup.py (path:/tmp/pip-JE75zB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:26:02 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)) 17:26:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:26:02 INFO - Running setup.py (path:/tmp/pip-M5FI2v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:26:02 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)) 17:26:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:26:02 INFO - Running setup.py (path:/tmp/pip-KNfzcE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:26:02 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)) 17:26:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:26:02 INFO - Running setup.py (path:/tmp/pip-FKgJxd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:26:03 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)) 17:26:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:26:03 INFO - Running setup.py (path:/tmp/pip-2j7lJJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:26:03 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)) 17:26:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:26:03 INFO - Running setup.py (path:/tmp/pip-2v4IBv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:26:03 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)) 17:26:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:26:03 INFO - Running setup.py (path:/tmp/pip-ZcYYOF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:26:03 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)) 17:26:03 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)) 17:26:03 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)) 17:26:03 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)) 17:26:03 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)) 17:26:03 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)) 17:26:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:26:03 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 17:26:03 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 17:26:03 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 17:26:03 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 17:26:03 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 17:26:03 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 17:26:04 INFO - Downloading blessings-1.5.1.tar.gz 17:26:04 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 17:26:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:26:04 INFO - Installing collected packages: blessings 17:26:04 INFO - Running setup.py install for blessings 17:26:05 INFO - Successfully installed blessings 17:26:05 INFO - Cleaning up... 17:26:05 INFO - Return code: 0 17:26:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:26:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:26:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:26:05 INFO - Reading from file tmpfile_stdout 17:26:05 INFO - Current package versions: 17:26:05 INFO - argparse == 1.2.1 17:26:05 INFO - blessings == 1.5.1 17:26:05 INFO - blobuploader == 1.2.4 17:26:05 INFO - docopt == 0.6.1 17:26:05 INFO - manifestparser == 1.1 17:26:05 INFO - mozInstall == 1.12 17:26:05 INFO - mozcrash == 0.16 17:26:05 INFO - mozdebug == 0.1 17:26:05 INFO - mozdevice == 0.47 17:26:05 INFO - mozfile == 1.2 17:26:05 INFO - mozhttpd == 0.7 17:26:05 INFO - mozinfo == 0.9 17:26:05 INFO - mozleak == 0.1 17:26:05 INFO - mozlog == 3.0 17:26:05 INFO - moznetwork == 0.27 17:26:05 INFO - mozprocess == 0.22 17:26:05 INFO - mozprofile == 0.27 17:26:05 INFO - mozrunner == 6.11 17:26:05 INFO - mozscreenshot == 0.1 17:26:05 INFO - mozsystemmonitor == 0.0 17:26:05 INFO - moztest == 0.7 17:26:05 INFO - mozversion == 1.4 17:26:05 INFO - psutil == 3.1.1 17:26:05 INFO - requests == 1.2.3 17:26:05 INFO - wsgiref == 0.1.2 17:26:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:26:05 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')]} 17:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:05 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')]} 17:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:05 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 0x7f55fac6fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26af7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f3d70>, '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 0x26f4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f4fb0>, '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': 'a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129', '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 17:26:05 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 17:26:05 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 17:26:05 INFO - Using env: {'DISPLAY': ':0', 17:26:05 INFO - 'HOME': '/home/cltbld', 17:26:05 INFO - 'LANG': 'en_US.UTF-8', 17:26:05 INFO - 'LANGUAGE': 'en_US:en', 17:26:05 INFO - 'LOGNAME': 'cltbld', 17:26:05 INFO - 'MAIL': '/var/mail/cltbld', 17:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:05 INFO - 'MOZ_NO_REMOTE': '1', 17:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:05 INFO - 'NO_EM_RESTART': '1', 17:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:05 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:05 INFO - 'SHELL': '/bin/bash', 17:26:05 INFO - 'SHLVL': '1', 17:26:05 INFO - 'TERM': 'linux', 17:26:05 INFO - 'TMOUT': '86400', 17:26:05 INFO - 'USER': 'cltbld', 17:26:05 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129', 17:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:05 INFO - '_': '/tools/buildbot/bin/python'} 17:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:05 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)) 17:26:05 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)) 17:26:05 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)) 17:26:05 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)) 17:26:05 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)) 17:26:05 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)) 17:26:05 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)) 17:26:05 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)) 17:26:05 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)) 17:26:05 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)) 17:26:05 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)) 17:26:05 INFO - Cleaning up... 17:26:05 INFO - Return code: 0 17:26:05 INFO - Running post-action listener: _resource_record_post_action 17:26:05 INFO - Running post-action listener: _start_resource_monitoring 17:26:05 INFO - Starting resource monitoring. 17:26:05 INFO - ##### 17:26:05 INFO - ##### Running install step. 17:26:05 INFO - ##### 17:26:05 INFO - Running pre-action listener: _resource_record_pre_action 17:26:05 INFO - Running main action method: install 17:26:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:26:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:26:05 INFO - Reading from file tmpfile_stdout 17:26:05 INFO - Detecting whether we're running mozinstall >=1.0... 17:26:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:26:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:26:05 INFO - Reading from file tmpfile_stdout 17:26:05 INFO - Output received: 17:26:05 INFO - Usage: mozinstall [options] installer 17:26:05 INFO - Options: 17:26:05 INFO - -h, --help show this help message and exit 17:26:05 INFO - -d DEST, --destination=DEST 17:26:05 INFO - Directory to install application into. [default: 17:26:05 INFO - "/builds/slave/test-pgo"] 17:26:05 INFO - --app=APP Application being installed. [default: firefox] 17:26:05 INFO - mkdir: /builds/slave/test-pgo/build/application 17:26:05 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'] 17:26:05 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 17:26:20 INFO - Reading from file tmpfile_stdout 17:26:20 INFO - Output received: 17:26:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:26:20 INFO - Running post-action listener: _resource_record_post_action 17:26:20 INFO - ##### 17:26:20 INFO - ##### Running run-tests step. 17:26:20 INFO - ##### 17:26:20 INFO - Running pre-action listener: _resource_record_pre_action 17:26:20 INFO - Running main action method: run_tests 17:26:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:26:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:26:20 INFO - Python 2.7.3 17:26:20 INFO - Return code: 0 17:26:20 INFO - grabbing minidump binary from tooltool 17:26:20 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')]} 17:26:20 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 0x26f3d70>, '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 0x26f4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f4fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:26:20 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 17:26:20 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 17:26:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:26:20 INFO - Return code: 0 17:26:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:26:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:26:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:26:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:26:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:26:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 17:26:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost 17:26:20 INFO - Using env: {'DISPLAY': ':0', 17:26:20 INFO - 'HOME': '/home/cltbld', 17:26:20 INFO - 'LANG': 'en_US.UTF-8', 17:26:20 INFO - 'LANGUAGE': 'en_US:en', 17:26:20 INFO - 'LOGNAME': 'cltbld', 17:26:20 INFO - 'MAIL': '/var/mail/cltbld', 17:26:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:26:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:20 INFO - 'MOZ_NO_REMOTE': '1', 17:26:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:26:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:20 INFO - 'NO_EM_RESTART': '1', 17:26:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:20 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:26:20 INFO - 'SHELL': '/bin/bash', 17:26:20 INFO - 'SHLVL': '1', 17:26:20 INFO - 'TERM': 'linux', 17:26:20 INFO - 'TMOUT': '86400', 17:26:20 INFO - 'USER': 'cltbld', 17:26:20 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129', 17:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:20 INFO - '_': '/tools/buildbot/bin/python'} 17:26:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost'] with output_timeout 3600 17:26:20 INFO - mozversion INFO | application_buildid: 20151120143004 17:26:20 INFO - mozversion INFO | application_changeset: e75cf58a362650b61c8b8f73b01ddcf931482cd1 17:26:20 INFO - mozversion INFO | application_display_name: Nightly 17:26:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:26:20 INFO - mozversion INFO | application_name: Firefox 17:26:20 INFO - mozversion INFO | application_remotingname: firefox 17:26:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 17:26:20 INFO - mozversion INFO | application_vendor: Mozilla 17:26:20 INFO - mozversion INFO | application_version: 45.0a1 17:26:20 INFO - mozversion INFO | platform_buildid: 20151120143004 17:26:20 INFO - mozversion INFO | platform_changeset: e75cf58a362650b61c8b8f73b01ddcf931482cd1 17:26:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 17:26:20 INFO - mozversion INFO | platform_version: 45.0a1 17:26:20 INFO - 2015-11-20 17:26:20,581 DEBUG : using testdate: 1448069180 17:26:20 INFO - 2015-11-20 17:26:20,581 DEBUG : actual date: 1448069180 17:26:20 INFO - 2015-11-20 17:26:20,631 INFO : starting webserver on 'localhost:39181' 17:26:20 INFO - 2015-11-20 17:26:20,632 INFO : Starting test suite talos-linux64-ix-031 17:26:20 INFO - 2015-11-20 17:26:20,632 INFO : Starting test dromaeo_css 17:26:20 INFO - 2015-11-20 17:26:20,632 DEBUG : operating with platform_type : linux_ 17:26:20 INFO - 2015-11-20 17:26:20,633 INFO : Initialising browser for dromaeo_css test... 17:26:20 INFO - 2015-11-20 17:26:20,649 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQXJV0A/profile http://localhost:39181/getInfo.html 17:26:24 INFO - 2015-11-20 17:26:24,854 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:26:24 INFO - 2015-11-20 17:26:24,855 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:26:24 INFO - 2015-11-20 17:26:24,855 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:26:24 INFO - 2015-11-20 17:26:24,855 DEBUG : BROWSER_OUTPUT: __metrics 17:26:24 INFO - 2015-11-20 17:26:24,951 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:26:26 INFO - 2015-11-20 17:26:26,270 INFO : Browser initialized. 17:26:26 INFO - 2015-11-20 17:26:26,271 INFO : Running cycle 1/1 for dromaeo_css test... 17:26:26 INFO - 2015-11-20 17:26:26,271 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQXJV0A/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:26:38 INFO - 2015-11-20 17:26:38,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 142016512 17:26:38 INFO - 2015-11-20 17:26:38,099 DEBUG : BROWSER_OUTPUT: 17:27:29 INFO - 2015-11-20 17:27:29,422 DEBUG : BROWSER_OUTPUT: 1448069249421 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] 17:29:38 INFO - 2015-11-20 17:29:38,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39181/tests/dromaeo/cssquery-ext.html) 17:29:39 INFO - 2015-11-20 17:29:39,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 226848768 17:29:39 INFO - 2015-11-20 17:29:39,357 DEBUG : BROWSER_OUTPUT: 17:32:41 INFO - 2015-11-20 17:32:41,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/dromaeo/cssquery-ext.html (next: http://localhost:39181/tests/dromaeo/cssquery-jquery.html) 17:32:42 INFO - 2015-11-20 17:32:42,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 225390592 17:32:42 INFO - 2015-11-20 17:32:42,323 DEBUG : BROWSER_OUTPUT: 17:35:44 INFO - 2015-11-20 17:35:44,164 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39181/tests/dromaeo/cssquery-mootools.html) 17:35:44 INFO - 2015-11-20 17:35:44,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 221188096 17:35:44 INFO - 2015-11-20 17:35:44,738 DEBUG : BROWSER_OUTPUT: 17:38:46 INFO - 2015-11-20 17:38:46,647 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39181/tests/dromaeo/cssquery-prototype.html) 17:38:47 INFO - 2015-11-20 17:38:47,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 196132864 17:38:47 INFO - 2015-11-20 17:38:47,228 DEBUG : BROWSER_OUTPUT: 17:41:49 INFO - 2015-11-20 17:41:49,806 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39181/tests/dromaeo/cssquery-yui.html) 17:41:50 INFO - 2015-11-20 17:41:50,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 203563008 17:41:50 INFO - 2015-11-20 17:41:50,397 DEBUG : BROWSER_OUTPUT: 17:44:52 INFO - 2015-11-20 17:44:52,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/dromaeo/cssquery-yui.html (next: http://localhost:39181/tests/dromaeo/cssquery-dojo.html) 17:44:53 INFO - 2015-11-20 17:44:53,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 259575808 17:44:53 INFO - 2015-11-20 17:44:53,132 DEBUG : BROWSER_OUTPUT: 17:44:53 INFO - 2015-11-20 17:44:53,132 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:44:53 INFO - 2015-11-20 17:44:53,133 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:44:53 INFO - 2015-11-20 17:44:53,133 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:44:53 INFO - 2015-11-20 17:44:53,133 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:44:53 INFO - 2015-11-20 17:44:53,134 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3163.9209019774516;3170.5561221429;3250.739940804736;3262.690044445777;3281.704646581808;5292.708901010443;5350.0102481040985;5379.865503362418;5382.2464854920345;5421.403645598981;5383.81156659517;5389.164679474688;5522.834314970557;5524.530414914737;5542.224088627585;4836.274558816188;4884.7069175849565;4894.755262236892;4900.142475066867;4965.900681986358;4966.9751651241695;5066.847994560169;5067.442581316052;5077.060743762416;5102.056119617882;4716.740579268139;4814.7833347499445;5002.82490112848;5006.148954677696;5091.592672586185;4967.081089998325;4974.253861920704;4976.253561965698;4977.178765503688;4980.800767969277;4950.579200767939;4954.504549545017;4961.751912404401;4969.329140566049;4971.980743947482;5083.669561478529;5192.324997750268;5220.269162317279;5278.234655974862;5280.656757310762;5814.273215848019;5819.854503637401;5829.795957141479;5845.503132233765;5892.705364731789;5830.38780928005;5836.241288632451;5836.737346819361;5843;5846.181534585162;5244.449332820075;5306.336707911511;5344.7862085516535;5417.6207665463435;5529.889402211933;5797.942020579824;5934.851628709231;6009.729562169713;6016;6028.909566356509;5804.622699524602;5829.533637309005;5830.1244627729775;5832.50423713989;5889.646621202742;5660.377358490563;5703.828885133453;5786.623869448473;5792.189093526909;5838.153467747238;5651.491365777099;5819.418058194146;5877.177195192677;5887.646741195542;5887.793927212612;5684.204211410406;5842.269716285465;5868.970655146697;5882.411758824083;5889.4993925515955;4464.04023135021;4467.285234362486;4506.098780243964;4510.864674059783;4530.048689775184;4061.3907913813164;4062.776547289868;4076.5719599442223;4092.7748973806133;4102.897427564275;5430;5544.584156188302;5581.469760372758;5586.664800112007;5588.022096133161;5776.277965254343;5842.591018628656;5861.0915308127305;5871.119332100219;5907.852303692442;5473.808416705396;5479.0959491684225;5486.890262194814;5504.587155963319;5543.889122217533;4966.1309270877455;5024.874378140503;5063.11395505785;5064.594832413398;5096.108181068298;6121.786386817384;6123.008104567321;6126.100908718312;6127.172831667757;6132.95225151398;5865.178874957424;5929.0513517836935;5931.288245410578;5939;5963.582549221513;5835.066389377849;6037.215162028908;6042.3655516170165;6134.079888016833;6178.474829639531;5772.5959182856795;5785.0454674978155;5787.074068149076;5799.2750906136735;5816.854578635399;5841.50347220474;5853.560982926212;5882.852928676817;5890.204822349099;5892.145638882424;5480.177973304037;5592.608517403743;5722.656640601577;5793.8551536211935;5842.649441033552;5677.403872593318;5694.231278777312;5694.316681998187;5699.116636921284;5702;5432.511074003359;5546.972265138648;5560.249366335493;5564.749586268546;5569.554435645057;5633.8309850704545;5689;5692.857678558069;5749.913751293818;5764.077747560538;5595.664260144405;5628.521575666115;5632.493075623213;5633.746481408429;5674.602777805514 17:44:53 INFO - 2015-11-20 17:44:53,136 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.270348546889;570.985725356866;572.4504475703325;588.9116632505124;607.6536374266669;31266.218344541398;39512.2097558049;40237.39643905344;40265.798671006676;40346.193076138494;43424.565754342446;43847.61523847614;43888.780556097256;44089.77955110228;44197;7600.619969001556;7753.844923101535;8757.168069033463;8921.375503714742;8924.196822285992;10532.947335263312;10630.096441802418;10676.092532134779;10685.252032357737;10699.893001069968;10444.21668374875;10542.314749541294;10549.84175237372;10551.525181366856;10558.472076396189;7792.10390805059;7940.1265860755275;10438.947805260963;10630.362178269328;10903.618373356894;10400.323978941344;10487.161027117812;10504;10541.20799464093;10557.41934193619;40668.593314067075;41043.794781026205;41161.1767764646;41195.58804411977;41208;3089.6292444906753;3197.2006998250436;3323.6344002159744;3408.4205685033357;3646.6535679110443;30396.54405183924;31039.844800776078;31044.223894402596;31067.223319417197;32399.028029159163;3836.251930873481;3878.9806050969846;3967.1867267210155;3993.9600603993877;4008.398740188995;273152;274178.6291068532;274348.93685099884;274592;275067;53311;54384.73691578518;58836.11745823816;59126.70436647789;64830.67584662141;60225.397746021976;60304.698476508216;60529.69735151384;60737;60761;15905.761413578806;16099.919500402657;16130.435434759727;16145.112018839076;16175.110368929587;11736.589219377282;11770.176087673952;11889.346085965355;11908.225965312227;11980.76038479243;19485.415437536896;19552.217911283675;19760.505987350145;19826.306079287155;19894.90052549728;7393.8151546211775;7634.847303053908;7638.388928885676;7655.6937722490475;7693.384529237647;910.2444970674325;918.150710592699;973.1728031173446;982.8329184038588;1113.3320007995137;24574.631380529307;24586.754132458445;24612.523248605143;24635.891384887724;24747.5050498989;981.9950900245453;1006.436395618456;1006.7936073104996;1075.5858994287255;1202.1344631865218;13055.608331750063;13440.260785656883;13490.258035807929;13768.380422880995;13954.302284885918;311937;312084;313732;316146;317077;50065.74967125214;50261.497385026414;50324.24513632225;50394.496055039715;50782.492175078514;1347.1916849890183;1357.8031185478249;1367.131871261756;1371.8833899118488;1375.3192169875977;23337.41656458602;27991;28679.283017924718;28851.422971540873;28984.275393115342;48265.517344826105;48507.757461212466;48518;48532;48593;250552;252691;253228;253288;254031;28120;28987.5651865218;32961.34077318488;33153;33377.499337510446;39131.21737565176;39153;39603.80198098991;39745.40381894332;39808.40287395749;36214.63785362113;36246.456303156;36886.26227475382;37016.81491592525;37240.441393378576;29394.85302573559;33879.661203388634;35716.82141589379;36791.26417471689;36968.44547331846;34776;34866.82566587252;35321.47017794684;35483.467747984316;35773;32169.678303217606;33180.1704957378;33212.667873320956;33229.50155747617;33261;23559;23667.881660592277;24087.759122409254;24201.636975445734;24255 17:44:53 INFO - 2015-11-20 17:44:53,139 DEBUG : BROWSER_OUTPUT: |2;jquery.html;363.7980920589072;365.1564885115384;365.5448966037284;366.97064234861216;370.25948103792416;14606.488772892952;14726.63183420415;16731.749023764638;17155.142242887854;17726.113694315296;17323.653526929455;17431.73852392212;17742.201600927958;17879.82120178801;17886.105694715276;5181.585473162157;5320.866978325535;5325.973370133144;5326.813561525348;5331.2003199519995;3936.980315098435;4030.234255491447;5315.548178404841;5775.682337471438;5932.406759324054;5804.071348584227;5840.328362238333;5842.328132264802;5848.941510584904;5860.09168578871;5662.37713851476;5738.971305143468;5744.4829965303115;5746;5778.27771528559;5083.847484575469;5089.6691715038405;5105.387353517564;5105.387353517602;5114.232865070269;20393.184272629078;20782.48043798902;20920.581588368146;21342.466438339165;21386.57226855454;2004.9599008019904;2069.772325044244;2090.822280106193;2114.4713821544615;2465.7968516262067;12614.558490452882;12665.556705515262;12924.806127908088;13065.281409522473;13088.672783180402;1547.5589457004698;1551.743962246228;1567.9216039198109;1591.1805420208602;1628.267279724117;60967.39032609662;62859;63181.36818631801;63685.68157159231;63827.36172638307;9514.096160864707;9641.132298093205;9914.702558923243;9921.107100361001;9980.600775969026;12816.231026138461;12896.097273190786;12898.097133200774;12908.419121139572;12923.676908077374;7513.436492263102;7730;7730.574818385043;7829;7914.960425197837;7780.416468764865;7801.141874393812;7840.45116841827;7868.567228802356;7873.606319683993;5951.851203719855;6029.8191054268445;6037.0642550404755;6042.335343112342;6090.969545152246;1650.5626009107596;1696.4316953820608;1702.4126676296657;1727.084645138079;1750.492357216393;894.4096896048577;941.2611100286242;978.7699890525721;1064.2337516987757;1094.3543309447305;14539.709205815825;15214.771778423332;16226.269817858225;16533.50399488017;17021.65956680884;888.6401007591936;901.1529162587148;919.0763282900642;938.666773295484;943.9008904065112;9132.726018219331;9475.810483790285;9565.282603804742;9863.977884533653;9948.651797187063;532237;536594;541416;542469;545443;77612;79387.60306198432;79410.6029469849;79780.20219797843;81811.18188818154;1153.3887039868882;1167.9299242045504;1200.477792160413;1204.3556697166973;1219.7987332090283;15586.298616562508;15631.218439078228;15816.446424375092;16081.19594020271;16106.758398623795;34738.47892281567;34886.953391398296;35006.72456290333;35372.585096595845;36062.63937360698;45993.77003114963;46411;46772.532274676814;48351.27473087836;49573.504264956886;9114.954425228098;9201.493917834583;9307.953460232655;9379.437233765995;9395.483248421402;17274.481765547054;17748.935063896206;17810.198541065423;18028.098595070456;18104.275828966693;13789.931050344683;14055.156690598596;14135.575932722035;14272.857271427152;14467.49363772263;13630.022459458909;14121.576352709435;14362.994590378574;14511;14664.560063198121;15114;15129.924350378178;15259.92370038187;15305.540833775005;15307.693846122793;9579.856302155335;12854.228746275254;13371.26458044778;14209;15193.696126077637;14607.853921461074;14723.116613003254;14728.705425891636;14986.250687465365;15653.21733913277 17:44:53 INFO - 2015-11-20 17:44:53,139 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1374.7319272741806;1709.077098366882;1732.237815361241;1758.9296428142875;1764.691179043667;6837.111175547178;7547.283008114227;7760.7283745068935;7764.3012128908385;7765.728199513004;7554.131274903388;7666.846663066735;7680.3087722105;7684.9231507685045;7689.961550192241;1972.477293517219;2024.1903238704488;2285.245868863271;2294.919677811277;2318.40880575453;2275.4993901341677;2279.32759835848;2279.6694479300572;2282.041542552132;2285.714285714286;2251.3583628665833;2325.2907863101746;2325.883705814711;2327.5344931013865;2330.0563271874917;1976.980230197701;2020.0202901592788;2268.739095004079;2292.7592602776804;2307.0310469602805;2296.184854376689;2297.9080836766675;2319.756425575324;2322.7212734471973;2324.4537533679572;7693.9615301923695;7747.30274275318;7766.650500727481;7771.611419429062;7776.066871975399;4644.674872758908;4740.383750112498;4748;4779.545943135397;4779.95220047802;3136.7176954074016;3142.4500712375243;3159.9684003160132;3194.6166460024715;3209.005208385408;976.2287792643803;1018.4093225928943;1038.9948050259775;1082.3181395720724;1086.0876863434673;10524.36853788775;10532.94733526335;10545.103666188383;10550.208734344878;10608.310459820164;4186.937195942063;4246.150769846043;4318.071614602875;4378.824847006084;4378.956210437918;9042.01075763331;9042.095790420904;9047.276217902683;9050.230730387859;9055.637774488947;4803.135435621622;4805.663603547788;4820.34925285082;4820.493848145964;4822.180229361017;4378.956210437918;4382.627476664519;4385.166818304512;4387.517373089022;4388.890277743082;3634.0733113056003;3679.6136405677553;3685.8709945152327;3690.520232369775;3743.1390780120723;1197.6526807225807;1198.3109711915683;1199.6461043992044;1202.2846406388185;1210.9455074521668;1012.6455740490917;1022.7596514819012;1216.2033867816594;1258.207329382483;1291.0897817038965;6379.170707807955;7155.821104472429;7236.529625574321;7277.781666550012;7316.304951029751;516.9121249387613;522.5088416888113;524.1691918309522;527.1354977836352;528.7884846061529;5831.387704290988;5842.269716285465;5847.26909136358;5858.326292476419;5876.7355469004;9109.27125829932;9238.353315268001;9397.248220142372;9400.717978460658;9432.952835235918;9175.44947303164;9277.489738064336;9287.396319239228;9306.488143152192;9313.44119352841;7144.607046612487;7323.487355885143;7370.557766534025;7392.889106663404;7394.630268486554;7231;7273.054502914587;7326.6702998364135;7343.302386273295;7345.522541034816;8235.176482351957;8238.217369349903;8274.462159959583;8405.369597280107;8428.030776460786;8442.746717598482;8482.915170848459;8679.652813887626;8684.478931264144;8690.044095149655;7002.334778196063;7073.504854660125;7089.184743754534;7095.680694368869;7104.325089116525;7493.775186744407;7533.058367704037;7547.773566793005;7587.772366829004;7604.771856844303;7002.7899163025195;7009.228984811769;7141.678624461808;7184.46116541251;7226.494145409771;7028.156621205488;7087.893681594677;7096.361327480551;7188.5327453715345;7214.603196824225;6211.65835879013;7135.892961605477;7176.4258859290085;7177.605231712306;7182.138143422822;6058.84852878664;6138.1713468681155;6147.815565533041;6158.630482171084;6171.84570385726;6381.298057213796;6435.839104022437;6443.613383197023;6444.130042444398;6446.484281257582 17:44:53 INFO - 2015-11-20 17:44:53,139 DEBUG : BROWSER_OUTPUT: |4;prototype.html;343.48991747255303;346.6152570646582;348.4651060621945;350.5547954098295;356.4297124600639;5854.3267524234725;5980.940190598093;6001.66990815505;6007.669578173199;6059.697015149241;5819.127130930363;5951.137085122655;5963.105534169866;5963.671998040106;5983.042713165894;4638.489766125724;4641.9071618567605;4649.9070018599605;4659.860204193879;4667.18324293249;4436.112777444524;4500.684952053358;4533.184026875161;4598.724076555417;4654.255319148937;4574.611158051553;4592.334111553822;4613.561711637406;4614.23865062266;4615.14619795339;4603.493615702287;4605;4611.631069514431;4619.792109355087;4637.095766325568;4030.435738996543;4060.7360521566;4063.045184381668;4063.6952228582973;4069.877903662895;5608.2428872102155;5679.659220446786;5687.658740475544;5693.77224911003;5718.799842005551;5356.276902618136;5357.624966252364;5359.5444387227135;5360.303160589137;5366.4633536646415;6031.668258245794;6331.493480521547;6341.04884267359;6347.143135676717;6347.238331400262;4379.0585024219945;4404.4934832494355;4472.1502914446155;4495.145922274757;4500.8649740507835;6509.674516274167;6553.67231638421;6585.93414065858;6594.505412094112;6596.934030659728;4609.95390046102;4611.838585649486;4611.9077618447445;4613.5847773700525;4613.677042606985;4437.06821567468;4499.752513611783;4533.478649955297;4663;4666.646672464947;5294.814681486129;5305.32882142124;5316.362036555561;5317.707526086102;5322.600804939645;6404.647744374104;6408.070829729663;6417.262014868256;6421.101045853584;6424.453921416639;1588.849059339361;1603.446810850255;1603.6151323682466;1604.8475394837471;1606.1808477676468;1026.6406757634918;1037.1339931157568;1037.258360272409;1075.1076606416655;1106.5463160104318;6012.609180403348;6099.634021958696;6229.595076320024;6240.31356550779;6240.970239910454;6626.039224312544;6629.1382120325015;6631.33686631333;6634.96682516594;6637.435817955431;6056.424639659225;6212.409821066992;6219;6221.346758590374;6222.81331560054;3524.242287908112;3539.7168226541817;3572.035550401429;3576.070221742366;3579.785212887235;6902.585844849325;6905.205901321312;6908.447324214051;6911.7926462206215;6922.307769223138;6544.934550654528;6766.898496522556;6770.796876093626;6815.625140617313;6828.5902845829405;6781.220159681699;6800.625965571941;6804.115464989619;6804.727810887707;6811.829704257433;6616.4045235929;6644.468442524683;6647.667616619053;6649.235337936199;6650.334966503311;6424.357564243538;6542.869142617026;6550.967245163743;6552.705128269335;6555.737770489127;6844.726210951705;6865.41643960269;6866.622335771581;6873.347032031949;6878.828029299308;4497.730136191839;4500;4524.457065152203;4529;4538.591526762607;6483;6565.244996825426;6618.470522358103;6625.039369291522;6635.502337324817;6404.583702059351;6439.195100612424;6445.967770161119;6455.48356131499;6455.741770329134;6414.647194404166;6417.807465776034;6427.1002059710745;6427.389398007182;6427.557528139278;6120.908186377297;6216.285127210429;6249.375062493714;6251.156093927261;6252.874942501034;6439.581427207217;6452;6454.774082907075;6455.48356131499;6464.22429308486;6323.968380158254;6339.90490142639;6340.30256671775;6345.90481142774;6346.904796427965 17:44:53 INFO - 2015-11-20 17:44:53,141 DEBUG : BROWSER_OUTPUT: |5;yui.html;745.4632664481574;755.1919446192576;800.6997375984006;806.870900655895;844.9493030418175;11997.460114294856;12302.753944921096;12314.38428078597;12328.198667086634;12338.07464440166;11769.70575735607;11851.940740296286;11860.110491713134;11876.406179691025;11880.049596032319;670.8121725916751;678.9524733268673;797.1709422200904;805.649542449035;814.4421071565996;813.1258896686056;813.995930020352;816.147126253067;819.848328059308;820.8235229425673;700.7547358424536;848.499385362636;852.2415050604967;854.6111519258723;858.8625819868822;704.5526090932269;830.5805568188057;842.4313588327915;843.2916350265775;843.3211264931728;618.928823185335;622.862970146567;623.4762799248607;623.4980840423457;624.0389799708444;11660.88339116615;11775.94112029443;11784.351860647661;11811.232269902515;11815.232009919413;10646.840297395545;11209.327440353605;11302.321860688302;11432.71418214543;11585.47865346053;9107.817843643157;9275.90679368488;9294.628214871396;9383.577739001761;9403.247740180768;3412.77816941898;3430.279641275335;3481.9477707834403;3486.477028445728;3488.5639295088113;44888.77555612201;44949.550504494866;45042;46160;46187.76906115482;7990.360771138295;8042.451778485715;8070.838583228303;8179.263866252066;8198.508089514648;15244.085354878744;15264.694706105816;15271.694566108838;15291.541253762405;15327.770083448757;6924.549904256207;6941.95870619401;6974.58152510851;7025.929740702528;7260.92739072613;3675.3751862182958;3744.588095309514;3752.8311225994894;3780.7920564369224;3836.9424458633143;2936.794424390315;2953.3059730963205;2961.348503329264;2964.925876853096;2976.9106926792233;524.4414698346325;587.9323877754027;590.1354515634616;590.3977942498714;600.5915977135502;613.5244736408855;622.439804176245;667.3960066140054;690.0454735002629;702.1889717376438;7275.67259473325;7392.260773922565;7649.426293028045;7868.291853733192;7949.443538952218;588.2793577867078;591.4233622218388;676.4115219758842;680.938715515606;719.3597698048741;3502.824858757052;3584.4085725854943;3615.584207816082;3617.8733744318824;3728.757630753992;50100.49899501031;55684;55689;55695;55786;46917.765411172724;50071.74964125156;50138;51233;51331.74334128306;44444.333335;44810.32784508235;46312.7684361576;46428.767856160506;46509;7657.387409007378;7658.310752032344;7869.960650196713;7897.131315555399;8159.674492769532;33710.662893370754;34381.656183437844;34702.30595388028;34948.65051349454;35264.29471410506;42654.78672606617;44065.559344407426;45966.310505341775;46102.30846537238;46434.30348544707;9850.310478266452;9884.801930103316;9961.950190249003;10003.249756268164;10271.332363396356;10850;10970.177236707439;11310.491027903929;11337.26307789991;11444.94277528607;10400.219983501116;10826.67519974402;11068;11127.443627818739;11145.052670522771;10402.895971040192;10625;10703.357798532114;10829.837552436562;11144.721381965192;10428.947855260978;10581;10647.89352106469;10885.401302928414;10896.782064358827;8489.702860399857;8849.734507964771;9007.36948413631;9215.815683686154;9301.767455813659;7809.648565814666;7977.920220797718;8046.235607617501;8550.529720865163;8633 17:44:53 INFO - 2015-11-20 17:44:53,141 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:44:53 INFO - 2015-11-20 17:44:53,141 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:44:53 INFO - 2015-11-20 17:44:53,141 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,841 17:44:53 INFO - 2015-11-20 17:44:53,141 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:44:53 INFO - 2015-11-20 17:44:53,141 DEBUG : BROWSER_OUTPUT: __startTimestamp1448070293130__endTimestamp 17:44:53 INFO - 2015-11-20 17:44:53,141 DEBUG : BROWSER_OUTPUT: 17:44:53 INFO - 2015-11-20 17:44:53,141 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:44:53 INFO - 2015-11-20 17:44:53,141 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:44:53 INFO - 2015-11-20 17:44:53,141 DEBUG : BROWSER_OUTPUT: 17:44:53 INFO - 2015-11-20 17:44:53,141 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5420.47 Median:5595.66 stddev:607.03 (10.8%) stddev-sans-first:582.51 17:44:53 INFO - 2015-11-20 17:44:53,142 DEBUG : BROWSER_OUTPUT: Values: 3163.9 3170.6 3250.7 3262.7 3281.7 5292.7 5350.0 5379.9 5382.2 5421.4 5383.8 5389.2 5522.8 5524.5 5542.2 4836.3 4884.7 4894.8 4900.1 4965.9 4967.0 5066.8 5067.4 5077.1 5102.1 4716.7 4814.8 5002.8 5006.1 5091.6 4967.1 4974.3 4976.3 4977.2 4980.8 4950.6 4954.5 4961.8 4969.3 4972.0 5083.7 5192.3 5220.3 5278.2 5280.7 5814.3 5819.9 5829.8 5845.5 5892.7 5830.4 5836.2 5836.7 5843.0 5846.2 5244.4 5306.3 5344.8 5417.6 5529.9 5797.9 5934.9 6009.7 6016.0 6028.9 5804.6 5829.5 5830.1 5832.5 5889.6 5660.4 5703.8 5786.6 5792.2 5838.2 5651.5 5819.4 5877.2 5887.6 5887.8 5684.2 5842.3 5869.0 5882.4 5889.5 4464.0 4467.3 4506.1 4510.9 4530.0 4061.4 4062.8 4076.6 4092.8 4102.9 5430.0 5544.6 5581.5 5586.7 5588.0 5776.3 5842.6 5861.1 5871.1 5907.9 5473.8 5479.1 5486.9 5504.6 5543.9 4966.1 5024.9 5063.1 5064.6 5096.1 6121.8 6123.0 6126.1 6127.2 6133.0 5865.2 5929.1 5931.3 5939.0 5963.6 5835.1 6037.2 6042.4 6134.1 6178.5 5772.6 5785.0 5787.1 5799.3 5816.9 5841.5 5853.6 5882.9 5890.2 5892.1 5480.2 5592.6 5722.7 5793.9 5842.6 5677.4 5694.2 5694.3 5699.1 5702.0 5432.5 5547.0 5560.2 5564.7 5569.6 5633.8 5689.0 5692.9 5749.9 5764.1 5595.7 5628.5 5632.5 5633.7 5674.6 17:44:53 INFO - 2015-11-20 17:44:53,142 DEBUG : BROWSER_OUTPUT: 17:44:53 INFO - 2015-11-20 17:44:53,142 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45257.72 Median:33057.17 stddev:73430.65 (222.1%) stddev-sans-first:73559.95 17:44:53 INFO - 2015-11-20 17:44:53,142 DEBUG : BROWSER_OUTPUT: Values: 561.3 571.0 572.5 588.9 607.7 31266.2 39512.2 40237.4 40265.8 40346.2 43424.6 43847.6 43888.8 44089.8 44197.0 7600.6 7753.8 8757.2 8921.4 8924.2 10532.9 10630.1 10676.1 10685.3 10699.9 10444.2 10542.3 10549.8 10551.5 10558.5 7792.1 7940.1 10438.9 10630.4 10903.6 10400.3 10487.2 10504.0 10541.2 10557.4 40668.6 41043.8 41161.2 41195.6 41208.0 3089.6 3197.2 3323.6 3408.4 3646.7 30396.5 31039.8 31044.2 31067.2 32399.0 3836.3 3879.0 3967.2 3994.0 4008.4 273152.0 274178.6 274348.9 274592.0 275067.0 53311.0 54384.7 58836.1 59126.7 64830.7 60225.4 60304.7 60529.7 60737.0 60761.0 15905.8 16099.9 16130.4 16145.1 16175.1 11736.6 11770.2 11889.3 11908.2 11980.8 19485.4 19552.2 19760.5 19826.3 19894.9 7393.8 7634.8 7638.4 7655.7 7693.4 910.2 918.2 973.2 982.8 1113.3 24574.6 24586.8 24612.5 24635.9 24747.5 982.0 1006.4 1006.8 1075.6 1202.1 13055.6 13440.3 13490.3 13768.4 13954.3 311937.0 312084.0 313732.0 316146.0 317077.0 50065.7 50261.5 50324.2 50394.5 50782.5 1347.2 1357.8 1367.1 1371.9 1375.3 23337.4 27991.0 28679.3 28851.4 28984.3 48265.5 48507.8 48518.0 48532.0 48593.0 250552.0 252691.0 253228.0 253288.0 254031.0 28120.0 28987.6 32961.3 33153.0 33377.5 39131.2 39153.0 39603.8 39745.4 39808.4 36214.6 36246.5 36886.3 37016.8 37240.4 29394.9 33879.7 35716.8 36791.3 36968.4 34776.0 34866.8 35321.5 35483.5 35773.0 32169.7 33180.2 33212.7 33229.5 33261.0 23559.0 23667.9 24087.8 24201.6 24255.0 17:44:53 INFO - 2015-11-20 17:44:53,142 DEBUG : BROWSER_OUTPUT: 17:44:53 INFO - 2015-11-20 17:44:53,142 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29239.90 Median:18213.22 stddev:88125.27 (483.9%) stddev-sans-first:88345.81 17:44:53 INFO - 2015-11-20 17:44:53,143 DEBUG : BROWSER_OUTPUT: Values: 363.8 365.2 365.5 367.0 370.3 14606.5 14726.6 16731.7 17155.1 17726.1 17323.7 17431.7 17742.2 17879.8 17886.1 5181.6 5320.9 5326.0 5326.8 5331.2 3937.0 4030.2 5315.5 5775.7 5932.4 5804.1 5840.3 5842.3 5848.9 5860.1 5662.4 5739.0 5744.5 5746.0 5778.3 5083.8 5089.7 5105.4 5105.4 5114.2 20393.2 20782.5 20920.6 21342.5 21386.6 2005.0 2069.8 2090.8 2114.5 2465.8 12614.6 12665.6 12924.8 13065.3 13088.7 1547.6 1551.7 1567.9 1591.2 1628.3 60967.4 62859.0 63181.4 63685.7 63827.4 9514.1 9641.1 9914.7 9921.1 9980.6 12816.2 12896.1 12898.1 12908.4 12923.7 7513.4 7730.0 7730.6 7829.0 7915.0 7780.4 7801.1 7840.5 7868.6 7873.6 5951.9 6029.8 6037.1 6042.3 6091.0 1650.6 1696.4 1702.4 1727.1 1750.5 894.4 941.3 978.8 1064.2 1094.4 14539.7 15214.8 16226.3 16533.5 17021.7 888.6 901.2 919.1 938.7 943.9 9132.7 9475.8 9565.3 9864.0 9948.7 532237.0 536594.0 541416.0 542469.0 545443.0 77612.0 79387.6 79410.6 79780.2 81811.2 1153.4 1167.9 1200.5 1204.4 1219.8 15586.3 15631.2 15816.4 16081.2 16106.8 34738.5 34887.0 35006.7 35372.6 36062.6 45993.8 46411.0 46772.5 48351.3 49573.5 9115.0 9201.5 9308.0 9379.4 9395.5 17274.5 17748.9 17810.2 18028.1 18104.3 13789.9 14055.2 14135.6 14272.9 14467.5 13630.0 14121.6 14363.0 14511.0 14664.6 15114.0 15129.9 15259.9 15305.5 15307.7 9579.9 12854.2 13371.3 14209.0 15193.7 14607.9 14723.1 14728.7 14986.3 15653.2 17:44:53 INFO - 2015-11-20 17:44:53,143 DEBUG : BROWSER_OUTPUT: 17:44:53 INFO - 2015-11-20 17:44:53,144 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5442.90 Median:6142.99 stddev:2822.27 (45.9%) stddev-sans-first:2813.62 17:44:53 INFO - 2015-11-20 17:44:53,144 DEBUG : BROWSER_OUTPUT: Values: 1374.7 1709.1 1732.2 1758.9 1764.7 6837.1 7547.3 7760.7 7764.3 7765.7 7554.1 7666.8 7680.3 7684.9 7690.0 1972.5 2024.2 2285.2 2294.9 2318.4 2275.5 2279.3 2279.7 2282.0 2285.7 2251.4 2325.3 2325.9 2327.5 2330.1 1977.0 2020.0 2268.7 2292.8 2307.0 2296.2 2297.9 2319.8 2322.7 2324.5 7694.0 7747.3 7766.7 7771.6 7776.1 4644.7 4740.4 4748.0 4779.5 4780.0 3136.7 3142.5 3160.0 3194.6 3209.0 976.2 1018.4 1039.0 1082.3 1086.1 10524.4 10532.9 10545.1 10550.2 10608.3 4186.9 4246.2 4318.1 4378.8 4379.0 9042.0 9042.1 9047.3 9050.2 9055.6 4803.1 4805.7 4820.3 4820.5 4822.2 4379.0 4382.6 4385.2 4387.5 4388.9 3634.1 3679.6 3685.9 3690.5 3743.1 1197.7 1198.3 1199.6 1202.3 1210.9 1012.6 1022.8 1216.2 1258.2 1291.1 6379.2 7155.8 7236.5 7277.8 7316.3 516.9 522.5 524.2 527.1 528.8 5831.4 5842.3 5847.3 5858.3 5876.7 9109.3 9238.4 9397.2 9400.7 9433.0 9175.4 9277.5 9287.4 9306.5 9313.4 7144.6 7323.5 7370.6 7392.9 7394.6 7231.0 7273.1 7326.7 7343.3 7345.5 8235.2 8238.2 8274.5 8405.4 8428.0 8442.7 8482.9 8679.7 8684.5 8690.0 7002.3 7073.5 7089.2 7095.7 7104.3 7493.8 7533.1 7547.8 7587.8 7604.8 7002.8 7009.2 7141.7 7184.5 7226.5 7028.2 7087.9 7096.4 7188.5 7214.6 6211.7 7135.9 7176.4 7177.6 7182.1 6058.8 6138.2 6147.8 6158.6 6171.8 6381.3 6435.8 6443.6 6444.1 6446.5 17:44:53 INFO - 2015-11-20 17:44:53,144 DEBUG : BROWSER_OUTPUT: 17:44:53 INFO - 2015-11-20 17:44:53,144 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5351.01 Median:6044.05 stddev:1614.75 (26.7%) stddev-sans-first:1574.93 17:44:53 INFO - 2015-11-20 17:44:53,144 DEBUG : BROWSER_OUTPUT: Values: 343.5 346.6 348.5 350.6 356.4 5854.3 5980.9 6001.7 6007.7 6059.7 5819.1 5951.1 5963.1 5963.7 5983.0 4638.5 4641.9 4649.9 4659.9 4667.2 4436.1 4500.7 4533.2 4598.7 4654.3 4574.6 4592.3 4613.6 4614.2 4615.1 4603.5 4605.0 4611.6 4619.8 4637.1 4030.4 4060.7 4063.0 4063.7 4069.9 5608.2 5679.7 5687.7 5693.8 5718.8 5356.3 5357.6 5359.5 5360.3 5366.5 6031.7 6331.5 6341.0 6347.1 6347.2 4379.1 4404.5 4472.2 4495.1 4500.9 6509.7 6553.7 6585.9 6594.5 6596.9 4610.0 4611.8 4611.9 4613.6 4613.7 4437.1 4499.8 4533.5 4663.0 4666.6 5294.8 5305.3 5316.4 5317.7 5322.6 6404.6 6408.1 6417.3 6421.1 6424.5 1588.8 1603.4 1603.6 1604.8 1606.2 1026.6 1037.1 1037.3 1075.1 1106.5 6012.6 6099.6 6229.6 6240.3 6241.0 6626.0 6629.1 6631.3 6635.0 6637.4 6056.4 6212.4 6219.0 6221.3 6222.8 3524.2 3539.7 3572.0 3576.1 3579.8 6902.6 6905.2 6908.4 6911.8 6922.3 6544.9 6766.9 6770.8 6815.6 6828.6 6781.2 6800.6 6804.1 6804.7 6811.8 6616.4 6644.5 6647.7 6649.2 6650.3 6424.4 6542.9 6551.0 6552.7 6555.7 6844.7 6865.4 6866.6 6873.3 6878.8 4497.7 4500.0 4524.5 4529.0 4538.6 6483.0 6565.2 6618.5 6625.0 6635.5 6404.6 6439.2 6446.0 6455.5 6455.7 6414.6 6417.8 6427.1 6427.4 6427.6 6120.9 6216.3 6249.4 6251.2 6252.9 6439.6 6452.0 6454.8 6455.5 6464.2 6324.0 6339.9 6340.3 6345.9 6346.9 17:44:53 INFO - 2015-11-20 17:44:53,144 DEBUG : BROWSER_OUTPUT: 17:44:53 INFO - 2015-11-20 17:44:53,144 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13016.45 Median:50685.50 stddev:15544.69 (30.7%) stddev-sans-first:15560.98 17:44:53 INFO - 2015-11-20 17:44:53,145 DEBUG : BROWSER_OUTPUT: Values: 745.5 755.2 800.7 806.9 844.9 11997.5 12302.8 12314.4 12328.2 12338.1 11769.7 11851.9 11860.1 11876.4 11880.0 670.8 679.0 797.2 805.6 814.4 813.1 814.0 816.1 819.8 820.8 700.8 848.5 852.2 854.6 858.9 704.6 830.6 842.4 843.3 843.3 618.9 622.9 623.5 623.5 624.0 11660.9 11775.9 11784.4 11811.2 11815.2 10646.8 11209.3 11302.3 11432.7 11585.5 9107.8 9275.9 9294.6 9383.6 9403.2 3412.8 3430.3 3481.9 3486.5 3488.6 44888.8 44949.6 45042.0 46160.0 46187.8 7990.4 8042.5 8070.8 8179.3 8198.5 15244.1 15264.7 15271.7 15291.5 15327.8 6924.5 6942.0 6974.6 7025.9 7260.9 3675.4 3744.6 3752.8 3780.8 3836.9 2936.8 2953.3 2961.3 2964.9 2976.9 524.4 587.9 590.1 590.4 600.6 613.5 622.4 667.4 690.0 702.2 7275.7 7392.3 7649.4 7868.3 7949.4 588.3 591.4 676.4 680.9 719.4 3502.8 3584.4 3615.6 3617.9 3728.8 50100.5 55684.0 55689.0 55695.0 55786.0 46917.8 50071.7 50138.0 51233.0 51331.7 44444.3 44810.3 46312.8 46428.8 46509.0 7657.4 7658.3 7870.0 7897.1 8159.7 33710.7 34381.7 34702.3 34948.7 35264.3 42654.8 44065.6 45966.3 46102.3 46434.3 9850.3 9884.8 9962.0 10003.2 10271.3 10850.0 10970.2 11310.5 11337.3 11444.9 10400.2 10826.7 11068.0 11127.4 11145.1 10402.9 10625.0 10703.4 10829.8 11144.7 10428.9 10581.0 10647.9 10885.4 10896.8 8489.7 8849.7 9007.4 9215.8 9301.8 7809.6 7977.9 8046.2 8550.5 8633.0 17:44:53 INFO - 2015-11-20 17:44:53,145 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:44:53 INFO - 2015-11-20 17:44:53,145 DEBUG : BROWSER_OUTPUT: 17:44:53 INFO - 2015-11-20 17:44:53,813 INFO : Browser exited with error code: 0 17:44:53 INFO - 2015-11-20 17:44:53,830 INFO : Completed test dromaeo_css (00:18:33) 17:44:53 INFO - 2015-11-20 17:44:53,830 INFO : Starting test kraken 17:44:53 INFO - 2015-11-20 17:44:53,830 DEBUG : operating with platform_type : linux_ 17:44:53 INFO - 2015-11-20 17:44:53,830 INFO : Initialising browser for kraken test... 17:44:53 INFO - 2015-11-20 17:44:53,836 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWVSLWI/profile http://localhost:39181/getInfo.html 17:44:57 INFO - 2015-11-20 17:44:57,730 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:44:57 INFO - 2015-11-20 17:44:57,730 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:44:57 INFO - 2015-11-20 17:44:57,730 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:44:57 INFO - 2015-11-20 17:44:57,730 DEBUG : BROWSER_OUTPUT: __metrics 17:44:57 INFO - 2015-11-20 17:44:57,867 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:44:59 INFO - 2015-11-20 17:44:59,055 INFO : Browser initialized. 17:44:59 INFO - 2015-11-20 17:44:59,055 INFO : Running cycle 1/1 for kraken test... 17:44:59 INFO - 2015-11-20 17:44:59,055 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWVSLWI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:45:10 INFO - 2015-11-20 17:45:10,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 141824000 17:45:10 INFO - 2015-11-20 17:45:10,856 DEBUG : BROWSER_OUTPUT: 17:45:13 INFO - 2015-11-20 17:45:13,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39181/tests/kraken/driver.html?testName=audio-beat-detection) 17:45:13 INFO - 2015-11-20 17:45:13,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 179838976 17:45:13 INFO - 2015-11-20 17:45:13,910 DEBUG : BROWSER_OUTPUT: 17:45:16 INFO - 2015-11-20 17:45:16,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39181/tests/kraken/driver.html?testName=audio-dft) 17:45:17 INFO - 2015-11-20 17:45:17,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 168284160 17:45:17 INFO - 2015-11-20 17:45:17,078 DEBUG : BROWSER_OUTPUT: 17:45:19 INFO - 2015-11-20 17:45:19,915 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39181/tests/kraken/driver.html?testName=audio-fft) 17:45:20 INFO - 2015-11-20 17:45:20,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 151695360 17:45:20 INFO - 2015-11-20 17:45:20,477 DEBUG : BROWSER_OUTPUT: 17:45:22 INFO - 2015-11-20 17:45:22,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39181/tests/kraken/driver.html?testName=audio-oscillator) 17:45:23 INFO - 2015-11-20 17:45:23,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 153374720 17:45:23 INFO - 2015-11-20 17:45:23,044 DEBUG : BROWSER_OUTPUT: 17:45:25 INFO - 2015-11-20 17:45:25,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39181/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:45:25 INFO - 2015-11-20 17:45:25,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 155942912 17:45:25 INFO - 2015-11-20 17:45:25,750 DEBUG : BROWSER_OUTPUT: 17:45:28 INFO - 2015-11-20 17:45:28,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39181/tests/kraken/driver.html?testName=imaging-darkroom) 17:45:29 INFO - 2015-11-20 17:45:29,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 155750400 17:45:29 INFO - 2015-11-20 17:45:29,234 DEBUG : BROWSER_OUTPUT: 17:45:32 INFO - 2015-11-20 17:45:32,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39181/tests/kraken/driver.html?testName=imaging-desaturate) 17:45:33 INFO - 2015-11-20 17:45:33,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 156594176 17:45:33 INFO - 2015-11-20 17:45:33,228 DEBUG : BROWSER_OUTPUT: 17:45:35 INFO - 2015-11-20 17:45:35,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39181/tests/kraken/driver.html?testName=json-parse-financial) 17:45:36 INFO - 2015-11-20 17:45:36,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 155537408 17:45:36 INFO - 2015-11-20 17:45:36,510 DEBUG : BROWSER_OUTPUT: 17:45:38 INFO - 2015-11-20 17:45:38,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39181/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:45:38 INFO - 2015-11-20 17:45:38,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 169873408 17:45:38 INFO - 2015-11-20 17:45:38,644 DEBUG : BROWSER_OUTPUT: 17:45:40 INFO - 2015-11-20 17:45:40,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39181/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:45:41 INFO - 2015-11-20 17:45:41,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 165974016 17:45:41 INFO - 2015-11-20 17:45:41,020 DEBUG : BROWSER_OUTPUT: 17:45:43 INFO - 2015-11-20 17:45:43,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39181/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:45:43 INFO - 2015-11-20 17:45:43,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 171134976 17:45:43 INFO - 2015-11-20 17:45:43,665 DEBUG : BROWSER_OUTPUT: 17:45:46 INFO - 2015-11-20 17:45:46,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39181/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:45:46 INFO - 2015-11-20 17:45:46,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 181301248 17:45:46 INFO - 2015-11-20 17:45:46,633 DEBUG : BROWSER_OUTPUT: 17:45:49 INFO - 2015-11-20 17:45:49,147 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39181/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:45:49 INFO - 2015-11-20 17:45:49,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 178802688 17:45:49 INFO - 2015-11-20 17:45:49,714 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,383 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39181/tests/kraken/driver.html?testName=ai-astar) 17:45:51 INFO - 2015-11-20 17:45:51,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 238051328 17:45:51 INFO - 2015-11-20 17:45:51,633 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,633 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:45:51 INFO - 2015-11-20 17:45:51,633 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:45:51 INFO - 2015-11-20 17:45:51,634 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:45:51 INFO - 2015-11-20 17:45:51,634 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:45:51 INFO - 2015-11-20 17:45:51,634 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;102;110;109;110;97;109;112;108 17:45:51 INFO - 2015-11-20 17:45:51,634 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;123;145;159;124;149;150;124;162;125 17:45:51 INFO - 2015-11-20 17:45:51,635 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;161;161;161;162;163;162;162;161 17:45:51 INFO - 2015-11-20 17:45:51,635 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;80;98;72;72;73;108;89;71 17:45:51 INFO - 2015-11-20 17:45:51,635 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;92;134;90;90;91;132;90;91;133 17:45:51 INFO - 2015-11-20 17:45:51,635 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 17:45:51 INFO - 2015-11-20 17:45:51,635 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;146;146;145;146;145;145;146;145 17:45:51 INFO - 2015-11-20 17:45:51,635 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;95;96;95;95;95;95 17:45:51 INFO - 2015-11-20 17:45:51,635 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;60;61;61;60;61;59;68;59;59 17:45:51 INFO - 2015-11-20 17:45:51,636 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;69;69;69;69;68;69 17:45:51 INFO - 2015-11-20 17:45:51,636 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;84;83;84;88;84;92;92;90;84 17:45:51 INFO - 2015-11-20 17:45:51,636 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;123;115;113;132;115;117;115;118;124 17:45:51 INFO - 2015-11-20 17:45:51,636 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;158;149;150;150;137;150;148;149;137 17:45:51 INFO - 2015-11-20 17:45:51,636 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;68;65;66;68;66;68;66;68 17:45:51 INFO - 2015-11-20 17:45:51,637 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:45:51 INFO - 2015-11-20 17:45:51,637 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:45:51 INFO - 2015-11-20 17:45:51,637 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,910 17:45:51 INFO - 2015-11-20 17:45:51,637 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:45:51 INFO - 2015-11-20 17:45:51,637 DEBUG : BROWSER_OUTPUT: __startTimestamp1448070351632__endTimestamp 17:45:51 INFO - 2015-11-20 17:45:51,637 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,638 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:45:51 INFO - 2015-11-20 17:45:51,639 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:45:51 INFO - 2015-11-20 17:45:51,639 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,639 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.60 Median:110.00 stddev:4.60 (4.2%) stddev-sans-first:4.88 17:45:51 INFO - 2015-11-20 17:45:51,639 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 102.0 110.0 109.0 110.0 97.0 109.0 112.0 108.0 17:45:51 INFO - 2015-11-20 17:45:51,639 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,639 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.90 Median:149.50 stddev:16.21 (10.8%) stddev-sans-first:16.11 17:45:51 INFO - 2015-11-20 17:45:51,639 DEBUG : BROWSER_OUTPUT: Values: 158.0 123.0 145.0 159.0 124.0 149.0 150.0 124.0 162.0 125.0 17:45:51 INFO - 2015-11-20 17:45:51,639 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,639 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.12 17:45:51 INFO - 2015-11-20 17:45:51,640 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 161.0 161.0 161.0 162.0 163.0 162.0 162.0 161.0 17:45:51 INFO - 2015-11-20 17:45:51,640 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,640 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.80 Median:73.00 stddev:13.14 (18.0%) stddev-sans-first:13.63 17:45:51 INFO - 2015-11-20 17:45:51,640 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 80.0 98.0 72.0 72.0 73.0 108.0 89.0 71.0 17:45:51 INFO - 2015-11-20 17:45:51,640 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,640 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.30 Median:90.00 stddev:20.51 (22.8%) stddev-sans-first:21.18 17:45:51 INFO - 2015-11-20 17:45:51,640 DEBUG : BROWSER_OUTPUT: Values: 90.0 92.0 134.0 90.0 90.0 91.0 132.0 90.0 91.0 133.0 17:45:51 INFO - 2015-11-20 17:45:51,640 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,640 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:45:51 INFO - 2015-11-20 17:45:51,641 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 17:45:51 INFO - 2015-11-20 17:45:51,641 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,641 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:45:51 INFO - 2015-11-20 17:45:51,641 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 17:45:51 INFO - 2015-11-20 17:45:51,641 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,641 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:45:51 INFO - 2015-11-20 17:45:51,641 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 17:45:51 INFO - 2015-11-20 17:45:51,641 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,642 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:2.64 (4.3%) stddev-sans-first:2.80 17:45:51 INFO - 2015-11-20 17:45:51,642 DEBUG : BROWSER_OUTPUT: Values: 61.0 60.0 61.0 61.0 60.0 61.0 59.0 68.0 59.0 59.0 17:45:51 INFO - 2015-11-20 17:45:51,642 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,642 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 17:45:51 INFO - 2015-11-20 17:45:51,642 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 69.0 69.0 69.0 69.0 68.0 69.0 17:45:51 INFO - 2015-11-20 17:45:51,643 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,643 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:86.50 stddev:3.57 (4.1%) stddev-sans-first:3.73 17:45:51 INFO - 2015-11-20 17:45:51,643 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 83.0 84.0 88.0 84.0 92.0 92.0 90.0 84.0 17:45:51 INFO - 2015-11-20 17:45:51,643 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,643 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:120.50 stddev:5.89 (4.9%) stddev-sans-first:6.11 17:45:51 INFO - 2015-11-20 17:45:51,643 DEBUG : BROWSER_OUTPUT: Values: 123.0 123.0 115.0 113.0 132.0 115.0 117.0 115.0 118.0 124.0 17:45:51 INFO - 2015-11-20 17:45:51,643 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,643 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.10 Median:149.50 stddev:6.44 (4.3%) stddev-sans-first:6.65 17:45:51 INFO - 2015-11-20 17:45:51,643 DEBUG : BROWSER_OUTPUT: Values: 143.0 158.0 149.0 150.0 150.0 137.0 150.0 148.0 149.0 137.0 17:45:51 INFO - 2015-11-20 17:45:51,643 DEBUG : BROWSER_OUTPUT: 17:45:51 INFO - 2015-11-20 17:45:51,644 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 17:45:51 INFO - 2015-11-20 17:45:51,644 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 68.0 65.0 66.0 68.0 66.0 68.0 66.0 68.0 17:45:51 INFO - 2015-11-20 17:45:51,644 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:45:51 INFO - 2015-11-20 17:45:51,644 DEBUG : BROWSER_OUTPUT: 17:45:52 INFO - 2015-11-20 17:45:52,489 INFO : Browser exited with error code: 0 17:45:52 INFO - 2015-11-20 17:45:52,543 INFO : Completed test kraken (00:00:58) 17:45:52 INFO - 2015-11-20 17:45:52,543 INFO : Starting test v8_7 17:45:52 INFO - 2015-11-20 17:45:52,543 DEBUG : operating with platform_type : linux_ 17:45:52 INFO - 2015-11-20 17:45:52,543 INFO : Initialising browser for v8_7 test... 17:45:52 INFO - 2015-11-20 17:45:52,550 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfvhO90/profile http://localhost:39181/getInfo.html 17:45:56 INFO - 2015-11-20 17:45:56,369 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:45:56 INFO - 2015-11-20 17:45:56,369 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:45:56 INFO - 2015-11-20 17:45:56,369 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:45:56 INFO - 2015-11-20 17:45:56,369 DEBUG : BROWSER_OUTPUT: __metrics 17:45:56 INFO - 2015-11-20 17:45:56,526 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:45:57 INFO - 2015-11-20 17:45:57,718 INFO : Browser initialized. 17:45:57 INFO - 2015-11-20 17:45:57,719 INFO : Running cycle 1/1 for v8_7 test... 17:45:57 INFO - 2015-11-20 17:45:57,719 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfvhO90/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:46:09 INFO - 2015-11-20 17:46:09,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 141889536 17:46:09 INFO - 2015-11-20 17:46:09,473 DEBUG : BROWSER_OUTPUT: 17:46:30 INFO - 2015-11-20 17:46:30,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39181/tests/v8_7/run.html (next: http://localhost:39181/tests/v8_7/run.html) 17:46:31 INFO - 2015-11-20 17:46:31,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 591704064 17:46:31 INFO - 2015-11-20 17:46:31,179 DEBUG : BROWSER_OUTPUT: 17:46:31 INFO - 2015-11-20 17:46:31,179 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:46:31 INFO - 2015-11-20 17:46:31,179 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:46:31 INFO - 2015-11-20 17:46:31,179 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:46:31 INFO - 2015-11-20 17:46:31,179 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:46:31 INFO - 2015-11-20 17:46:31,180 DEBUG : BROWSER_OUTPUT: |0;Richards;162.78691193228065 17:46:31 INFO - 2015-11-20 17:46:31,181 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.21246844047388 17:46:31 INFO - 2015-11-20 17:46:31,181 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.7959416976279 17:46:31 INFO - 2015-11-20 17:46:31,181 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 17:46:31 INFO - 2015-11-20 17:46:31,181 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1109.8779134295228 17:46:31 INFO - 2015-11-20 17:46:31,181 DEBUG : BROWSER_OUTPUT: |5;Earley;793.0214115781126 17:46:31 INFO - 2015-11-20 17:46:31,182 DEBUG : BROWSER_OUTPUT: |6;Boyer;12243.90243902439 17:46:31 INFO - 2015-11-20 17:46:31,182 DEBUG : BROWSER_OUTPUT: |7;RegExp;25717.94871794872 17:46:31 INFO - 2015-11-20 17:46:31,182 DEBUG : BROWSER_OUTPUT: |8;Splay;622.1255438160348 17:46:31 INFO - 2015-11-20 17:46:31,182 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 17:46:31 INFO - 2015-11-20 17:46:31,182 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:46:31 INFO - 2015-11-20 17:46:31,182 DEBUG : BROWSER_OUTPUT: __startTimestamp1448070391178__endTimestamp 17:46:31 INFO - 2015-11-20 17:46:31,182 DEBUG : BROWSER_OUTPUT: 17:46:31 INFO - 2015-11-20 17:46:31,183 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:46:31 INFO - 2015-11-20 17:46:31,183 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:46:31 INFO - 2015-11-20 17:46:31,183 DEBUG : BROWSER_OUTPUT: 17:46:31 INFO - 2015-11-20 17:46:31,183 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.79 Median:162.79 stddev:0.00 (0.0%) 17:46:31 INFO - 2015-11-20 17:46:31,183 DEBUG : BROWSER_OUTPUT: Values: 162.8 17:46:31 INFO - 2015-11-20 17:46:31,183 DEBUG : BROWSER_OUTPUT: 17:46:31 INFO - 2015-11-20 17:46:31,183 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.21 Median:194.21 stddev:0.00 (0.0%) 17:46:31 INFO - 2015-11-20 17:46:31,184 DEBUG : BROWSER_OUTPUT: Values: 194.2 17:46:31 INFO - 2015-11-20 17:46:31,184 DEBUG : BROWSER_OUTPUT: 17:46:31 INFO - 2015-11-20 17:46:31,184 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.80 Median:285.80 stddev:0.00 (0.0%) 17:46:31 INFO - 2015-11-20 17:46:31,184 DEBUG : BROWSER_OUTPUT: Values: 285.8 17:46:31 INFO - 2015-11-20 17:46:31,184 DEBUG : BROWSER_OUTPUT: 17:46:31 INFO - 2015-11-20 17:46:31,184 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 17:46:31 INFO - 2015-11-20 17:46:31,185 DEBUG : BROWSER_OUTPUT: Values: 5035.2 17:46:31 INFO - 2015-11-20 17:46:31,185 DEBUG : BROWSER_OUTPUT: 17:46:31 INFO - 2015-11-20 17:46:31,185 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1109.88 Median:1109.88 stddev:0.00 (0.0%) 17:46:31 INFO - 2015-11-20 17:46:31,185 DEBUG : BROWSER_OUTPUT: Values: 1109.9 17:46:31 INFO - 2015-11-20 17:46:31,185 DEBUG : BROWSER_OUTPUT: 17:46:31 INFO - 2015-11-20 17:46:31,185 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.02 Median:793.02 stddev:0.00 (0.0%) 17:46:31 INFO - 2015-11-20 17:46:31,185 DEBUG : BROWSER_OUTPUT: Values: 793.0 17:46:31 INFO - 2015-11-20 17:46:31,186 DEBUG : BROWSER_OUTPUT: 17:46:31 INFO - 2015-11-20 17:46:31,186 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 17:46:31 INFO - 2015-11-20 17:46:31,186 DEBUG : BROWSER_OUTPUT: Values: 12243.9 17:46:31 INFO - 2015-11-20 17:46:31,186 DEBUG : BROWSER_OUTPUT: 17:46:31 INFO - 2015-11-20 17:46:31,186 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25717.95 Median:25717.95 stddev:0.00 (0.0%) 17:46:31 INFO - 2015-11-20 17:46:31,186 DEBUG : BROWSER_OUTPUT: Values: 25717.9 17:46:31 INFO - 2015-11-20 17:46:31,186 DEBUG : BROWSER_OUTPUT: 17:46:31 INFO - 2015-11-20 17:46:31,187 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:622.13 Median:622.13 stddev:0.00 (0.0%) 17:46:31 INFO - 2015-11-20 17:46:31,187 DEBUG : BROWSER_OUTPUT: Values: 622.1 17:46:31 INFO - 2015-11-20 17:46:31,187 DEBUG : BROWSER_OUTPUT: 17:46:31 INFO - 2015-11-20 17:46:31,187 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 17:46:31 INFO - 2015-11-20 17:46:31,187 DEBUG : BROWSER_OUTPUT: Values: 4845.4 17:46:31 INFO - 2015-11-20 17:46:31,187 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:46:31 INFO - 2015-11-20 17:46:31,187 DEBUG : BROWSER_OUTPUT: 17:46:32 INFO - 2015-11-20 17:46:32,049 INFO : Browser exited with error code: 0 17:46:32 INFO - 2015-11-20 17:46:32,066 INFO : Completed test v8_7 (00:00:39) 17:46:32 INFO - 2015-11-20 17:46:32,142 INFO : Completed test suite (00:20:11) 17:46:32 INFO - 2015-11-20 17:46:32,142 DEBUG : Working with test: dromaeo_css 17:46:32 INFO - 2015-11-20 17:46:32,142 DEBUG : Generating results file: dromaeo_css 17:46:32 INFO - 2015-11-20 17:46:32,143 DEBUG : Working with test: kraken 17:46:32 INFO - 2015-11-20 17:46:32,144 DEBUG : Generating results file: kraken 17:46:32 INFO - 2015-11-20 17:46:32,144 INFO : javascript benchmark 17:46:32 INFO - 2015-11-20 17:46:32,144 DEBUG : Working with test: v8_7 17:46:32 INFO - 2015-11-20 17:46:32,144 DEBUG : Generating results file: v8_7 17:46:32 INFO - 2015-11-20 17:46:32,145 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:46:32 INFO - 2015-11-20 17:46:32,196 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 17:46:32 INFO - 2015-11-20 17:46:32,196 DEBUG : process_Request line: dromaeo_css 6973.01 graph.html#tests=[[72,201,35]] 17:46:32 INFO - 2015-11-20 17:46:32,196 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:46:32 INFO - 2015-11-20 17:46:32,225 DEBUG : process_Request line: kraken 1494.20 graph.html#tests=[[232,201,35]] 17:46:32 INFO - 2015-11-20 17:46:32,225 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:46:32 INFO - 2015-11-20 17:46:32,254 DEBUG : process_Request line: v8_7 20962.85 graph.html#tests=[[230,201,35]] 17:46:32 INFO - 2015-11-20 17:46:32,255 INFO : javascript benchmark 17:46:32 INFO - 2015-11-20 17:46:32,258 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3163.9209019774516, 3170.5561221429, 3250.739940804736, 3262.690044445777, 3281.704646581808, 5292.708901010443, 5350.0102481040985, 5379.865503362418, 5382.2464854920345, 5421.403645598981, 5383.81156659517, 5389.164679474688, 5522.834314970557, 5524.530414914737, 5542.224088627585, 4836.274558816188, 4884.7069175849565, 4894.755262236892, 4900.142475066867, 4965.900681986358, 4966.9751651241695, 5066.847994560169, 5067.442581316052, 5077.060743762416, 5102.056119617882, 4716.740579268139, 4814.7833347499445, 5002.82490112848, 5006.148954677696, 5091.592672586185, 4967.081089998325, 4974.253861920704, 4976.253561965698, 4977.178765503688, 4980.800767969277, 4950.579200767939, 4954.504549545017, 4961.751912404401, 4969.329140566049, 4971.980743947482, 5083.669561478529, 5192.324997750268, 5220.269162317279, 5278.234655974862, 5280.656757310762, 5814.273215848019, 5819.854503637401, 5829.795957141479, 5845.503132233765, 5892.705364731789, 5830.38780928005, 5836.241288632451, 5836.737346819361, 5843.0, 5846.181534585162, 5244.449332820075, 5306.336707911511, 5344.7862085516535, 5417.6207665463435, 5529.889402211933, 5797.942020579824, 5934.851628709231, 6009.729562169713, 6016.0, 6028.909566356509, 5804.622699524602, 5829.533637309005, 5830.1244627729775, 5832.50423713989, 5889.646621202742, 5660.377358490563, 5703.828885133453, 5786.623869448473, 5792.189093526909, 5838.153467747238, 5651.491365777099, 5819.418058194146, 5877.177195192677, 5887.646741195542, 5887.793927212612, 5684.204211410406, 5842.269716285465, 5868.970655146697, 5882.411758824083, 5889.4993925515955, 4464.04023135021, 4467.285234362486, 4506.098780243964, 4510.864674059783, 4530.048689775184, 4061.3907913813164, 4062.776547289868, 4076.5719599442223, 4092.7748973806133, 4102.897427564275, 5430.0, 5544.584156188302, 5581.469760372758, 5586.664800112007, 5588.022096133161, 5776.277965254343, 5842.591018628656, 5861.0915308127305, 5871.119332100219, 5907.852303692442, 5473.808416705396, 5479.0959491684225, 5486.890262194814, 5504.587155963319, 5543.889122217533, 4966.1309270877455, 5024.874378140503, 5063.11395505785, 5064.594832413398, 5096.108181068298, 6121.786386817384, 6123.008104567321, 6126.100908718312, 6127.172831667757, 6132.95225151398, 5865.178874957424, 5929.0513517836935, 5931.288245410578, 5939.0, 5963.582549221513, 5835.066389377849, 6037.215162028908, 6042.3655516170165, 6134.079888016833, 6178.474829639531, 5772.5959182856795, 5785.0454674978155, 5787.074068149076, 5799.2750906136735, 5816.854578635399, 5841.50347220474, 5853.560982926212, 5882.852928676817, 5890.204822349099, 5892.145638882424, 5480.177973304037, 5592.608517403743, 5722.656640601577, 5793.8551536211935, 5842.649441033552, 5677.403872593318, 5694.231278777312, 5694.316681998187, 5699.116636921284, 5702.0, 5432.511074003359, 5546.972265138648, 5560.249366335493, 5564.749586268546, 5569.554435645057, 5633.8309850704545, 5689.0, 5692.857678558069, 5749.913751293818, 5764.077747560538, 5595.664260144405, 5628.521575666115, 5632.493075623213, 5633.746481408429, 5674.602777805514], "unit": "ms", "name": "dojo.html", "value": 5380.869121658563}, {"lowerIsBetter": false, "replicates": [561.270348546889, 570.985725356866, 572.4504475703325, 588.9116632505124, 607.6536374266669, 31266.218344541398, 39512.2097558049, 40237.39643905344, 40265.798671006676, 40346.193076138494, 43424.565754342446, 43847.61523847614, 43888.780556097256, 44089.77955110228, 44197.0, 7600.619969001556, 7753.844923101535, 8757.168069033463, 8921.375503714742, 8924.196822285992, 10532.947335263312, 10630.096441802418, 10676.092532134779, 10685.252032357737, 10699.893001069968, 10444.21668374875, 10542.314749541294, 10549.84175237372, 10551.525181366856, 10558.472076396189, 7792.10390805059, 7940.1265860755275, 10438.947805260963, 10630.362178269328, 10903.618373356894, 10400.323978941344, 10487.161027117812, 10504.0, 10541.20799464093, 10557.41934193619, 40668.593314067075, 41043.794781026205, 41161.1767764646, 41195.58804411977, 41208.0, 3089.6292444906753, 3197.2006998250436, 3323.6344002159744, 3408.4205685033357, 3646.6535679110443, 30396.54405183924, 31039.844800776078, 31044.223894402596, 31067.223319417197, 32399.028029159163, 3836.251930873481, 3878.9806050969846, 3967.1867267210155, 3993.9600603993877, 4008.398740188995, 273152.0, 274178.6291068532, 274348.93685099884, 274592.0, 275067.0, 53311.0, 54384.73691578518, 58836.11745823816, 59126.70436647789, 64830.67584662141, 60225.397746021976, 60304.698476508216, 60529.69735151384, 60737.0, 60761.0, 15905.761413578806, 16099.919500402657, 16130.435434759727, 16145.112018839076, 16175.110368929587, 11736.589219377282, 11770.176087673952, 11889.346085965355, 11908.225965312227, 11980.76038479243, 19485.415437536896, 19552.217911283675, 19760.505987350145, 19826.306079287155, 19894.90052549728, 7393.8151546211775, 7634.847303053908, 7638.388928885676, 7655.6937722490475, 7693.384529237647, 910.2444970674325, 918.150710592699, 973.1728031173446, 982.8329184038588, 1113.3320007995137, 24574.631380529307, 24586.754132458445, 24612.523248605143, 24635.891384887724, 24747.5050498989, 981.9950900245453, 1006.436395618456, 1006.7936073104996, 1075.5858994287255, 1202.1344631865218, 13055.608331750063, 13440.260785656883, 13490.258035807929, 13768.380422880995, 13954.302284885918, 311937.0, 312084.0, 313732.0, 316146.0, 317077.0, 50065.74967125214, 50261.497385026414, 50324.24513632225, 50394.496055039715, 50782.492175078514, 1347.1916849890183, 1357.8031185478249, 1367.131871261756, 1371.8833899118488, 1375.3192169875977, 23337.41656458602, 27991.0, 28679.283017924718, 28851.422971540873, 28984.275393115342, 48265.517344826105, 48507.757461212466, 48518.0, 48532.0, 48593.0, 250552.0, 252691.0, 253228.0, 253288.0, 254031.0, 28120.0, 28987.5651865218, 32961.34077318488, 33153.0, 33377.499337510446, 39131.21737565176, 39153.0, 39603.80198098991, 39745.40381894332, 39808.40287395749, 36214.63785362113, 36246.456303156, 36886.26227475382, 37016.81491592525, 37240.441393378576, 29394.85302573559, 33879.661203388634, 35716.82141589379, 36791.26417471689, 36968.44547331846, 34776.0, 34866.82566587252, 35321.47017794684, 35483.467747984316, 35773.0, 32169.678303217606, 33180.1704957378, 33212.667873320956, 33229.50155747617, 33261.0, 23559.0, 23667.881660592277, 24087.759122409254, 24201.636975445734, 24255.0], "unit": "ms", "name": "ext.html", "value": 18563.80736825904}, {"lowerIsBetter": false, "replicates": [363.7980920589072, 365.1564885115384, 365.5448966037284, 366.97064234861216, 370.25948103792416, 14606.488772892952, 14726.63183420415, 16731.749023764638, 17155.142242887854, 17726.113694315296, 17323.653526929455, 17431.73852392212, 17742.201600927958, 17879.82120178801, 17886.105694715276, 5181.585473162157, 5320.866978325535, 5325.973370133144, 5326.813561525348, 5331.2003199519995, 3936.980315098435, 4030.234255491447, 5315.548178404841, 5775.682337471438, 5932.406759324054, 5804.071348584227, 5840.328362238333, 5842.328132264802, 5848.941510584904, 5860.09168578871, 5662.37713851476, 5738.971305143468, 5744.4829965303115, 5746.0, 5778.27771528559, 5083.847484575469, 5089.6691715038405, 5105.387353517564, 5105.387353517602, 5114.232865070269, 20393.184272629078, 20782.48043798902, 20920.581588368146, 21342.466438339165, 21386.57226855454, 2004.9599008019904, 2069.772325044244, 2090.822280106193, 2114.4713821544615, 2465.7968516262067, 12614.558490452882, 12665.556705515262, 12924.806127908088, 13065.281409522473, 13088.672783180402, 1547.5589457004698, 1551.743962246228, 1567.9216039198109, 1591.1805420208602, 1628.267279724117, 60967.39032609662, 62859.0, 63181.36818631801, 63685.68157159231, 63827.36172638307, 9514.096160864707, 9641.132298093205, 9914.702558923243, 9921.107100361001, 9980.600775969026, 12816.231026138461, 12896.097273190786, 12898.097133200774, 12908.419121139572, 12923.676908077374, 7513.436492263102, 7730.0, 7730.574818385043, 7829.0, 7914.960425197837, 7780.416468764865, 7801.141874393812, 7840.45116841827, 7868.567228802356, 7873.606319683993, 5951.851203719855, 6029.8191054268445, 6037.0642550404755, 6042.335343112342, 6090.969545152246, 1650.5626009107596, 1696.4316953820608, 1702.4126676296657, 1727.084645138079, 1750.492357216393, 894.4096896048577, 941.2611100286242, 978.7699890525721, 1064.2337516987757, 1094.3543309447305, 14539.709205815825, 15214.771778423332, 16226.269817858225, 16533.50399488017, 17021.65956680884, 888.6401007591936, 901.1529162587148, 919.0763282900642, 938.666773295484, 943.9008904065112, 9132.726018219331, 9475.810483790285, 9565.282603804742, 9863.977884533653, 9948.651797187063, 532237.0, 536594.0, 541416.0, 542469.0, 545443.0, 77612.0, 79387.60306198432, 79410.6029469849, 79780.20219797843, 81811.18188818154, 1153.3887039868882, 1167.9299242045504, 1200.477792160413, 1204.3556697166973, 1219.7987332090283, 15586.298616562508, 15631.218439078228, 15816.446424375092, 16081.19594020271, 16106.758398623795, 34738.47892281567, 34886.953391398296, 35006.72456290333, 35372.585096595845, 36062.63937360698, 45993.77003114963, 46411.0, 46772.532274676814, 48351.27473087836, 49573.504264956886, 9114.954425228098, 9201.493917834583, 9307.953460232655, 9379.437233765995, 9395.483248421402, 17274.481765547054, 17748.935063896206, 17810.198541065423, 18028.098595070456, 18104.275828966693, 13789.931050344683, 14055.156690598596, 14135.575932722035, 14272.857271427152, 14467.49363772263, 13630.022459458909, 14121.576352709435, 14362.994590378574, 14511.0, 14664.560063198121, 15114.0, 15129.924350378178, 15259.92370038187, 15305.540833775005, 15307.693846122793, 9579.856302155335, 12854.228746275254, 13371.26458044778, 14209.0, 15193.696126077637, 14607.853921461074, 14723.116613003254, 14728.705425891636, 14986.250687465365, 15653.21733913277], "unit": "ms", "name": "jquery.html", "value": 9145.684056111539}, {"lowerIsBetter": false, "replicates": [1374.7319272741806, 1709.077098366882, 1732.237815361241, 1758.9296428142875, 1764.691179043667, 6837.111175547178, 7547.283008114227, 7760.7283745068935, 7764.3012128908385, 7765.728199513004, 7554.131274903388, 7666.846663066735, 7680.3087722105, 7684.9231507685045, 7689.961550192241, 1972.477293517219, 2024.1903238704488, 2285.245868863271, 2294.919677811277, 2318.40880575453, 2275.4993901341677, 2279.32759835848, 2279.6694479300572, 2282.041542552132, 2285.714285714286, 2251.3583628665833, 2325.2907863101746, 2325.883705814711, 2327.5344931013865, 2330.0563271874917, 1976.980230197701, 2020.0202901592788, 2268.739095004079, 2292.7592602776804, 2307.0310469602805, 2296.184854376689, 2297.9080836766675, 2319.756425575324, 2322.7212734471973, 2324.4537533679572, 7693.9615301923695, 7747.30274275318, 7766.650500727481, 7771.611419429062, 7776.066871975399, 4644.674872758908, 4740.383750112498, 4748.0, 4779.545943135397, 4779.95220047802, 3136.7176954074016, 3142.4500712375243, 3159.9684003160132, 3194.6166460024715, 3209.005208385408, 976.2287792643803, 1018.4093225928943, 1038.9948050259775, 1082.3181395720724, 1086.0876863434673, 10524.36853788775, 10532.94733526335, 10545.103666188383, 10550.208734344878, 10608.310459820164, 4186.937195942063, 4246.150769846043, 4318.071614602875, 4378.824847006084, 4378.956210437918, 9042.01075763331, 9042.095790420904, 9047.276217902683, 9050.230730387859, 9055.637774488947, 4803.135435621622, 4805.663603547788, 4820.34925285082, 4820.493848145964, 4822.180229361017, 4378.956210437918, 4382.627476664519, 4385.166818304512, 4387.517373089022, 4388.890277743082, 3634.0733113056003, 3679.6136405677553, 3685.8709945152327, 3690.520232369775, 3743.1390780120723, 1197.6526807225807, 1198.3109711915683, 1199.6461043992044, 1202.2846406388185, 1210.9455074521668, 1012.6455740490917, 1022.7596514819012, 1216.2033867816594, 1258.207329382483, 1291.0897817038965, 6379.170707807955, 7155.821104472429, 7236.529625574321, 7277.781666550012, 7316.304951029751, 516.9121249387613, 522.5088416888113, 524.1691918309522, 527.1354977836352, 528.7884846061529, 5831.387704290988, 5842.269716285465, 5847.26909136358, 5858.326292476419, 5876.7355469004, 9109.27125829932, 9238.353315268001, 9397.248220142372, 9400.717978460658, 9432.952835235918, 9175.44947303164, 9277.489738064336, 9287.396319239228, 9306.488143152192, 9313.44119352841, 7144.607046612487, 7323.487355885143, 7370.557766534025, 7392.889106663404, 7394.630268486554, 7231.0, 7273.054502914587, 7326.6702998364135, 7343.302386273295, 7345.522541034816, 8235.176482351957, 8238.217369349903, 8274.462159959583, 8405.369597280107, 8428.030776460786, 8442.746717598482, 8482.915170848459, 8679.652813887626, 8684.478931264144, 8690.044095149655, 7002.334778196063, 7073.504854660125, 7089.184743754534, 7095.680694368869, 7104.325089116525, 7493.775186744407, 7533.058367704037, 7547.773566793005, 7587.772366829004, 7604.771856844303, 7002.7899163025195, 7009.228984811769, 7141.678624461808, 7184.46116541251, 7226.494145409771, 7028.156621205488, 7087.893681594677, 7096.361327480551, 7188.5327453715345, 7214.603196824225, 6211.65835879013, 7135.892961605477, 7176.4258859290085, 7177.605231712306, 7182.138143422822, 6058.84852878664, 6138.1713468681155, 6147.815565533041, 6158.630482171084, 6171.84570385726, 6381.298057213796, 6435.839104022437, 6443.613383197023, 6444.130042444398, 6446.484281257582], "unit": "ms", "name": "mootools.html", "value": 4411.572635506656}, {"lowerIsBetter": false, "replicates": [343.48991747255303, 346.6152570646582, 348.4651060621945, 350.5547954098295, 356.4297124600639, 5854.3267524234725, 5980.940190598093, 6001.66990815505, 6007.669578173199, 6059.697015149241, 5819.127130930363, 5951.137085122655, 5963.105534169866, 5963.671998040106, 5983.042713165894, 4638.489766125724, 4641.9071618567605, 4649.9070018599605, 4659.860204193879, 4667.18324293249, 4436.112777444524, 4500.684952053358, 4533.184026875161, 4598.724076555417, 4654.255319148937, 4574.611158051553, 4592.334111553822, 4613.561711637406, 4614.23865062266, 4615.14619795339, 4603.493615702287, 4605.0, 4611.631069514431, 4619.792109355087, 4637.095766325568, 4030.435738996543, 4060.7360521566, 4063.045184381668, 4063.6952228582973, 4069.877903662895, 5608.2428872102155, 5679.659220446786, 5687.658740475544, 5693.77224911003, 5718.799842005551, 5356.276902618136, 5357.624966252364, 5359.5444387227135, 5360.303160589137, 5366.4633536646415, 6031.668258245794, 6331.493480521547, 6341.04884267359, 6347.143135676717, 6347.238331400262, 4379.0585024219945, 4404.4934832494355, 4472.1502914446155, 4495.145922274757, 4500.8649740507835, 6509.674516274167, 6553.67231638421, 6585.93414065858, 6594.505412094112, 6596.934030659728, 4609.95390046102, 4611.838585649486, 4611.9077618447445, 4613.5847773700525, 4613.677042606985, 4437.06821567468, 4499.752513611783, 4533.478649955297, 4663.0, 4666.646672464947, 5294.814681486129, 5305.32882142124, 5316.362036555561, 5317.707526086102, 5322.600804939645, 6404.647744374104, 6408.070829729663, 6417.262014868256, 6421.101045853584, 6424.453921416639, 1588.849059339361, 1603.446810850255, 1603.6151323682466, 1604.8475394837471, 1606.1808477676468, 1026.6406757634918, 1037.1339931157568, 1037.258360272409, 1075.1076606416655, 1106.5463160104318, 6012.609180403348, 6099.634021958696, 6229.595076320024, 6240.31356550779, 6240.970239910454, 6626.039224312544, 6629.1382120325015, 6631.33686631333, 6634.96682516594, 6637.435817955431, 6056.424639659225, 6212.409821066992, 6219.0, 6221.346758590374, 6222.81331560054, 3524.242287908112, 3539.7168226541817, 3572.035550401429, 3576.070221742366, 3579.785212887235, 6902.585844849325, 6905.205901321312, 6908.447324214051, 6911.7926462206215, 6922.307769223138, 6544.934550654528, 6766.898496522556, 6770.796876093626, 6815.625140617313, 6828.5902845829405, 6781.220159681699, 6800.625965571941, 6804.115464989619, 6804.727810887707, 6811.829704257433, 6616.4045235929, 6644.468442524683, 6647.667616619053, 6649.235337936199, 6650.334966503311, 6424.357564243538, 6542.869142617026, 6550.967245163743, 6552.705128269335, 6555.737770489127, 6844.726210951705, 6865.41643960269, 6866.622335771581, 6873.347032031949, 6878.828029299308, 4497.730136191839, 4500.0, 4524.457065152203, 4529.0, 4538.591526762607, 6483.0, 6565.244996825426, 6618.470522358103, 6625.039369291522, 6635.502337324817, 6404.583702059351, 6439.195100612424, 6445.967770161119, 6455.48356131499, 6455.741770329134, 6414.647194404166, 6417.807465776034, 6427.1002059710745, 6427.389398007182, 6427.557528139278, 6120.908186377297, 6216.285127210429, 6249.375062493714, 6251.156093927261, 6252.874942501034, 6439.581427207217, 6452.0, 6454.774082907075, 6455.48356131499, 6464.22429308486, 6323.968380158254, 6339.90490142639, 6340.30256671775, 6345.90481142774, 6346.904796427965], "unit": "ms", "name": "prototype.html", "value": 4826.333680749735}, {"lowerIsBetter": false, "replicates": [745.4632664481574, 755.1919446192576, 800.6997375984006, 806.870900655895, 844.9493030418175, 11997.460114294856, 12302.753944921096, 12314.38428078597, 12328.198667086634, 12338.07464440166, 11769.70575735607, 11851.940740296286, 11860.110491713134, 11876.406179691025, 11880.049596032319, 670.8121725916751, 678.9524733268673, 797.1709422200904, 805.649542449035, 814.4421071565996, 813.1258896686056, 813.995930020352, 816.147126253067, 819.848328059308, 820.8235229425673, 700.7547358424536, 848.499385362636, 852.2415050604967, 854.6111519258723, 858.8625819868822, 704.5526090932269, 830.5805568188057, 842.4313588327915, 843.2916350265775, 843.3211264931728, 618.928823185335, 622.862970146567, 623.4762799248607, 623.4980840423457, 624.0389799708444, 11660.88339116615, 11775.94112029443, 11784.351860647661, 11811.232269902515, 11815.232009919413, 10646.840297395545, 11209.327440353605, 11302.321860688302, 11432.71418214543, 11585.47865346053, 9107.817843643157, 9275.90679368488, 9294.628214871396, 9383.577739001761, 9403.247740180768, 3412.77816941898, 3430.279641275335, 3481.9477707834403, 3486.477028445728, 3488.5639295088113, 44888.77555612201, 44949.550504494866, 45042.0, 46160.0, 46187.76906115482, 7990.360771138295, 8042.451778485715, 8070.838583228303, 8179.263866252066, 8198.508089514648, 15244.085354878744, 15264.694706105816, 15271.694566108838, 15291.541253762405, 15327.770083448757, 6924.549904256207, 6941.95870619401, 6974.58152510851, 7025.929740702528, 7260.92739072613, 3675.3751862182958, 3744.588095309514, 3752.8311225994894, 3780.7920564369224, 3836.9424458633143, 2936.794424390315, 2953.3059730963205, 2961.348503329264, 2964.925876853096, 2976.9106926792233, 524.4414698346325, 587.9323877754027, 590.1354515634616, 590.3977942498714, 600.5915977135502, 613.5244736408855, 622.439804176245, 667.3960066140054, 690.0454735002629, 702.1889717376438, 7275.67259473325, 7392.260773922565, 7649.426293028045, 7868.291853733192, 7949.443538952218, 588.2793577867078, 591.4233622218388, 676.4115219758842, 680.938715515606, 719.3597698048741, 3502.824858757052, 3584.4085725854943, 3615.584207816082, 3617.8733744318824, 3728.757630753992, 50100.49899501031, 55684.0, 55689.0, 55695.0, 55786.0, 46917.765411172724, 50071.74964125156, 50138.0, 51233.0, 51331.74334128306, 44444.333335, 44810.32784508235, 46312.7684361576, 46428.767856160506, 46509.0, 7657.387409007378, 7658.310752032344, 7869.960650196713, 7897.131315555399, 8159.674492769532, 33710.662893370754, 34381.656183437844, 34702.30595388028, 34948.65051349454, 35264.29471410506, 42654.78672606617, 44065.559344407426, 45966.310505341775, 46102.30846537238, 46434.30348544707, 9850.310478266452, 9884.801930103316, 9961.950190249003, 10003.249756268164, 10271.332363396356, 10850.0, 10970.177236707439, 11310.491027903929, 11337.26307789991, 11444.94277528607, 10400.219983501116, 10826.67519974402, 11068.0, 11127.443627818739, 11145.052670522771, 10402.895971040192, 10625.0, 10703.357798532114, 10829.837552436562, 11144.721381965192, 10428.947855260978, 10581.0, 10647.89352106469, 10885.401302928414, 10896.782064358827, 8489.702860399857, 8849.734507964771, 9007.36948413631, 9215.815683686154, 9301.767455813659, 7809.648565814666, 7977.920220797718, 8046.235607617501, 8550.529720865163, 8633.0], "unit": "ms", "name": "yui.html", "value": 5909.282264726422}], "name": "dromaeo_css", "value": 6973.008052734306}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 102.0, 110.0, 109.0, 110.0, 97.0, 109.0, 112.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [158.0, 123.0, 145.0, 159.0, 124.0, 149.0, 150.0, 124.0, 162.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.9}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 161.0, 161.0, 161.0, 162.0, 163.0, 162.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 80.0, 98.0, 72.0, 72.0, 73.0, 108.0, 89.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [90.0, 92.0, 134.0, 90.0, 90.0, 91.0, 132.0, 90.0, 91.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 103.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [61.0, 60.0, 61.0, 61.0, 60.0, 61.0, 59.0, 68.0, 59.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 83.0, 84.0, 88.0, 84.0, 92.0, 92.0, 90.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.6}, {"lowerIsBetter": true, "replicates": [123.0, 123.0, 115.0, 113.0, 132.0, 115.0, 117.0, 115.0, 118.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.5}, {"lowerIsBetter": true, "replicates": [143.0, 158.0, 149.0, 150.0, 150.0, 137.0, 150.0, 148.0, 149.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.1}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 68.0, 65.0, 66.0, 68.0, 66.0, 68.0, 66.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1494.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.78691193228065], "unit": "score", "name": "Richards", "value": 216.86018600000003}, {"lowerIsBetter": false, "replicates": [194.21246844047388], "unit": "score", "name": "DeltaBlue", "value": 340.441582}, {"lowerIsBetter": false, "replicates": [285.7959416976279], "unit": "score", "name": "Encrypt", "value": 931.3673189999998}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [1109.8779134295228], "unit": "score", "name": "RayTrace", "value": 666.7300889999998}, {"lowerIsBetter": false, "replicates": [793.0214115781126], "unit": "score", "name": "Earley", "value": 840.4098429999997}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [25717.94871794872], "unit": "score", "name": "RegExp", "value": 35.42214855433696}, {"lowerIsBetter": false, "replicates": [622.1255438160348], "unit": "score", "name": "Splay", "value": 130.988030969031}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20962.85478727479}]} 17:46:32 INFO - RETURN: dromaeo_css: 6973.01 17:46:32 INFO - RETURN: kraken: 1494.20 17:46:32 INFO - RETURN: v8_7: 20962.85 17:46:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20962.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1494.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6973.01"}}} 17:46:32 INFO - Return code: 0 17:46:32 INFO - # TBPL SUCCESS # 17:46:32 INFO - Running post-action listener: _resource_record_post_action 17:46:32 INFO - Running post-run listener: _resource_record_post_run 17:46:33 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 8192; Write bytes: 506818560; Read time: 292; Write time: 560272 17:46:33 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 232226816; Read time: 0; Write time: 356284 17:46:33 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 8192; Write bytes: 274591744; Read time: 292; Write time: 203988 17:46:33 INFO - Running post-run listener: _upload_blobber_files 17:46:33 INFO - Blob upload gear active. 17:46:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:46:33 INFO - Copying logs to upload dir... 17:46:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.572145 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-20 17:46:33.252757) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 17:46:33.256703) ========= 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=a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009897 build_url: 'https://queue.taskcluster.net/v1/task/0j9pKhSnSCCZUvr0es3rNQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 17:46:33.314511) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 17:46:33.315066) ========= 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=a9e534cca236dfa67d42a089000001c1-1448067859.971100-335706129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 17:46:33.368031) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 17:46:33.368477) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 17:46:33.368882) ========= ========= Total master_lag: 0.24 =========