builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1448321314.49 results: success (0) buildid: 20151123143007 builduid: a88fdf2437194ae49c327ee4f10d9630 revision: 5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.493691) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.494117) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.494398) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006715 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.515105) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.515410) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.532502) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.532771) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004672 ========= master_lag: 0.19 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.731758) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.732083) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.732444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.732732) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 15:28: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-11-23 15:28:35 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191695 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.939437) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.939737) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017939 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.992721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.993075) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3 --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/fx-team --rev 5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3 --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=76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 15:28:35,438 truncating revision to first 12 chars 2015-11-23 15:28:35,438 Setting DEBUG logging. 2015-11-23 15:28:35,438 attempt 1/10 2015-11-23 15:28:35,438 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5f6ea7bb1641?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 15:28:35,818 unpacking tar archive at: fx-team-5f6ea7bb1641/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680465 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:35.692252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:35.692625) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:35.703163) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:35.703517) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:35.703960) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-23 15:28:35.704301) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:28:36 INFO - MultiFileLogger online at 20151123 15:28:36 in /builds/slave/test-pgo 15:28:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:28:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:28:36 INFO - {'append_to_log': False, 15:28:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:28:36 INFO - 'blob_upload_branch': 'Fx-Team', 15:28:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:28:36 INFO - 'branch': 'Fx-Team', 15:28:36 INFO - 'buildbot_json_path': 'buildprops.json', 15:28:36 INFO - 'config_files': ('talos/linux_config.py',), 15:28:36 INFO - 'default_actions': ('clobber', 15:28:36 INFO - 'read-buildbot-config', 15:28:36 INFO - 'download-and-extract', 15:28:36 INFO - 'populate-webroot', 15:28:36 INFO - 'create-virtualenv', 15:28:36 INFO - 'install', 15:28:36 INFO - 'run-tests'), 15:28:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:28:36 INFO - 'download_minidump_stackwalk': True, 15:28:36 INFO - 'download_symbols': 'ondemand', 15:28:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:28:36 INFO - 'tooltool.py': '/tools/tooltool.py', 15:28:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:28:36 INFO - '/tools/misc-python/virtualenv.py')}, 15:28:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:28:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:28:36 INFO - 'installer_path': 'installer.exe', 15:28:36 INFO - 'log_level': 'info', 15:28:36 INFO - 'log_name': 'talos', 15:28:36 INFO - 'log_to_console': True, 15:28:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:28:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:28:36 INFO - 'opt_config_files': (), 15:28:36 INFO - 'pip_index': False, 15:28:36 INFO - 'sps_profile': False, 15:28:36 INFO - 'sps_profile_interval': 0, 15:28:36 INFO - 'suite': 'dromaeojs', 15:28:36 INFO - 'system_bits': '64', 15:28:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:28:36 INFO - 'title': 'talos-linux64-ix-011', 15:28:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:28:36 INFO - 'use_talos_json': True, 15:28:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:28:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:28:36 INFO - 'work_dir': 'build'} 15:28:36 INFO - ##### 15:28:36 INFO - ##### Running clobber step. 15:28:36 INFO - ##### 15:28:36 INFO - Running pre-action listener: _resource_record_pre_action 15:28:36 INFO - Running main action method: clobber 15:28:36 INFO - rmtree: /builds/slave/test-pgo/build 15:28:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:28:37 INFO - Running post-action listener: _resource_record_post_action 15:28:37 INFO - ##### 15:28:37 INFO - ##### Running read-buildbot-config step. 15:28:37 INFO - ##### 15:28:37 INFO - Running pre-action listener: _resource_record_pre_action 15:28:37 INFO - Running main action method: read_buildbot_config 15:28:37 INFO - Using buildbot properties: 15:28:37 INFO - { 15:28:37 INFO - "properties": { 15:28:37 INFO - "buildnumber": 798, 15:28:37 INFO - "product": "firefox", 15:28:37 INFO - "script_repo_revision": "production", 15:28:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:28:37 INFO - "repository": "", 15:28:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 15:28:37 INFO - "buildid": "20151123143007", 15:28:37 INFO - "slavename": "talos-linux64-ix-011", 15:28:37 INFO - "pgo_build": "True", 15:28:37 INFO - "basedir": "/builds/slave/test-pgo", 15:28:37 INFO - "project": "", 15:28:37 INFO - "platform": "ubuntu64_hw", 15:28:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:28:37 INFO - "slavebuilddir": "test", 15:28:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 15:28:37 INFO - "branch": "fx-team", 15:28:37 INFO - "repo_path": "integration/fx-team", 15:28:37 INFO - "stage_platform": "linux64-pgo", 15:28:37 INFO - "builduid": "a88fdf2437194ae49c327ee4f10d9630", 15:28:37 INFO - "revision": "5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3" 15:28:37 INFO - }, 15:28:37 INFO - "sourcestamp": { 15:28:37 INFO - "repository": "", 15:28:37 INFO - "hasPatch": false, 15:28:37 INFO - "project": "", 15:28:37 INFO - "branch": "fx-team-linux64-pgo-talos", 15:28:37 INFO - "changes": [ 15:28:37 INFO - { 15:28:37 INFO - "category": null, 15:28:37 INFO - "files": [ 15:28:37 INFO - { 15:28:37 INFO - "url": null, 15:28:37 INFO - "name": "https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:28:37 INFO - } 15:28:37 INFO - ], 15:28:37 INFO - "repository": "", 15:28:37 INFO - "rev": "5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3", 15:28:37 INFO - "who": "sendchange", 15:28:37 INFO - "when": 1448321288, 15:28:37 INFO - "number": 6697496, 15:28:37 INFO - "comments": "", 15:28:37 INFO - "project": "", 15:28:37 INFO - "at": "Mon 23 Nov 2015 15:28:08", 15:28:37 INFO - "branch": "fx-team-linux64-pgo-talos", 15:28:37 INFO - "revlink": "", 15:28:37 INFO - "properties": [ 15:28:37 INFO - [ 15:28:37 INFO - "buildid", 15:28:37 INFO - "20151123143007", 15:28:37 INFO - "Change" 15:28:37 INFO - ], 15:28:37 INFO - [ 15:28:37 INFO - "builduid", 15:28:37 INFO - "a88fdf2437194ae49c327ee4f10d9630", 15:28:37 INFO - "Change" 15:28:37 INFO - ], 15:28:37 INFO - [ 15:28:37 INFO - "pgo_build", 15:28:37 INFO - "True", 15:28:37 INFO - "Change" 15:28:37 INFO - ] 15:28:37 INFO - ], 15:28:37 INFO - "revision": "5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3" 15:28:37 INFO - } 15:28:37 INFO - ], 15:28:37 INFO - "revision": "5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3" 15:28:37 INFO - } 15:28:37 INFO - } 15:28:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:28:37 INFO - Running post-action listener: _resource_record_post_action 15:28:37 INFO - ##### 15:28:37 INFO - ##### Running download-and-extract step. 15:28:37 INFO - ##### 15:28:37 INFO - Running pre-action listener: _resource_record_pre_action 15:28:37 INFO - Running main action method: download_and_extract 15:28:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:28: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')]} 15:28:37 INFO - https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:28:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/test_packages.json 15:28:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/test_packages.json 15:28:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:28:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:28:39 INFO - Downloaded 1302 bytes. 15:28:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:28:39 INFO - Using the following test package requirements: 15:28:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:28:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:28:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:39 INFO - u'jsshell-linux-x86_64.zip'], 15:28:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:28:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:28:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:28:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:28:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:28:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:28:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:28:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:28:39 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')]} 15:28:39 INFO - https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:28:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:28:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:28:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/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 15:28:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/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 15:28:41 INFO - Downloaded 22525834 bytes. 15:28:41 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 15:28:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:28:41 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 15:28:42 INFO - Return code: 0 15:28:42 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 15:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:42 INFO - https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:28:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:28:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:28:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/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 15:28:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/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 15:28:47 INFO - Downloaded 22525834 bytes. 15:28:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:28:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:28:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:28:48 INFO - Return code: 0 15:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:48 INFO - https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:28:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:28:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:28:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/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 15:28:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/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 15:28:49 INFO - Downloaded 11130997 bytes. 15:28:49 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 15:28:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:28:49 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 15:28:49 INFO - Return code: 0 15:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:49 INFO - https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:28:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:28:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:28:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/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 15:28:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/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 15:28:52 INFO - Downloaded 57549466 bytes. 15:28:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:28:52 INFO - mkdir: /builds/slave/test-pgo/properties 15:28:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:28:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:28:52 INFO - Contents: 15:28:52 INFO - build_url:https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:28:52 INFO - Running post-action listener: _resource_record_post_action 15:28:52 INFO - Running post-action listener: set_extra_try_arguments 15:28:52 INFO - ##### 15:28:52 INFO - ##### Running populate-webroot step. 15:28:52 INFO - ##### 15:28:52 INFO - Running pre-action listener: _resource_record_pre_action 15:28:52 INFO - Running main action method: populate_webroot 15:28:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:28:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:28:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:28:52 INFO - '../fennec_ids.txt'], 15:28:52 INFO - 'tests': ['tcheck2']}, 15:28:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:28:52 INFO - '--tppagecycles', 15:28:52 INFO - '7'], 15:28:52 INFO - 'tests': ['tsvgm']}}, 15:28:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:28:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:28:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:28:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:28:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:28:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:28:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:28:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:52 INFO - 'talos_options': ['--e10s'], 15:28:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:28:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:52 INFO - 'tests': ['damp', 'tps']}, 15:28:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:52 INFO - 'talos_options': ['--e10s'], 15:28:52 INFO - 'tests': ['damp', 'tps']}, 15:28:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:28:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:28:52 INFO - 'other': {'tests': ['a11yr', 15:28:52 INFO - 'ts_paint', 15:28:52 INFO - 'tpaint', 15:28:52 INFO - 'sessionrestore', 15:28:52 INFO - 'sessionrestore_no_auto_restore']}, 15:28:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:28:52 INFO - 'tests': ['a11yr', 15:28:52 INFO - 'ts_paint', 15:28:52 INFO - 'tpaint', 15:28:52 INFO - 'sessionrestore', 15:28:52 INFO - 'sessionrestore_no_auto_restore']}, 15:28:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:28:52 INFO - 'tests': ['a11yr', 15:28:52 INFO - 'ts_paint', 15:28:52 INFO - 'tpaint', 15:28:52 INFO - 'sessionrestore', 15:28:52 INFO - 'sessionrestore_no_auto_restore']}, 15:28:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:28:52 INFO - 'tests': ['a11yr', 15:28:52 INFO - 'ts_paint', 15:28:52 INFO - 'tpaint', 15:28:52 INFO - 'sessionrestore', 15:28:52 INFO - 'sessionrestore_no_auto_restore']}, 15:28:52 INFO - 'other_l64': {'tests': ['a11yr', 15:28:52 INFO - 'ts_paint', 15:28:52 INFO - 'tpaint', 15:28:52 INFO - 'sessionrestore', 15:28:52 INFO - 'sessionrestore_no_auto_restore']}, 15:28:52 INFO - 'other_nol64': {'tests': ['a11yr', 15:28:52 INFO - 'ts_paint', 15:28:52 INFO - 'tpaint', 15:28:52 INFO - 'sessionrestore', 15:28:52 INFO - 'sessionrestore_no_auto_restore']}, 15:28:52 INFO - 'svgr': {'tests': ['tsvgx', 15:28:52 INFO - 'tsvgr_opacity', 15:28:52 INFO - 'tart', 15:28:52 INFO - 'tscrollx', 15:28:52 INFO - 'cart']}, 15:28:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:28:52 INFO - 'tests': ['tsvgx', 15:28:52 INFO - 'tsvgr_opacity', 15:28:52 INFO - 'tart', 15:28:52 INFO - 'tscrollx', 15:28:52 INFO - 'cart']}, 15:28:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:52 INFO - 'tests': ['tp5o']}, 15:28:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:52 INFO - 'talos_options': ['--e10s'], 15:28:52 INFO - 'tests': ['tp5o']}, 15:28:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:52 INFO - 'talos_options': ['--xperf_path', 15:28:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:28:52 INFO - 'tests': ['tp5n']}, 15:28:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:52 INFO - 'talos_options': ['--e10s', 15:28:52 INFO - '--xperf_path', 15:28:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:28:52 INFO - 'tests': ['tp5n']}}, 15:28:52 INFO - 'talos.zip': {'path': '', 15:28:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:28:52 INFO - Running post-action listener: _resource_record_post_action 15:28:52 INFO - ##### 15:28:52 INFO - ##### Running create-virtualenv step. 15:28:52 INFO - ##### 15:28:52 INFO - Running pre-action listener: _resource_record_pre_action 15:28:52 INFO - Running main action method: create_virtualenv 15:28:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:28:52 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 15:28:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:28:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:28:52 INFO - Using real prefix '/usr' 15:28:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:28:53 INFO - Installing distribute.............................................................................................................................................................................................done. 15:28:55 INFO - Installing pip.................done. 15:28:55 INFO - Return code: 0 15:28:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:28: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')]} 15:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28: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')]} 15:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7c93e51c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18687c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18acd70>, '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 0x18adb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18adfb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432', '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 15:28: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 15:28: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 pip>=1.5 15:28:55 INFO - Using env: {'DISPLAY': ':0', 15:28:55 INFO - 'HOME': '/home/cltbld', 15:28:55 INFO - 'LANG': 'en_US.UTF-8', 15:28:55 INFO - 'LANGUAGE': 'en_US:en', 15:28:55 INFO - 'LOGNAME': 'cltbld', 15:28:55 INFO - 'MAIL': '/var/mail/cltbld', 15:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:55 INFO - 'MOZ_NO_REMOTE': '1', 15:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:55 INFO - 'NO_EM_RESTART': '1', 15:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:28:55 INFO - 'PWD': '/builds/slave/test-pgo', 15:28:55 INFO - 'SHELL': '/bin/bash', 15:28:55 INFO - 'SHLVL': '1', 15:28:55 INFO - 'TERM': 'linux', 15:28:55 INFO - 'TMOUT': '86400', 15:28:55 INFO - 'USER': 'cltbld', 15:28:55 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432', 15:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:55 INFO - '_': '/tools/buildbot/bin/python'} 15:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:28:55 INFO - Cleaning up... 15:28:55 INFO - Return code: 0 15:28:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:28: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')]} 15:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28: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')]} 15:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28: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', '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 0x7f7c93e51c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18687c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18acd70>, '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 0x18adb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18adfb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432', '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 15:28: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 15:28: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 psutil>=0.7.1 15:28:55 INFO - Using env: {'DISPLAY': ':0', 15:28:55 INFO - 'HOME': '/home/cltbld', 15:28:55 INFO - 'LANG': 'en_US.UTF-8', 15:28:55 INFO - 'LANGUAGE': 'en_US:en', 15:28:55 INFO - 'LOGNAME': 'cltbld', 15:28:55 INFO - 'MAIL': '/var/mail/cltbld', 15:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:55 INFO - 'MOZ_NO_REMOTE': '1', 15:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:55 INFO - 'NO_EM_RESTART': '1', 15:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:28:55 INFO - 'PWD': '/builds/slave/test-pgo', 15:28:55 INFO - 'SHELL': '/bin/bash', 15:28:55 INFO - 'SHLVL': '1', 15:28:55 INFO - 'TERM': 'linux', 15:28:55 INFO - 'TMOUT': '86400', 15:28:55 INFO - 'USER': 'cltbld', 15:28:55 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432', 15:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:55 INFO - '_': '/tools/buildbot/bin/python'} 15:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:55 INFO - Downloading/unpacking psutil>=0.7.1 15:28: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 15:28: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 15:28: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 15:28: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 15:28: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 15:28: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 15:28:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:28:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:28:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:28:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:28:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:28:57 INFO - Installing collected packages: psutil 15:28:57 INFO - Running setup.py install for psutil 15:28:57 INFO - building 'psutil._psutil_linux' extension 15:28:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:28:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:28:57 INFO - building 'psutil._psutil_posix' extension 15:28:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:28:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:28:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:28:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:28:57 INFO - Successfully installed psutil 15:28:57 INFO - Cleaning up... 15:28:57 INFO - Return code: 0 15:28:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:57 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 0x7f7c93e51c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18687c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18acd70>, '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 0x18adb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18adfb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432', '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 15:28:57 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 15:28:57 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 15:28:57 INFO - Using env: {'DISPLAY': ':0', 15:28:57 INFO - 'HOME': '/home/cltbld', 15:28:57 INFO - 'LANG': 'en_US.UTF-8', 15:28:57 INFO - 'LANGUAGE': 'en_US:en', 15:28:57 INFO - 'LOGNAME': 'cltbld', 15:28:57 INFO - 'MAIL': '/var/mail/cltbld', 15:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:57 INFO - 'MOZ_NO_REMOTE': '1', 15:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:57 INFO - 'NO_EM_RESTART': '1', 15:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:28:57 INFO - 'PWD': '/builds/slave/test-pgo', 15:28:57 INFO - 'SHELL': '/bin/bash', 15:28:57 INFO - 'SHLVL': '1', 15:28:57 INFO - 'TERM': 'linux', 15:28:57 INFO - 'TMOUT': '86400', 15:28:57 INFO - 'USER': 'cltbld', 15:28:57 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432', 15:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:57 INFO - '_': '/tools/buildbot/bin/python'} 15:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:28:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:28:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:28:59 INFO - Installing collected packages: mozsystemmonitor 15:28:59 INFO - Running setup.py install for mozsystemmonitor 15:28:59 INFO - Successfully installed mozsystemmonitor 15:28:59 INFO - Cleaning up... 15:28:59 INFO - Return code: 0 15:28:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:28:59 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')]} 15:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:59 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')]} 15:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:59 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 0x7f7c93e51c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18687c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18acd70>, '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 0x18adb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18adfb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432', '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 15:28:59 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 15:28:59 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 15:28:59 INFO - Using env: {'DISPLAY': ':0', 15:28:59 INFO - 'HOME': '/home/cltbld', 15:28:59 INFO - 'LANG': 'en_US.UTF-8', 15:28:59 INFO - 'LANGUAGE': 'en_US:en', 15:28:59 INFO - 'LOGNAME': 'cltbld', 15:28:59 INFO - 'MAIL': '/var/mail/cltbld', 15:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:59 INFO - 'MOZ_NO_REMOTE': '1', 15:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:59 INFO - 'NO_EM_RESTART': '1', 15:28:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:28:59 INFO - 'PWD': '/builds/slave/test-pgo', 15:28:59 INFO - 'SHELL': '/bin/bash', 15:28:59 INFO - 'SHLVL': '1', 15:28:59 INFO - 'TERM': 'linux', 15:28:59 INFO - 'TMOUT': '86400', 15:28:59 INFO - 'USER': 'cltbld', 15:28:59 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432', 15:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:59 INFO - '_': '/tools/buildbot/bin/python'} 15:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:00 INFO - Downloading/unpacking blobuploader==1.2.4 15:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:01 INFO - Downloading blobuploader-1.2.4.tar.gz 15:29:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:29:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:29:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:29:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:29:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:02 INFO - Downloading docopt-0.6.1.tar.gz 15:29:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:29:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:29:02 INFO - Installing collected packages: blobuploader, requests, docopt 15:29:02 INFO - Running setup.py install for blobuploader 15:29:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:29:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:29:02 INFO - Running setup.py install for requests 15:29:03 INFO - Running setup.py install for docopt 15:29:03 INFO - Successfully installed blobuploader requests docopt 15:29:03 INFO - Cleaning up... 15:29:03 INFO - Return code: 0 15:29:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:03 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 0x7f7c93e51c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18687c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18acd70>, '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 0x18adb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18adfb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432', '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 15:29:03 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 15:29:03 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 15:29:03 INFO - Using env: {'DISPLAY': ':0', 15:29:03 INFO - 'HOME': '/home/cltbld', 15:29:03 INFO - 'LANG': 'en_US.UTF-8', 15:29:03 INFO - 'LANGUAGE': 'en_US:en', 15:29:03 INFO - 'LOGNAME': 'cltbld', 15:29:03 INFO - 'MAIL': '/var/mail/cltbld', 15:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:03 INFO - 'MOZ_NO_REMOTE': '1', 15:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:03 INFO - 'NO_EM_RESTART': '1', 15:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:29:03 INFO - 'PWD': '/builds/slave/test-pgo', 15:29:03 INFO - 'SHELL': '/bin/bash', 15:29:03 INFO - 'SHLVL': '1', 15:29:03 INFO - 'TERM': 'linux', 15:29:03 INFO - 'TMOUT': '86400', 15:29:03 INFO - 'USER': 'cltbld', 15:29:03 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432', 15:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:03 INFO - '_': '/tools/buildbot/bin/python'} 15:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:29:03 INFO - Running setup.py (path:/tmp/pip-YppRXq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:29:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:29:03 INFO - Running setup.py (path:/tmp/pip-bFyq5V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:29:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:29:03 INFO - Running setup.py (path:/tmp/pip-med5oq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:29:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:29:03 INFO - Running setup.py (path:/tmp/pip-_JfAqZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:29:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:29:03 INFO - Running setup.py (path:/tmp/pip-UNb_vV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:29:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:29:03 INFO - Running setup.py (path:/tmp/pip-PF_zX6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:29:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:29:03 INFO - Running setup.py (path:/tmp/pip-WXi4Zl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:29:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:29:03 INFO - Running setup.py (path:/tmp/pip-qcW31C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:29:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:29:03 INFO - Running setup.py (path:/tmp/pip-8RbaTl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:29:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:29:04 INFO - Running setup.py (path:/tmp/pip-D_iqKe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:29:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:29:04 INFO - Running setup.py (path:/tmp/pip-HuAD3B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:29:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:29:04 INFO - Running setup.py (path:/tmp/pip-foQXcd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:29:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:29:04 INFO - Running setup.py (path:/tmp/pip-RdtKS6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:29:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:29:04 INFO - Running setup.py (path:/tmp/pip-ArMZoI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:29:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:29:04 INFO - Running setup.py (path:/tmp/pip-1q0jjN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:29:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:29:04 INFO - Running setup.py (path:/tmp/pip-1L2lyH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:29:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:29:04 INFO - Running setup.py (path:/tmp/pip-1ugRJ0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:29:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:29:04 INFO - Running setup.py install for manifestparser 15:29:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:29:04 INFO - Running setup.py install for mozcrash 15:29:04 INFO - Running setup.py install for mozdebug 15:29:04 INFO - Running setup.py install for mozdevice 15:29:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:29:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:29:05 INFO - Running setup.py install for mozfile 15:29:05 INFO - Running setup.py install for mozhttpd 15:29:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:29:05 INFO - Running setup.py install for mozinfo 15:29:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:29:05 INFO - Running setup.py install for mozInstall 15:29:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:29:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:29:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:29:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:29:05 INFO - Running setup.py install for mozleak 15:29:05 INFO - Running setup.py install for mozlog 15:29:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:29:05 INFO - Running setup.py install for moznetwork 15:29:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:29:05 INFO - Running setup.py install for mozprocess 15:29:05 INFO - Running setup.py install for mozprofile 15:29:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:29:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:29:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:29:05 INFO - Running setup.py install for mozrunner 15:29:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:29:06 INFO - Running setup.py install for mozscreenshot 15:29:06 INFO - Running setup.py install for moztest 15:29:06 INFO - Running setup.py install for mozversion 15:29:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:29:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:29:06 INFO - Cleaning up... 15:29:06 INFO - Return code: 0 15:29:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f7c93e51c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18687c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18acd70>, '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 0x18adb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18adfb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432', '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 15:29:06 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 15:29:06 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 15:29:06 INFO - Using env: {'DISPLAY': ':0', 15:29:06 INFO - 'HOME': '/home/cltbld', 15:29:06 INFO - 'LANG': 'en_US.UTF-8', 15:29:06 INFO - 'LANGUAGE': 'en_US:en', 15:29:06 INFO - 'LOGNAME': 'cltbld', 15:29:06 INFO - 'MAIL': '/var/mail/cltbld', 15:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:06 INFO - 'MOZ_NO_REMOTE': '1', 15:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:06 INFO - 'NO_EM_RESTART': '1', 15:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:29:06 INFO - 'PWD': '/builds/slave/test-pgo', 15:29:06 INFO - 'SHELL': '/bin/bash', 15:29:06 INFO - 'SHLVL': '1', 15:29:06 INFO - 'TERM': 'linux', 15:29:06 INFO - 'TMOUT': '86400', 15:29:06 INFO - 'USER': 'cltbld', 15:29:06 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432', 15:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:06 INFO - '_': '/tools/buildbot/bin/python'} 15:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:29:06 INFO - Running setup.py (path:/tmp/pip-zlCSf9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:29:06 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)) 15:29:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:29:06 INFO - Running setup.py (path:/tmp/pip-2CwRCj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:29:06 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)) 15:29:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:29:06 INFO - Running setup.py (path:/tmp/pip-orLkUS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:29:06 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)) 15:29:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:29:06 INFO - Running setup.py (path:/tmp/pip-95xmFL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:29:06 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)) 15:29:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:29:06 INFO - Running setup.py (path:/tmp/pip-0bkLU_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:29:06 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)) 15:29:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:29:06 INFO - Running setup.py (path:/tmp/pip-r0Ca1U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:29:07 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)) 15:29:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:29:07 INFO - Running setup.py (path:/tmp/pip-pFqDYQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:29:07 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)) 15:29:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:29:07 INFO - Running setup.py (path:/tmp/pip-skUqfx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:29:07 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)) 15:29:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:29:07 INFO - Running setup.py (path:/tmp/pip-3KOvvW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:29:07 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)) 15:29:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:29:07 INFO - Running setup.py (path:/tmp/pip-baN9li-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:29:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:29:07 INFO - Running setup.py (path:/tmp/pip-GIpj9Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:29:07 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)) 15:29:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:29:07 INFO - Running setup.py (path:/tmp/pip-7X3udB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:29:07 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)) 15:29:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:29:07 INFO - Running setup.py (path:/tmp/pip-GlVfcp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:29:07 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)) 15:29:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:29:07 INFO - Running setup.py (path:/tmp/pip-dHjmYq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:29:07 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)) 15:29:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:29:07 INFO - Running setup.py (path:/tmp/pip-PiIaJm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:29:07 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)) 15:29:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:29:07 INFO - Running setup.py (path:/tmp/pip-uHSg35-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:29:07 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)) 15:29:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:29:07 INFO - Running setup.py (path:/tmp/pip-gsoVeQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:29:07 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)) 15:29:07 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)) 15:29:07 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)) 15:29:07 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)) 15:29:07 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)) 15:29:07 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)) 15:29:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:29:07 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 15:29:07 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 15:29:07 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 15:29:07 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 15:29:07 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 15:29:07 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 15:29:09 INFO - Downloading blessings-1.5.1.tar.gz 15:29:09 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 15:29:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:29:09 INFO - Installing collected packages: blessings 15:29:09 INFO - Running setup.py install for blessings 15:29:09 INFO - Successfully installed blessings 15:29:09 INFO - Cleaning up... 15:29:09 INFO - Return code: 0 15:29:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:29:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:29:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:29:09 INFO - Reading from file tmpfile_stdout 15:29:09 INFO - Current package versions: 15:29:09 INFO - argparse == 1.2.1 15:29:09 INFO - blessings == 1.5.1 15:29:09 INFO - blobuploader == 1.2.4 15:29:09 INFO - docopt == 0.6.1 15:29:09 INFO - manifestparser == 1.1 15:29:09 INFO - mozInstall == 1.12 15:29:09 INFO - mozcrash == 0.16 15:29:09 INFO - mozdebug == 0.1 15:29:09 INFO - mozdevice == 0.47 15:29:09 INFO - mozfile == 1.2 15:29:09 INFO - mozhttpd == 0.7 15:29:09 INFO - mozinfo == 0.9 15:29:09 INFO - mozleak == 0.1 15:29:09 INFO - mozlog == 3.1 15:29:09 INFO - moznetwork == 0.27 15:29:09 INFO - mozprocess == 0.22 15:29:09 INFO - mozprofile == 0.27 15:29:09 INFO - mozrunner == 6.11 15:29:09 INFO - mozscreenshot == 0.1 15:29:09 INFO - mozsystemmonitor == 0.0 15:29:09 INFO - moztest == 0.7 15:29:09 INFO - mozversion == 1.4 15:29:09 INFO - psutil == 3.1.1 15:29:09 INFO - requests == 1.2.3 15:29:09 INFO - wsgiref == 0.1.2 15:29:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:29:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:09 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 0x7f7c93e51c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18687c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18acd70>, '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 0x18adb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18adfb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432', '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 15:29:09 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 15:29:09 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 15:29:09 INFO - Using env: {'DISPLAY': ':0', 15:29:09 INFO - 'HOME': '/home/cltbld', 15:29:09 INFO - 'LANG': 'en_US.UTF-8', 15:29:09 INFO - 'LANGUAGE': 'en_US:en', 15:29:09 INFO - 'LOGNAME': 'cltbld', 15:29:09 INFO - 'MAIL': '/var/mail/cltbld', 15:29:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:09 INFO - 'MOZ_NO_REMOTE': '1', 15:29:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:09 INFO - 'NO_EM_RESTART': '1', 15:29:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:29:09 INFO - 'PWD': '/builds/slave/test-pgo', 15:29:09 INFO - 'SHELL': '/bin/bash', 15:29:09 INFO - 'SHLVL': '1', 15:29:09 INFO - 'TERM': 'linux', 15:29:09 INFO - 'TMOUT': '86400', 15:29:09 INFO - 'USER': 'cltbld', 15:29:09 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432', 15:29:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:09 INFO - '_': '/tools/buildbot/bin/python'} 15:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:10 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)) 15:29:10 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)) 15:29:10 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)) 15:29:10 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)) 15:29:10 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)) 15:29:10 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)) 15:29:10 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)) 15:29:10 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)) 15:29:10 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)) 15:29:10 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)) 15:29:10 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)) 15:29:10 INFO - Cleaning up... 15:29:10 INFO - Return code: 0 15:29:10 INFO - Running post-action listener: _resource_record_post_action 15:29:10 INFO - Running post-action listener: _start_resource_monitoring 15:29:10 INFO - Starting resource monitoring. 15:29:10 INFO - ##### 15:29:10 INFO - ##### Running install step. 15:29:10 INFO - ##### 15:29:10 INFO - Running pre-action listener: _resource_record_pre_action 15:29:10 INFO - Running main action method: install 15:29:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:29:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:29:10 INFO - Reading from file tmpfile_stdout 15:29:10 INFO - Detecting whether we're running mozinstall >=1.0... 15:29:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:29:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:29:10 INFO - Reading from file tmpfile_stdout 15:29:10 INFO - Output received: 15:29:10 INFO - Usage: mozinstall [options] installer 15:29:10 INFO - Options: 15:29:10 INFO - -h, --help show this help message and exit 15:29:10 INFO - -d DEST, --destination=DEST 15:29:10 INFO - Directory to install application into. [default: 15:29:10 INFO - "/builds/slave/test-pgo"] 15:29:10 INFO - --app=APP Application being installed. [default: firefox] 15:29:10 INFO - mkdir: /builds/slave/test-pgo/build/application 15:29:10 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'] 15:29:10 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 15:29:24 INFO - Reading from file tmpfile_stdout 15:29:24 INFO - Output received: 15:29:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:29:24 INFO - Running post-action listener: _resource_record_post_action 15:29:24 INFO - ##### 15:29:24 INFO - ##### Running run-tests step. 15:29:24 INFO - ##### 15:29:24 INFO - Running pre-action listener: _resource_record_pre_action 15:29:24 INFO - Running main action method: run_tests 15:29:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:29:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:29:24 INFO - Python 2.7.3 15:29:24 INFO - Return code: 0 15:29:24 INFO - grabbing minidump binary from tooltool 15:29:24 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')]} 15:29:24 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 0x18acd70>, '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 0x18adb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18adfb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:29:24 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 15:29:24 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 15:29:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:29:25 INFO - Return code: 0 15:29:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:29:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:29:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:29:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:29:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:29:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 15:29:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost 15:29:25 INFO - Using env: {'DISPLAY': ':0', 15:29:25 INFO - 'HOME': '/home/cltbld', 15:29:25 INFO - 'LANG': 'en_US.UTF-8', 15:29:25 INFO - 'LANGUAGE': 'en_US:en', 15:29:25 INFO - 'LOGNAME': 'cltbld', 15:29:25 INFO - 'MAIL': '/var/mail/cltbld', 15:29:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:29:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:25 INFO - 'MOZ_NO_REMOTE': '1', 15:29:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:29:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:25 INFO - 'NO_EM_RESTART': '1', 15:29:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:29:25 INFO - 'PWD': '/builds/slave/test-pgo', 15:29:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:29:25 INFO - 'SHELL': '/bin/bash', 15:29:25 INFO - 'SHLVL': '1', 15:29:25 INFO - 'TERM': 'linux', 15:29:25 INFO - 'TMOUT': '86400', 15:29:25 INFO - 'USER': 'cltbld', 15:29:25 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432', 15:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:25 INFO - '_': '/tools/buildbot/bin/python'} 15:29:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] with output_timeout 3600 15:29:25 INFO - mozversion INFO | application_buildid: 20151123143007 15:29:25 INFO - mozversion INFO | application_changeset: 5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3 15:29:25 INFO - mozversion INFO | application_display_name: Nightly 15:29:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:29:25 INFO - mozversion INFO | application_name: Firefox 15:29:25 INFO - mozversion INFO | application_remotingname: firefox 15:29:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 15:29:25 INFO - mozversion INFO | application_vendor: Mozilla 15:29:25 INFO - mozversion INFO | application_version: 45.0a1 15:29:25 INFO - mozversion INFO | platform_buildid: 20151123143007 15:29:25 INFO - mozversion INFO | platform_changeset: 5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3 15:29:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 15:29:25 INFO - mozversion INFO | platform_version: 45.0a1 15:29:25 INFO - 2015-11-23 15:29:25,256 DEBUG : using testdate: 1448321365 15:29:25 INFO - 2015-11-23 15:29:25,256 DEBUG : actual date: 1448321365 15:29:25 INFO - 2015-11-23 15:29:25,265 INFO : starting webserver on 'localhost:59229' 15:29:25 INFO - 2015-11-23 15:29:25,266 INFO : Starting test suite talos-linux64-ix-011 15:29:25 INFO - 2015-11-23 15:29:25,266 INFO : Starting test dromaeo_css 15:29:25 INFO - 2015-11-23 15:29:25,266 DEBUG : operating with platform_type : linux_ 15:29:25 INFO - 2015-11-23 15:29:25,267 INFO : Initialising browser for dromaeo_css test... 15:29:25 INFO - 2015-11-23 15:29:25,280 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcHUOR9/profile http://localhost:59229/getInfo.html 15:29:30 INFO - 2015-11-23 15:29:30,142 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:29:30 INFO - 2015-11-23 15:29:30,142 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:29:30 INFO - 2015-11-23 15:29:30,142 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:29:30 INFO - 2015-11-23 15:29:30,142 DEBUG : BROWSER_OUTPUT: __metrics 15:29:30 INFO - 2015-11-23 15:29:30,299 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:29:31 INFO - 2015-11-23 15:29:31,800 INFO : Browser initialized. 15:29:31 INFO - 2015-11-23 15:29:31,800 INFO : Running cycle 1/1 for dromaeo_css test... 15:29:31 INFO - 2015-11-23 15:29:31,800 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcHUOR9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:29:43 INFO - 2015-11-23 15:29:43,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 141697024 15:29:43 INFO - 2015-11-23 15:29:43,609 DEBUG : BROWSER_OUTPUT: 15:30:35 INFO - 2015-11-23 15:30:35,135 DEBUG : BROWSER_OUTPUT: 1448321435132 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] 15:32:44 INFO - 2015-11-23 15:32:44,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59229/tests/dromaeo/cssquery-ext.html) 15:32:45 INFO - 2015-11-23 15:32:45,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 240787456 15:32:45 INFO - 2015-11-23 15:32:45,296 DEBUG : BROWSER_OUTPUT: 15:35:47 INFO - 2015-11-23 15:35:47,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/dromaeo/cssquery-ext.html (next: http://localhost:59229/tests/dromaeo/cssquery-jquery.html) 15:35:48 INFO - 2015-11-23 15:35:48,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 219877376 15:35:48 INFO - 2015-11-23 15:35:48,232 DEBUG : BROWSER_OUTPUT: 15:38:50 INFO - 2015-11-23 15:38:50,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59229/tests/dromaeo/cssquery-mootools.html) 15:38:50 INFO - 2015-11-23 15:38:50,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 212115456 15:38:50 INFO - 2015-11-23 15:38:50,734 DEBUG : BROWSER_OUTPUT: 15:41:52 INFO - 2015-11-23 15:41:52,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59229/tests/dromaeo/cssquery-prototype.html) 15:41:53 INFO - 2015-11-23 15:41:53,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 199647232 15:41:53 INFO - 2015-11-23 15:41:53,130 DEBUG : BROWSER_OUTPUT: 15:44:55 INFO - 2015-11-23 15:44:55,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59229/tests/dromaeo/cssquery-yui.html) 15:44:56 INFO - 2015-11-23 15:44:56,138 DEBUG : BROWSER_OUTPUT: RSS: Main: 204587008 15:44:56 INFO - 2015-11-23 15:44:56,138 DEBUG : BROWSER_OUTPUT: 15:47:58 INFO - 2015-11-23 15:47:58,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/dromaeo/cssquery-yui.html (next: http://localhost:59229/tests/dromaeo/cssquery-dojo.html) 15:47:58 INFO - 2015-11-23 15:47:58,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 281260032 15:47:58 INFO - 2015-11-23 15:47:58,885 DEBUG : BROWSER_OUTPUT: 15:47:58 INFO - 2015-11-23 15:47:58,885 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:47:58 INFO - 2015-11-23 15:47:58,886 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:47:58 INFO - 2015-11-23 15:47:58,886 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:47:58 INFO - 2015-11-23 15:47:58,886 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:47:58 INFO - 2015-11-23 15:47:58,886 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3180.9999999999995;3230.676932306771;3265.934681306374;3271.4275001874653;3298.983505082475;5178.741062946857;5287.576993840493;5310.73446327683;5355.758990845412;5387.865303367418;5269.578433725303;5320.920186197211;5371.704556249405;5371.865703357418;5385.057614917384;4848.709077455355;4906.362172917534;4920.384951881015;4931.679440836334;4972.577330926875;4720.12677654635;4950.455449900508;4984.601231901457;5011.67424117433;5067.670601410897;4893.21708526634;4899.853004409855;4905.681130726509;4908.828191013297;4913.852584422473;4817.229243321087;4899.681520701143;4911.435184953704;4913.852584422473;4916.926246106311;4839.41926968766;4865.8783530411665;4897.3878265216845;4919;4946.678465899705;5203.661761985497;5224.503672151178;5255.106631872591;5264.9736751315995;5290.788368465257;5520.227168196456;5634.887302253932;5814.534837213013;5837.211976383176;5840.912386314209;5645.5483561314995;5751.05107657236;5847.883042339172;5893.58744887858;5898.734556944948;5383.407825139231;5445.074337362618;5445.618806683534;5452.427495113036;5452.509274165344;5745.712714364348;5818.185454036438;5883.294004719461;5926.940730592639;5938.851528711731;5635.126555383922;5700.629459085229;5703.315602127771;5705.7147142643535;5752.108423194328;5818.738156782955;5849.678267695318;5851.444112809277;5853.590248682552;5857.0335894577765;5660.8867822643315;5780.53755699543;5785.363610002896;5795.884082318415;5810.041343178328;5659.320881494247;5722.484976352148;5723.141528770718;5725.484706376363;5774.249347584787;4431.8670439886855;4449.132419178294;4467.865964021084;4467.910641787146;4507.211238033331;3932.1349303153834;3941.2117576484243;3975;4025.315696331572;4027.234825383168;5494.917576236359;5525.889482210333;5531.557475401958;5536.390996990328;5564.165375193672;5875.383084776123;5888.676122813286;5892.970535147382;5893.3222679391565;5893.499052580579;5268.1834315681135;5380.650257733235;5390.730463476811;5467.152591348347;5476.123820188751;5094.312267843868;5104.234364845229;5106.234064890296;5126.87182820425;5169.9741501293;6033.095035744674;6036.607620504653;6037.486813620803;6046.395360463918;6047.365026672136;5674.404187560247;5787.652740835563;5793.565482588907;5796.159556864147;5797.826065218051;5993.820185394445;6080.615497489187;6086.348141495564;6121.112438696453;6134.907976380268;5697.401772813961;5701.914471282851;5725.541956643375;5730.484256416776;5734.082546792493;5569.944300556943;5689.77240910359;5756.453136951983;5793.102069179284;5806.970965145148;5695.174199741097;5728.1694154348215;5729.885402292014;5731.598788084961;5766.913496297475;5682.261306030189;5685.800996965087;5688.601797874275;5692.6299790513485;5713.457221564111;5388.407275199646;5497.945020549903;5508.118701007819;5624.212610234488;5638.295213098363;5703.429657034263;5706.201131841629;5725.828225153252;5728.026235540052;5776.653400795965;5561.499465048165;5587.720613969366;5588.497035266845;5589.888202236014;5608.46719561641 15:47:58 INFO - 2015-11-23 15:47:58,886 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.9193895538523;590.530528230057;594.7739858853635;616.8334549671591;617.6726335042429;31331.216719581993;39903.60096399035;40228;40259.79870100649;40268.194636107335;42783.14433711324;43288.3506747399;43328.3500747489;43418;43476.56523434765;7581.772546823577;7706.6917323307;7713.267239612228;8752.081031491698;8932.508712020835;10504.2647014709;10788.5684572617;10816.513256903458;10823.080038196762;10823.945880270587;10361.585536578528;10540.841887371696;10543.156547476221;10546.367217966908;10569;7749.263819937097;7904.644291006918;10358.844617330746;10592.205584581186;10872.782544349147;10238.078572928398;10266.12737917278;10334.483275836254;10389.584416623326;10395.740106497322;38831.8058409709;39090.413643795364;39170;39221.60778392208;39374.60625393738;3335.449189693152;3352.8155951422664;3470.722342212617;3504.123969007748;3656.177360093984;29144.417111657647;29282.70717292821;29320;29793.25516862074;30031.099067028023;3846.996494582523;3904.7657140571655;3974.3442332015184;4019.97990010051;4106.548279689232;274391;275189;276317;277147;277327;51242.48757512377;51262.9494820203;55547.722261389245;57434.71282643644;57930.420695792505;55069.173962390596;55193;55253.447465525634;55499.44500555024;55582;15585.844141558438;15996.360145594279;16035.679286414206;16036.919815401081;16038.75941860873;11511;11604.94197529007;11617.244879082833;11626.651200463999;11690.766184676258;19076.71384929227;19134.71297930532;19153.425397238105;19166;19171.233150674096;7291.781246562611;7434.628268586549;7500.437467189982;7525.586092764841;7585.506942048749;1002.5238011944268;1020.4438580973239;1109.3233127792041;1130.361345839598;1154.4458659843322;27895.45041443397;27947.161585152477;28042.439151216862;28163.451010194636;28419.016003319768;1032.4992378696327;1037.1702637889657;1062.824633935392;1133.7562424078862;1203.0796440722854;13953.65115872091;13985.79021314681;13986.300684965914;14205.431782728781;14230.14619122856;318086;321733;322993;323334;324683;51127.48872511227;51183.23225151626;51226.487735122915;51367.22949155766;51438.74280628648;1375.24361601119;1386.2791348498724;1393.2824595333411;1393.4078016842802;1397.2325008863795;26080.478390432465;26167.51484520512;26584.202473925812;26784.866075670277;26888.865555672095;43080.35379469248;43702.78148609237;44288;44320.55679443164;44337;203033;376246;386471;386526;386817;29628;30179.396412072074;30214.920985667533;30215;30275.697243028168;41618.58381416147;42022.57977420309;42091.7895410521;42755.572444276404;43088.569114308455;34572.82713586416;35350.29299414049;35759.82120089383;36219.818900905324;36651.633483664824;35373.46939795957;36318.455223172205;36377.81811090928;36474.45288320624;36795.63204368029;32083.839580801945;34859.47710784391;35000.64999349974;35014.82492587521;35061.1432742393;29935.70064299416;32521.674783252813;32950.83524582362;33028.83485582653;33034.17414564655;24443.633345500188;24803;25181.748182517942;25187;25374.492510150063 15:47:58 INFO - 2015-11-23 15:47:58,887 DEBUG : BROWSER_OUTPUT: |2;jquery.html;351.7695909179487;353.74176850898857;356.58101730466694;356.6344496890687;356.82515567371996;14086.506972255947;14447.711045779079;16134.193290335495;16526.752098718513;17336.65326693467;15824.683506329866;15861.762073568905;16211.270492827822;16268.349266029345;16368.75446868295;4717.150912835688;4939.481354457784;4942.728149951751;4943.357363542735;4947.455779864212;3837.9616203838023;3953.48604681391;4869.659123861331;5404.351477822647;5552.77788888446;5485.4788795064605;5512.503874651281;5513.696746678931;5540.556755459574;5547.528460080898;5398.6220964532495;5547.889042219133;5551.361593416728;5556.611037227396;5557.305336832876;5290.709011004393;5358.5981051421295;5359.598030147755;5366.973165134149;5368.141097424433;16995.915020424818;19361.12874920632;19619.411417657495;20543.691844622343;20559.691604625943;2106.757722861875;2173.413178441812;2192.78072192781;2232.6651002349613;2258.108047321315;9465.337426380156;10719.892801071968;11644.41777911101;13063.608091757262;13319.600411987656;1798.4604618614494;1806.6386722655523;1808.6834803909264;1868.560888191274;1873.1570793143003;57745.422545774425;60293;60668.69665651643;60951.39048609546;61077.38922610806;9851;10107.64623238183;10168.949155254177;10189.54147063384;10253.384796912209;13147.882429993366;13179.802302965463;13219.074664773374;13243.735125297633;13282.867171328164;7526.623668816537;7582.696692132363;7629.160792312841;7647.388208943271;7703.768886933401;7524;7528.134264559646;7537;7559.735409260649;7579.772606821804;4316.633086187647;4405.118976204772;4414.536473670282;4429.512753597101;4439.600435960714;1719.415398764426;1733.6099377640182;1734.3149455964824;1747.1962897067237;1753.7895452545777;937.2782957123113;938.2400255792693;959.1463597398321;997.481309718942;1002.3134153105146;13433.731325373437;16115.274812633459;16315.673686526441;16353.918230408772;16556.83443165553;929.0198840223494;940.8212439636447;970.7476056225291;977.2084611464736;1007.37039350406;9034.774130646654;9310.720678379525;9325.626974920928;9365.625374984924;9374.906250937403;439805;441984;472499;477121;484756;66234;71836.64081679663;75796.62101689457;75974.62012689901;77857.61071194608;1110.5335758981248;1117.2681893359863;1150;1168.0480408467072;1169.6724917023078;14523.34644940959;15126;15168.469103581321;15391.230438478255;15453.922730386275;32589.18527036843;32633.34733305273;32832.343353133285;32874;34505.30989380148;43605.78197108994;44130.55869441265;44720.77639611781;45111.774441127585;46926.76536617295;9356.438613682929;9404.717858464257;9474.621015159317;9501.857472138061;9585.233181345337;11522.76954460923;16513.587160321087;16967.830321696623;17140.057296848794;17163.82836171672;13795.724085518033;13969.650758731113;14042.578722638336;14268.357923893658;14338;13893.096948698303;13960;14000.159990400609;14030.508932187324;14509.911756618085;13779.104358216684;13980.720385592027;14045.508407205698;14072.296385180905;14815.92592037033;8852.38033337686;9203.263738901005;9368.484733339732;9434.914984776564;9440.33917625787;9679.564419601276;9743.074407931235;13126.474941002252;13308;13862.376193071133 15:47:58 INFO - 2015-11-23 15:47:58,888 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1365.1194979238385;1691.517917393543;1706.940257091002;1750.0549703160293;1760.9295628174873;6679.86640267195;7202.747903823367;7317.9634101829415;7324.48728588999;7328.083989501312;7404.40764738821;7468.178500364956;7509.0238269025085;7523.623818809065;7539.41672248827;2242.4057624729458;2259.197984715427;2261.366817291153;2267.614505534055;2269.954600907981;2282.5549017941507;2291.4385975435957;2320.9071637134493;2322.140807901079;2323.6282194848827;2242.7869352411494;2257.2776711452343;2262.253456359406;2263.8981245843893;2269.909203631853;2244.9663255051187;2258.0290475095703;2275.6358982562874;2278.4759505313787;2279.0541925101065;2256.289268880314;2263.7849404306567;2264.1396269417683;2270.1146552844402;2280.486890449652;6513.902291465632;6658.4340331071435;7437.665305061285;7495.925040749577;7496.100467943827;4556.863294101149;4634.675572709912;4644.071185762828;4649.372334734801;4664.067186562667;2855.8429286389446;2875.223689603816;2923.3422479942055;2930;2989;897.8653202019749;917.5962576466334;920.6639576554576;927.7866090799154;930.7486978515763;10141.898581014242;10253.333533320385;10255.6410525632;10257.692269231935;10263.589456421734;4176.749395036308;4195.7692326922315;4216.557261487561;4267.701260911706;4274.529801721808;8754.737357879274;8772.429792063624;8786.956065219632;8791.428557143765;8802.339824513187;4703.623710103184;4709.128811169876;4732.716037037789;4746.905061898743;4748.026654535812;4232.534421213664;4240.321548552217;4255.851045213464;4264.253755592759;4286.442762440863;3557.3063252665484;3568.660977207161;3588.318219538279;3592.8203589820405;3612.078919875415;1166.0904494494307;1196.4795314038422;1204.072863894796;1205.0961778666;1206.4269472000728;1291.8708129187194;1293.5407930184838;1321.1346567997784;1323.6426164935413;1323.8080478330587;6998.4751143664425;7018.298170182941;7033.226345102034;7044.859102817915;7056.717731290691;1195.4381440722846;1216.355331674214;1222.0712258683463;1232.4022848918266;1244.67638414013;5385.9730701347025;5652.943470565242;5721.713914304268;5741.62679425836;5758.62568933018;8621.69824056155;9018.954905225432;9106.27149828012;9117.361784675142;9124.45253284805;8773;8943.686970955985;8982.640694372283;8985.550722463982;8996.685116021039;7147.428205743528;7195.172555156224;7272.96363518179;7273.163586187656;7276.7816965490065;7032.5077244592385;7084.64576771149;7084.893726594209;7121.750738724119;7141.678624461808;7874.3306818918745;7989.360851132012;8096.473729207818;8122.7157049502985;8143.307818835466;8162.755117346489;8181.386396020203;8319;8328.916710833057;8336.249737523653;6903.6203008835;6974.930250697428;6976.058232138596;6984.301569842975;6989.5107342485535;7268.200497945116;7302.415806735342;7310.671019804228;7317.231690672403;7398.445116616383;6887.896681549681;6914.8617027660175;6917.515773895779;6954.756583519553;6966.721331146698;6608.084358523688;6614.272430032596;6677.866442671217;6844.28135045813;6861.725530978705;6442.613443193423;6615.636140012345;6634.734610615521;6642.43539299165;6660.56706314088;6171.166892469639;6205.348438413902;6205.6586887721605;6210.534209934182;6217.502599792097;6152.261728592597;6190.473809726223;6228.128062071404;6266.530010249158;6272.40412160844 15:47:58 INFO - 2015-11-23 15:47:58,889 DEBUG : BROWSER_OUTPUT: |4;prototype.html;329.160640367064;330.85277051711984;336.6145763101251;339.0506581571599;339.30273288392357;5900.527957763379;5923.111533270012;5947.851303717409;5953.851153721153;5963.671998040106;5647.661140331583;5710.086386178213;5805.970970145154;5874.70626468677;5891.558133140021;4505.707129036618;4541.477730061036;4556.20266453371;4565.680402371835;4569.611583015448;4545.045540436496;4545.227311357077;4548.295014272793;4549.067441174568;4560.885977850564;4334.306510958248;4393.406890069848;4431.689781715281;4467.463904331468;4476.81364438424;4506.864794056183;4510.345999830006;4514.210013247702;4518.502964673883;4531.682782205247;3959.1487830116375;3959.2477429288633;3965.1078507335906;3974.4038394241097;3976.880693579168;5598.944010559883;5623.775048998035;5624.015797235467;5625.184348269478;5644.096944488903;5162.741862906877;5279.9208011879855;5291.576673866081;5297.12597421425;5299.788008479656;6228;6240.937590624127;6245.437910588023;6255.593386429913;6261.06084087386;4416.160929423431;4419.381286619876;4422.159789639958;4426.336049592554;4431.7784110794655;6345.8413539661415;6536.248331441898;6537.215534135934;6543.770968016144;6567.507436942201;4402.449693788277;4426.247537918497;4434.955650443519;4439.089986552749;4443.977780111079;4486;4490.820367185276;4490.865274041784;4491.056878055645;4491.73049617024;5217.426083130853;5223.13818219997;5228.607854410934;5228.712420816892;5231.450697676765;6149.723262453111;6315.5894866833505;6319.715612797435;6320.683965801692;6321.589096708699;1567.4984005118254;1576.3536949850507;1578.8184358798655;1578.968420631581;1579.8578127968538;1037.4397825174472;1039.443897514826;1040.661784919904;1055.466989170464;1057.180684969155;6050.6974651267265;6056.485198758067;6057.545684073624;6061.8484537886025;6067.817965461043;6502.382273683992;6504.056911747864;6510.772122975768;6517.217933847874;6520.804375868732;5895.233619629421;5974.970125149433;6020;6050.515958723292;6126.816195514141;3510.140015696171;3521.207728261121;3527.735419843522;3535.505029295901;3540;6820.3861652451515;6826.317368263233;6827.453803695693;6827.52207345491;6833.248342682301;6545.607263564201;6683.699233534503;6696.430803381767;6696.5647232929705;6699.464042876558;6700.329967003261;6808.38724514796;6820.454363650896;6830.829229269209;6831.760888368884;6535.934640653532;6541.6075035498025;6543.149390579194;6546;6551.50863685216;6248.812535623939;6443.484521238383;6447.871042579029;6454.935450645621;6464.450521705708;6754.5609535380045;6805.115335006418;6806.353396427331;6814.2163651180745;6816.454683625398;4420.7126536775;4423.60187583119;4424.557544245549;4425.977870110629;4427.623651989488;6365.936340636719;6513.8697226056165;6513.934860651522;6526.477881769542;6535.542512024303;6342.968285158545;6358.332375100733;6358.745650173942;6361.427471527585;6362.872742545031;6334.4932405406535;6337.65142917144;6338.11266422692;6341.55609107358;6346.111544383698;6074.787382441594;6241.063840423973;6245.156903817927;6281.842953926189;6285.057241413824;6411.871762564816;6419.839504012437;6423.229212494343;6430.324815894263;6432.195975503062;6253.280872699515;6264.718087685974;6265.655388953652;6271.498280137669;6272.498200143887 15:47:58 INFO - 2015-11-23 15:47:58,891 DEBUG : BROWSER_OUTPUT: |5;yui.html;863.4085651328841;864.9610767515462;865.7532603208087;868.3574155125209;887.1084560017182;13155.605331840048;13358;13366.33168341584;13374.197548147118;13406.1286016409;12498.062645301616;12637.115401921868;12653.746925061494;12669.746605067892;12689.555865544684;673.3333999340654;686.7733647896207;814.6537721468382;825.331481499984;831.8752187171912;830.9792255193609;832.1678321678322;838.9622466989;839.1734141870253;839.3117643532306;858.2533196119385;863.2834747159874;865.3855762408697;865.4115201662867;865.6753717355991;712.3268511256864;722.0793488302404;843.822797212583;858.888344515209;861.0184389795638;637.8979363301896;638.3393188050392;638.6998110887876;639.1850390751782;639.2840019178503;13032.609021729364;13140.60578182656;13147.671308217276;13148.539801106916;13165;11796.233244839059;12615.621531354074;12709.618711438672;13045.86954130456;13148;9899.45552994585;9990.500474976223;10022.59909603615;10085.193184545218;10127.088562029452;3530.5586801649793;3605.3510368133725;3610.548681414823;3639;3703.0187000444903;46091.539084609394;46406.535934640895;46442.071158576975;46469.535304647194;46503.30245046327;9820.116189542832;9862.263598803609;9968.850467242997;9989.750256243651;10255.794884102275;18158.548595939643;18168.818311816714;18171.818281817013;18220;18222.27110915575;7425.7029718810645;7478.439117066242;7510.812229694192;7520.210377910241;7536.962315188389;4028.536718277377;4038.1116154445976;4068.4914385701786;4102.077032667626;4143.834246630161;3070.9539356909663;3114.4394009078583;3116.9064928052194;3118.7349075328852;3121.188490992313;538.7791005687727;543.6439132368305;547.2939907519335;550.6255746092695;553.0294333444859;562.1848319936028;627.9560430769893;630.9526785491106;664.285892665377;709.0923617769264;7971.163027882105;7975.521468711896;8050.396220283502;8124.187581241828;8138.511689298661;460.7005446459828;544.7004147718739;552.9281193444826;659.482306389482;668.204836244867;3652.470391793175;3699.1491956849536;3754.2679177560112;3777.962220377816;3865.1303456722576;61351.386486134565;61816.381836181965;62173.37826621766;62483.687581561804;62794.68602656957;53664.48697182398;54028.45971540313;54392.45607543874;54555;55004;48372.51627483751;48681;48745.51254487481;49400.25899611437;49858.75070624624;7332.376747976482;7545.358644515278;7550.5469671819865;7565.886511702439;7685.269899359552;36460.81769591241;36971.815140924125;37286.44070338893;37687.24625507529;37773.62226377701;43912.34131488094;44096.7951602425;45937.540624593326;46153.76923115497;46251.53748462472;10344.844827327446;10825.07986821129;11328.660140195807;11351.14866385008;11768.411579421167;11708.47311870985;11779.705507362385;11847.466863991314;12514.31171285588;12530;10823.512941917475;11006.669799906016;11168.553257869919;11198.328100314007;11621.360825154698;11407.942960285145;11570.537178512765;11687.824682629938;12057.095717821023;12074.39628018613;11394.943025285153;11711.707207319885;11819.113566482376;12085;12100.576479823163;9206.355555111079;9260.281328778845;9490.905090949002;9568.904310956801;9839.704808855746;8602.397832151939;8684;8830.205281524693;8878.47900238194;9000.909990900007 15:47:58 INFO - 2015-11-23 15:47:58,891 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:47:58 INFO - 2015-11-23 15:47:58,891 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:47:58 INFO - 2015-11-23 15:47:58,891 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,827 15:47:58 INFO - 2015-11-23 15:47:58,891 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:47:58 INFO - 2015-11-23 15:47:58,891 DEBUG : BROWSER_OUTPUT: __startTimestamp1448322478878__endTimestamp 15:47:58 INFO - 2015-11-23 15:47:58,891 DEBUG : BROWSER_OUTPUT: 15:47:58 INFO - 2015-11-23 15:47:58,891 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:47:58 INFO - 2015-11-23 15:47:58,891 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:47:58 INFO - 2015-11-23 15:47:58,892 DEBUG : BROWSER_OUTPUT: 15:47:58 INFO - 2015-11-23 15:47:58,892 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5380.35 Median:5588.50 stddev:598.76 (10.7%) stddev-sans-first:575.20 15:47:58 INFO - 2015-11-23 15:47:58,892 DEBUG : BROWSER_OUTPUT: Values: 3181.0 3230.7 3265.9 3271.4 3299.0 5178.7 5287.6 5310.7 5355.8 5387.9 5269.6 5320.9 5371.7 5371.9 5385.1 4848.7 4906.4 4920.4 4931.7 4972.6 4720.1 4950.5 4984.6 5011.7 5067.7 4893.2 4899.9 4905.7 4908.8 4913.9 4817.2 4899.7 4911.4 4913.9 4916.9 4839.4 4865.9 4897.4 4919.0 4946.7 5203.7 5224.5 5255.1 5265.0 5290.8 5520.2 5634.9 5814.5 5837.2 5840.9 5645.5 5751.1 5847.9 5893.6 5898.7 5383.4 5445.1 5445.6 5452.4 5452.5 5745.7 5818.2 5883.3 5926.9 5938.9 5635.1 5700.6 5703.3 5705.7 5752.1 5818.7 5849.7 5851.4 5853.6 5857.0 5660.9 5780.5 5785.4 5795.9 5810.0 5659.3 5722.5 5723.1 5725.5 5774.2 4431.9 4449.1 4467.9 4467.9 4507.2 3932.1 3941.2 3975.0 4025.3 4027.2 5494.9 5525.9 5531.6 5536.4 5564.2 5875.4 5888.7 5893.0 5893.3 5893.5 5268.2 5380.7 5390.7 5467.2 5476.1 5094.3 5104.2 5106.2 5126.9 5170.0 6033.1 6036.6 6037.5 6046.4 6047.4 5674.4 5787.7 5793.6 5796.2 5797.8 5993.8 6080.6 6086.3 6121.1 6134.9 5697.4 5701.9 5725.5 5730.5 5734.1 5569.9 5689.8 5756.5 5793.1 5807.0 5695.2 5728.2 5729.9 5731.6 5766.9 5682.3 5685.8 5688.6 5692.6 5713.5 5388.4 5497.9 5508.1 5624.2 5638.3 5703.4 5706.2 5725.8 5728.0 5776.7 5561.5 5587.7 5588.5 5589.9 5608.5 15:47:58 INFO - 2015-11-23 15:47:58,892 DEBUG : BROWSER_OUTPUT: 15:47:58 INFO - 2015-11-23 15:47:58,892 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47814.45 Median:324008.50 stddev:83814.83 (25.9%) stddev-sans-first:83974.87 15:47:58 INFO - 2015-11-23 15:47:58,893 DEBUG : BROWSER_OUTPUT: Values: 562.9 590.5 594.8 616.8 617.7 31331.2 39903.6 40228.0 40259.8 40268.2 42783.1 43288.4 43328.4 43418.0 43476.6 7581.8 7706.7 7713.3 8752.1 8932.5 10504.3 10788.6 10816.5 10823.1 10823.9 10361.6 10540.8 10543.2 10546.4 10569.0 7749.3 7904.6 10358.8 10592.2 10872.8 10238.1 10266.1 10334.5 10389.6 10395.7 38831.8 39090.4 39170.0 39221.6 39374.6 3335.4 3352.8 3470.7 3504.1 3656.2 29144.4 29282.7 29320.0 29793.3 30031.1 3847.0 3904.8 3974.3 4020.0 4106.5 274391.0 275189.0 276317.0 277147.0 277327.0 51242.5 51262.9 55547.7 57434.7 57930.4 55069.2 55193.0 55253.4 55499.4 55582.0 15585.8 15996.4 16035.7 16036.9 16038.8 11511.0 11604.9 11617.2 11626.7 11690.8 19076.7 19134.7 19153.4 19166.0 19171.2 7291.8 7434.6 7500.4 7525.6 7585.5 1002.5 1020.4 1109.3 1130.4 1154.4 27895.5 27947.2 28042.4 28163.5 28419.0 1032.5 1037.2 1062.8 1133.8 1203.1 13953.7 13985.8 13986.3 14205.4 14230.1 318086.0 321733.0 322993.0 323334.0 324683.0 51127.5 51183.2 51226.5 51367.2 51438.7 1375.2 1386.3 1393.3 1393.4 1397.2 26080.5 26167.5 26584.2 26784.9 26888.9 43080.4 43702.8 44288.0 44320.6 44337.0 203033.0 376246.0 386471.0 386526.0 386817.0 29628.0 30179.4 30214.9 30215.0 30275.7 41618.6 42022.6 42091.8 42755.6 43088.6 34572.8 35350.3 35759.8 36219.8 36651.6 35373.5 36318.5 36377.8 36474.5 36795.6 32083.8 34859.5 35000.6 35014.8 35061.1 29935.7 32521.7 32950.8 33028.8 33034.2 24443.6 24803.0 25181.7 25187.0 25374.5 15:47:58 INFO - 2015-11-23 15:47:58,893 DEBUG : BROWSER_OUTPUT: 15:47:58 INFO - 2015-11-23 15:47:58,893 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26246.56 Median:356.61 stddev:75785.65 (21251.8%) stddev-sans-first:75973.30 15:47:58 INFO - 2015-11-23 15:47:58,894 DEBUG : BROWSER_OUTPUT: Values: 351.8 353.7 356.6 356.6 356.8 14086.5 14447.7 16134.2 16526.8 17336.7 15824.7 15861.8 16211.3 16268.3 16368.8 4717.2 4939.5 4942.7 4943.4 4947.5 3838.0 3953.5 4869.7 5404.4 5552.8 5485.5 5512.5 5513.7 5540.6 5547.5 5398.6 5547.9 5551.4 5556.6 5557.3 5290.7 5358.6 5359.6 5367.0 5368.1 16995.9 19361.1 19619.4 20543.7 20559.7 2106.8 2173.4 2192.8 2232.7 2258.1 9465.3 10719.9 11644.4 13063.6 13319.6 1798.5 1806.6 1808.7 1868.6 1873.2 57745.4 60293.0 60668.7 60951.4 61077.4 9851.0 10107.6 10168.9 10189.5 10253.4 13147.9 13179.8 13219.1 13243.7 13282.9 7526.6 7582.7 7629.2 7647.4 7703.8 7524.0 7528.1 7537.0 7559.7 7579.8 4316.6 4405.1 4414.5 4429.5 4439.6 1719.4 1733.6 1734.3 1747.2 1753.8 937.3 938.2 959.1 997.5 1002.3 13433.7 16115.3 16315.7 16353.9 16556.8 929.0 940.8 970.7 977.2 1007.4 9034.8 9310.7 9325.6 9365.6 9374.9 439805.0 441984.0 472499.0 477121.0 484756.0 66234.0 71836.6 75796.6 75974.6 77857.6 1110.5 1117.3 1150.0 1168.0 1169.7 14523.3 15126.0 15168.5 15391.2 15453.9 32589.2 32633.3 32832.3 32874.0 34505.3 43605.8 44130.6 44720.8 45111.8 46926.8 9356.4 9404.7 9474.6 9501.9 9585.2 11522.8 16513.6 16967.8 17140.1 17163.8 13795.7 13969.7 14042.6 14268.4 14338.0 13893.1 13960.0 14000.2 14030.5 14509.9 13779.1 13980.7 14045.5 14072.3 14815.9 8852.4 9203.3 9368.5 9434.9 9440.3 9679.6 9743.1 13126.5 13308.0 13862.4 15:47:58 INFO - 2015-11-23 15:47:58,894 DEBUG : BROWSER_OUTPUT: 15:47:58 INFO - 2015-11-23 15:47:58,894 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5305.84 Median:6214.02 stddev:2674.12 (43.0%) stddev-sans-first:2665.21 15:47:58 INFO - 2015-11-23 15:47:58,895 DEBUG : BROWSER_OUTPUT: Values: 1365.1 1691.5 1706.9 1750.1 1760.9 6679.9 7202.7 7318.0 7324.5 7328.1 7404.4 7468.2 7509.0 7523.6 7539.4 2242.4 2259.2 2261.4 2267.6 2270.0 2282.6 2291.4 2320.9 2322.1 2323.6 2242.8 2257.3 2262.3 2263.9 2269.9 2245.0 2258.0 2275.6 2278.5 2279.1 2256.3 2263.8 2264.1 2270.1 2280.5 6513.9 6658.4 7437.7 7495.9 7496.1 4556.9 4634.7 4644.1 4649.4 4664.1 2855.8 2875.2 2923.3 2930.0 2989.0 897.9 917.6 920.7 927.8 930.7 10141.9 10253.3 10255.6 10257.7 10263.6 4176.7 4195.8 4216.6 4267.7 4274.5 8754.7 8772.4 8787.0 8791.4 8802.3 4703.6 4709.1 4732.7 4746.9 4748.0 4232.5 4240.3 4255.9 4264.3 4286.4 3557.3 3568.7 3588.3 3592.8 3612.1 1166.1 1196.5 1204.1 1205.1 1206.4 1291.9 1293.5 1321.1 1323.6 1323.8 6998.5 7018.3 7033.2 7044.9 7056.7 1195.4 1216.4 1222.1 1232.4 1244.7 5386.0 5652.9 5721.7 5741.6 5758.6 8621.7 9019.0 9106.3 9117.4 9124.5 8773.0 8943.7 8982.6 8985.6 8996.7 7147.4 7195.2 7273.0 7273.2 7276.8 7032.5 7084.6 7084.9 7121.8 7141.7 7874.3 7989.4 8096.5 8122.7 8143.3 8162.8 8181.4 8319.0 8328.9 8336.2 6903.6 6974.9 6976.1 6984.3 6989.5 7268.2 7302.4 7310.7 7317.2 7398.4 6887.9 6914.9 6917.5 6954.8 6966.7 6608.1 6614.3 6677.9 6844.3 6861.7 6442.6 6615.6 6634.7 6642.4 6660.6 6171.2 6205.3 6205.7 6210.5 6217.5 6152.3 6190.5 6228.1 6266.5 6272.4 15:47:58 INFO - 2015-11-23 15:47:58,895 DEBUG : BROWSER_OUTPUT: 15:47:58 INFO - 2015-11-23 15:47:58,895 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5273.89 Median:5969.32 stddev:1601.29 (26.8%) stddev-sans-first:1562.18 15:47:58 INFO - 2015-11-23 15:47:58,895 DEBUG : BROWSER_OUTPUT: Values: 329.2 330.9 336.6 339.1 339.3 5900.5 5923.1 5947.9 5953.9 5963.7 5647.7 5710.1 5806.0 5874.7 5891.6 4505.7 4541.5 4556.2 4565.7 4569.6 4545.0 4545.2 4548.3 4549.1 4560.9 4334.3 4393.4 4431.7 4467.5 4476.8 4506.9 4510.3 4514.2 4518.5 4531.7 3959.1 3959.2 3965.1 3974.4 3976.9 5598.9 5623.8 5624.0 5625.2 5644.1 5162.7 5279.9 5291.6 5297.1 5299.8 6228.0 6240.9 6245.4 6255.6 6261.1 4416.2 4419.4 4422.2 4426.3 4431.8 6345.8 6536.2 6537.2 6543.8 6567.5 4402.4 4426.2 4435.0 4439.1 4444.0 4486.0 4490.8 4490.9 4491.1 4491.7 5217.4 5223.1 5228.6 5228.7 5231.5 6149.7 6315.6 6319.7 6320.7 6321.6 1567.5 1576.4 1578.8 1579.0 1579.9 1037.4 1039.4 1040.7 1055.5 1057.2 6050.7 6056.5 6057.5 6061.8 6067.8 6502.4 6504.1 6510.8 6517.2 6520.8 5895.2 5975.0 6020.0 6050.5 6126.8 3510.1 3521.2 3527.7 3535.5 3540.0 6820.4 6826.3 6827.5 6827.5 6833.2 6545.6 6683.7 6696.4 6696.6 6699.5 6700.3 6808.4 6820.5 6830.8 6831.8 6535.9 6541.6 6543.1 6546.0 6551.5 6248.8 6443.5 6447.9 6454.9 6464.5 6754.6 6805.1 6806.4 6814.2 6816.5 4420.7 4423.6 4424.6 4426.0 4427.6 6365.9 6513.9 6513.9 6526.5 6535.5 6343.0 6358.3 6358.7 6361.4 6362.9 6334.5 6337.7 6338.1 6341.6 6346.1 6074.8 6241.1 6245.2 6281.8 6285.1 6411.9 6419.8 6423.2 6430.3 6432.2 6253.3 6264.7 6265.7 6271.5 6272.5 15:47:58 INFO - 2015-11-23 15:47:58,895 DEBUG : BROWSER_OUTPUT: 15:47:58 INFO - 2015-11-23 15:47:58,895 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14019.08 Median:48526.76 stddev:16716.98 (34.4%) stddev-sans-first:16734.68 15:47:58 INFO - 2015-11-23 15:47:58,895 DEBUG : BROWSER_OUTPUT: Values: 863.4 865.0 865.8 868.4 887.1 13155.6 13358.0 13366.3 13374.2 13406.1 12498.1 12637.1 12653.7 12669.7 12689.6 673.3 686.8 814.7 825.3 831.9 831.0 832.2 839.0 839.2 839.3 858.3 863.3 865.4 865.4 865.7 712.3 722.1 843.8 858.9 861.0 637.9 638.3 638.7 639.2 639.3 13032.6 13140.6 13147.7 13148.5 13165.0 11796.2 12615.6 12709.6 13045.9 13148.0 9899.5 9990.5 10022.6 10085.2 10127.1 3530.6 3605.4 3610.5 3639.0 3703.0 46091.5 46406.5 46442.1 46469.5 46503.3 9820.1 9862.3 9968.9 9989.8 10255.8 18158.5 18168.8 18171.8 18220.0 18222.3 7425.7 7478.4 7510.8 7520.2 7537.0 4028.5 4038.1 4068.5 4102.1 4143.8 3071.0 3114.4 3116.9 3118.7 3121.2 538.8 543.6 547.3 550.6 553.0 562.2 628.0 631.0 664.3 709.1 7971.2 7975.5 8050.4 8124.2 8138.5 460.7 544.7 552.9 659.5 668.2 3652.5 3699.1 3754.3 3778.0 3865.1 61351.4 61816.4 62173.4 62483.7 62794.7 53664.5 54028.5 54392.5 54555.0 55004.0 48372.5 48681.0 48745.5 49400.3 49858.8 7332.4 7545.4 7550.5 7565.9 7685.3 36460.8 36971.8 37286.4 37687.2 37773.6 43912.3 44096.8 45937.5 46153.8 46251.5 10344.8 10825.1 11328.7 11351.1 11768.4 11708.5 11779.7 11847.5 12514.3 12530.0 10823.5 11006.7 11168.6 11198.3 11621.4 11407.9 11570.5 11687.8 12057.1 12074.4 11394.9 11711.7 11819.1 12085.0 12100.6 9206.4 9260.3 9490.9 9568.9 9839.7 8602.4 8684.0 8830.2 8878.5 9000.9 15:47:58 INFO - 2015-11-23 15:47:58,895 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:47:58 INFO - 2015-11-23 15:47:58,895 DEBUG : BROWSER_OUTPUT: 15:47:59 INFO - 2015-11-23 15:47:59,573 INFO : Browser exited with error code: 0 15:47:59 INFO - 2015-11-23 15:47:59,595 INFO : Completed test dromaeo_css (00:18:34) 15:47:59 INFO - 2015-11-23 15:47:59,595 INFO : Starting test kraken 15:47:59 INFO - 2015-11-23 15:47:59,595 DEBUG : operating with platform_type : linux_ 15:47:59 INFO - 2015-11-23 15:47:59,595 INFO : Initialising browser for kraken test... 15:47:59 INFO - 2015-11-23 15:47:59,601 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp778r1i/profile http://localhost:59229/getInfo.html 15:48:03 INFO - 2015-11-23 15:48:03,833 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:48:03 INFO - 2015-11-23 15:48:03,833 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:48:03 INFO - 2015-11-23 15:48:03,833 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:48:03 INFO - 2015-11-23 15:48:03,833 DEBUG : BROWSER_OUTPUT: __metrics 15:48:04 INFO - 2015-11-23 15:48:04,063 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:48:05 INFO - 2015-11-23 15:48:05,522 INFO : Browser initialized. 15:48:05 INFO - 2015-11-23 15:48:05,523 INFO : Running cycle 1/1 for kraken test... 15:48:05 INFO - 2015-11-23 15:48:05,523 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp778r1i/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:48:17 INFO - 2015-11-23 15:48:17,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 139628544 15:48:17 INFO - 2015-11-23 15:48:17,342 DEBUG : BROWSER_OUTPUT: 15:48:19 INFO - 2015-11-23 15:48:19,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59229/tests/kraken/driver.html?testName=audio-beat-detection) 15:48:20 INFO - 2015-11-23 15:48:20,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 179499008 15:48:20 INFO - 2015-11-23 15:48:20,397 DEBUG : BROWSER_OUTPUT: 15:48:23 INFO - 2015-11-23 15:48:23,014 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59229/tests/kraken/driver.html?testName=audio-dft) 15:48:23 INFO - 2015-11-23 15:48:23,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 169213952 15:48:23 INFO - 2015-11-23 15:48:23,583 DEBUG : BROWSER_OUTPUT: 15:48:26 INFO - 2015-11-23 15:48:26,472 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59229/tests/kraken/driver.html?testName=audio-fft) 15:48:27 INFO - 2015-11-23 15:48:27,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 150564864 15:48:27 INFO - 2015-11-23 15:48:27,033 DEBUG : BROWSER_OUTPUT: 15:48:29 INFO - 2015-11-23 15:48:29,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59229/tests/kraken/driver.html?testName=audio-oscillator) 15:48:29 INFO - 2015-11-23 15:48:29,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 154079232 15:48:29 INFO - 2015-11-23 15:48:29,578 DEBUG : BROWSER_OUTPUT: 15:48:31 INFO - 2015-11-23 15:48:31,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:48:32 INFO - 2015-11-23 15:48:32,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 154509312 15:48:32 INFO - 2015-11-23 15:48:32,338 DEBUG : BROWSER_OUTPUT: 15:48:35 INFO - 2015-11-23 15:48:35,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59229/tests/kraken/driver.html?testName=imaging-darkroom) 15:48:35 INFO - 2015-11-23 15:48:35,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 155062272 15:48:35 INFO - 2015-11-23 15:48:35,776 DEBUG : BROWSER_OUTPUT: 15:48:39 INFO - 2015-11-23 15:48:39,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59229/tests/kraken/driver.html?testName=imaging-desaturate) 15:48:39 INFO - 2015-11-23 15:48:39,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 157863936 15:48:39 INFO - 2015-11-23 15:48:39,745 DEBUG : BROWSER_OUTPUT: 15:48:42 INFO - 2015-11-23 15:48:42,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59229/tests/kraken/driver.html?testName=json-parse-financial) 15:48:43 INFO - 2015-11-23 15:48:43,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 156213248 15:48:43 INFO - 2015-11-23 15:48:43,038 DEBUG : BROWSER_OUTPUT: 15:48:44 INFO - 2015-11-23 15:48:44,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:48:45 INFO - 2015-11-23 15:48:45,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 167735296 15:48:45 INFO - 2015-11-23 15:48:45,165 DEBUG : BROWSER_OUTPUT: 15:48:46 INFO - 2015-11-23 15:48:46,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59229/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:48:47 INFO - 2015-11-23 15:48:47,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 166928384 15:48:47 INFO - 2015-11-23 15:48:47,559 DEBUG : BROWSER_OUTPUT: 15:48:49 INFO - 2015-11-23 15:48:49,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:48:50 INFO - 2015-11-23 15:48:50,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 170770432 15:48:50 INFO - 2015-11-23 15:48:50,188 DEBUG : BROWSER_OUTPUT: 15:48:52 INFO - 2015-11-23 15:48:52,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:48:53 INFO - 2015-11-23 15:48:53,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 180506624 15:48:53 INFO - 2015-11-23 15:48:53,142 DEBUG : BROWSER_OUTPUT: 15:48:55 INFO - 2015-11-23 15:48:55,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:48:56 INFO - 2015-11-23 15:48:56,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 179589120 15:48:56 INFO - 2015-11-23 15:48:56,226 DEBUG : BROWSER_OUTPUT: 15:48:57 INFO - 2015-11-23 15:48:57,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59229/tests/kraken/driver.html?testName=ai-astar) 15:48:58 INFO - 2015-11-23 15:48:58,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 239570944 15:48:58 INFO - 2015-11-23 15:48:58,169 DEBUG : BROWSER_OUTPUT: 15:48:58 INFO - 2015-11-23 15:48:58,170 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:48:58 INFO - 2015-11-23 15:48:58,170 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:48:58 INFO - 2015-11-23 15:48:58,170 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:48:58 INFO - 2015-11-23 15:48:58,170 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:48:58 INFO - 2015-11-23 15:48:58,171 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;104;109;110;111;99;111;109;100 15:48:58 INFO - 2015-11-23 15:48:58,171 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;125;152;174;133;149;154;129;175;122 15:48:58 INFO - 2015-11-23 15:48:58,171 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;159;161;160;159;158;163;161;160 15:48:58 INFO - 2015-11-23 15:48:58,171 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;71;92;93;71;71;71;99;92;71 15:48:58 INFO - 2015-11-23 15:48:58,171 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;97;94;144;93;94;93;132;93;93;136 15:48:58 INFO - 2015-11-23 15:48:58,172 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;112;109;110;109;110;109 15:48:58 INFO - 2015-11-23 15:48:58,172 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;145;145;146;145;145;146;145;145 15:48:58 INFO - 2015-11-23 15:48:58,172 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;96;96;96;96;95;95 15:48:58 INFO - 2015-11-23 15:48:58,172 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;65;58;60;58;59;61;61;61;59 15:48:58 INFO - 2015-11-23 15:48:58,172 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;70;69;69;70;70;69;70;69;71 15:48:58 INFO - 2015-11-23 15:48:58,173 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;97;84;86;89;91;86;84;85;86;86 15:48:58 INFO - 2015-11-23 15:48:58,173 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;116;122;113;123;115;124;116;119;116 15:48:58 INFO - 2015-11-23 15:48:58,173 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;152;154;142;149;137;149;141;143;141 15:48:58 INFO - 2015-11-23 15:48:58,173 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;70;66;66;66;71;68;66;68;71 15:48:58 INFO - 2015-11-23 15:48:58,173 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:48:58 INFO - 2015-11-23 15:48:58,174 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:48:58 INFO - 2015-11-23 15:48:58,174 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,925 15:48:58 INFO - 2015-11-23 15:48:58,174 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:48:58 INFO - 2015-11-23 15:48:58,174 DEBUG : BROWSER_OUTPUT: __startTimestamp1448322538169__endTimestamp 15:48:58 INFO - 2015-11-23 15:48:58,174 DEBUG : BROWSER_OUTPUT: 15:48:58 INFO - 2015-11-23 15:48:58,178 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:48:58 INFO - 2015-11-23 15:48:58,178 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:48:58 INFO - 2015-11-23 15:48:58,178 DEBUG : BROWSER_OUTPUT: 15:48:58 INFO - 2015-11-23 15:48:58,178 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.30 Median:110.50 stddev:4.60 (4.2%) stddev-sans-first:4.83 15:48:58 INFO - 2015-11-23 15:48:58,178 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 104.0 109.0 110.0 111.0 99.0 111.0 109.0 100.0 15:48:58 INFO - 2015-11-23 15:48:58,179 DEBUG : BROWSER_OUTPUT: 15:48:58 INFO - 2015-11-23 15:48:58,179 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.50 Median:152.00 stddev:18.98 (12.5%) stddev-sans-first:20.03 15:48:58 INFO - 2015-11-23 15:48:58,179 DEBUG : BROWSER_OUTPUT: Values: 152.0 125.0 152.0 174.0 133.0 149.0 154.0 129.0 175.0 122.0 15:48:58 INFO - 2015-11-23 15:48:58,179 DEBUG : BROWSER_OUTPUT: 15:48:58 INFO - 2015-11-23 15:48:58,179 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:1.41 (0.9%) stddev-sans-first:1.50 15:48:58 INFO - 2015-11-23 15:48:58,180 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 159.0 161.0 160.0 159.0 158.0 163.0 161.0 160.0 15:48:58 INFO - 2015-11-23 15:48:58,180 DEBUG : BROWSER_OUTPUT: 15:48:58 INFO - 2015-11-23 15:48:58,180 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.80 Median:84.50 stddev:11.67 (13.8%) stddev-sans-first:12.30 15:48:58 INFO - 2015-11-23 15:48:58,180 DEBUG : BROWSER_OUTPUT: Values: 77.0 71.0 92.0 93.0 71.0 71.0 71.0 99.0 92.0 71.0 15:48:58 INFO - 2015-11-23 15:48:58,181 DEBUG : BROWSER_OUTPUT: 15:48:58 INFO - 2015-11-23 15:48:58,181 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.90 Median:93.00 stddev:21.23 (22.8%) stddev-sans-first:22.21 15:48:58 INFO - 2015-11-23 15:48:58,181 DEBUG : BROWSER_OUTPUT: Values: 97.0 94.0 144.0 93.0 94.0 93.0 132.0 93.0 93.0 136.0 15:48:58 INFO - 2015-11-23 15:48:58,181 DEBUG : BROWSER_OUTPUT: 15:48:58 INFO - 2015-11-23 15:48:58,181 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.95 (0.9%) stddev-sans-first:1.00 15:48:58 INFO - 2015-11-23 15:48:58,181 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 112.0 109.0 110.0 109.0 110.0 109.0 15:48:58 INFO - 2015-11-23 15:48:58,181 DEBUG : BROWSER_OUTPUT: 15:48:58 INFO - 2015-11-23 15:48:58,182 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 15:48:58 INFO - 2015-11-23 15:48:58,182 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 15:48:58 INFO - 2015-11-23 15:48:58,182 DEBUG : BROWSER_OUTPUT: 15:48:58 INFO - 2015-11-23 15:48:58,182 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:48:58 INFO - 2015-11-23 15:48:58,182 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 15:48:58 INFO - 2015-11-23 15:48:58,183 DEBUG : BROWSER_OUTPUT: 15:48:58 INFO - 2015-11-23 15:48:58,183 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.10 Median:60.50 stddev:2.08 (3.4%) stddev-sans-first:2.17 15:48:58 INFO - 2015-11-23 15:48:58,183 DEBUG : BROWSER_OUTPUT: Values: 59.0 65.0 58.0 60.0 58.0 59.0 61.0 61.0 61.0 59.0 15:48:58 INFO - 2015-11-23 15:48:58,183 DEBUG : BROWSER_OUTPUT: 15:48:58 INFO - 2015-11-23 15:48:58,183 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 15:48:58 INFO - 2015-11-23 15:48:58,183 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 69.0 69.0 70.0 70.0 69.0 70.0 69.0 71.0 15:48:58 INFO - 2015-11-23 15:48:58,184 DEBUG : BROWSER_OUTPUT: 15:48:58 INFO - 2015-11-23 15:48:58,184 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:86.00 stddev:4.01 (4.7%) stddev-sans-first:2.29 15:48:58 INFO - 2015-11-23 15:48:58,184 DEBUG : BROWSER_OUTPUT: Values: 97.0 84.0 86.0 89.0 91.0 86.0 84.0 85.0 86.0 86.0 15:48:58 INFO - 2015-11-23 15:48:58,184 DEBUG : BROWSER_OUTPUT: 15:48:58 INFO - 2015-11-23 15:48:58,184 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:117.50 stddev:3.84 (3.3%) stddev-sans-first:3.93 15:48:58 INFO - 2015-11-23 15:48:58,184 DEBUG : BROWSER_OUTPUT: Values: 115.0 116.0 122.0 113.0 123.0 115.0 124.0 116.0 119.0 116.0 15:48:58 INFO - 2015-11-23 15:48:58,184 DEBUG : BROWSER_OUTPUT: 15:48:58 INFO - 2015-11-23 15:48:58,184 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.10 Median:146.00 stddev:5.53 (3.8%) stddev-sans-first:5.81 15:48:58 INFO - 2015-11-23 15:48:58,184 DEBUG : BROWSER_OUTPUT: Values: 143.0 152.0 154.0 142.0 149.0 137.0 149.0 141.0 143.0 141.0 15:48:58 INFO - 2015-11-23 15:48:58,184 DEBUG : BROWSER_OUTPUT: 15:48:58 INFO - 2015-11-23 15:48:58,185 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:2.08 (3.1%) stddev-sans-first:2.18 15:48:58 INFO - 2015-11-23 15:48:58,185 DEBUG : BROWSER_OUTPUT: Values: 67.0 70.0 66.0 66.0 66.0 71.0 68.0 66.0 68.0 71.0 15:48:58 INFO - 2015-11-23 15:48:58,185 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:48:58 INFO - 2015-11-23 15:48:58,185 DEBUG : BROWSER_OUTPUT: 15:48:59 INFO - 2015-11-23 15:48:59,077 INFO : Browser exited with error code: 0 15:48:59 INFO - 2015-11-23 15:48:59,131 INFO : Completed test kraken (00:00:59) 15:48:59 INFO - 2015-11-23 15:48:59,131 INFO : Starting test v8_7 15:48:59 INFO - 2015-11-23 15:48:59,131 DEBUG : operating with platform_type : linux_ 15:48:59 INFO - 2015-11-23 15:48:59,131 INFO : Initialising browser for v8_7 test... 15:48:59 INFO - 2015-11-23 15:48:59,137 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvlHawz/profile http://localhost:59229/getInfo.html 15:49:03 INFO - 2015-11-23 15:49:03,624 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:49:03 INFO - 2015-11-23 15:49:03,624 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:49:03 INFO - 2015-11-23 15:49:03,624 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:49:03 INFO - 2015-11-23 15:49:03,624 DEBUG : BROWSER_OUTPUT: __metrics 15:49:03 INFO - 2015-11-23 15:49:03,781 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:49:05 INFO - 2015-11-23 15:49:05,306 INFO : Browser initialized. 15:49:05 INFO - 2015-11-23 15:49:05,306 INFO : Running cycle 1/1 for v8_7 test... 15:49:05 INFO - 2015-11-23 15:49:05,307 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvlHawz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:49:17 INFO - 2015-11-23 15:49:17,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 140075008 15:49:17 INFO - 2015-11-23 15:49:17,088 DEBUG : BROWSER_OUTPUT: 15:49:38 INFO - 2015-11-23 15:49:38,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59229/tests/v8_7/run.html (next: http://localhost:59229/tests/v8_7/run.html) 15:49:38 INFO - 2015-11-23 15:49:38,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 547573760 15:49:38 INFO - 2015-11-23 15:49:38,703 DEBUG : BROWSER_OUTPUT: 15:49:38 INFO - 2015-11-23 15:49:38,705 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:49:38 INFO - 2015-11-23 15:49:38,705 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:49:38 INFO - 2015-11-23 15:49:38,705 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:49:38 INFO - 2015-11-23 15:49:38,705 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:49:38 INFO - 2015-11-23 15:49:38,706 DEBUG : BROWSER_OUTPUT: |0;Richards;189.3939393939394 15:49:38 INFO - 2015-11-23 15:49:38,706 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.66614755693985 15:49:38 INFO - 2015-11-23 15:49:38,706 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.9002849002849 15:49:38 INFO - 2015-11-23 15:49:38,706 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4995.024875621891 15:49:38 INFO - 2015-11-23 15:49:38,706 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1955.078125 15:49:38 INFO - 2015-11-23 15:49:38,707 DEBUG : BROWSER_OUTPUT: |5;Earley;775.7951900698216 15:49:38 INFO - 2015-11-23 15:49:38,707 DEBUG : BROWSER_OUTPUT: |6;Boyer;12156.626506024097 15:49:38 INFO - 2015-11-23 15:49:38,707 DEBUG : BROWSER_OUTPUT: |7;RegExp;25871.79487179487 15:49:38 INFO - 2015-11-23 15:49:38,707 DEBUG : BROWSER_OUTPUT: |8;Splay;594.883997620464 15:49:38 INFO - 2015-11-23 15:49:38,708 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 15:49:38 INFO - 2015-11-23 15:49:38,708 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:49:38 INFO - 2015-11-23 15:49:38,708 DEBUG : BROWSER_OUTPUT: __startTimestamp1448322578703__endTimestamp 15:49:38 INFO - 2015-11-23 15:49:38,709 DEBUG : BROWSER_OUTPUT: 15:49:38 INFO - 2015-11-23 15:49:38,709 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:49:38 INFO - 2015-11-23 15:49:38,709 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:49:38 INFO - 2015-11-23 15:49:38,709 DEBUG : BROWSER_OUTPUT: 15:49:38 INFO - 2015-11-23 15:49:38,710 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.39 Median:189.39 stddev:0.00 (0.0%) 15:49:38 INFO - 2015-11-23 15:49:38,710 DEBUG : BROWSER_OUTPUT: Values: 189.4 15:49:38 INFO - 2015-11-23 15:49:38,710 DEBUG : BROWSER_OUTPUT: 15:49:38 INFO - 2015-11-23 15:49:38,711 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.67 Median:194.67 stddev:0.00 (0.0%) 15:49:38 INFO - 2015-11-23 15:49:38,711 DEBUG : BROWSER_OUTPUT: Values: 194.7 15:49:38 INFO - 2015-11-23 15:49:38,711 DEBUG : BROWSER_OUTPUT: 15:49:38 INFO - 2015-11-23 15:49:38,711 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.90 Median:284.90 stddev:0.00 (0.0%) 15:49:38 INFO - 2015-11-23 15:49:38,712 DEBUG : BROWSER_OUTPUT: Values: 284.9 15:49:38 INFO - 2015-11-23 15:49:38,712 DEBUG : BROWSER_OUTPUT: 15:49:38 INFO - 2015-11-23 15:49:38,712 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4995.02 Median:4995.02 stddev:0.00 (0.0%) 15:49:38 INFO - 2015-11-23 15:49:38,713 DEBUG : BROWSER_OUTPUT: Values: 4995.0 15:49:38 INFO - 2015-11-23 15:49:38,713 DEBUG : BROWSER_OUTPUT: 15:49:38 INFO - 2015-11-23 15:49:38,713 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1955.08 Median:1955.08 stddev:0.00 (0.0%) 15:49:38 INFO - 2015-11-23 15:49:38,714 DEBUG : BROWSER_OUTPUT: Values: 1955.1 15:49:38 INFO - 2015-11-23 15:49:38,714 DEBUG : BROWSER_OUTPUT: 15:49:38 INFO - 2015-11-23 15:49:38,714 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:775.80 Median:775.80 stddev:0.00 (0.0%) 15:49:38 INFO - 2015-11-23 15:49:38,714 DEBUG : BROWSER_OUTPUT: Values: 775.8 15:49:38 INFO - 2015-11-23 15:49:38,715 DEBUG : BROWSER_OUTPUT: 15:49:38 INFO - 2015-11-23 15:49:38,715 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12156.63 Median:12156.63 stddev:0.00 (0.0%) 15:49:38 INFO - 2015-11-23 15:49:38,715 DEBUG : BROWSER_OUTPUT: Values: 12156.6 15:49:38 INFO - 2015-11-23 15:49:38,715 DEBUG : BROWSER_OUTPUT: 15:49:38 INFO - 2015-11-23 15:49:38,715 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25871.79 Median:25871.79 stddev:0.00 (0.0%) 15:49:38 INFO - 2015-11-23 15:49:38,716 DEBUG : BROWSER_OUTPUT: Values: 25871.8 15:49:38 INFO - 2015-11-23 15:49:38,716 DEBUG : BROWSER_OUTPUT: 15:49:38 INFO - 2015-11-23 15:49:38,716 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:594.88 Median:594.88 stddev:0.00 (0.0%) 15:49:38 INFO - 2015-11-23 15:49:38,716 DEBUG : BROWSER_OUTPUT: Values: 594.9 15:49:38 INFO - 2015-11-23 15:49:38,716 DEBUG : BROWSER_OUTPUT: 15:49:38 INFO - 2015-11-23 15:49:38,716 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 15:49:38 INFO - 2015-11-23 15:49:38,717 DEBUG : BROWSER_OUTPUT: Values: 4850.2 15:49:38 INFO - 2015-11-23 15:49:38,717 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:49:38 INFO - 2015-11-23 15:49:38,717 DEBUG : BROWSER_OUTPUT: 15:49:39 INFO - 2015-11-23 15:49:39,673 INFO : Browser exited with error code: 0 15:49:39 INFO - 2015-11-23 15:49:39,690 INFO : Completed test v8_7 (00:00:40) 15:49:39 INFO - 2015-11-23 15:49:39,757 INFO : Completed test suite (00:20:14) 15:49:39 INFO - 2015-11-23 15:49:39,757 DEBUG : Working with test: dromaeo_css 15:49:39 INFO - 2015-11-23 15:49:39,757 DEBUG : Generating results file: dromaeo_css 15:49:39 INFO - 2015-11-23 15:49:39,758 DEBUG : Working with test: kraken 15:49:39 INFO - 2015-11-23 15:49:39,759 DEBUG : Generating results file: kraken 15:49:39 INFO - 2015-11-23 15:49:39,759 INFO : javascript benchmark 15:49:39 INFO - 2015-11-23 15:49:39,759 DEBUG : Working with test: v8_7 15:49:39 INFO - 2015-11-23 15:49:39,759 DEBUG : Generating results file: v8_7 15:49:39 INFO - 2015-11-23 15:49:39,760 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:49:39 INFO - 2015-11-23 15:49:39,810 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 15:49:39 INFO - 2015-11-23 15:49:39,810 DEBUG : process_Request line: dromaeo_css 6960.74 graph.html#tests=[[72,64,35]] 15:49:39 INFO - 2015-11-23 15:49:39,810 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:49:39 INFO - 2015-11-23 15:49:39,838 DEBUG : process_Request line: kraken 1500.20 graph.html#tests=[[232,64,35]] 15:49:39 INFO - 2015-11-23 15:49:39,838 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:49:39 INFO - 2015-11-23 15:49:39,864 DEBUG : process_Request line: v8_7 19656.27 graph.html#tests=[[230,64,35]] 15:49:39 INFO - 2015-11-23 15:49:39,865 INFO : javascript benchmark 15:49:39 INFO - 2015-11-23 15:49:39,869 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3180.9999999999995, 3230.676932306771, 3265.934681306374, 3271.4275001874653, 3298.983505082475, 5178.741062946857, 5287.576993840493, 5310.73446327683, 5355.758990845412, 5387.865303367418, 5269.578433725303, 5320.920186197211, 5371.704556249405, 5371.865703357418, 5385.057614917384, 4848.709077455355, 4906.362172917534, 4920.384951881015, 4931.679440836334, 4972.577330926875, 4720.12677654635, 4950.455449900508, 4984.601231901457, 5011.67424117433, 5067.670601410897, 4893.21708526634, 4899.853004409855, 4905.681130726509, 4908.828191013297, 4913.852584422473, 4817.229243321087, 4899.681520701143, 4911.435184953704, 4913.852584422473, 4916.926246106311, 4839.41926968766, 4865.8783530411665, 4897.3878265216845, 4919.0, 4946.678465899705, 5203.661761985497, 5224.503672151178, 5255.106631872591, 5264.9736751315995, 5290.788368465257, 5520.227168196456, 5634.887302253932, 5814.534837213013, 5837.211976383176, 5840.912386314209, 5645.5483561314995, 5751.05107657236, 5847.883042339172, 5893.58744887858, 5898.734556944948, 5383.407825139231, 5445.074337362618, 5445.618806683534, 5452.427495113036, 5452.509274165344, 5745.712714364348, 5818.185454036438, 5883.294004719461, 5926.940730592639, 5938.851528711731, 5635.126555383922, 5700.629459085229, 5703.315602127771, 5705.7147142643535, 5752.108423194328, 5818.738156782955, 5849.678267695318, 5851.444112809277, 5853.590248682552, 5857.0335894577765, 5660.8867822643315, 5780.53755699543, 5785.363610002896, 5795.884082318415, 5810.041343178328, 5659.320881494247, 5722.484976352148, 5723.141528770718, 5725.484706376363, 5774.249347584787, 4431.8670439886855, 4449.132419178294, 4467.865964021084, 4467.910641787146, 4507.211238033331, 3932.1349303153834, 3941.2117576484243, 3975.0, 4025.315696331572, 4027.234825383168, 5494.917576236359, 5525.889482210333, 5531.557475401958, 5536.390996990328, 5564.165375193672, 5875.383084776123, 5888.676122813286, 5892.970535147382, 5893.3222679391565, 5893.499052580579, 5268.1834315681135, 5380.650257733235, 5390.730463476811, 5467.152591348347, 5476.123820188751, 5094.312267843868, 5104.234364845229, 5106.234064890296, 5126.87182820425, 5169.9741501293, 6033.095035744674, 6036.607620504653, 6037.486813620803, 6046.395360463918, 6047.365026672136, 5674.404187560247, 5787.652740835563, 5793.565482588907, 5796.159556864147, 5797.826065218051, 5993.820185394445, 6080.615497489187, 6086.348141495564, 6121.112438696453, 6134.907976380268, 5697.401772813961, 5701.914471282851, 5725.541956643375, 5730.484256416776, 5734.082546792493, 5569.944300556943, 5689.77240910359, 5756.453136951983, 5793.102069179284, 5806.970965145148, 5695.174199741097, 5728.1694154348215, 5729.885402292014, 5731.598788084961, 5766.913496297475, 5682.261306030189, 5685.800996965087, 5688.601797874275, 5692.6299790513485, 5713.457221564111, 5388.407275199646, 5497.945020549903, 5508.118701007819, 5624.212610234488, 5638.295213098363, 5703.429657034263, 5706.201131841629, 5725.828225153252, 5728.026235540052, 5776.653400795965, 5561.499465048165, 5587.720613969366, 5588.497035266845, 5589.888202236014, 5608.46719561641], "unit": "ms", "name": "dojo.html", "value": 5341.591123608498}, {"lowerIsBetter": false, "replicates": [562.9193895538523, 590.530528230057, 594.7739858853635, 616.8334549671591, 617.6726335042429, 31331.216719581993, 39903.60096399035, 40228.0, 40259.79870100649, 40268.194636107335, 42783.14433711324, 43288.3506747399, 43328.3500747489, 43418.0, 43476.56523434765, 7581.772546823577, 7706.6917323307, 7713.267239612228, 8752.081031491698, 8932.508712020835, 10504.2647014709, 10788.5684572617, 10816.513256903458, 10823.080038196762, 10823.945880270587, 10361.585536578528, 10540.841887371696, 10543.156547476221, 10546.367217966908, 10569.0, 7749.263819937097, 7904.644291006918, 10358.844617330746, 10592.205584581186, 10872.782544349147, 10238.078572928398, 10266.12737917278, 10334.483275836254, 10389.584416623326, 10395.740106497322, 38831.8058409709, 39090.413643795364, 39170.0, 39221.60778392208, 39374.60625393738, 3335.449189693152, 3352.8155951422664, 3470.722342212617, 3504.123969007748, 3656.177360093984, 29144.417111657647, 29282.70717292821, 29320.0, 29793.25516862074, 30031.099067028023, 3846.996494582523, 3904.7657140571655, 3974.3442332015184, 4019.97990010051, 4106.548279689232, 274391.0, 275189.0, 276317.0, 277147.0, 277327.0, 51242.48757512377, 51262.9494820203, 55547.722261389245, 57434.71282643644, 57930.420695792505, 55069.173962390596, 55193.0, 55253.447465525634, 55499.44500555024, 55582.0, 15585.844141558438, 15996.360145594279, 16035.679286414206, 16036.919815401081, 16038.75941860873, 11511.0, 11604.94197529007, 11617.244879082833, 11626.651200463999, 11690.766184676258, 19076.71384929227, 19134.71297930532, 19153.425397238105, 19166.0, 19171.233150674096, 7291.781246562611, 7434.628268586549, 7500.437467189982, 7525.586092764841, 7585.506942048749, 1002.5238011944268, 1020.4438580973239, 1109.3233127792041, 1130.361345839598, 1154.4458659843322, 27895.45041443397, 27947.161585152477, 28042.439151216862, 28163.451010194636, 28419.016003319768, 1032.4992378696327, 1037.1702637889657, 1062.824633935392, 1133.7562424078862, 1203.0796440722854, 13953.65115872091, 13985.79021314681, 13986.300684965914, 14205.431782728781, 14230.14619122856, 318086.0, 321733.0, 322993.0, 323334.0, 324683.0, 51127.48872511227, 51183.23225151626, 51226.487735122915, 51367.22949155766, 51438.74280628648, 1375.24361601119, 1386.2791348498724, 1393.2824595333411, 1393.4078016842802, 1397.2325008863795, 26080.478390432465, 26167.51484520512, 26584.202473925812, 26784.866075670277, 26888.865555672095, 43080.35379469248, 43702.78148609237, 44288.0, 44320.55679443164, 44337.0, 203033.0, 376246.0, 386471.0, 386526.0, 386817.0, 29628.0, 30179.396412072074, 30214.920985667533, 30215.0, 30275.697243028168, 41618.58381416147, 42022.57977420309, 42091.7895410521, 42755.572444276404, 43088.569114308455, 34572.82713586416, 35350.29299414049, 35759.82120089383, 36219.818900905324, 36651.633483664824, 35373.46939795957, 36318.455223172205, 36377.81811090928, 36474.45288320624, 36795.63204368029, 32083.839580801945, 34859.47710784391, 35000.64999349974, 35014.82492587521, 35061.1432742393, 29935.70064299416, 32521.674783252813, 32950.83524582362, 33028.83485582653, 33034.17414564655, 24443.633345500188, 24803.0, 25181.748182517942, 25187.0, 25374.492510150063], "unit": "ms", "name": "ext.html", "value": 18714.144346163317}, {"lowerIsBetter": false, "replicates": [351.7695909179487, 353.74176850898857, 356.58101730466694, 356.6344496890687, 356.82515567371996, 14086.506972255947, 14447.711045779079, 16134.193290335495, 16526.752098718513, 17336.65326693467, 15824.683506329866, 15861.762073568905, 16211.270492827822, 16268.349266029345, 16368.75446868295, 4717.150912835688, 4939.481354457784, 4942.728149951751, 4943.357363542735, 4947.455779864212, 3837.9616203838023, 3953.48604681391, 4869.659123861331, 5404.351477822647, 5552.77788888446, 5485.4788795064605, 5512.503874651281, 5513.696746678931, 5540.556755459574, 5547.528460080898, 5398.6220964532495, 5547.889042219133, 5551.361593416728, 5556.611037227396, 5557.305336832876, 5290.709011004393, 5358.5981051421295, 5359.598030147755, 5366.973165134149, 5368.141097424433, 16995.915020424818, 19361.12874920632, 19619.411417657495, 20543.691844622343, 20559.691604625943, 2106.757722861875, 2173.413178441812, 2192.78072192781, 2232.6651002349613, 2258.108047321315, 9465.337426380156, 10719.892801071968, 11644.41777911101, 13063.608091757262, 13319.600411987656, 1798.4604618614494, 1806.6386722655523, 1808.6834803909264, 1868.560888191274, 1873.1570793143003, 57745.422545774425, 60293.0, 60668.69665651643, 60951.39048609546, 61077.38922610806, 9851.0, 10107.64623238183, 10168.949155254177, 10189.54147063384, 10253.384796912209, 13147.882429993366, 13179.802302965463, 13219.074664773374, 13243.735125297633, 13282.867171328164, 7526.623668816537, 7582.696692132363, 7629.160792312841, 7647.388208943271, 7703.768886933401, 7524.0, 7528.134264559646, 7537.0, 7559.735409260649, 7579.772606821804, 4316.633086187647, 4405.118976204772, 4414.536473670282, 4429.512753597101, 4439.600435960714, 1719.415398764426, 1733.6099377640182, 1734.3149455964824, 1747.1962897067237, 1753.7895452545777, 937.2782957123113, 938.2400255792693, 959.1463597398321, 997.481309718942, 1002.3134153105146, 13433.731325373437, 16115.274812633459, 16315.673686526441, 16353.918230408772, 16556.83443165553, 929.0198840223494, 940.8212439636447, 970.7476056225291, 977.2084611464736, 1007.37039350406, 9034.774130646654, 9310.720678379525, 9325.626974920928, 9365.625374984924, 9374.906250937403, 439805.0, 441984.0, 472499.0, 477121.0, 484756.0, 66234.0, 71836.64081679663, 75796.62101689457, 75974.62012689901, 77857.61071194608, 1110.5335758981248, 1117.2681893359863, 1150.0, 1168.0480408467072, 1169.6724917023078, 14523.34644940959, 15126.0, 15168.469103581321, 15391.230438478255, 15453.922730386275, 32589.18527036843, 32633.34733305273, 32832.343353133285, 32874.0, 34505.30989380148, 43605.78197108994, 44130.55869441265, 44720.77639611781, 45111.774441127585, 46926.76536617295, 9356.438613682929, 9404.717858464257, 9474.621015159317, 9501.857472138061, 9585.233181345337, 11522.76954460923, 16513.587160321087, 16967.830321696623, 17140.057296848794, 17163.82836171672, 13795.724085518033, 13969.650758731113, 14042.578722638336, 14268.357923893658, 14338.0, 13893.096948698303, 13960.0, 14000.159990400609, 14030.508932187324, 14509.911756618085, 13779.104358216684, 13980.720385592027, 14045.508407205698, 14072.296385180905, 14815.92592037033, 8852.38033337686, 9203.263738901005, 9368.484733339732, 9434.914984776564, 9440.33917625787, 9679.564419601276, 9743.074407931235, 13126.474941002252, 13308.0, 13862.376193071133], "unit": "ms", "name": "jquery.html", "value": 8678.446186101126}, {"lowerIsBetter": false, "replicates": [1365.1194979238385, 1691.517917393543, 1706.940257091002, 1750.0549703160293, 1760.9295628174873, 6679.86640267195, 7202.747903823367, 7317.9634101829415, 7324.48728588999, 7328.083989501312, 7404.40764738821, 7468.178500364956, 7509.0238269025085, 7523.623818809065, 7539.41672248827, 2242.4057624729458, 2259.197984715427, 2261.366817291153, 2267.614505534055, 2269.954600907981, 2282.5549017941507, 2291.4385975435957, 2320.9071637134493, 2322.140807901079, 2323.6282194848827, 2242.7869352411494, 2257.2776711452343, 2262.253456359406, 2263.8981245843893, 2269.909203631853, 2244.9663255051187, 2258.0290475095703, 2275.6358982562874, 2278.4759505313787, 2279.0541925101065, 2256.289268880314, 2263.7849404306567, 2264.1396269417683, 2270.1146552844402, 2280.486890449652, 6513.902291465632, 6658.4340331071435, 7437.665305061285, 7495.925040749577, 7496.100467943827, 4556.863294101149, 4634.675572709912, 4644.071185762828, 4649.372334734801, 4664.067186562667, 2855.8429286389446, 2875.223689603816, 2923.3422479942055, 2930.0, 2989.0, 897.8653202019749, 917.5962576466334, 920.6639576554576, 927.7866090799154, 930.7486978515763, 10141.898581014242, 10253.333533320385, 10255.6410525632, 10257.692269231935, 10263.589456421734, 4176.749395036308, 4195.7692326922315, 4216.557261487561, 4267.701260911706, 4274.529801721808, 8754.737357879274, 8772.429792063624, 8786.956065219632, 8791.428557143765, 8802.339824513187, 4703.623710103184, 4709.128811169876, 4732.716037037789, 4746.905061898743, 4748.026654535812, 4232.534421213664, 4240.321548552217, 4255.851045213464, 4264.253755592759, 4286.442762440863, 3557.3063252665484, 3568.660977207161, 3588.318219538279, 3592.8203589820405, 3612.078919875415, 1166.0904494494307, 1196.4795314038422, 1204.072863894796, 1205.0961778666, 1206.4269472000728, 1291.8708129187194, 1293.5407930184838, 1321.1346567997784, 1323.6426164935413, 1323.8080478330587, 6998.4751143664425, 7018.298170182941, 7033.226345102034, 7044.859102817915, 7056.717731290691, 1195.4381440722846, 1216.355331674214, 1222.0712258683463, 1232.4022848918266, 1244.67638414013, 5385.9730701347025, 5652.943470565242, 5721.713914304268, 5741.62679425836, 5758.62568933018, 8621.69824056155, 9018.954905225432, 9106.27149828012, 9117.361784675142, 9124.45253284805, 8773.0, 8943.686970955985, 8982.640694372283, 8985.550722463982, 8996.685116021039, 7147.428205743528, 7195.172555156224, 7272.96363518179, 7273.163586187656, 7276.7816965490065, 7032.5077244592385, 7084.64576771149, 7084.893726594209, 7121.750738724119, 7141.678624461808, 7874.3306818918745, 7989.360851132012, 8096.473729207818, 8122.7157049502985, 8143.307818835466, 8162.755117346489, 8181.386396020203, 8319.0, 8328.916710833057, 8336.249737523653, 6903.6203008835, 6974.930250697428, 6976.058232138596, 6984.301569842975, 6989.5107342485535, 7268.200497945116, 7302.415806735342, 7310.671019804228, 7317.231690672403, 7398.445116616383, 6887.896681549681, 6914.8617027660175, 6917.515773895779, 6954.756583519553, 6966.721331146698, 6608.084358523688, 6614.272430032596, 6677.866442671217, 6844.28135045813, 6861.725530978705, 6442.613443193423, 6615.636140012345, 6634.734610615521, 6642.43539299165, 6660.56706314088, 6171.166892469639, 6205.348438413902, 6205.6586887721605, 6210.534209934182, 6217.502599792097, 6152.261728592597, 6190.473809726223, 6228.128062071404, 6266.530010249158, 6272.40412160844], "unit": "ms", "name": "mootools.html", "value": 4414.815425324014}, {"lowerIsBetter": false, "replicates": [329.160640367064, 330.85277051711984, 336.6145763101251, 339.0506581571599, 339.30273288392357, 5900.527957763379, 5923.111533270012, 5947.851303717409, 5953.851153721153, 5963.671998040106, 5647.661140331583, 5710.086386178213, 5805.970970145154, 5874.70626468677, 5891.558133140021, 4505.707129036618, 4541.477730061036, 4556.20266453371, 4565.680402371835, 4569.611583015448, 4545.045540436496, 4545.227311357077, 4548.295014272793, 4549.067441174568, 4560.885977850564, 4334.306510958248, 4393.406890069848, 4431.689781715281, 4467.463904331468, 4476.81364438424, 4506.864794056183, 4510.345999830006, 4514.210013247702, 4518.502964673883, 4531.682782205247, 3959.1487830116375, 3959.2477429288633, 3965.1078507335906, 3974.4038394241097, 3976.880693579168, 5598.944010559883, 5623.775048998035, 5624.015797235467, 5625.184348269478, 5644.096944488903, 5162.741862906877, 5279.9208011879855, 5291.576673866081, 5297.12597421425, 5299.788008479656, 6228.0, 6240.937590624127, 6245.437910588023, 6255.593386429913, 6261.06084087386, 4416.160929423431, 4419.381286619876, 4422.159789639958, 4426.336049592554, 4431.7784110794655, 6345.8413539661415, 6536.248331441898, 6537.215534135934, 6543.770968016144, 6567.507436942201, 4402.449693788277, 4426.247537918497, 4434.955650443519, 4439.089986552749, 4443.977780111079, 4486.0, 4490.820367185276, 4490.865274041784, 4491.056878055645, 4491.73049617024, 5217.426083130853, 5223.13818219997, 5228.607854410934, 5228.712420816892, 5231.450697676765, 6149.723262453111, 6315.5894866833505, 6319.715612797435, 6320.683965801692, 6321.589096708699, 1567.4984005118254, 1576.3536949850507, 1578.8184358798655, 1578.968420631581, 1579.8578127968538, 1037.4397825174472, 1039.443897514826, 1040.661784919904, 1055.466989170464, 1057.180684969155, 6050.6974651267265, 6056.485198758067, 6057.545684073624, 6061.8484537886025, 6067.817965461043, 6502.382273683992, 6504.056911747864, 6510.772122975768, 6517.217933847874, 6520.804375868732, 5895.233619629421, 5974.970125149433, 6020.0, 6050.515958723292, 6126.816195514141, 3510.140015696171, 3521.207728261121, 3527.735419843522, 3535.505029295901, 3540.0, 6820.3861652451515, 6826.317368263233, 6827.453803695693, 6827.52207345491, 6833.248342682301, 6545.607263564201, 6683.699233534503, 6696.430803381767, 6696.5647232929705, 6699.464042876558, 6700.329967003261, 6808.38724514796, 6820.454363650896, 6830.829229269209, 6831.760888368884, 6535.934640653532, 6541.6075035498025, 6543.149390579194, 6546.0, 6551.50863685216, 6248.812535623939, 6443.484521238383, 6447.871042579029, 6454.935450645621, 6464.450521705708, 6754.5609535380045, 6805.115335006418, 6806.353396427331, 6814.2163651180745, 6816.454683625398, 4420.7126536775, 4423.60187583119, 4424.557544245549, 4425.977870110629, 4427.623651989488, 6365.936340636719, 6513.8697226056165, 6513.934860651522, 6526.477881769542, 6535.542512024303, 6342.968285158545, 6358.332375100733, 6358.745650173942, 6361.427471527585, 6362.872742545031, 6334.4932405406535, 6337.65142917144, 6338.11266422692, 6341.55609107358, 6346.111544383698, 6074.787382441594, 6241.063840423973, 6245.156903817927, 6281.842953926189, 6285.057241413824, 6411.871762564816, 6419.839504012437, 6423.229212494343, 6430.324815894263, 6432.195975503062, 6253.280872699515, 6264.718087685974, 6265.655388953652, 6271.498280137669, 6272.498200143887], "unit": "ms", "name": "prototype.html", "value": 4751.507668193402}, {"lowerIsBetter": false, "replicates": [863.4085651328841, 864.9610767515462, 865.7532603208087, 868.3574155125209, 887.1084560017182, 13155.605331840048, 13358.0, 13366.33168341584, 13374.197548147118, 13406.1286016409, 12498.062645301616, 12637.115401921868, 12653.746925061494, 12669.746605067892, 12689.555865544684, 673.3333999340654, 686.7733647896207, 814.6537721468382, 825.331481499984, 831.8752187171912, 830.9792255193609, 832.1678321678322, 838.9622466989, 839.1734141870253, 839.3117643532306, 858.2533196119385, 863.2834747159874, 865.3855762408697, 865.4115201662867, 865.6753717355991, 712.3268511256864, 722.0793488302404, 843.822797212583, 858.888344515209, 861.0184389795638, 637.8979363301896, 638.3393188050392, 638.6998110887876, 639.1850390751782, 639.2840019178503, 13032.609021729364, 13140.60578182656, 13147.671308217276, 13148.539801106916, 13165.0, 11796.233244839059, 12615.621531354074, 12709.618711438672, 13045.86954130456, 13148.0, 9899.45552994585, 9990.500474976223, 10022.59909603615, 10085.193184545218, 10127.088562029452, 3530.5586801649793, 3605.3510368133725, 3610.548681414823, 3639.0, 3703.0187000444903, 46091.539084609394, 46406.535934640895, 46442.071158576975, 46469.535304647194, 46503.30245046327, 9820.116189542832, 9862.263598803609, 9968.850467242997, 9989.750256243651, 10255.794884102275, 18158.548595939643, 18168.818311816714, 18171.818281817013, 18220.0, 18222.27110915575, 7425.7029718810645, 7478.439117066242, 7510.812229694192, 7520.210377910241, 7536.962315188389, 4028.536718277377, 4038.1116154445976, 4068.4914385701786, 4102.077032667626, 4143.834246630161, 3070.9539356909663, 3114.4394009078583, 3116.9064928052194, 3118.7349075328852, 3121.188490992313, 538.7791005687727, 543.6439132368305, 547.2939907519335, 550.6255746092695, 553.0294333444859, 562.1848319936028, 627.9560430769893, 630.9526785491106, 664.285892665377, 709.0923617769264, 7971.163027882105, 7975.521468711896, 8050.396220283502, 8124.187581241828, 8138.511689298661, 460.7005446459828, 544.7004147718739, 552.9281193444826, 659.482306389482, 668.204836244867, 3652.470391793175, 3699.1491956849536, 3754.2679177560112, 3777.962220377816, 3865.1303456722576, 61351.386486134565, 61816.381836181965, 62173.37826621766, 62483.687581561804, 62794.68602656957, 53664.48697182398, 54028.45971540313, 54392.45607543874, 54555.0, 55004.0, 48372.51627483751, 48681.0, 48745.51254487481, 49400.25899611437, 49858.75070624624, 7332.376747976482, 7545.358644515278, 7550.5469671819865, 7565.886511702439, 7685.269899359552, 36460.81769591241, 36971.815140924125, 37286.44070338893, 37687.24625507529, 37773.62226377701, 43912.34131488094, 44096.7951602425, 45937.540624593326, 46153.76923115497, 46251.53748462472, 10344.844827327446, 10825.07986821129, 11328.660140195807, 11351.14866385008, 11768.411579421167, 11708.47311870985, 11779.705507362385, 11847.466863991314, 12514.31171285588, 12530.0, 10823.512941917475, 11006.669799906016, 11168.553257869919, 11198.328100314007, 11621.360825154698, 11407.942960285145, 11570.537178512765, 11687.824682629938, 12057.095717821023, 12074.39628018613, 11394.943025285153, 11711.707207319885, 11819.113566482376, 12085.0, 12100.576479823163, 9206.355555111079, 9260.281328778845, 9490.905090949002, 9568.904310956801, 9839.704808855746, 8602.397832151939, 8684.0, 8830.205281524693, 8878.47900238194, 9000.909990900007], "unit": "ms", "name": "yui.html", "value": 6249.786450832465}], "name": "dromaeo_css", "value": 6960.736625119892}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 104.0, 109.0, 110.0, 111.0, 99.0, 111.0, 109.0, 100.0], "unit": "ms", "name": "ai-astar", "value": 107.3}, {"lowerIsBetter": true, "replicates": [152.0, 125.0, 152.0, 174.0, 133.0, 149.0, 154.0, 129.0, 175.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.5}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 159.0, 161.0, 160.0, 159.0, 158.0, 163.0, 161.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.0}, {"lowerIsBetter": true, "replicates": [77.0, 71.0, 92.0, 93.0, 71.0, 71.0, 71.0, 99.0, 92.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [97.0, 94.0, 144.0, 93.0, 94.0, 93.0, 132.0, 93.0, 93.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 112.0, 109.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [59.0, 65.0, 58.0, 60.0, 58.0, 59.0, 61.0, 61.0, 61.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 60.1}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 69.0, 70.0, 70.0, 69.0, 70.0, 69.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.7}, {"lowerIsBetter": true, "replicates": [97.0, 84.0, 86.0, 89.0, 91.0, 86.0, 84.0, 85.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [115.0, 116.0, 122.0, 113.0, 123.0, 115.0, 124.0, 116.0, 119.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.9}, {"lowerIsBetter": true, "replicates": [143.0, 152.0, 154.0, 142.0, 149.0, 137.0, 149.0, 141.0, 143.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.1}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 66.0, 66.0, 66.0, 71.0, 68.0, 66.0, 68.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1500.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [189.3939393939394], "unit": "score", "name": "Richards", "value": 186.39456000000004}, {"lowerIsBetter": false, "replicates": [194.66614755693985], "unit": "score", "name": "DeltaBlue", "value": 339.6481659999999}, {"lowerIsBetter": false, "replicates": [284.9002849002849], "unit": "score", "name": "Encrypt", "value": 934.2953100000001}, {"lowerIsBetter": false, "replicates": [4995.024875621891], "unit": "score", "name": "Decrypt", "value": 53.289224103585696}, {"lowerIsBetter": false, "replicates": [1955.078125], "unit": "score", "name": "RayTrace", "value": 378.49587212787225}, {"lowerIsBetter": false, "replicates": [775.7951900698216], "unit": "score", "name": "Earley", "value": 859.0708069999997}, {"lowerIsBetter": false, "replicates": [12156.626506024097], "unit": "score", "name": "Boyer", "value": 54.82302180376615}, {"lowerIsBetter": false, "replicates": [25871.79487179487], "unit": "score", "name": "RegExp", "value": 35.21151139742318}, {"lowerIsBetter": false, "replicates": [594.883997620464], "unit": "score", "name": "Splay", "value": 136.98637100000005}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19656.274529682156}]} 15:49:39 INFO - RETURN: dromaeo_css: 6960.74 15:49:39 INFO - RETURN: kraken: 1500.20 15:49:39 INFO - RETURN: v8_7: 19656.27 15:49:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19656.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1500.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6960.74"}}} 15:49:39 INFO - Return code: 0 15:49:39 INFO - # TBPL SUCCESS # 15:49:39 INFO - Running post-action listener: _resource_record_post_action 15:49:39 INFO - Running post-run listener: _resource_record_post_run 15:49:41 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 8192; Write bytes: 522215424; Read time: 356; Write time: 735596 15:49:41 INFO - install - Wall time: 15s; CPU: 17.0%; Read bytes: 0; Write bytes: 238604288; Read time: 0; Write time: 482388 15:49:41 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 8192; Write bytes: 283607040; Read time: 356; Write time: 251924 15:49:41 INFO - Running post-run listener: _upload_blobber_files 15:49:41 INFO - Blob upload gear active. 15:49:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:49:41 INFO - Copying logs to upload dir... 15:49:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.961735 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-23 15:49:40.685022) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 15:49:40.688582) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009909 build_url: 'https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 15:49:40.740357) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:49:40.740746) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448320727.364644-1551195432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:49:40.791277) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 15:49:40.791618) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 15:49:40.792022) ========= ========= Total master_lag: 0.38 =========