builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1448097035.15 results: success (0) buildid: 20151120233007 builduid: a126159747784a09a5f1caa993c3fba9 revision: fad3d3556cf5e5687e338f7618fbc092956499ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:35.151766) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:35.152322) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:35.152649) ========= 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=01deea79d00cc2c334834894000001d2-1448096070.18268-224290911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006479 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:35.184972) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:35.185374) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:35.238296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:35.238551) ========= 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=01deea79d00cc2c334834894000001d2-1448096070.18268-224290911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004766 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:35.293991) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:35.294286) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:35.294650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:35.294927) ========= 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=01deea79d00cc2c334834894000001d2-1448096070.18268-224290911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-21 01:10: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% 217M=0s 2015-11-21 01:10:36 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.204324 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:35.512260) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:35.512624) ========= 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=01deea79d00cc2c334834894000001d2-1448096070.18268-224290911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017744 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:35.568475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-21 01:10:35.569032) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev fad3d3556cf5e5687e338f7618fbc092956499ae --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev fad3d3556cf5e5687e338f7618fbc092956499ae --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=01deea79d00cc2c334834894000001d2-1448096070.18268-224290911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-21 01:10:36,152 truncating revision to first 12 chars 2015-11-21 01:10:36,152 Setting DEBUG logging. 2015-11-21 01:10:36,152 attempt 1/10 2015-11-21 01:10:36,152 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/fad3d3556cf5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-21 01:10:37,050 unpacking tar archive at: b2g-inbound-fad3d3556cf5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.192518 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-21 01:10:36.788554) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:36.788830) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:36.797961) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:36.798291) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 01:10:36.798715) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-21 01:10:36.799015) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=01deea79d00cc2c334834894000001d2-1448096070.18268-224290911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:10:37 INFO - MultiFileLogger online at 20151121 01:10:37 in /builds/slave/test-pgo 01:10:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 01:10:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:10:37 INFO - {'append_to_log': False, 01:10:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:10:37 INFO - 'blob_upload_branch': 'B2G-Inbound', 01:10:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:10:37 INFO - 'branch': 'B2G-Inbound', 01:10:37 INFO - 'buildbot_json_path': 'buildprops.json', 01:10:37 INFO - 'config_files': ('talos/linux_config.py',), 01:10:37 INFO - 'default_actions': ('clobber', 01:10:37 INFO - 'read-buildbot-config', 01:10:37 INFO - 'download-and-extract', 01:10:37 INFO - 'populate-webroot', 01:10:37 INFO - 'create-virtualenv', 01:10:37 INFO - 'install', 01:10:37 INFO - 'run-tests'), 01:10:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:10:37 INFO - 'download_minidump_stackwalk': True, 01:10:37 INFO - 'download_symbols': 'ondemand', 01:10:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:10:37 INFO - 'tooltool.py': '/tools/tooltool.py', 01:10:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:10:37 INFO - '/tools/misc-python/virtualenv.py')}, 01:10:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:10:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:10:37 INFO - 'installer_path': 'installer.exe', 01:10:37 INFO - 'log_level': 'info', 01:10:37 INFO - 'log_name': 'talos', 01:10:37 INFO - 'log_to_console': True, 01:10:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:10:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:10:37 INFO - 'opt_config_files': (), 01:10:37 INFO - 'pip_index': False, 01:10:37 INFO - 'sps_profile': False, 01:10:37 INFO - 'sps_profile_interval': 0, 01:10:37 INFO - 'suite': 'dromaeojs', 01:10:37 INFO - 'system_bits': '64', 01:10:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:10:37 INFO - 'title': 'talos-linux64-ix-014', 01:10:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:10:37 INFO - 'use_talos_json': True, 01:10:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:10:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:10:37 INFO - 'work_dir': 'build'} 01:10:37 INFO - ##### 01:10:37 INFO - ##### Running clobber step. 01:10:37 INFO - ##### 01:10:37 INFO - Running pre-action listener: _resource_record_pre_action 01:10:37 INFO - Running main action method: clobber 01:10:37 INFO - rmtree: /builds/slave/test-pgo/build 01:10:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:10:37 INFO - Running post-action listener: _resource_record_post_action 01:10:37 INFO - ##### 01:10:37 INFO - ##### Running read-buildbot-config step. 01:10:37 INFO - ##### 01:10:37 INFO - Running pre-action listener: _resource_record_pre_action 01:10:37 INFO - Running main action method: read_buildbot_config 01:10:37 INFO - Using buildbot properties: 01:10:37 INFO - { 01:10:37 INFO - "properties": { 01:10:37 INFO - "buildnumber": 989, 01:10:37 INFO - "product": "firefox", 01:10:37 INFO - "script_repo_revision": "production", 01:10:37 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 01:10:37 INFO - "repository": "", 01:10:37 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 01:10:37 INFO - "buildid": "20151120233007", 01:10:37 INFO - "slavename": "talos-linux64-ix-014", 01:10:37 INFO - "pgo_build": "True", 01:10:37 INFO - "basedir": "/builds/slave/test-pgo", 01:10:37 INFO - "project": "", 01:10:37 INFO - "platform": "ubuntu64_hw", 01:10:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:10:37 INFO - "slavebuilddir": "test", 01:10:37 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 01:10:37 INFO - "branch": "b2g-inbound", 01:10:37 INFO - "repo_path": "integration/b2g-inbound", 01:10:37 INFO - "stage_platform": "linux64-pgo", 01:10:37 INFO - "builduid": "a126159747784a09a5f1caa993c3fba9", 01:10:37 INFO - "revision": "fad3d3556cf5e5687e338f7618fbc092956499ae" 01:10:37 INFO - }, 01:10:37 INFO - "sourcestamp": { 01:10:37 INFO - "repository": "", 01:10:37 INFO - "hasPatch": false, 01:10:37 INFO - "project": "", 01:10:37 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 01:10:37 INFO - "changes": [ 01:10:37 INFO - { 01:10:37 INFO - "category": null, 01:10:37 INFO - "files": [ 01:10:37 INFO - { 01:10:37 INFO - "url": null, 01:10:37 INFO - "name": "https://queue.taskcluster.net/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 01:10:37 INFO - } 01:10:37 INFO - ], 01:10:37 INFO - "repository": "", 01:10:37 INFO - "rev": "fad3d3556cf5e5687e338f7618fbc092956499ae", 01:10:37 INFO - "who": "sendchange", 01:10:37 INFO - "when": 1448097006, 01:10:37 INFO - "number": 6692139, 01:10:37 INFO - "comments": "", 01:10:37 INFO - "project": "", 01:10:37 INFO - "at": "Sat 21 Nov 2015 01:10:06", 01:10:37 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 01:10:37 INFO - "revlink": "", 01:10:37 INFO - "properties": [ 01:10:37 INFO - [ 01:10:37 INFO - "buildid", 01:10:37 INFO - "20151120233007", 01:10:37 INFO - "Change" 01:10:37 INFO - ], 01:10:37 INFO - [ 01:10:37 INFO - "builduid", 01:10:37 INFO - "a126159747784a09a5f1caa993c3fba9", 01:10:37 INFO - "Change" 01:10:37 INFO - ], 01:10:37 INFO - [ 01:10:37 INFO - "pgo_build", 01:10:37 INFO - "True", 01:10:37 INFO - "Change" 01:10:37 INFO - ] 01:10:37 INFO - ], 01:10:37 INFO - "revision": "fad3d3556cf5e5687e338f7618fbc092956499ae" 01:10:37 INFO - } 01:10:37 INFO - ], 01:10:37 INFO - "revision": "fad3d3556cf5e5687e338f7618fbc092956499ae" 01:10:37 INFO - } 01:10:37 INFO - } 01:10:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 01:10:37 INFO - Running post-action listener: _resource_record_post_action 01:10:37 INFO - ##### 01:10:37 INFO - ##### Running download-and-extract step. 01:10:37 INFO - ##### 01:10:37 INFO - Running pre-action listener: _resource_record_pre_action 01:10:37 INFO - Running main action method: download_and_extract 01:10:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:10: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')]} 01:10:37 INFO - https://queue.taskcluster.net/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:10:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/test_packages.json 01:10:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/test_packages.json 01:10:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:10:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:10:38 INFO - Downloaded 1302 bytes. 01:10:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:10:38 INFO - Using the following test package requirements: 01:10:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:10:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:10:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:38 INFO - u'jsshell-linux-x86_64.zip'], 01:10:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:10:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:10:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:10:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:10:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:10:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:10:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:10:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:38 INFO - https://queue.taskcluster.net/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:10:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:10:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:10:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/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 01:10:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/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 01:10:39 INFO - Downloaded 22522902 bytes. 01:10:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:10:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:10:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:10:40 INFO - Return code: 0 01:10:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:40 INFO - https://queue.taskcluster.net/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:10:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:10:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:10:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/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 01:10:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/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 01:10:42 INFO - Downloaded 22522902 bytes. 01:10:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:10:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:10:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:10:43 INFO - Return code: 0 01:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:43 INFO - https://queue.taskcluster.net/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:10:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:10:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:10:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/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 01:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/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 01:10:45 INFO - Downloaded 11130997 bytes. 01:10:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 01:10:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:10:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 01:10:45 INFO - Return code: 0 01:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:45 INFO - https://queue.taskcluster.net/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:10:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:10:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:10:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/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 01:10:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJqTvtKfRa6-p2k_r68OGQ/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 01:10:46 INFO - Downloaded 57447330 bytes. 01:10:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:10:46 INFO - mkdir: /builds/slave/test-pgo/properties 01:10:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:10:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:10:46 INFO - Contents: 01:10:46 INFO - build_url:https://queue.taskcluster.net/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:10:46 INFO - Running post-action listener: _resource_record_post_action 01:10:46 INFO - Running post-action listener: set_extra_try_arguments 01:10:46 INFO - ##### 01:10:46 INFO - ##### Running populate-webroot step. 01:10:46 INFO - ##### 01:10:46 INFO - Running pre-action listener: _resource_record_pre_action 01:10:46 INFO - Running main action method: populate_webroot 01:10:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:10:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:10:46 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:10:46 INFO - '../fennec_ids.txt'], 01:10:46 INFO - 'tests': ['tcheck2']}, 01:10:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:10:46 INFO - '--tppagecycles', 01:10:46 INFO - '7'], 01:10:46 INFO - 'tests': ['tsvgm']}}, 01:10:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:10:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:10:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:10:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:10:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:10:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:10:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:10:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:46 INFO - 'talos_options': ['--e10s'], 01:10:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:10:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:46 INFO - 'tests': ['damp', 'tps']}, 01:10:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:46 INFO - 'talos_options': ['--e10s'], 01:10:46 INFO - 'tests': ['damp', 'tps']}, 01:10:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:10:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:10:46 INFO - 'other': {'tests': ['a11yr', 01:10:46 INFO - 'ts_paint', 01:10:46 INFO - 'tpaint', 01:10:46 INFO - 'sessionrestore', 01:10:46 INFO - 'sessionrestore_no_auto_restore']}, 01:10:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:10:46 INFO - 'tests': ['a11yr', 01:10:46 INFO - 'ts_paint', 01:10:46 INFO - 'tpaint', 01:10:46 INFO - 'sessionrestore', 01:10:46 INFO - 'sessionrestore_no_auto_restore']}, 01:10:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:10:46 INFO - 'tests': ['a11yr', 01:10:46 INFO - 'ts_paint', 01:10:46 INFO - 'tpaint', 01:10:46 INFO - 'sessionrestore', 01:10:46 INFO - 'sessionrestore_no_auto_restore']}, 01:10:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:10:46 INFO - 'tests': ['a11yr', 01:10:46 INFO - 'ts_paint', 01:10:46 INFO - 'tpaint', 01:10:46 INFO - 'sessionrestore', 01:10:46 INFO - 'sessionrestore_no_auto_restore']}, 01:10:46 INFO - 'other_l64': {'tests': ['a11yr', 01:10:46 INFO - 'ts_paint', 01:10:46 INFO - 'tpaint', 01:10:46 INFO - 'sessionrestore', 01:10:46 INFO - 'sessionrestore_no_auto_restore']}, 01:10:46 INFO - 'other_nol64': {'tests': ['a11yr', 01:10:46 INFO - 'ts_paint', 01:10:46 INFO - 'tpaint', 01:10:46 INFO - 'sessionrestore', 01:10:46 INFO - 'sessionrestore_no_auto_restore']}, 01:10:46 INFO - 'svgr': {'tests': ['tsvgx', 01:10:46 INFO - 'tsvgr_opacity', 01:10:46 INFO - 'tart', 01:10:46 INFO - 'tscrollx', 01:10:46 INFO - 'cart']}, 01:10:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:10:46 INFO - 'tests': ['tsvgx', 01:10:46 INFO - 'tsvgr_opacity', 01:10:46 INFO - 'tart', 01:10:46 INFO - 'tscrollx', 01:10:46 INFO - 'cart']}, 01:10:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:46 INFO - 'tests': ['tp5o']}, 01:10:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:46 INFO - 'talos_options': ['--e10s'], 01:10:46 INFO - 'tests': ['tp5o']}, 01:10:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:46 INFO - 'talos_options': ['--xperf_path', 01:10:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:10:46 INFO - 'tests': ['tp5n']}, 01:10:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:46 INFO - 'talos_options': ['--e10s', 01:10:46 INFO - '--xperf_path', 01:10:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:10:46 INFO - 'tests': ['tp5n']}}, 01:10:46 INFO - 'talos.zip': {'path': '', 01:10:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:10:46 INFO - Running post-action listener: _resource_record_post_action 01:10:46 INFO - ##### 01:10:46 INFO - ##### Running create-virtualenv step. 01:10:46 INFO - ##### 01:10:46 INFO - Running pre-action listener: _resource_record_pre_action 01:10:46 INFO - Running main action method: create_virtualenv 01:10:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:10:46 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 01:10:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:10:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:10:46 INFO - Using real prefix '/usr' 01:10:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:10:47 INFO - Installing distribute.............................................................................................................................................................................................done. 01:10:49 INFO - Installing pip.................done. 01:10:49 INFO - Return code: 0 01:10:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:10: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')]} 01:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10: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')]} 01:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:49 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 0x7f5b40c09c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9d70>, '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 0x1eeab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeafb0>, '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': '01deea79d00cc2c334834894000001d2-1448096070.18268-224290911', '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 01:10:49 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 01:10:49 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 01:10:49 INFO - Using env: {'DISPLAY': ':0', 01:10:49 INFO - 'HOME': '/home/cltbld', 01:10:49 INFO - 'LANG': 'en_US.UTF-8', 01:10:49 INFO - 'LANGUAGE': 'en_US:en', 01:10:49 INFO - 'LOGNAME': 'cltbld', 01:10:49 INFO - 'MAIL': '/var/mail/cltbld', 01:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:49 INFO - 'MOZ_NO_REMOTE': '1', 01:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:49 INFO - 'NO_EM_RESTART': '1', 01:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:10:49 INFO - 'PWD': '/builds/slave/test-pgo', 01:10:49 INFO - 'SHELL': '/bin/bash', 01:10:49 INFO - 'SHLVL': '1', 01:10:49 INFO - 'TERM': 'linux', 01:10:49 INFO - 'TMOUT': '86400', 01:10:49 INFO - 'USER': 'cltbld', 01:10:49 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448096070.18268-224290911', 01:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:49 INFO - '_': '/tools/buildbot/bin/python'} 01:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:49 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 01:10:49 INFO - Cleaning up... 01:10:49 INFO - Return code: 0 01:10:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:10: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')]} 01:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10: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')]} 01:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:49 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 0x7f5b40c09c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9d70>, '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 0x1eeab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeafb0>, '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': '01deea79d00cc2c334834894000001d2-1448096070.18268-224290911', '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 01:10:49 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 01:10:49 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 01:10:49 INFO - Using env: {'DISPLAY': ':0', 01:10:49 INFO - 'HOME': '/home/cltbld', 01:10:49 INFO - 'LANG': 'en_US.UTF-8', 01:10:49 INFO - 'LANGUAGE': 'en_US:en', 01:10:49 INFO - 'LOGNAME': 'cltbld', 01:10:49 INFO - 'MAIL': '/var/mail/cltbld', 01:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:49 INFO - 'MOZ_NO_REMOTE': '1', 01:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:49 INFO - 'NO_EM_RESTART': '1', 01:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:10:49 INFO - 'PWD': '/builds/slave/test-pgo', 01:10:49 INFO - 'SHELL': '/bin/bash', 01:10:49 INFO - 'SHLVL': '1', 01:10:49 INFO - 'TERM': 'linux', 01:10:49 INFO - 'TMOUT': '86400', 01:10:49 INFO - 'USER': 'cltbld', 01:10:49 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448096070.18268-224290911', 01:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:49 INFO - '_': '/tools/buildbot/bin/python'} 01:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:49 INFO - Downloading/unpacking psutil>=0.7.1 01:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:10:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:10:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:10:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:10:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:10:51 INFO - Installing collected packages: psutil 01:10:51 INFO - Running setup.py install for psutil 01:10:51 INFO - building 'psutil._psutil_linux' extension 01:10:51 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 01:10:51 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 01:10:51 INFO - building 'psutil._psutil_posix' extension 01:10:51 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 01:10:52 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 01:10:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:10:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:10:52 INFO - Successfully installed psutil 01:10:52 INFO - Cleaning up... 01:10:52 INFO - Return code: 0 01:10:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:10:52 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')]} 01:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:52 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')]} 01:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:52 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 0x7f5b40c09c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9d70>, '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 0x1eeab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeafb0>, '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': '01deea79d00cc2c334834894000001d2-1448096070.18268-224290911', '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 01:10:52 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 01:10:52 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 01:10:52 INFO - Using env: {'DISPLAY': ':0', 01:10:52 INFO - 'HOME': '/home/cltbld', 01:10:52 INFO - 'LANG': 'en_US.UTF-8', 01:10:52 INFO - 'LANGUAGE': 'en_US:en', 01:10:52 INFO - 'LOGNAME': 'cltbld', 01:10:52 INFO - 'MAIL': '/var/mail/cltbld', 01:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:52 INFO - 'MOZ_NO_REMOTE': '1', 01:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:52 INFO - 'NO_EM_RESTART': '1', 01:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:10:52 INFO - 'PWD': '/builds/slave/test-pgo', 01:10:52 INFO - 'SHELL': '/bin/bash', 01:10:52 INFO - 'SHLVL': '1', 01:10:52 INFO - 'TERM': 'linux', 01:10:52 INFO - 'TMOUT': '86400', 01:10:52 INFO - 'USER': 'cltbld', 01:10:52 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448096070.18268-224290911', 01:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:52 INFO - '_': '/tools/buildbot/bin/python'} 01:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:10:52 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 01:10:52 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 01:10:52 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 01:10:52 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 01:10:52 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 01:10:52 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 01:10:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:10:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:10:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:10:54 INFO - Installing collected packages: mozsystemmonitor 01:10:54 INFO - Running setup.py install for mozsystemmonitor 01:10:54 INFO - Successfully installed mozsystemmonitor 01:10:54 INFO - Cleaning up... 01:10:54 INFO - Return code: 0 01:10:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:10:54 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')]} 01:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:54 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')]} 01:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:54 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 0x7f5b40c09c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9d70>, '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 0x1eeab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeafb0>, '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': '01deea79d00cc2c334834894000001d2-1448096070.18268-224290911', '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 01:10:54 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 01:10:54 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 01:10:54 INFO - Using env: {'DISPLAY': ':0', 01:10:54 INFO - 'HOME': '/home/cltbld', 01:10:54 INFO - 'LANG': 'en_US.UTF-8', 01:10:54 INFO - 'LANGUAGE': 'en_US:en', 01:10:54 INFO - 'LOGNAME': 'cltbld', 01:10:54 INFO - 'MAIL': '/var/mail/cltbld', 01:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:54 INFO - 'MOZ_NO_REMOTE': '1', 01:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:54 INFO - 'NO_EM_RESTART': '1', 01:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:10:54 INFO - 'PWD': '/builds/slave/test-pgo', 01:10:54 INFO - 'SHELL': '/bin/bash', 01:10:54 INFO - 'SHLVL': '1', 01:10:54 INFO - 'TERM': 'linux', 01:10:54 INFO - 'TMOUT': '86400', 01:10:54 INFO - 'USER': 'cltbld', 01:10:54 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448096070.18268-224290911', 01:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:54 INFO - '_': '/tools/buildbot/bin/python'} 01:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:54 INFO - Downloading/unpacking blobuploader==1.2.4 01:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:56 INFO - Downloading blobuploader-1.2.4.tar.gz 01:10:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:10:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:10:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:10:56 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 01:10:56 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 01:10:56 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 01:10:56 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 01:10:56 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 01:10:56 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 01:10:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:10:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:10:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:10:56 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 01:10:56 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 01:10:56 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 01:10:56 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 01:10:56 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 01:10:56 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 01:10:56 INFO - Downloading docopt-0.6.1.tar.gz 01:10:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:10:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:10:56 INFO - Installing collected packages: blobuploader, requests, docopt 01:10:56 INFO - Running setup.py install for blobuploader 01:10:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:10:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:10:56 INFO - Running setup.py install for requests 01:10:57 INFO - Running setup.py install for docopt 01:10:57 INFO - Successfully installed blobuploader requests docopt 01:10:57 INFO - Cleaning up... 01:10:57 INFO - Return code: 0 01:10:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:10: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')]} 01:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10: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')]} 01:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:57 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 0x7f5b40c09c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9d70>, '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 0x1eeab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeafb0>, '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': '01deea79d00cc2c334834894000001d2-1448096070.18268-224290911', '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 01:10:57 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 01:10:57 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 01:10:57 INFO - Using env: {'DISPLAY': ':0', 01:10:57 INFO - 'HOME': '/home/cltbld', 01:10:57 INFO - 'LANG': 'en_US.UTF-8', 01:10:57 INFO - 'LANGUAGE': 'en_US:en', 01:10:57 INFO - 'LOGNAME': 'cltbld', 01:10:57 INFO - 'MAIL': '/var/mail/cltbld', 01:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:57 INFO - 'MOZ_NO_REMOTE': '1', 01:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:57 INFO - 'NO_EM_RESTART': '1', 01:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:10:57 INFO - 'PWD': '/builds/slave/test-pgo', 01:10:57 INFO - 'SHELL': '/bin/bash', 01:10:57 INFO - 'SHLVL': '1', 01:10:57 INFO - 'TERM': 'linux', 01:10:57 INFO - 'TMOUT': '86400', 01:10:57 INFO - 'USER': 'cltbld', 01:10:57 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448096070.18268-224290911', 01:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:57 INFO - '_': '/tools/buildbot/bin/python'} 01:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:10:57 INFO - Running setup.py (path:/tmp/pip-vcqrfP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:10:57 INFO - Running setup.py (path:/tmp/pip-dzcxGP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:10:57 INFO - Running setup.py (path:/tmp/pip-pyKbz9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:10:57 INFO - Running setup.py (path:/tmp/pip-pTF_bW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:10:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:10:57 INFO - Running setup.py (path:/tmp/pip-R0JF8P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:10:58 INFO - Running setup.py (path:/tmp/pip-jPJ9RU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:10:58 INFO - Running setup.py (path:/tmp/pip-OK3fnX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:10:58 INFO - Running setup.py (path:/tmp/pip-9YSROX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:10:58 INFO - Running setup.py (path:/tmp/pip-kA0o5V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:10:58 INFO - Running setup.py (path:/tmp/pip-lJPRgA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:10:58 INFO - Running setup.py (path:/tmp/pip-a6sDTm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:10:58 INFO - Running setup.py (path:/tmp/pip-EL8ktc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:10:58 INFO - Running setup.py (path:/tmp/pip-tnIkMc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:10:58 INFO - Running setup.py (path:/tmp/pip-9NYtJt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:10:58 INFO - Running setup.py (path:/tmp/pip-jZPTqn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:10:58 INFO - Running setup.py (path:/tmp/pip-hRSA8m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:10:58 INFO - Running setup.py (path:/tmp/pip-T9pUPZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:10:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:10:58 INFO - Running setup.py install for manifestparser 01:10:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:10:58 INFO - Running setup.py install for mozcrash 01:10:59 INFO - Running setup.py install for mozdebug 01:10:59 INFO - Running setup.py install for mozdevice 01:10:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:10:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:10:59 INFO - Running setup.py install for mozfile 01:10:59 INFO - Running setup.py install for mozhttpd 01:10:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:10:59 INFO - Running setup.py install for mozinfo 01:10:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:10:59 INFO - Running setup.py install for mozInstall 01:10:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:10:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:10:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:10:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:10:59 INFO - Running setup.py install for mozleak 01:10:59 INFO - Running setup.py install for mozlog 01:10:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:10:59 INFO - Running setup.py install for moznetwork 01:10:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:10:59 INFO - Running setup.py install for mozprocess 01:11:00 INFO - Running setup.py install for mozprofile 01:11:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:11:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:11:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:11:00 INFO - Running setup.py install for mozrunner 01:11:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:11:00 INFO - Running setup.py install for mozscreenshot 01:11:00 INFO - Running setup.py install for moztest 01:11:00 INFO - Running setup.py install for mozversion 01:11:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:11:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:11:00 INFO - Cleaning up... 01:11:00 INFO - Return code: 0 01:11:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:11:00 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')]} 01:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:00 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')]} 01:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:00 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 0x7f5b40c09c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9d70>, '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 0x1eeab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeafb0>, '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': '01deea79d00cc2c334834894000001d2-1448096070.18268-224290911', '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 01:11:00 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 01:11:00 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 01:11:00 INFO - Using env: {'DISPLAY': ':0', 01:11:00 INFO - 'HOME': '/home/cltbld', 01:11:00 INFO - 'LANG': 'en_US.UTF-8', 01:11:00 INFO - 'LANGUAGE': 'en_US:en', 01:11:00 INFO - 'LOGNAME': 'cltbld', 01:11:00 INFO - 'MAIL': '/var/mail/cltbld', 01:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:00 INFO - 'MOZ_NO_REMOTE': '1', 01:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:00 INFO - 'NO_EM_RESTART': '1', 01:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:11:00 INFO - 'PWD': '/builds/slave/test-pgo', 01:11:00 INFO - 'SHELL': '/bin/bash', 01:11:00 INFO - 'SHLVL': '1', 01:11:00 INFO - 'TERM': 'linux', 01:11:00 INFO - 'TMOUT': '86400', 01:11:00 INFO - 'USER': 'cltbld', 01:11:00 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448096070.18268-224290911', 01:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:00 INFO - '_': '/tools/buildbot/bin/python'} 01:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:11:00 INFO - Running setup.py (path:/tmp/pip-JdJeAj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:11:00 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)) 01:11:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:11:00 INFO - Running setup.py (path:/tmp/pip-R9sOaN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:11:01 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)) 01:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:11:01 INFO - Running setup.py (path:/tmp/pip-LNVtch-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:11:01 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)) 01:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:11:01 INFO - Running setup.py (path:/tmp/pip-DObHl1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:11:01 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)) 01:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:11:01 INFO - Running setup.py (path:/tmp/pip-P2GkAL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:11:01 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)) 01:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:11:01 INFO - Running setup.py (path:/tmp/pip-Thv5Jh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:11:01 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)) 01:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:11:01 INFO - Running setup.py (path:/tmp/pip-ekhMTE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:11:01 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)) 01:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:11:01 INFO - Running setup.py (path:/tmp/pip-cdlEVt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:11:01 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)) 01:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:11:01 INFO - Running setup.py (path:/tmp/pip-D8mmCl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:11:01 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)) 01:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:11:01 INFO - Running setup.py (path:/tmp/pip-NzDOV8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:11:01 INFO - Running setup.py (path:/tmp/pip-v0i2Pt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:11:01 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)) 01:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:11:01 INFO - Running setup.py (path:/tmp/pip-c1ZQpk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:11:01 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)) 01:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:11:01 INFO - Running setup.py (path:/tmp/pip-S3K5K9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:11:01 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)) 01:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:11:01 INFO - Running setup.py (path:/tmp/pip-WffR7x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:11:01 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)) 01:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:11:01 INFO - Running setup.py (path:/tmp/pip-svi1y1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:11:01 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)) 01:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:11:01 INFO - Running setup.py (path:/tmp/pip-wGcDuf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:11:02 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)) 01:11:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:11:02 INFO - Running setup.py (path:/tmp/pip-loNDxL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:11:02 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)) 01:11:02 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)) 01:11:02 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)) 01:11:02 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)) 01:11:02 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)) 01:11:02 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)) 01:11:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:11: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 01:11: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 01:11: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 01:11: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 01:11: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 01:11: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 01:11:03 INFO - Downloading blessings-1.5.1.tar.gz 01:11:03 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 01:11:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:11:03 INFO - Installing collected packages: blessings 01:11:03 INFO - Running setup.py install for blessings 01:11:03 INFO - Successfully installed blessings 01:11:03 INFO - Cleaning up... 01:11:04 INFO - Return code: 0 01:11:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:11:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:11:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:11:04 INFO - Reading from file tmpfile_stdout 01:11:04 INFO - Current package versions: 01:11:04 INFO - argparse == 1.2.1 01:11:04 INFO - blessings == 1.5.1 01:11:04 INFO - blobuploader == 1.2.4 01:11:04 INFO - docopt == 0.6.1 01:11:04 INFO - manifestparser == 1.1 01:11:04 INFO - mozInstall == 1.12 01:11:04 INFO - mozcrash == 0.16 01:11:04 INFO - mozdebug == 0.1 01:11:04 INFO - mozdevice == 0.47 01:11:04 INFO - mozfile == 1.2 01:11:04 INFO - mozhttpd == 0.7 01:11:04 INFO - mozinfo == 0.9 01:11:04 INFO - mozleak == 0.1 01:11:04 INFO - mozlog == 3.0 01:11:04 INFO - moznetwork == 0.27 01:11:04 INFO - mozprocess == 0.22 01:11:04 INFO - mozprofile == 0.27 01:11:04 INFO - mozrunner == 6.11 01:11:04 INFO - mozscreenshot == 0.1 01:11:04 INFO - mozsystemmonitor == 0.0 01:11:04 INFO - moztest == 0.7 01:11:04 INFO - mozversion == 1.4 01:11:04 INFO - psutil == 3.1.1 01:11:04 INFO - requests == 1.2.3 01:11:04 INFO - wsgiref == 0.1.2 01:11:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f5b40c09c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9d70>, '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 0x1eeab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeafb0>, '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': '01deea79d00cc2c334834894000001d2-1448096070.18268-224290911', '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 01:11:04 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 01:11:04 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 01:11:04 INFO - Using env: {'DISPLAY': ':0', 01:11:04 INFO - 'HOME': '/home/cltbld', 01:11:04 INFO - 'LANG': 'en_US.UTF-8', 01:11:04 INFO - 'LANGUAGE': 'en_US:en', 01:11:04 INFO - 'LOGNAME': 'cltbld', 01:11:04 INFO - 'MAIL': '/var/mail/cltbld', 01:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:04 INFO - 'MOZ_NO_REMOTE': '1', 01:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:04 INFO - 'NO_EM_RESTART': '1', 01:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:11:04 INFO - 'PWD': '/builds/slave/test-pgo', 01:11:04 INFO - 'SHELL': '/bin/bash', 01:11:04 INFO - 'SHLVL': '1', 01:11:04 INFO - 'TERM': 'linux', 01:11:04 INFO - 'TMOUT': '86400', 01:11:04 INFO - 'USER': 'cltbld', 01:11:04 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448096070.18268-224290911', 01:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:04 INFO - '_': '/tools/buildbot/bin/python'} 01:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:04 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)) 01:11:04 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)) 01:11:04 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)) 01:11:04 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)) 01:11:04 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)) 01:11:04 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)) 01:11:04 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)) 01:11:04 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)) 01:11:04 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)) 01:11:04 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)) 01:11:04 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)) 01:11:04 INFO - Cleaning up... 01:11:04 INFO - Return code: 0 01:11:04 INFO - Running post-action listener: _resource_record_post_action 01:11:04 INFO - Running post-action listener: _start_resource_monitoring 01:11:04 INFO - Starting resource monitoring. 01:11:04 INFO - ##### 01:11:04 INFO - ##### Running install step. 01:11:04 INFO - ##### 01:11:04 INFO - Running pre-action listener: _resource_record_pre_action 01:11:04 INFO - Running main action method: install 01:11:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:11:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:11:04 INFO - Reading from file tmpfile_stdout 01:11:04 INFO - Detecting whether we're running mozinstall >=1.0... 01:11:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:11:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:11:04 INFO - Reading from file tmpfile_stdout 01:11:04 INFO - Output received: 01:11:04 INFO - Usage: mozinstall [options] installer 01:11:04 INFO - Options: 01:11:04 INFO - -h, --help show this help message and exit 01:11:04 INFO - -d DEST, --destination=DEST 01:11:04 INFO - Directory to install application into. [default: 01:11:04 INFO - "/builds/slave/test-pgo"] 01:11:04 INFO - --app=APP Application being installed. [default: firefox] 01:11:04 INFO - mkdir: /builds/slave/test-pgo/build/application 01:11:04 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'] 01:11:04 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 01:11:19 INFO - Reading from file tmpfile_stdout 01:11:19 INFO - Output received: 01:11:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:11:19 INFO - Running post-action listener: _resource_record_post_action 01:11:19 INFO - ##### 01:11:19 INFO - ##### Running run-tests step. 01:11:19 INFO - ##### 01:11:19 INFO - Running pre-action listener: _resource_record_pre_action 01:11:19 INFO - Running main action method: run_tests 01:11:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:11:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:11:19 INFO - Python 2.7.3 01:11:19 INFO - Return code: 0 01:11:19 INFO - grabbing minidump binary from tooltool 01:11:19 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')]} 01:11:19 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 0x1ee9d70>, '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 0x1eeab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeafb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:11:19 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 01:11:19 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 01:11:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:11:19 INFO - Return code: 0 01:11:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:11:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:11:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:11:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:11:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:11:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 01:11:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost 01:11:19 INFO - Using env: {'DISPLAY': ':0', 01:11:19 INFO - 'HOME': '/home/cltbld', 01:11:19 INFO - 'LANG': 'en_US.UTF-8', 01:11:19 INFO - 'LANGUAGE': 'en_US:en', 01:11:19 INFO - 'LOGNAME': 'cltbld', 01:11:19 INFO - 'MAIL': '/var/mail/cltbld', 01:11:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:11:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:19 INFO - 'MOZ_NO_REMOTE': '1', 01:11:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:19 INFO - 'NO_EM_RESTART': '1', 01:11:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:11:19 INFO - 'PWD': '/builds/slave/test-pgo', 01:11:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:11:19 INFO - 'SHELL': '/bin/bash', 01:11:19 INFO - 'SHLVL': '1', 01:11:19 INFO - 'TERM': 'linux', 01:11:19 INFO - 'TMOUT': '86400', 01:11:19 INFO - 'USER': 'cltbld', 01:11:19 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448096070.18268-224290911', 01:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:19 INFO - '_': '/tools/buildbot/bin/python'} 01:11:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] with output_timeout 3600 01:11:19 INFO - mozversion INFO | application_buildid: 20151120233007 01:11:19 INFO - mozversion INFO | application_changeset: fad3d3556cf5e5687e338f7618fbc092956499ae 01:11:19 INFO - mozversion INFO | application_display_name: Nightly 01:11:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:11:19 INFO - mozversion INFO | application_name: Firefox 01:11:19 INFO - mozversion INFO | application_remotingname: firefox 01:11:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 01:11:19 INFO - mozversion INFO | application_vendor: Mozilla 01:11:19 INFO - mozversion INFO | application_version: 45.0a1 01:11:19 INFO - mozversion INFO | platform_buildid: 20151120233007 01:11:19 INFO - mozversion INFO | platform_changeset: fad3d3556cf5e5687e338f7618fbc092956499ae 01:11:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 01:11:19 INFO - mozversion INFO | platform_version: 45.0a1 01:11:19 INFO - 2015-11-21 01:11:19,464 DEBUG : using testdate: 1448097079 01:11:19 INFO - 2015-11-21 01:11:19,464 DEBUG : actual date: 1448097079 01:11:19 INFO - 2015-11-21 01:11:19,552 INFO : starting webserver on 'localhost:53547' 01:11:19 INFO - 2015-11-21 01:11:19,553 INFO : Starting test suite talos-linux64-ix-014 01:11:19 INFO - 2015-11-21 01:11:19,553 INFO : Starting test dromaeo_css 01:11:19 INFO - 2015-11-21 01:11:19,554 DEBUG : operating with platform_type : linux_ 01:11:19 INFO - 2015-11-21 01:11:19,554 INFO : Initialising browser for dromaeo_css test... 01:11:19 INFO - 2015-11-21 01:11:19,570 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpokWDG9/profile http://localhost:53547/getInfo.html 01:11:23 INFO - 2015-11-21 01:11:23,639 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:11:23 INFO - 2015-11-21 01:11:23,639 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:11:23 INFO - 2015-11-21 01:11:23,639 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:11:23 INFO - 2015-11-21 01:11:23,639 DEBUG : BROWSER_OUTPUT: __metrics 01:11:24 INFO - 2015-11-21 01:11:24,003 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:11:25 INFO - 2015-11-21 01:11:25,190 INFO : Browser initialized. 01:11:25 INFO - 2015-11-21 01:11:25,190 INFO : Running cycle 1/1 for dromaeo_css test... 01:11:25 INFO - 2015-11-21 01:11:25,190 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpokWDG9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:11:36 INFO - 2015-11-21 01:11:36,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 141443072 01:11:36 INFO - 2015-11-21 01:11:36,951 DEBUG : BROWSER_OUTPUT: 01:12:28 INFO - 2015-11-21 01:12:28,613 DEBUG : BROWSER_OUTPUT: 1448097148612 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] 01:14:37 INFO - 2015-11-21 01:14:37,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53547/tests/dromaeo/cssquery-ext.html) 01:14:38 INFO - 2015-11-21 01:14:38,751 DEBUG : BROWSER_OUTPUT: RSS: Main: 265035776 01:14:38 INFO - 2015-11-21 01:14:38,751 DEBUG : BROWSER_OUTPUT: 01:17:41 INFO - 2015-11-21 01:17:41,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/dromaeo/cssquery-ext.html (next: http://localhost:53547/tests/dromaeo/cssquery-jquery.html) 01:17:41 INFO - 2015-11-21 01:17:41,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 218206208 01:17:41 INFO - 2015-11-21 01:17:41,808 DEBUG : BROWSER_OUTPUT: 01:20:43 INFO - 2015-11-21 01:20:43,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53547/tests/dromaeo/cssquery-mootools.html) 01:20:44 INFO - 2015-11-21 01:20:44,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 219754496 01:20:44 INFO - 2015-11-21 01:20:44,253 DEBUG : BROWSER_OUTPUT: 01:23:46 INFO - 2015-11-21 01:23:46,192 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53547/tests/dromaeo/cssquery-prototype.html) 01:23:46 INFO - 2015-11-21 01:23:46,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 196964352 01:23:46 INFO - 2015-11-21 01:23:46,779 DEBUG : BROWSER_OUTPUT: 01:26:49 INFO - 2015-11-21 01:26:49,325 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53547/tests/dromaeo/cssquery-yui.html) 01:26:49 INFO - 2015-11-21 01:26:49,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 200794112 01:26:49 INFO - 2015-11-21 01:26:49,907 DEBUG : BROWSER_OUTPUT: 01:29:52 INFO - 2015-11-21 01:29:52,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/dromaeo/cssquery-yui.html (next: http://localhost:53547/tests/dromaeo/cssquery-dojo.html) 01:29:52 INFO - 2015-11-21 01:29:52,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 305852416 01:29:52 INFO - 2015-11-21 01:29:52,800 DEBUG : BROWSER_OUTPUT: 01:29:52 INFO - 2015-11-21 01:29:52,800 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:29:52 INFO - 2015-11-21 01:29:52,800 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:29:52 INFO - 2015-11-21 01:29:52,800 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:29:52 INFO - 2015-11-21 01:29:52,800 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:29:52 INFO - 2015-11-21 01:29:52,800 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3203.327301266734;3233.2725136844197;3275.950860737088;3284.4744840825474;3297.818619975902;5304.893902121955;5411.080116380215;5415.620906536539;5442;5445.31933508312;5418;5491.752871120799;5534.861628459291;5546.278983732109;5557.472040156179;5004.499550044994;5022.84931452057;5046.798128074873;5067.974660126694;5118.206677964903;4865.586425153866;5070.239464080399;5081.517255860687;5108.233764935271;5144.768485418146;4890.021995600876;4983.152864013126;4985.750712464381;4991.725455099968;5024.723640199788;4998.075356059141;5011.749412529395;5016.799328026875;5026.949730502684;5054.342935418372;4920.384951881015;4968.130577149021;4970.229614409773;4978.626603004789;5056.949430505685;5189.117849965515;5267.604929630254;5294.6029047821185;5306.416294207634;5338.546223571001;5951.851203719898;5974.790882319141;5980.491658209057;5981.52147828177;5987.191729116557;5846.619969701956;5966.522678185778;6001.909971350433;6017.518598512109;6026.397360263983;5554.972225138848;5573.777048918079;5623.606347555632;5624.746886390122;5667.518260947865;5982.820515384546;6005.579609427386;6011.879762404815;6025.676696212087;6078.179445774852;5745.540356771448;5796.768129274782;5830.7084645767545;5833.67914764692;5887.911681324698;5779.913301300484;5906.055031194988;5908.05471124618;5909.970450147722;5913.113033045078;5908.704564771744;5955.940440595626;5960.046392577166;5967.045272756338;5973.820785376446;5963.2844058713235;5975.282966044103;5975.641461512323;5979.940200597938;5988.970055149784;4442.53353397895;4477.753723545236;4493.326001099796;4573.656975726767;4595.9080818383445;4074.9812546863286;4081.0613558881623;4085.20338533989;4094.9385759213637;4133.256013917464;5535.612507124462;5535.916961245584;5540.612157148961;5543.279373681396;5591.440855914376;5777.7977770777825;5880.647161170258;5899.587028907935;5908.113782932594;5958.493528050078;5488.725563721798;5499.587530935116;5501.257330260443;5505.724713764296;5506.669599824023;5124.666896651705;5157.63896527247;5162.199859021857;5166.509181627739;5214.817481388133;5944;6002.609830361012;6030.909536356959;6064.06007068905;6134.570580059353;5884.264466941632;5929.822105336847;5930.733117009659;5947.9702601486715;5948.73230704628;6155.784547540815;6157.72290246931;6163.229596300463;6164.7842325518395;6164.876702466016;5716.314042314949;5742.59801813869;5811.099279611667;5816.70916454184;5874.383189765013;5919.200907877382;5943.078822782476;5950.375210602998;5951.1073338999495;5951.1073338999495;5748.511376533042;5801.3038435388025;5810.796622118206;5815.273090863642;5817.185594016925;5643.633163844337;5757.36668966405;5763.682997435181;5863.706814659165;5922.378150294157;5661.603687741818;5710.628809127394;5716.28546431696;5722.341930677859;5735;5619.466150715675;5799.3040835100055;5841.357450680337;5844.532437405082;5861.120831875082;5535;5609.1305847593685;5647.322321321303;5647.858803529944;5690.601657883908 01:29:52 INFO - 2015-11-21 01:29:52,800 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.4292899980653;588.6115163991765;589.9675517846518;605.2132228103467;609.8717372860207;29585;30418.239544011383;30511.69488305119;41077.17845643093;41598.79200604001;43195.3520697189;43802;43856;43940.560594394046;43976.56023439773;8639.136086391374;8741.213290803826;8765.991910930261;8813.735587932373;8821.779455513599;7787.922120778776;7935.444518883681;8572.14278572144;10365.533550990185;10643.308184967953;10327.896721032768;10343.22425818063;10422.9478852606;10426.895731042669;10428.16574674028;7819.452638315321;10356.482175891213;10427.322224055411;10445.373277603368;10449.9477502612;7699.923000769976;10388.117010054155;10636.734081648021;10661.253712240146;10663.040326370663;39719.20561588781;40252.79873600613;40282.79858600718;40372;40379.59620403788;3167.33485967947;3229.3056992746438;3255;3328.4508056170703;3642.3990041643096;29905.551416728766;30216.395672086433;30285;30880;31398;3931.646151846319;3954.6638535724496;4021.0751527148627;4037.1723796621914;4079.73528206257;278261;280594.5970270156;280881;281233;281464;59932.101018484755;60344.39655603476;60344.45694288214;60385;60465.395346046855;61312.69343653253;62022.37977620166;71285;72164;72203.63898180581;14497.565073047825;14545.854541454662;14628.414863405345;14646.048006879519;14654.340554675066;10906.236563440483;10929.836052459219;10960.28758130719;10961.397123158304;10967.670969870916;19755.444020076236;20083.096260668306;20102.195912163643;20203.494912627302;20227.59544809125;8021.679132834738;8123.675052997932;8191.262786349257;8269.29710974574;8332.583370831435;854.4446110028531;958.8226178157063;1024.6977141743203;1036.9941157077624;1042.8893228711397;25621;25741.485170296488;26288.737112628627;27914.441711165662;28355.71644283572;1002.9381006921936;1018.6892997635792;1027.768752030802;1032.9431881246603;1118.9537782173693;14540.709185816224;14566.344514496874;14629.195394253205;14659.780103298459;14785.260736963324;328456;331060;331792;332148;333471;53613.46386536163;54266.18600720992;54299.72850135724;54326.456735432934;54395.72802135964;1313.080843409617;1344.4420565465418;1358.44303835427;1364.522417154008;1367.6580854786303;25786.742132578434;26877.865610671823;27867.44265114727;28000.29999250035;29229.85385073061;44503.442379516564;44906.55093449154;44964;44985.1002979932;45286;215364;216435;216892;217105;217162;27007.45985080248;27902.44195116127;28801.279968000967;32744.181395465304;32870.178245544055;39439;39578.60421395864;39767.2046559073;39887.60112398955;40366;36215.81892090523;36431;36531.634683652825;37524;37693.81153094217;30000.549991749704;35641.1089722759;36510;36737;36886.44670330001;35454.11364715903;35799.64200358067;35818.283634326646;36257.45613815848;36628.45057324089;30136.547951780303;31266;31369;31918;32956.34087318288;25215.46121698112;25257.719154432332;25355.239342819747;25420.237392878244;25640.871795640902 01:29:52 INFO - 2015-11-21 01:29:52,801 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.1038955857343;359.9748017638765;360.1482493901922;360.1680118925281;362.2121884900341;13934.790978135336;13988;16948.152592370378;17235.569110772238;17855;11135.72160695983;11373.943130284357;16493.422730204446;17398.739018914694;17410.738838917427;4850.320955066285;4931.408231012284;4953.653244272902;4967.304577359173;4972.179590367603;3696.9260614787686;3811.6950643948558;4903.068417000776;4930.7534623268875;5290.761915713802;5399.325084364455;5412.512873841353;5425.484578964992;5440.891182176354;5444.373897001856;5179.766910489018;5299.814506492255;5312.893742125136;5404.4595540446035;5408.026555220059;5066.949330506684;5116.718580478072;5117.897642047175;5120.257562653394;5136.024155410498;13324.600261992156;13335.799963000563;18009.27962881483;20084.096215670328;20461;2022.9797702022938;2033.4611327998093;2081.8126368626895;2091.884946327951;2124.4370241885913;9839.606415743361;9979.401235925796;11967.94016029923;13238.139520931109;13695.657608559766;1771.8228177182307;1797.0565453137076;1817.9818201817945;1853.5366158460386;1895.9336423225259;60869.08696369558;61984.69007654978;63249;63394.366056339306;63956.04065939015;9948.303618746619;9954.751131221632;10014.3490673106;10177.949110254402;10316.690499285034;12873.678158045936;12900.419481123372;12902.225866448043;12915.806262906064;12923.15999460032;7028.824279392954;7286.817829554304;7294.562326260441;7311.597862117528;7337.376323012603;6655.23464801554;6690.096836926952;6708.563943343667;6883.036374907517;6971.825704357431;4155.605217504332;4223.662107031491;4244.957550424518;4247.532771395144;4254.829806807693;1679.5717092141426;1786.63374008328;1786.9374571890182;1809.9457016289532;1867.9346222882405;844.594594594598;910.6266430763487;960.9279304052224;962.8892677342055;970.8592254123113;16641.334346625998;17217.39739109125;17544.473665790047;17639;17655.470335889942;795.6936579416966;889.9199072083544;916.7983043730369;933.2627224492575;945.7588314979636;9205.263578913671;9385.38994965325;9517;9526.476043817518;9625.374350667184;403227;405626;406000;408006;564587.718289582;76325;82059.5897020523;82124.58937705273;85153.57423212845;85405;1099.5107177306022;1112.3437172068357;1166.3585028234438;1180.5690922813112;1191.249512806926;15755.842441575896;16052.357905684108;16096.678066438371;16124.435644752846;16246.756298655293;34172.65827341794;35500.467492988144;36149.81925090358;37413.438798417505;38722.41916371313;46890;47791.283130752374;47884.76057619829;48038.279425807945;49578.25632615441;9516.429014258889;9577.23382129414;9605.903940960781;9715.319927605;9828.901710983084;11636.301821890713;11741.29552226835;11834.644960651194;13751;18300.084995749894;14736.336864840894;14758.33587488587;14803.333849976992;15195.544133676007;15316;14252.786208206679;14342.928285358506;14652.926735366682;14715;15150;10937.781244375226;14629.268536573341;14931.626709332353;14947.177905215318;14958.700825983202;9394.107559781809;9411.905880941376;9541.475218862752;9631;9645.71062868115;10165.84751228747;12770.361481926053;14136;14535.854641453872;14625.488107916171 01:29:52 INFO - 2015-11-21 01:29:52,801 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1304.3217526886026;1481.2667729473908;1534.3709079277498;1661.1113054515836;1773.299546679061;6630.469562435006;7089.574625522466;7242.818929526751;7249.420046396295;7257.237990011052;7095.85808283834;7198.244184360646;7209.81975450614;7224.241454647252;7234.240404757504;1961.4213806926991;2034.1354924157247;2183.1813070098715;2187.114218741412;2204.691343211952;2288.8969996350206;2301.631738921773;2302.6085565453914;2302.7121609798774;2303.608386574286;2195.879226642534;2264;2267.4218074391006;2272.8522646027955;2278.2254033628565;1970.7635083789964;1997.6404247235491;2223.288547664748;2265.410993141795;2270.182734215681;2241.540484200735;2250.718660167479;2264.1735766445295;2270.3416009357265;2306.6078766609717;7504.8123796904965;7548.924510754877;7559;7564.962175189089;7570.507916985433;4596.655250856199;4728.361671174382;4731.172044892164;4733.905321893577;4734.242521196592;3159.3839201355745;3167.8099314041;3187.10760986924;3194.568733221032;3225.161458020908;996.7408473796793;1004.4826914139225;1018.3177271228295;1047.9895201048043;1067.7490789664423;10219.897801021969;10226.181905447545;10228.38629682214;10241.436720980342;10256.589736410535;4145.564715704868;4228.682848786353;4291.463567054118;4294.334378171388;4312.331588603772;8928.15182557656;8932.46405215689;8936.195742383217;8937.419067760575;8944.8658270126;4670.462896766848;4672.369230153954;4688.835890743808;4710.764461776966;4714.127886341038;4193.559676234013;4278.89302767427;4285.37862010013;4286.121345124242;4290.442242508454;3601.981990090033;3653.908652283714;3668.596454390015;3676.227992121631;3691.3171063353366;1197.9221350612183;1205.2647884790272;1213.2841623442212;1213.9210951288137;1221.8472690913636;993.9613104306018;1040.3081950502983;1224.5101959216206;1312.8884044856104;1342.1745626439865;6512.316206798313;7023.719051237996;7263.201047884729;7271.67277472515;7279.854402911912;584.430180573937;588.364566268429;599.7358779080732;627.3694936588699;635.4789072960128;5575.69333686643;5638.4925356718095;5686.601937864392;5689.487946084872;5701;8837.646494140163;9011.909880901238;9100.635974560944;9102.226310763526;9105.043970383014;8968.641254349883;8987.820243595223;8993.730188094367;9009.909900901039;9011.549422528848;6810.931890681129;6989.266127056688;6997.720091196397;7051.753188638373;7071.964640176766;6797.72809087631;6825.965870170618;6826.112605361272;6830.829229269308;6837.042814006142;7608.80977975555;7832.451728378959;7936.960315198387;8032.357411406956;8060.274575288252;8192.54940978252;8200.548969806718;8200.712975045844;8200.712975045844;8208.179182081743;6715.462762978852;6954.061201737701;6979.476539259677;6983.546069505466;6985.895211571932;7388.298111679382;7422.66598003102;7433.479656423999;7438.73964411243;7439;6819.454443644596;6961.164660240804;6979.40675042627;7027.051348067946;7101.928980710127;6883.724651013903;6903.482238832208;6928.618925959121;7004.439644828503;7007.019017337475;5912.970435147797;6512.511561632802;6647.634380108947;6649.268580456049;6988.37104660583;5811.4479124483105;5978.491828194652;6097.634141951497;6098.0852872069545;6104.32852386246;6347.587406818542;6363.077353783583;6402.647854368054;6403.231612206565;6405.647689377129 01:29:52 INFO - 2015-11-21 01:29:52,801 DEBUG : BROWSER_OUTPUT: |4;prototype.html;340.1292690711778;345.047668435119;345.4628053376999;348.2113014023236;352.1249694509144;5930.822075337736;5958.37437069108;5991.790287339944;6065.848353791146;6141.477974372173;6018.3981601839905;6020.45815876571;6021.367756385571;6032.577719559622;6035.215421995134;4605.608523275526;4657.999999999992;4661.790219440133;4679.344891715145;4684.2739375396695;4650.86047418578;4654.650901182408;4672.439307283131;4690.835820746274;4692.9296060558945;4596.103759766846;4626.028534007863;4627.768611569425;4641.187792136379;4644.071185762844;4425.225585522537;4502.774861256924;4509.03055842992;4560.270356742905;4631;4006.238814625241;4024.959750402517;4102.630763231294;4105.158442519277;4109.075458021951;5692.146178073281;5705.172749951275;5707.74315155819;5717.656940583578;5734.340550836666;5150.587952963754;5283.313169287968;5288.0745869472685;5412.323459567554;5421.21392398104;5903.675297858616;6245.812625621194;6279.560430769848;6299.811005669837;6302.054691796221;4217.91564168718;4221.092465120014;4462.955370446286;4470.709403888737;4472.686911916167;6642.66786660665;6642.833929151761;6650.7031128929875;6651.434628056621;6652.966735166342;4405.273129933589;4510.481294651091;4568.885777855514;4573.588377046081;4574.108048930427;4591.816327346869;4594.150082234797;4598.379218805485;4605.355250264965;4605.746683932416;5319.281896943863;5324.946750532523;5335.199720042025;5340.172273297645;5348.652337598121;6472.190976127984;6477;6479.8056058318325;6481.902771458432;6483.643399612973;1582.7388480900522;1606.6304749907588;1623.6022174567306;1627.015655528412;1631.5350125214256;1042.1298215989734;1048.9265751397481;1057.0803401041144;1104.0119093411352;1104.7238190452388;6094.786682466092;6133;6136.846578835565;6137.723802428902;6141.662208578571;6560.507961902877;6574.868502629921;6608.3391660834495;6611.107500487469;6611.900821487681;5951.583389162717;5970.850728731816;6006.099085137264;6007.068904319837;6019.127226552126;3503.632118627558;3586.964130358663;3597.8201089945396;3600.369935261319;3601.675849173587;6588.439982601437;6758.695858686273;6805;6868.759593414306;6970.93029069713;6836.726530938707;6860.485463590251;6873;6878.931210687829;6887.276835932255;6923.099997000358;6929.237783843773;6929.757458488929;6932.410745086724;6933.965330173418;6540.149780528501;6675.532712710064;6688.264290928091;6703.564268322543;6718.428933540704;6641.302663220292;6641.701123449553;6642.867142657216;6644.60132392058;6651.33486651331;6820.863582728219;6944.895826562504;6948.791536253921;6950.409215216561;6951.991961165704;4419.315006174048;4533.501314855429;4558.0883823236145;4560.1335746208115;4560.5211452796975;6639.568428052161;6644.169478815148;6646.5347425681675;6652.634105124264;6655.2013758347375;6467.902981455376;6486.189226346707;6494.253160886369;6512.544121911421;6517.902231466626;6329.651869147241;6502.577332473374;6508.8047358579315;6531.412172904462;6531.673416329259;6400.583962042452;6403.679816009274;6405.519586030973;6412.038194270896;6417.454516366161;6568.376004279586;6570.342965703391;6571.507136964842;6579.967100164468;6580.473562114924;6209.813705588839;6407.615543067431;6409;6413.967930160319;6415.101885735908 01:29:52 INFO - 2015-11-21 01:29:52,802 DEBUG : BROWSER_OUTPUT: |5;yui.html;752.8306131120497;860.5138096975209;866.878636990821;867.9522626255554;878.8549889268271;12489.875101248985;12601.117921745481;12667.11330206886;12688.429020694057;12723.427445764939;11799.587014454495;12546.372681365941;12550.121491495598;12566.30885301308;12573.80548847858;669.3574168797948;814.3322475570035;829.9253067223949;832.9333653307751;835.9623816928222;812.5815205169313;823.6211342782298;828.7099515169702;830.0330115415563;830.5681045856181;700.7792545348225;706.3995603736809;858.4977787994031;868.3877866104413;868.9217970382664;837.9916200837974;865.6104752861238;866.4151697604156;866.4627930682954;866.8483015472299;636.6816591704148;639.5267502048497;640.8301800022998;641.6086187425667;641.9005054216603;12157.452914618863;12282;12307.4461649226;12316.199447035913;12341.62975110748;11413.714657133554;12213.633590992284;12909.601994497294;13024.41390137446;13259.86740132596;10485.266031377807;10672.199585031154;10712.517936692868;10926.453677316182;10938.398388088652;3598.946015809765;3656.5063716398213;3686.502322186497;3688.8340024698687;3767.6044015378266;45283;45404.77297613524;45808;45917;46084.308735368664;9466.810663786824;9719.125278724949;9861.950690246646;9989.350692204984;10293.845592316122;17252.827471725373;17323.653526929644;17364.565885852953;17366.65266694659;17379.73930391045;7140.678669459887;7239.927600723925;7277.417806575461;7298.160711518243;7393.371563417062;4498.50516443191;4527.1398434298035;4581.450225972904;4583.908321833612;4604.355390245301;3042.0569623416814;3052.5726398304255;3082.7071428214285;3086.506159014547;3217.1957010747315;598.628850112924;599.8710277290404;601.0323379359228;619.4239357397573;621.6674079367607;523.2961666558473;578.8784355285353;675.9188897332351;681.1621705302506;684.8732984397902;8122.634481448349;8491.702790402307;8700.869486957701;8798.20816126539;8893.64425422976;517.366226372698;588.8752482757998;608.7534548507862;614.3119705929388;625.0561651905655;3743.794091325003;3888.902777430587;3929.8821035368983;3963.4054891766464;4031.012387017046;52859.471405285454;56795.716021420456;61456.385436145065;61865.38134618596;61883.381166188665;47403;47436.52563474321;47596.28605570919;47817;47868;46605.76697116493;47240.291395629094;48684.269735954695;48840.26739598909;49563.752181238866;8375.581220938806;8658;8658.264047556027;8664.826703466022;8830.867536986822;35838.10404739902;36565.26869462649;36827.81586092053;36966;37048.629513704516;41401;41432;44641.10717785691;45758.084838303716;45928.31107533457;11101.50043248072;11469.942650286695;11484.540618375171;11629.418529073344;11750.647480575597;12600.747985040065;13050.738985220432;13206.537771177962;13257.170058312691;13410.262435566137;10323.093351876345;10617.787644247226;10739.838902416313;11300.830487542858;11340.09279257641;11927.880721193023;12286.815697764361;12357.93821030889;12522.436490358137;12694.936525317315;6418.211200446766;9216.493092879957;10170.338927969658;10283.537240824331;10374.252836981697;8999.730008099768;9410.341276110606;9467.66863159786;9485.430874147572;9595.28035397362;7800.882986755317;8917.955410222907;8922.286217102746;9291.62833486653;9531.857022144812 01:29:52 INFO - 2015-11-21 01:29:52,802 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:29:52 INFO - 2015-11-21 01:29:52,802 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:29:52 INFO - 2015-11-21 01:29:52,802 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,985 01:29:52 INFO - 2015-11-21 01:29:52,802 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:29:52 INFO - 2015-11-21 01:29:52,803 DEBUG : BROWSER_OUTPUT: __startTimestamp1448098192793__endTimestamp 01:29:52 INFO - 2015-11-21 01:29:52,803 DEBUG : BROWSER_OUTPUT: 01:29:52 INFO - 2015-11-21 01:29:52,803 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:29:52 INFO - 2015-11-21 01:29:52,803 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:29:52 INFO - 2015-11-21 01:29:52,803 DEBUG : BROWSER_OUTPUT: 01:29:52 INFO - 2015-11-21 01:29:52,803 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5485.75 Median:5690.60 stddev:616.13 (10.8%) stddev-sans-first:591.43 01:29:52 INFO - 2015-11-21 01:29:52,803 DEBUG : BROWSER_OUTPUT: Values: 3203.3 3233.3 3276.0 3284.5 3297.8 5304.9 5411.1 5415.6 5442.0 5445.3 5418.0 5491.8 5534.9 5546.3 5557.5 5004.5 5022.8 5046.8 5068.0 5118.2 4865.6 5070.2 5081.5 5108.2 5144.8 4890.0 4983.2 4985.8 4991.7 5024.7 4998.1 5011.7 5016.8 5026.9 5054.3 4920.4 4968.1 4970.2 4978.6 5056.9 5189.1 5267.6 5294.6 5306.4 5338.5 5951.9 5974.8 5980.5 5981.5 5987.2 5846.6 5966.5 6001.9 6017.5 6026.4 5555.0 5573.8 5623.6 5624.7 5667.5 5982.8 6005.6 6011.9 6025.7 6078.2 5745.5 5796.8 5830.7 5833.7 5887.9 5779.9 5906.1 5908.1 5910.0 5913.1 5908.7 5955.9 5960.0 5967.0 5973.8 5963.3 5975.3 5975.6 5979.9 5989.0 4442.5 4477.8 4493.3 4573.7 4595.9 4075.0 4081.1 4085.2 4094.9 4133.3 5535.6 5535.9 5540.6 5543.3 5591.4 5777.8 5880.6 5899.6 5908.1 5958.5 5488.7 5499.6 5501.3 5505.7 5506.7 5124.7 5157.6 5162.2 5166.5 5214.8 5944.0 6002.6 6030.9 6064.1 6134.6 5884.3 5929.8 5930.7 5948.0 5948.7 6155.8 6157.7 6163.2 6164.8 6164.9 5716.3 5742.6 5811.1 5816.7 5874.4 5919.2 5943.1 5950.4 5951.1 5951.1 5748.5 5801.3 5810.8 5815.3 5817.2 5643.6 5757.4 5763.7 5863.7 5922.4 5661.6 5710.6 5716.3 5722.3 5735.0 5619.5 5799.3 5841.4 5844.5 5861.1 5535.0 5609.1 5647.3 5647.9 5690.6 01:29:52 INFO - 2015-11-21 01:29:52,803 DEBUG : BROWSER_OUTPUT: 01:29:52 INFO - 2015-11-21 01:29:52,803 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45043.99 Median:3242.15 stddev:73287.64 (2260.5%) stddev-sans-first:73417.08 01:29:52 INFO - 2015-11-21 01:29:52,804 DEBUG : BROWSER_OUTPUT: Values: 549.4 588.6 590.0 605.2 609.9 29585.0 30418.2 30511.7 41077.2 41598.8 43195.4 43802.0 43856.0 43940.6 43976.6 8639.1 8741.2 8766.0 8813.7 8821.8 7787.9 7935.4 8572.1 10365.5 10643.3 10327.9 10343.2 10422.9 10426.9 10428.2 7819.5 10356.5 10427.3 10445.4 10449.9 7699.9 10388.1 10636.7 10661.3 10663.0 39719.2 40252.8 40282.8 40372.0 40379.6 3167.3 3229.3 3255.0 3328.5 3642.4 29905.6 30216.4 30285.0 30880.0 31398.0 3931.6 3954.7 4021.1 4037.2 4079.7 278261.0 280594.6 280881.0 281233.0 281464.0 59932.1 60344.4 60344.5 60385.0 60465.4 61312.7 62022.4 71285.0 72164.0 72203.6 14497.6 14545.9 14628.4 14646.0 14654.3 10906.2 10929.8 10960.3 10961.4 10967.7 19755.4 20083.1 20102.2 20203.5 20227.6 8021.7 8123.7 8191.3 8269.3 8332.6 854.4 958.8 1024.7 1037.0 1042.9 25621.0 25741.5 26288.7 27914.4 28355.7 1002.9 1018.7 1027.8 1032.9 1119.0 14540.7 14566.3 14629.2 14659.8 14785.3 328456.0 331060.0 331792.0 332148.0 333471.0 53613.5 54266.2 54299.7 54326.5 54395.7 1313.1 1344.4 1358.4 1364.5 1367.7 25786.7 26877.9 27867.4 28000.3 29229.9 44503.4 44906.6 44964.0 44985.1 45286.0 215364.0 216435.0 216892.0 217105.0 217162.0 27007.5 27902.4 28801.3 32744.2 32870.2 39439.0 39578.6 39767.2 39887.6 40366.0 36215.8 36431.0 36531.6 37524.0 37693.8 30000.5 35641.1 36510.0 36737.0 36886.4 35454.1 35799.6 35818.3 36257.5 36628.5 30136.5 31266.0 31369.0 31918.0 32956.3 25215.5 25257.7 25355.2 25420.2 25640.9 01:29:52 INFO - 2015-11-21 01:29:52,804 DEBUG : BROWSER_OUTPUT: 01:29:52 INFO - 2015-11-21 01:29:52,804 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25953.65 Median:20612.57 stddev:72623.27 (352.3%) stddev-sans-first:72801.55 01:29:52 INFO - 2015-11-21 01:29:52,805 DEBUG : BROWSER_OUTPUT: Values: 352.1 360.0 360.1 360.2 362.2 13934.8 13988.0 16948.2 17235.6 17855.0 11135.7 11373.9 16493.4 17398.7 17410.7 4850.3 4931.4 4953.7 4967.3 4972.2 3696.9 3811.7 4903.1 4930.8 5290.8 5399.3 5412.5 5425.5 5440.9 5444.4 5179.8 5299.8 5312.9 5404.5 5408.0 5066.9 5116.7 5117.9 5120.3 5136.0 13324.6 13335.8 18009.3 20084.1 20461.0 2023.0 2033.5 2081.8 2091.9 2124.4 9839.6 9979.4 11967.9 13238.1 13695.7 1771.8 1797.1 1818.0 1853.5 1895.9 60869.1 61984.7 63249.0 63394.4 63956.0 9948.3 9954.8 10014.3 10177.9 10316.7 12873.7 12900.4 12902.2 12915.8 12923.2 7028.8 7286.8 7294.6 7311.6 7337.4 6655.2 6690.1 6708.6 6883.0 6971.8 4155.6 4223.7 4245.0 4247.5 4254.8 1679.6 1786.6 1786.9 1809.9 1867.9 844.6 910.6 960.9 962.9 970.9 16641.3 17217.4 17544.5 17639.0 17655.5 795.7 889.9 916.8 933.3 945.8 9205.3 9385.4 9517.0 9526.5 9625.4 403227.0 405626.0 406000.0 408006.0 564587.7 76325.0 82059.6 82124.6 85153.6 85405.0 1099.5 1112.3 1166.4 1180.6 1191.2 15755.8 16052.4 16096.7 16124.4 16246.8 34172.7 35500.5 36149.8 37413.4 38722.4 46890.0 47791.3 47884.8 48038.3 49578.3 9516.4 9577.2 9605.9 9715.3 9828.9 11636.3 11741.3 11834.6 13751.0 18300.1 14736.3 14758.3 14803.3 15195.5 15316.0 14252.8 14342.9 14652.9 14715.0 15150.0 10937.8 14629.3 14931.6 14947.2 14958.7 9394.1 9411.9 9541.5 9631.0 9645.7 10165.8 12770.4 14136.0 14535.9 14625.5 01:29:52 INFO - 2015-11-21 01:29:52,805 DEBUG : BROWSER_OUTPUT: 01:29:52 INFO - 2015-11-21 01:29:52,805 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5286.16 Median:6101.21 stddev:2708.02 (44.4%) stddev-sans-first:2699.07 01:29:52 INFO - 2015-11-21 01:29:52,806 DEBUG : BROWSER_OUTPUT: Values: 1304.3 1481.3 1534.4 1661.1 1773.3 6630.5 7089.6 7242.8 7249.4 7257.2 7095.9 7198.2 7209.8 7224.2 7234.2 1961.4 2034.1 2183.2 2187.1 2204.7 2288.9 2301.6 2302.6 2302.7 2303.6 2195.9 2264.0 2267.4 2272.9 2278.2 1970.8 1997.6 2223.3 2265.4 2270.2 2241.5 2250.7 2264.2 2270.3 2306.6 7504.8 7548.9 7559.0 7565.0 7570.5 4596.7 4728.4 4731.2 4733.9 4734.2 3159.4 3167.8 3187.1 3194.6 3225.2 996.7 1004.5 1018.3 1048.0 1067.7 10219.9 10226.2 10228.4 10241.4 10256.6 4145.6 4228.7 4291.5 4294.3 4312.3 8928.2 8932.5 8936.2 8937.4 8944.9 4670.5 4672.4 4688.8 4710.8 4714.1 4193.6 4278.9 4285.4 4286.1 4290.4 3602.0 3653.9 3668.6 3676.2 3691.3 1197.9 1205.3 1213.3 1213.9 1221.8 994.0 1040.3 1224.5 1312.9 1342.2 6512.3 7023.7 7263.2 7271.7 7279.9 584.4 588.4 599.7 627.4 635.5 5575.7 5638.5 5686.6 5689.5 5701.0 8837.6 9011.9 9100.6 9102.2 9105.0 8968.6 8987.8 8993.7 9009.9 9011.5 6810.9 6989.3 6997.7 7051.8 7072.0 6797.7 6826.0 6826.1 6830.8 6837.0 7608.8 7832.5 7937.0 8032.4 8060.3 8192.5 8200.5 8200.7 8200.7 8208.2 6715.5 6954.1 6979.5 6983.5 6985.9 7388.3 7422.7 7433.5 7438.7 7439.0 6819.5 6961.2 6979.4 7027.1 7101.9 6883.7 6903.5 6928.6 7004.4 7007.0 5913.0 6512.5 6647.6 6649.3 6988.4 5811.4 5978.5 6097.6 6098.1 6104.3 6347.6 6363.1 6402.6 6403.2 6405.6 01:29:52 INFO - 2015-11-21 01:29:52,806 DEBUG : BROWSER_OUTPUT: 01:29:52 INFO - 2015-11-21 01:29:52,806 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5373.19 Median:6020.91 stddev:1630.66 (27.1%) stddev-sans-first:1590.88 01:29:52 INFO - 2015-11-21 01:29:52,806 DEBUG : BROWSER_OUTPUT: Values: 340.1 345.0 345.5 348.2 352.1 5930.8 5958.4 5991.8 6065.8 6141.5 6018.4 6020.5 6021.4 6032.6 6035.2 4605.6 4658.0 4661.8 4679.3 4684.3 4650.9 4654.7 4672.4 4690.8 4692.9 4596.1 4626.0 4627.8 4641.2 4644.1 4425.2 4502.8 4509.0 4560.3 4631.0 4006.2 4025.0 4102.6 4105.2 4109.1 5692.1 5705.2 5707.7 5717.7 5734.3 5150.6 5283.3 5288.1 5412.3 5421.2 5903.7 6245.8 6279.6 6299.8 6302.1 4217.9 4221.1 4463.0 4470.7 4472.7 6642.7 6642.8 6650.7 6651.4 6653.0 4405.3 4510.5 4568.9 4573.6 4574.1 4591.8 4594.2 4598.4 4605.4 4605.7 5319.3 5324.9 5335.2 5340.2 5348.7 6472.2 6477.0 6479.8 6481.9 6483.6 1582.7 1606.6 1623.6 1627.0 1631.5 1042.1 1048.9 1057.1 1104.0 1104.7 6094.8 6133.0 6136.8 6137.7 6141.7 6560.5 6574.9 6608.3 6611.1 6611.9 5951.6 5970.9 6006.1 6007.1 6019.1 3503.6 3587.0 3597.8 3600.4 3601.7 6588.4 6758.7 6805.0 6868.8 6970.9 6836.7 6860.5 6873.0 6878.9 6887.3 6923.1 6929.2 6929.8 6932.4 6934.0 6540.1 6675.5 6688.3 6703.6 6718.4 6641.3 6641.7 6642.9 6644.6 6651.3 6820.9 6944.9 6948.8 6950.4 6952.0 4419.3 4533.5 4558.1 4560.1 4560.5 6639.6 6644.2 6646.5 6652.6 6655.2 6467.9 6486.2 6494.3 6512.5 6517.9 6329.7 6502.6 6508.8 6531.4 6531.7 6400.6 6403.7 6405.5 6412.0 6417.5 6568.4 6570.3 6571.5 6580.0 6580.5 6209.8 6407.6 6409.0 6414.0 6415.1 01:29:52 INFO - 2015-11-21 01:29:52,806 DEBUG : BROWSER_OUTPUT: 01:29:52 INFO - 2015-11-21 01:29:52,806 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13626.22 Median:47321.65 stddev:15844.99 (33.5%) stddev-sans-first:15859.95 01:29:52 INFO - 2015-11-21 01:29:52,807 DEBUG : BROWSER_OUTPUT: Values: 752.8 860.5 866.9 868.0 878.9 12489.9 12601.1 12667.1 12688.4 12723.4 11799.6 12546.4 12550.1 12566.3 12573.8 669.4 814.3 829.9 832.9 836.0 812.6 823.6 828.7 830.0 830.6 700.8 706.4 858.5 868.4 868.9 838.0 865.6 866.4 866.5 866.8 636.7 639.5 640.8 641.6 641.9 12157.5 12282.0 12307.4 12316.2 12341.6 11413.7 12213.6 12909.6 13024.4 13259.9 10485.3 10672.2 10712.5 10926.5 10938.4 3598.9 3656.5 3686.5 3688.8 3767.6 45283.0 45404.8 45808.0 45917.0 46084.3 9466.8 9719.1 9862.0 9989.4 10293.8 17252.8 17323.7 17364.6 17366.7 17379.7 7140.7 7239.9 7277.4 7298.2 7393.4 4498.5 4527.1 4581.5 4583.9 4604.4 3042.1 3052.6 3082.7 3086.5 3217.2 598.6 599.9 601.0 619.4 621.7 523.3 578.9 675.9 681.2 684.9 8122.6 8491.7 8700.9 8798.2 8893.6 517.4 588.9 608.8 614.3 625.1 3743.8 3888.9 3929.9 3963.4 4031.0 52859.5 56795.7 61456.4 61865.4 61883.4 47403.0 47436.5 47596.3 47817.0 47868.0 46605.8 47240.3 48684.3 48840.3 49563.8 8375.6 8658.0 8658.3 8664.8 8830.9 35838.1 36565.3 36827.8 36966.0 37048.6 41401.0 41432.0 44641.1 45758.1 45928.3 11101.5 11469.9 11484.5 11629.4 11750.6 12600.7 13050.7 13206.5 13257.2 13410.3 10323.1 10617.8 10739.8 11300.8 11340.1 11927.9 12286.8 12357.9 12522.4 12694.9 6418.2 9216.5 10170.3 10283.5 10374.3 8999.7 9410.3 9467.7 9485.4 9595.3 7800.9 8918.0 8922.3 9291.6 9531.9 01:29:52 INFO - 2015-11-21 01:29:52,807 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:29:52 INFO - 2015-11-21 01:29:52,807 DEBUG : BROWSER_OUTPUT: 01:29:53 INFO - 2015-11-21 01:29:53,402 INFO : Browser exited with error code: 0 01:29:53 INFO - 2015-11-21 01:29:53,425 INFO : Completed test dromaeo_css (00:18:33) 01:29:53 INFO - 2015-11-21 01:29:53,425 INFO : Starting test kraken 01:29:53 INFO - 2015-11-21 01:29:53,425 DEBUG : operating with platform_type : linux_ 01:29:53 INFO - 2015-11-21 01:29:53,425 INFO : Initialising browser for kraken test... 01:29:53 INFO - 2015-11-21 01:29:53,431 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqmNJOb/profile http://localhost:53547/getInfo.html 01:29:57 INFO - 2015-11-21 01:29:57,376 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:29:57 INFO - 2015-11-21 01:29:57,377 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:29:57 INFO - 2015-11-21 01:29:57,377 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:29:57 INFO - 2015-11-21 01:29:57,377 DEBUG : BROWSER_OUTPUT: __metrics 01:29:57 INFO - 2015-11-21 01:29:57,458 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:29:58 INFO - 2015-11-21 01:29:58,801 INFO : Browser initialized. 01:29:58 INFO - 2015-11-21 01:29:58,802 INFO : Running cycle 1/1 for kraken test... 01:29:58 INFO - 2015-11-21 01:29:58,802 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqmNJOb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:30:10 INFO - 2015-11-21 01:30:10,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 141930496 01:30:10 INFO - 2015-11-21 01:30:10,587 DEBUG : BROWSER_OUTPUT: 01:30:13 INFO - 2015-11-21 01:30:13,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53547/tests/kraken/driver.html?testName=audio-beat-detection) 01:30:13 INFO - 2015-11-21 01:30:13,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 178900992 01:30:13 INFO - 2015-11-21 01:30:13,624 DEBUG : BROWSER_OUTPUT: 01:30:16 INFO - 2015-11-21 01:30:16,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53547/tests/kraken/driver.html?testName=audio-dft) 01:30:16 INFO - 2015-11-21 01:30:16,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 166772736 01:30:16 INFO - 2015-11-21 01:30:16,788 DEBUG : BROWSER_OUTPUT: 01:30:19 INFO - 2015-11-21 01:30:19,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53547/tests/kraken/driver.html?testName=audio-fft) 01:30:20 INFO - 2015-11-21 01:30:20,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 151576576 01:30:20 INFO - 2015-11-21 01:30:20,229 DEBUG : BROWSER_OUTPUT: 01:30:22 INFO - 2015-11-21 01:30:22,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53547/tests/kraken/driver.html?testName=audio-oscillator) 01:30:22 INFO - 2015-11-21 01:30:22,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 154714112 01:30:22 INFO - 2015-11-21 01:30:22,773 DEBUG : BROWSER_OUTPUT: 01:30:24 INFO - 2015-11-21 01:30:24,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53547/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:30:25 INFO - 2015-11-21 01:30:25,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 156639232 01:30:25 INFO - 2015-11-21 01:30:25,479 DEBUG : BROWSER_OUTPUT: 01:30:28 INFO - 2015-11-21 01:30:28,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53547/tests/kraken/driver.html?testName=imaging-darkroom) 01:30:28 INFO - 2015-11-21 01:30:28,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 155803648 01:30:28 INFO - 2015-11-21 01:30:28,959 DEBUG : BROWSER_OUTPUT: 01:30:32 INFO - 2015-11-21 01:30:32,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53547/tests/kraken/driver.html?testName=imaging-desaturate) 01:30:32 INFO - 2015-11-21 01:30:32,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 155676672 01:30:32 INFO - 2015-11-21 01:30:32,937 DEBUG : BROWSER_OUTPUT: 01:30:35 INFO - 2015-11-21 01:30:35,679 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53547/tests/kraken/driver.html?testName=json-parse-financial) 01:30:36 INFO - 2015-11-21 01:30:36,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 155136000 01:30:36 INFO - 2015-11-21 01:30:36,249 DEBUG : BROWSER_OUTPUT: 01:30:37 INFO - 2015-11-21 01:30:37,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53547/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:30:38 INFO - 2015-11-21 01:30:38,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 165351424 01:30:38 INFO - 2015-11-21 01:30:38,366 DEBUG : BROWSER_OUTPUT: 01:30:40 INFO - 2015-11-21 01:30:40,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53547/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:30:40 INFO - 2015-11-21 01:30:40,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 164118528 01:30:40 INFO - 2015-11-21 01:30:40,750 DEBUG : BROWSER_OUTPUT: 01:30:42 INFO - 2015-11-21 01:30:42,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53547/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:30:43 INFO - 2015-11-21 01:30:43,368 DEBUG : BROWSER_OUTPUT: RSS: Main: 166612992 01:30:43 INFO - 2015-11-21 01:30:43,368 DEBUG : BROWSER_OUTPUT: 01:30:45 INFO - 2015-11-21 01:30:45,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:30:46 INFO - 2015-11-21 01:30:46,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 178548736 01:30:46 INFO - 2015-11-21 01:30:46,330 DEBUG : BROWSER_OUTPUT: 01:30:48 INFO - 2015-11-21 01:30:48,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:30:49 INFO - 2015-11-21 01:30:49,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 176263168 01:30:49 INFO - 2015-11-21 01:30:49,435 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53547/tests/kraken/driver.html?testName=ai-astar) 01:30:51 INFO - 2015-11-21 01:30:51,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 235229184 01:30:51 INFO - 2015-11-21 01:30:51,351 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,354 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:30:51 INFO - 2015-11-21 01:30:51,354 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:30:51 INFO - 2015-11-21 01:30:51,354 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:30:51 INFO - 2015-11-21 01:30:51,355 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:30:51 INFO - 2015-11-21 01:30:51,355 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;104;109;114;112;98;109;114;110 01:30:51 INFO - 2015-11-21 01:30:51,355 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;126;148;161;132;158;150;126;165;124 01:30:51 INFO - 2015-11-21 01:30:51,355 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;160;160;160;160;162;161;162 01:30:51 INFO - 2015-11-21 01:30:51,355 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;73;88;73;72;72;105;90;72 01:30:51 INFO - 2015-11-21 01:30:51,356 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;134;89;89;90;136;89;91;137 01:30:51 INFO - 2015-11-21 01:30:51,356 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;110;110;109;109;109 01:30:51 INFO - 2015-11-21 01:30:51,356 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;147;146;145;150;145;145;145;145;145 01:30:51 INFO - 2015-11-21 01:30:51,356 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;96;96;96;95;95 01:30:51 INFO - 2015-11-21 01:30:51,356 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;57;56;57;57;57;56;65;56;58 01:30:51 INFO - 2015-11-21 01:30:51,357 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;69;69;69;69;69;69;68;68 01:30:51 INFO - 2015-11-21 01:30:51,357 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;85;85;87;91;84;85;84;86;85 01:30:51 INFO - 2015-11-21 01:30:51,357 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;115;122;114;118;123;114;115;124;122 01:30:51 INFO - 2015-11-21 01:30:51,357 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;149;144;146;153;138;147;149;148;141 01:30:51 INFO - 2015-11-21 01:30:51,357 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;66;65;66;68;65;67;65;66 01:30:51 INFO - 2015-11-21 01:30:51,357 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:30:51 INFO - 2015-11-21 01:30:51,357 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:30:51 INFO - 2015-11-21 01:30:51,357 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,907 01:30:51 INFO - 2015-11-21 01:30:51,358 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:30:51 INFO - 2015-11-21 01:30:51,358 DEBUG : BROWSER_OUTPUT: __startTimestamp1448098251352__endTimestamp 01:30:51 INFO - 2015-11-21 01:30:51,358 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,359 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:30:51 INFO - 2015-11-21 01:30:51,359 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:30:51 INFO - 2015-11-21 01:30:51,359 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,359 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:4.81 (4.3%) stddev-sans-first:5.09 01:30:51 INFO - 2015-11-21 01:30:51,359 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 104.0 109.0 114.0 112.0 98.0 109.0 114.0 110.0 01:30:51 INFO - 2015-11-21 01:30:51,359 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,360 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.60 Median:153.00 stddev:16.02 (10.5%) stddev-sans-first:16.45 01:30:51 INFO - 2015-11-21 01:30:51,360 DEBUG : BROWSER_OUTPUT: Values: 156.0 126.0 148.0 161.0 132.0 158.0 150.0 126.0 165.0 124.0 01:30:51 INFO - 2015-11-21 01:30:51,360 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,360 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 01:30:51 INFO - 2015-11-21 01:30:51,360 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 160.0 160.0 160.0 160.0 162.0 161.0 162.0 01:30:51 INFO - 2015-11-21 01:30:51,360 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,360 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.00 Median:73.00 stddev:11.46 (15.7%) stddev-sans-first:11.95 01:30:51 INFO - 2015-11-21 01:30:51,360 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 88.0 73.0 72.0 72.0 105.0 90.0 72.0 01:30:51 INFO - 2015-11-21 01:30:51,360 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,360 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.50 Median:89.50 stddev:22.22 (24.8%) stddev-sans-first:23.02 01:30:51 INFO - 2015-11-21 01:30:51,360 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 134.0 89.0 89.0 90.0 136.0 89.0 91.0 137.0 01:30:51 INFO - 2015-11-21 01:30:51,361 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,361 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 01:30:51 INFO - 2015-11-21 01:30:51,361 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 109.0 01:30:51 INFO - 2015-11-21 01:30:51,361 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,361 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:145.00 stddev:1.62 (1.1%) stddev-sans-first:1.69 01:30:51 INFO - 2015-11-21 01:30:51,361 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 146.0 145.0 150.0 145.0 145.0 145.0 145.0 145.0 01:30:51 INFO - 2015-11-21 01:30:51,361 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,362 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:30:51 INFO - 2015-11-21 01:30:51,362 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 01:30:51 INFO - 2015-11-21 01:30:51,362 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,362 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:2.67 (4.7%) stddev-sans-first:2.83 01:30:51 INFO - 2015-11-21 01:30:51,362 DEBUG : BROWSER_OUTPUT: Values: 57.0 57.0 56.0 57.0 57.0 57.0 56.0 65.0 56.0 58.0 01:30:51 INFO - 2015-11-21 01:30:51,363 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,363 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.44 01:30:51 INFO - 2015-11-21 01:30:51,363 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 69.0 69.0 69.0 69.0 69.0 69.0 68.0 68.0 01:30:51 INFO - 2015-11-21 01:30:51,363 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,363 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:2.37 (2.8%) stddev-sans-first:2.17 01:30:51 INFO - 2015-11-21 01:30:51,363 DEBUG : BROWSER_OUTPUT: Values: 82.0 85.0 85.0 87.0 91.0 84.0 85.0 84.0 86.0 85.0 01:30:51 INFO - 2015-11-21 01:30:51,363 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,363 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:120.00 stddev:4.03 (3.4%) stddev-sans-first:4.19 01:30:51 INFO - 2015-11-21 01:30:51,363 DEBUG : BROWSER_OUTPUT: Values: 116.0 115.0 122.0 114.0 118.0 123.0 114.0 115.0 124.0 122.0 01:30:51 INFO - 2015-11-21 01:30:51,363 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,364 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:147.50 stddev:4.84 (3.3%) stddev-sans-first:4.54 01:30:51 INFO - 2015-11-21 01:30:51,364 DEBUG : BROWSER_OUTPUT: Values: 139.0 149.0 144.0 146.0 153.0 138.0 147.0 149.0 148.0 141.0 01:30:51 INFO - 2015-11-21 01:30:51,364 DEBUG : BROWSER_OUTPUT: 01:30:51 INFO - 2015-11-21 01:30:51,364 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 01:30:51 INFO - 2015-11-21 01:30:51,364 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 66.0 65.0 66.0 68.0 65.0 67.0 65.0 66.0 01:30:51 INFO - 2015-11-21 01:30:51,364 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:30:51 INFO - 2015-11-21 01:30:51,364 DEBUG : BROWSER_OUTPUT: 01:30:52 INFO - 2015-11-21 01:30:52,157 INFO : Browser exited with error code: 0 01:30:52 INFO - 2015-11-21 01:30:52,212 INFO : Completed test kraken (00:00:58) 01:30:52 INFO - 2015-11-21 01:30:52,212 INFO : Starting test v8_7 01:30:52 INFO - 2015-11-21 01:30:52,212 DEBUG : operating with platform_type : linux_ 01:30:52 INFO - 2015-11-21 01:30:52,212 INFO : Initialising browser for v8_7 test... 01:30:52 INFO - 2015-11-21 01:30:52,218 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgQJFeC/profile http://localhost:53547/getInfo.html 01:30:56 INFO - 2015-11-21 01:30:56,227 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:30:56 INFO - 2015-11-21 01:30:56,227 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:30:56 INFO - 2015-11-21 01:30:56,227 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:30:56 INFO - 2015-11-21 01:30:56,227 DEBUG : BROWSER_OUTPUT: __metrics 01:30:56 INFO - 2015-11-21 01:30:56,384 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:30:57 INFO - 2015-11-21 01:30:57,638 INFO : Browser initialized. 01:30:57 INFO - 2015-11-21 01:30:57,639 INFO : Running cycle 1/1 for v8_7 test... 01:30:57 INFO - 2015-11-21 01:30:57,639 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgQJFeC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:31:09 INFO - 2015-11-21 01:31:09,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 141979648 01:31:09 INFO - 2015-11-21 01:31:09,355 DEBUG : BROWSER_OUTPUT: 01:31:30 INFO - 2015-11-21 01:31:30,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53547/tests/v8_7/run.html (next: http://localhost:53547/tests/v8_7/run.html) 01:31:31 INFO - 2015-11-21 01:31:31,047 DEBUG : BROWSER_OUTPUT: RSS: Main: 603770880 01:31:31 INFO - 2015-11-21 01:31:31,047 DEBUG : BROWSER_OUTPUT: 01:31:31 INFO - 2015-11-21 01:31:31,047 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:31:31 INFO - 2015-11-21 01:31:31,048 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:31:31 INFO - 2015-11-21 01:31:31,048 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:31:31 INFO - 2015-11-21 01:31:31,048 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:31:31 INFO - 2015-11-21 01:31:31,048 DEBUG : BROWSER_OUTPUT: |0;Richards;168.57720836142954 01:31:31 INFO - 2015-11-21 01:31:31,048 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.57336430507164 01:31:31 INFO - 2015-11-21 01:31:31,048 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.12570781426956 01:31:31 INFO - 2015-11-21 01:31:31,048 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 01:31:31 INFO - 2015-11-21 01:31:31,048 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1108.6474501108648 01:31:31 INFO - 2015-11-21 01:31:31,049 DEBUG : BROWSER_OUTPUT: |5;Earley;779.423226812159 01:31:31 INFO - 2015-11-21 01:31:31,049 DEBUG : BROWSER_OUTPUT: |6;Boyer;12341.463414634147 01:31:31 INFO - 2015-11-21 01:31:31,049 DEBUG : BROWSER_OUTPUT: |7;RegExp;25743.589743589742 01:31:31 INFO - 2015-11-21 01:31:31,049 DEBUG : BROWSER_OUTPUT: |8;Splay;643.915003219575 01:31:31 INFO - 2015-11-21 01:31:31,049 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 01:31:31 INFO - 2015-11-21 01:31:31,049 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:31:31 INFO - 2015-11-21 01:31:31,049 DEBUG : BROWSER_OUTPUT: __startTimestamp1448098291040__endTimestamp 01:31:31 INFO - 2015-11-21 01:31:31,050 DEBUG : BROWSER_OUTPUT: 01:31:31 INFO - 2015-11-21 01:31:31,050 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:31:31 INFO - 2015-11-21 01:31:31,050 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:31:31 INFO - 2015-11-21 01:31:31,050 DEBUG : BROWSER_OUTPUT: 01:31:31 INFO - 2015-11-21 01:31:31,050 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.58 Median:168.58 stddev:0.00 (0.0%) 01:31:31 INFO - 2015-11-21 01:31:31,050 DEBUG : BROWSER_OUTPUT: Values: 168.6 01:31:31 INFO - 2015-11-21 01:31:31,050 DEBUG : BROWSER_OUTPUT: 01:31:31 INFO - 2015-11-21 01:31:31,051 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.57 Median:193.57 stddev:0.00 (0.0%) 01:31:31 INFO - 2015-11-21 01:31:31,051 DEBUG : BROWSER_OUTPUT: Values: 193.6 01:31:31 INFO - 2015-11-21 01:31:31,051 DEBUG : BROWSER_OUTPUT: 01:31:31 INFO - 2015-11-21 01:31:31,051 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.13 Median:283.13 stddev:0.00 (0.0%) 01:31:31 INFO - 2015-11-21 01:31:31,051 DEBUG : BROWSER_OUTPUT: Values: 283.1 01:31:31 INFO - 2015-11-21 01:31:31,051 DEBUG : BROWSER_OUTPUT: 01:31:31 INFO - 2015-11-21 01:31:31,051 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 01:31:31 INFO - 2015-11-21 01:31:31,052 DEBUG : BROWSER_OUTPUT: Values: 5050.5 01:31:31 INFO - 2015-11-21 01:31:31,052 DEBUG : BROWSER_OUTPUT: 01:31:31 INFO - 2015-11-21 01:31:31,052 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1108.65 Median:1108.65 stddev:0.00 (0.0%) 01:31:31 INFO - 2015-11-21 01:31:31,052 DEBUG : BROWSER_OUTPUT: Values: 1108.6 01:31:31 INFO - 2015-11-21 01:31:31,052 DEBUG : BROWSER_OUTPUT: 01:31:31 INFO - 2015-11-21 01:31:31,052 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:779.42 Median:779.42 stddev:0.00 (0.0%) 01:31:31 INFO - 2015-11-21 01:31:31,052 DEBUG : BROWSER_OUTPUT: Values: 779.4 01:31:31 INFO - 2015-11-21 01:31:31,052 DEBUG : BROWSER_OUTPUT: 01:31:31 INFO - 2015-11-21 01:31:31,053 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12341.46 Median:12341.46 stddev:0.00 (0.0%) 01:31:31 INFO - 2015-11-21 01:31:31,053 DEBUG : BROWSER_OUTPUT: Values: 12341.5 01:31:31 INFO - 2015-11-21 01:31:31,053 DEBUG : BROWSER_OUTPUT: 01:31:31 INFO - 2015-11-21 01:31:31,053 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25743.59 Median:25743.59 stddev:0.00 (0.0%) 01:31:31 INFO - 2015-11-21 01:31:31,053 DEBUG : BROWSER_OUTPUT: Values: 25743.6 01:31:31 INFO - 2015-11-21 01:31:31,053 DEBUG : BROWSER_OUTPUT: 01:31:31 INFO - 2015-11-21 01:31:31,053 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:643.92 Median:643.92 stddev:0.00 (0.0%) 01:31:31 INFO - 2015-11-21 01:31:31,053 DEBUG : BROWSER_OUTPUT: Values: 643.9 01:31:31 INFO - 2015-11-21 01:31:31,053 DEBUG : BROWSER_OUTPUT: 01:31:31 INFO - 2015-11-21 01:31:31,053 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 01:31:31 INFO - 2015-11-21 01:31:31,053 DEBUG : BROWSER_OUTPUT: Values: 4826.9 01:31:31 INFO - 2015-11-21 01:31:31,053 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:31:31 INFO - 2015-11-21 01:31:31,054 DEBUG : BROWSER_OUTPUT: 01:31:31 INFO - 2015-11-21 01:31:31,881 INFO : Browser exited with error code: 0 01:31:31 INFO - 2015-11-21 01:31:31,896 INFO : Completed test v8_7 (00:00:39) 01:31:32 INFO - 2015-11-21 01:31:32,021 INFO : Completed test suite (00:20:12) 01:31:32 INFO - 2015-11-21 01:31:32,021 DEBUG : Working with test: dromaeo_css 01:31:32 INFO - 2015-11-21 01:31:32,022 DEBUG : Generating results file: dromaeo_css 01:31:32 INFO - 2015-11-21 01:31:32,023 DEBUG : Working with test: kraken 01:31:32 INFO - 2015-11-21 01:31:32,023 DEBUG : Generating results file: kraken 01:31:32 INFO - 2015-11-21 01:31:32,023 INFO : javascript benchmark 01:31:32 INFO - 2015-11-21 01:31:32,023 DEBUG : Working with test: v8_7 01:31:32 INFO - 2015-11-21 01:31:32,023 DEBUG : Generating results file: v8_7 01:31:32 INFO - 2015-11-21 01:31:32,024 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:31:32 INFO - 2015-11-21 01:31:32,079 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 01:31:32 INFO - 2015-11-21 01:31:32,079 DEBUG : process_Request line: dromaeo_css 6960.36 graph.html#tests=[[72,201,35]] 01:31:32 INFO - 2015-11-21 01:31:32,080 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:31:32 INFO - 2015-11-21 01:31:32,111 DEBUG : process_Request line: kraken 1488.80 graph.html#tests=[[232,201,35]] 01:31:32 INFO - 2015-11-21 01:31:32,111 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:31:32 INFO - 2015-11-21 01:31:32,137 DEBUG : process_Request line: v8_7 20866.53 graph.html#tests=[[230,201,35]] 01:31:32 INFO - 2015-11-21 01:31:32,138 INFO : javascript benchmark 01:31:32 INFO - 2015-11-21 01:31:32,142 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3203.327301266734, 3233.2725136844197, 3275.950860737088, 3284.4744840825474, 3297.818619975902, 5304.893902121955, 5411.080116380215, 5415.620906536539, 5442.0, 5445.31933508312, 5418.0, 5491.752871120799, 5534.861628459291, 5546.278983732109, 5557.472040156179, 5004.499550044994, 5022.84931452057, 5046.798128074873, 5067.974660126694, 5118.206677964903, 4865.586425153866, 5070.239464080399, 5081.517255860687, 5108.233764935271, 5144.768485418146, 4890.021995600876, 4983.152864013126, 4985.750712464381, 4991.725455099968, 5024.723640199788, 4998.075356059141, 5011.749412529395, 5016.799328026875, 5026.949730502684, 5054.342935418372, 4920.384951881015, 4968.130577149021, 4970.229614409773, 4978.626603004789, 5056.949430505685, 5189.117849965515, 5267.604929630254, 5294.6029047821185, 5306.416294207634, 5338.546223571001, 5951.851203719898, 5974.790882319141, 5980.491658209057, 5981.52147828177, 5987.191729116557, 5846.619969701956, 5966.522678185778, 6001.909971350433, 6017.518598512109, 6026.397360263983, 5554.972225138848, 5573.777048918079, 5623.606347555632, 5624.746886390122, 5667.518260947865, 5982.820515384546, 6005.579609427386, 6011.879762404815, 6025.676696212087, 6078.179445774852, 5745.540356771448, 5796.768129274782, 5830.7084645767545, 5833.67914764692, 5887.911681324698, 5779.913301300484, 5906.055031194988, 5908.05471124618, 5909.970450147722, 5913.113033045078, 5908.704564771744, 5955.940440595626, 5960.046392577166, 5967.045272756338, 5973.820785376446, 5963.2844058713235, 5975.282966044103, 5975.641461512323, 5979.940200597938, 5988.970055149784, 4442.53353397895, 4477.753723545236, 4493.326001099796, 4573.656975726767, 4595.9080818383445, 4074.9812546863286, 4081.0613558881623, 4085.20338533989, 4094.9385759213637, 4133.256013917464, 5535.612507124462, 5535.916961245584, 5540.612157148961, 5543.279373681396, 5591.440855914376, 5777.7977770777825, 5880.647161170258, 5899.587028907935, 5908.113782932594, 5958.493528050078, 5488.725563721798, 5499.587530935116, 5501.257330260443, 5505.724713764296, 5506.669599824023, 5124.666896651705, 5157.63896527247, 5162.199859021857, 5166.509181627739, 5214.817481388133, 5944.0, 6002.609830361012, 6030.909536356959, 6064.06007068905, 6134.570580059353, 5884.264466941632, 5929.822105336847, 5930.733117009659, 5947.9702601486715, 5948.73230704628, 6155.784547540815, 6157.72290246931, 6163.229596300463, 6164.7842325518395, 6164.876702466016, 5716.314042314949, 5742.59801813869, 5811.099279611667, 5816.70916454184, 5874.383189765013, 5919.200907877382, 5943.078822782476, 5950.375210602998, 5951.1073338999495, 5951.1073338999495, 5748.511376533042, 5801.3038435388025, 5810.796622118206, 5815.273090863642, 5817.185594016925, 5643.633163844337, 5757.36668966405, 5763.682997435181, 5863.706814659165, 5922.378150294157, 5661.603687741818, 5710.628809127394, 5716.28546431696, 5722.341930677859, 5735.0, 5619.466150715675, 5799.3040835100055, 5841.357450680337, 5844.532437405082, 5861.120831875082, 5535.0, 5609.1305847593685, 5647.322321321303, 5647.858803529944, 5690.601657883908], "unit": "ms", "name": "dojo.html", "value": 5445.141956122667}, {"lowerIsBetter": false, "replicates": [549.4292899980653, 588.6115163991765, 589.9675517846518, 605.2132228103467, 609.8717372860207, 29585.0, 30418.239544011383, 30511.69488305119, 41077.17845643093, 41598.79200604001, 43195.3520697189, 43802.0, 43856.0, 43940.560594394046, 43976.56023439773, 8639.136086391374, 8741.213290803826, 8765.991910930261, 8813.735587932373, 8821.779455513599, 7787.922120778776, 7935.444518883681, 8572.14278572144, 10365.533550990185, 10643.308184967953, 10327.896721032768, 10343.22425818063, 10422.9478852606, 10426.895731042669, 10428.16574674028, 7819.452638315321, 10356.482175891213, 10427.322224055411, 10445.373277603368, 10449.9477502612, 7699.923000769976, 10388.117010054155, 10636.734081648021, 10661.253712240146, 10663.040326370663, 39719.20561588781, 40252.79873600613, 40282.79858600718, 40372.0, 40379.59620403788, 3167.33485967947, 3229.3056992746438, 3255.0, 3328.4508056170703, 3642.3990041643096, 29905.551416728766, 30216.395672086433, 30285.0, 30880.0, 31398.0, 3931.646151846319, 3954.6638535724496, 4021.0751527148627, 4037.1723796621914, 4079.73528206257, 278261.0, 280594.5970270156, 280881.0, 281233.0, 281464.0, 59932.101018484755, 60344.39655603476, 60344.45694288214, 60385.0, 60465.395346046855, 61312.69343653253, 62022.37977620166, 71285.0, 72164.0, 72203.63898180581, 14497.565073047825, 14545.854541454662, 14628.414863405345, 14646.048006879519, 14654.340554675066, 10906.236563440483, 10929.836052459219, 10960.28758130719, 10961.397123158304, 10967.670969870916, 19755.444020076236, 20083.096260668306, 20102.195912163643, 20203.494912627302, 20227.59544809125, 8021.679132834738, 8123.675052997932, 8191.262786349257, 8269.29710974574, 8332.583370831435, 854.4446110028531, 958.8226178157063, 1024.6977141743203, 1036.9941157077624, 1042.8893228711397, 25621.0, 25741.485170296488, 26288.737112628627, 27914.441711165662, 28355.71644283572, 1002.9381006921936, 1018.6892997635792, 1027.768752030802, 1032.9431881246603, 1118.9537782173693, 14540.709185816224, 14566.344514496874, 14629.195394253205, 14659.780103298459, 14785.260736963324, 328456.0, 331060.0, 331792.0, 332148.0, 333471.0, 53613.46386536163, 54266.18600720992, 54299.72850135724, 54326.456735432934, 54395.72802135964, 1313.080843409617, 1344.4420565465418, 1358.44303835427, 1364.522417154008, 1367.6580854786303, 25786.742132578434, 26877.865610671823, 27867.44265114727, 28000.29999250035, 29229.85385073061, 44503.442379516564, 44906.55093449154, 44964.0, 44985.1002979932, 45286.0, 215364.0, 216435.0, 216892.0, 217105.0, 217162.0, 27007.45985080248, 27902.44195116127, 28801.279968000967, 32744.181395465304, 32870.178245544055, 39439.0, 39578.60421395864, 39767.2046559073, 39887.60112398955, 40366.0, 36215.81892090523, 36431.0, 36531.634683652825, 37524.0, 37693.81153094217, 30000.549991749704, 35641.1089722759, 36510.0, 36737.0, 36886.44670330001, 35454.11364715903, 35799.64200358067, 35818.283634326646, 36257.45613815848, 36628.45057324089, 30136.547951780303, 31266.0, 31369.0, 31918.0, 32956.34087318288, 25215.46121698112, 25257.719154432332, 25355.239342819747, 25420.237392878244, 25640.871795640902], "unit": "ms", "name": "ext.html", "value": 18501.81417591895}, {"lowerIsBetter": false, "replicates": [352.1038955857343, 359.9748017638765, 360.1482493901922, 360.1680118925281, 362.2121884900341, 13934.790978135336, 13988.0, 16948.152592370378, 17235.569110772238, 17855.0, 11135.72160695983, 11373.943130284357, 16493.422730204446, 17398.739018914694, 17410.738838917427, 4850.320955066285, 4931.408231012284, 4953.653244272902, 4967.304577359173, 4972.179590367603, 3696.9260614787686, 3811.6950643948558, 4903.068417000776, 4930.7534623268875, 5290.761915713802, 5399.325084364455, 5412.512873841353, 5425.484578964992, 5440.891182176354, 5444.373897001856, 5179.766910489018, 5299.814506492255, 5312.893742125136, 5404.4595540446035, 5408.026555220059, 5066.949330506684, 5116.718580478072, 5117.897642047175, 5120.257562653394, 5136.024155410498, 13324.600261992156, 13335.799963000563, 18009.27962881483, 20084.096215670328, 20461.0, 2022.9797702022938, 2033.4611327998093, 2081.8126368626895, 2091.884946327951, 2124.4370241885913, 9839.606415743361, 9979.401235925796, 11967.94016029923, 13238.139520931109, 13695.657608559766, 1771.8228177182307, 1797.0565453137076, 1817.9818201817945, 1853.5366158460386, 1895.9336423225259, 60869.08696369558, 61984.69007654978, 63249.0, 63394.366056339306, 63956.04065939015, 9948.303618746619, 9954.751131221632, 10014.3490673106, 10177.949110254402, 10316.690499285034, 12873.678158045936, 12900.419481123372, 12902.225866448043, 12915.806262906064, 12923.15999460032, 7028.824279392954, 7286.817829554304, 7294.562326260441, 7311.597862117528, 7337.376323012603, 6655.23464801554, 6690.096836926952, 6708.563943343667, 6883.036374907517, 6971.825704357431, 4155.605217504332, 4223.662107031491, 4244.957550424518, 4247.532771395144, 4254.829806807693, 1679.5717092141426, 1786.63374008328, 1786.9374571890182, 1809.9457016289532, 1867.9346222882405, 844.594594594598, 910.6266430763487, 960.9279304052224, 962.8892677342055, 970.8592254123113, 16641.334346625998, 17217.39739109125, 17544.473665790047, 17639.0, 17655.470335889942, 795.6936579416966, 889.9199072083544, 916.7983043730369, 933.2627224492575, 945.7588314979636, 9205.263578913671, 9385.38994965325, 9517.0, 9526.476043817518, 9625.374350667184, 403227.0, 405626.0, 406000.0, 408006.0, 564587.718289582, 76325.0, 82059.5897020523, 82124.58937705273, 85153.57423212845, 85405.0, 1099.5107177306022, 1112.3437172068357, 1166.3585028234438, 1180.5690922813112, 1191.249512806926, 15755.842441575896, 16052.357905684108, 16096.678066438371, 16124.435644752846, 16246.756298655293, 34172.65827341794, 35500.467492988144, 36149.81925090358, 37413.438798417505, 38722.41916371313, 46890.0, 47791.283130752374, 47884.76057619829, 48038.279425807945, 49578.25632615441, 9516.429014258889, 9577.23382129414, 9605.903940960781, 9715.319927605, 9828.901710983084, 11636.301821890713, 11741.29552226835, 11834.644960651194, 13751.0, 18300.084995749894, 14736.336864840894, 14758.33587488587, 14803.333849976992, 15195.544133676007, 15316.0, 14252.786208206679, 14342.928285358506, 14652.926735366682, 14715.0, 15150.0, 10937.781244375226, 14629.268536573341, 14931.626709332353, 14947.177905215318, 14958.700825983202, 9394.107559781809, 9411.905880941376, 9541.475218862752, 9631.0, 9645.71062868115, 10165.84751228747, 12770.361481926053, 14136.0, 14535.854641453872, 14625.488107916171], "unit": "ms", "name": "jquery.html", "value": 8638.74769029684}, {"lowerIsBetter": false, "replicates": [1304.3217526886026, 1481.2667729473908, 1534.3709079277498, 1661.1113054515836, 1773.299546679061, 6630.469562435006, 7089.574625522466, 7242.818929526751, 7249.420046396295, 7257.237990011052, 7095.85808283834, 7198.244184360646, 7209.81975450614, 7224.241454647252, 7234.240404757504, 1961.4213806926991, 2034.1354924157247, 2183.1813070098715, 2187.114218741412, 2204.691343211952, 2288.8969996350206, 2301.631738921773, 2302.6085565453914, 2302.7121609798774, 2303.608386574286, 2195.879226642534, 2264.0, 2267.4218074391006, 2272.8522646027955, 2278.2254033628565, 1970.7635083789964, 1997.6404247235491, 2223.288547664748, 2265.410993141795, 2270.182734215681, 2241.540484200735, 2250.718660167479, 2264.1735766445295, 2270.3416009357265, 2306.6078766609717, 7504.8123796904965, 7548.924510754877, 7559.0, 7564.962175189089, 7570.507916985433, 4596.655250856199, 4728.361671174382, 4731.172044892164, 4733.905321893577, 4734.242521196592, 3159.3839201355745, 3167.8099314041, 3187.10760986924, 3194.568733221032, 3225.161458020908, 996.7408473796793, 1004.4826914139225, 1018.3177271228295, 1047.9895201048043, 1067.7490789664423, 10219.897801021969, 10226.181905447545, 10228.38629682214, 10241.436720980342, 10256.589736410535, 4145.564715704868, 4228.682848786353, 4291.463567054118, 4294.334378171388, 4312.331588603772, 8928.15182557656, 8932.46405215689, 8936.195742383217, 8937.419067760575, 8944.8658270126, 4670.462896766848, 4672.369230153954, 4688.835890743808, 4710.764461776966, 4714.127886341038, 4193.559676234013, 4278.89302767427, 4285.37862010013, 4286.121345124242, 4290.442242508454, 3601.981990090033, 3653.908652283714, 3668.596454390015, 3676.227992121631, 3691.3171063353366, 1197.9221350612183, 1205.2647884790272, 1213.2841623442212, 1213.9210951288137, 1221.8472690913636, 993.9613104306018, 1040.3081950502983, 1224.5101959216206, 1312.8884044856104, 1342.1745626439865, 6512.316206798313, 7023.719051237996, 7263.201047884729, 7271.67277472515, 7279.854402911912, 584.430180573937, 588.364566268429, 599.7358779080732, 627.3694936588699, 635.4789072960128, 5575.69333686643, 5638.4925356718095, 5686.601937864392, 5689.487946084872, 5701.0, 8837.646494140163, 9011.909880901238, 9100.635974560944, 9102.226310763526, 9105.043970383014, 8968.641254349883, 8987.820243595223, 8993.730188094367, 9009.909900901039, 9011.549422528848, 6810.931890681129, 6989.266127056688, 6997.720091196397, 7051.753188638373, 7071.964640176766, 6797.72809087631, 6825.965870170618, 6826.112605361272, 6830.829229269308, 6837.042814006142, 7608.80977975555, 7832.451728378959, 7936.960315198387, 8032.357411406956, 8060.274575288252, 8192.54940978252, 8200.548969806718, 8200.712975045844, 8200.712975045844, 8208.179182081743, 6715.462762978852, 6954.061201737701, 6979.476539259677, 6983.546069505466, 6985.895211571932, 7388.298111679382, 7422.66598003102, 7433.479656423999, 7438.73964411243, 7439.0, 6819.454443644596, 6961.164660240804, 6979.40675042627, 7027.051348067946, 7101.928980710127, 6883.724651013903, 6903.482238832208, 6928.618925959121, 7004.439644828503, 7007.019017337475, 5912.970435147797, 6512.511561632802, 6647.634380108947, 6649.268580456049, 6988.37104660583, 5811.4479124483105, 5978.491828194652, 6097.634141951497, 6098.0852872069545, 6104.32852386246, 6347.587406818542, 6363.077353783583, 6402.647854368054, 6403.231612206565, 6405.647689377129], "unit": "ms", "name": "mootools.html", "value": 4321.763713558129}, {"lowerIsBetter": false, "replicates": [340.1292690711778, 345.047668435119, 345.4628053376999, 348.2113014023236, 352.1249694509144, 5930.822075337736, 5958.37437069108, 5991.790287339944, 6065.848353791146, 6141.477974372173, 6018.3981601839905, 6020.45815876571, 6021.367756385571, 6032.577719559622, 6035.215421995134, 4605.608523275526, 4657.999999999992, 4661.790219440133, 4679.344891715145, 4684.2739375396695, 4650.86047418578, 4654.650901182408, 4672.439307283131, 4690.835820746274, 4692.9296060558945, 4596.103759766846, 4626.028534007863, 4627.768611569425, 4641.187792136379, 4644.071185762844, 4425.225585522537, 4502.774861256924, 4509.03055842992, 4560.270356742905, 4631.0, 4006.238814625241, 4024.959750402517, 4102.630763231294, 4105.158442519277, 4109.075458021951, 5692.146178073281, 5705.172749951275, 5707.74315155819, 5717.656940583578, 5734.340550836666, 5150.587952963754, 5283.313169287968, 5288.0745869472685, 5412.323459567554, 5421.21392398104, 5903.675297858616, 6245.812625621194, 6279.560430769848, 6299.811005669837, 6302.054691796221, 4217.91564168718, 4221.092465120014, 4462.955370446286, 4470.709403888737, 4472.686911916167, 6642.66786660665, 6642.833929151761, 6650.7031128929875, 6651.434628056621, 6652.966735166342, 4405.273129933589, 4510.481294651091, 4568.885777855514, 4573.588377046081, 4574.108048930427, 4591.816327346869, 4594.150082234797, 4598.379218805485, 4605.355250264965, 4605.746683932416, 5319.281896943863, 5324.946750532523, 5335.199720042025, 5340.172273297645, 5348.652337598121, 6472.190976127984, 6477.0, 6479.8056058318325, 6481.902771458432, 6483.643399612973, 1582.7388480900522, 1606.6304749907588, 1623.6022174567306, 1627.015655528412, 1631.5350125214256, 1042.1298215989734, 1048.9265751397481, 1057.0803401041144, 1104.0119093411352, 1104.7238190452388, 6094.786682466092, 6133.0, 6136.846578835565, 6137.723802428902, 6141.662208578571, 6560.507961902877, 6574.868502629921, 6608.3391660834495, 6611.107500487469, 6611.900821487681, 5951.583389162717, 5970.850728731816, 6006.099085137264, 6007.068904319837, 6019.127226552126, 3503.632118627558, 3586.964130358663, 3597.8201089945396, 3600.369935261319, 3601.675849173587, 6588.439982601437, 6758.695858686273, 6805.0, 6868.759593414306, 6970.93029069713, 6836.726530938707, 6860.485463590251, 6873.0, 6878.931210687829, 6887.276835932255, 6923.099997000358, 6929.237783843773, 6929.757458488929, 6932.410745086724, 6933.965330173418, 6540.149780528501, 6675.532712710064, 6688.264290928091, 6703.564268322543, 6718.428933540704, 6641.302663220292, 6641.701123449553, 6642.867142657216, 6644.60132392058, 6651.33486651331, 6820.863582728219, 6944.895826562504, 6948.791536253921, 6950.409215216561, 6951.991961165704, 4419.315006174048, 4533.501314855429, 4558.0883823236145, 4560.1335746208115, 4560.5211452796975, 6639.568428052161, 6644.169478815148, 6646.5347425681675, 6652.634105124264, 6655.2013758347375, 6467.902981455376, 6486.189226346707, 6494.253160886369, 6512.544121911421, 6517.902231466626, 6329.651869147241, 6502.577332473374, 6508.8047358579315, 6531.412172904462, 6531.673416329259, 6400.583962042452, 6403.679816009274, 6405.519586030973, 6412.038194270896, 6417.454516366161, 6568.376004279586, 6570.342965703391, 6571.507136964842, 6579.967100164468, 6580.473562114924, 6209.813705588839, 6407.615543067431, 6409.0, 6413.967930160319, 6415.101885735908], "unit": "ms", "name": "prototype.html", "value": 4843.752290748569}, {"lowerIsBetter": false, "replicates": [752.8306131120497, 860.5138096975209, 866.878636990821, 867.9522626255554, 878.8549889268271, 12489.875101248985, 12601.117921745481, 12667.11330206886, 12688.429020694057, 12723.427445764939, 11799.587014454495, 12546.372681365941, 12550.121491495598, 12566.30885301308, 12573.80548847858, 669.3574168797948, 814.3322475570035, 829.9253067223949, 832.9333653307751, 835.9623816928222, 812.5815205169313, 823.6211342782298, 828.7099515169702, 830.0330115415563, 830.5681045856181, 700.7792545348225, 706.3995603736809, 858.4977787994031, 868.3877866104413, 868.9217970382664, 837.9916200837974, 865.6104752861238, 866.4151697604156, 866.4627930682954, 866.8483015472299, 636.6816591704148, 639.5267502048497, 640.8301800022998, 641.6086187425667, 641.9005054216603, 12157.452914618863, 12282.0, 12307.4461649226, 12316.199447035913, 12341.62975110748, 11413.714657133554, 12213.633590992284, 12909.601994497294, 13024.41390137446, 13259.86740132596, 10485.266031377807, 10672.199585031154, 10712.517936692868, 10926.453677316182, 10938.398388088652, 3598.946015809765, 3656.5063716398213, 3686.502322186497, 3688.8340024698687, 3767.6044015378266, 45283.0, 45404.77297613524, 45808.0, 45917.0, 46084.308735368664, 9466.810663786824, 9719.125278724949, 9861.950690246646, 9989.350692204984, 10293.845592316122, 17252.827471725373, 17323.653526929644, 17364.565885852953, 17366.65266694659, 17379.73930391045, 7140.678669459887, 7239.927600723925, 7277.417806575461, 7298.160711518243, 7393.371563417062, 4498.50516443191, 4527.1398434298035, 4581.450225972904, 4583.908321833612, 4604.355390245301, 3042.0569623416814, 3052.5726398304255, 3082.7071428214285, 3086.506159014547, 3217.1957010747315, 598.628850112924, 599.8710277290404, 601.0323379359228, 619.4239357397573, 621.6674079367607, 523.2961666558473, 578.8784355285353, 675.9188897332351, 681.1621705302506, 684.8732984397902, 8122.634481448349, 8491.702790402307, 8700.869486957701, 8798.20816126539, 8893.64425422976, 517.366226372698, 588.8752482757998, 608.7534548507862, 614.3119705929388, 625.0561651905655, 3743.794091325003, 3888.902777430587, 3929.8821035368983, 3963.4054891766464, 4031.012387017046, 52859.471405285454, 56795.716021420456, 61456.385436145065, 61865.38134618596, 61883.381166188665, 47403.0, 47436.52563474321, 47596.28605570919, 47817.0, 47868.0, 46605.76697116493, 47240.291395629094, 48684.269735954695, 48840.26739598909, 49563.752181238866, 8375.581220938806, 8658.0, 8658.264047556027, 8664.826703466022, 8830.867536986822, 35838.10404739902, 36565.26869462649, 36827.81586092053, 36966.0, 37048.629513704516, 41401.0, 41432.0, 44641.10717785691, 45758.084838303716, 45928.31107533457, 11101.50043248072, 11469.942650286695, 11484.540618375171, 11629.418529073344, 11750.647480575597, 12600.747985040065, 13050.738985220432, 13206.537771177962, 13257.170058312691, 13410.262435566137, 10323.093351876345, 10617.787644247226, 10739.838902416313, 11300.830487542858, 11340.09279257641, 11927.880721193023, 12286.815697764361, 12357.93821030889, 12522.436490358137, 12694.936525317315, 6418.211200446766, 9216.493092879957, 10170.338927969658, 10283.537240824331, 10374.252836981697, 8999.730008099768, 9410.341276110606, 9467.66863159786, 9485.430874147572, 9595.28035397362, 7800.882986755317, 8917.955410222907, 8922.286217102746, 9291.62833486653, 9531.857022144812], "unit": "ms", "name": "yui.html", "value": 6240.733101576888}], "name": "dromaeo_css", "value": 6960.364038323992}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 104.0, 109.0, 114.0, 112.0, 98.0, 109.0, 114.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [156.0, 126.0, 148.0, 161.0, 132.0, 158.0, 150.0, 126.0, 165.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 162.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 88.0, 73.0, 72.0, 72.0, 105.0, 90.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [90.0, 90.0, 134.0, 89.0, 89.0, 90.0, 136.0, 89.0, 91.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 103.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 146.0, 145.0, 150.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 56.0, 57.0, 57.0, 57.0, 56.0, 65.0, 56.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 85.0, 87.0, 91.0, 84.0, 85.0, 84.0, 86.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [116.0, 115.0, 122.0, 114.0, 118.0, 123.0, 114.0, 115.0, 124.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [139.0, 149.0, 144.0, 146.0, 153.0, 138.0, 147.0, 149.0, 148.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 65.0, 66.0, 68.0, 65.0, 67.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1488.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.57720836142954], "unit": "score", "name": "Richards", "value": 209.41146399999997}, {"lowerIsBetter": false, "replicates": [193.57336430507164], "unit": "score", "name": "DeltaBlue", "value": 341.56558799999993}, {"lowerIsBetter": false, "replicates": [283.12570781426956], "unit": "score", "name": "Encrypt", "value": 940.1512919999999}, {"lowerIsBetter": false, "replicates": [5050.50505050505], "unit": "score", "name": "Decrypt", "value": 52.70383799999996}, {"lowerIsBetter": false, "replicates": [1108.6474501108648], "unit": "score", "name": "RayTrace", "value": 667.4700779999998}, {"lowerIsBetter": false, "replicates": [779.423226812159], "unit": "score", "name": "Earley", "value": 855.072029}, {"lowerIsBetter": false, "replicates": [12341.463414634147], "unit": "score", "name": "Boyer", "value": 54.00194268774702}, {"lowerIsBetter": false, "replicates": [25743.589743589742], "unit": "score", "name": "RegExp", "value": 35.38686752988046}, {"lowerIsBetter": false, "replicates": [643.915003219575], "unit": "score", "name": "Splay", "value": 126.55552300000004}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20866.53184748903}]} 01:31:32 INFO - RETURN: dromaeo_css: 6960.36 01:31:32 INFO - RETURN: kraken: 1488.80 01:31:32 INFO - RETURN: v8_7: 20866.53 01:31:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20866.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1488.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6960.36"}}} 01:31:32 INFO - Return code: 0 01:31:32 INFO - # TBPL SUCCESS # 01:31:32 INFO - Running post-action listener: _resource_record_post_action 01:31:32 INFO - Running post-run listener: _resource_record_post_run 01:31:33 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 508452864; Read time: 20; Write time: 599616 01:31:33 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 203522048; Read time: 0; Write time: 353508 01:31:33 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 271368192; Read time: 20; Write time: 133808 01:31:33 INFO - Running post-run listener: _upload_blobber_files 01:31:33 INFO - Blob upload gear active. 01:31:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:31:33 INFO - Copying logs to upload dir... 01:31:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.020233 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-21 01:31:32.841390) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-21 01:31:32.845627) ========= 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=01deea79d00cc2c334834894000001d2-1448096070.18268-224290911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/PJqTvtKfRa6-p2k_r68OGQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009927 build_url: 'https://queue.taskcluster.net/v1/task/PJqTvtKfRa6-p2k_r68OGQ/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-21 01:31:32.897321) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 01:31:32.897696) ========= 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=01deea79d00cc2c334834894000001d2-1448096070.18268-224290911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 01:31:32.948223) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 01:31:32.948531) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 01:31:32.948842) ========= ========= Total master_lag: 0.26 =========