builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1447459728.86 results: success (0) buildid: 20151113143006 builduid: b030d97338b14f079523f8eb2ad170b4 revision: 683059d91038fe69139456a4094ff3be47574d90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:48.864970) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:48.865496) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:48.865796) ========= 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=6e558709db315bacd2260379000001b6-1447456499.376036-2115906253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006459 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:48.892107) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:48.892496) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:48.911156) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:48.911426) ========= 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=6e558709db315bacd2260379000001b6-1447456499.376036-2115906253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004691 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:48.961993) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:48.962279) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:48.962615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:48.962895) ========= 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=6e558709db315bacd2260379000001b6-1447456499.376036-2115906253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-13 16:08:49-- 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% 226M=0s 2015-11-13 16:08:49 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169927 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:49.145575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:49.145880) ========= 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=6e558709db315bacd2260379000001b6-1447456499.376036-2115906253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019529 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:49.197265) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 16:08:49.197582) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 683059d91038fe69139456a4094ff3be47574d90 --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 683059d91038fe69139456a4094ff3be47574d90 --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=6e558709db315bacd2260379000001b6-1447456499.376036-2115906253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-13 16:08:49,377 truncating revision to first 12 chars 2015-11-13 16:08:49,377 Setting DEBUG logging. 2015-11-13 16:08:49,377 attempt 1/10 2015-11-13 16:08:49,377 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/683059d91038?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 16:08:50,313 unpacking tar archive at: b2g-inbound-683059d91038/testing/mozharness/ program finished with exit code 0 elapsedTime=1.210022 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 16:08:50.420643) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:50.420955) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:50.429783) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:50.430205) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 16:08:50.430644) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-13 16:08:50.430938) ========= /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=6e558709db315bacd2260379000001b6-1447456499.376036-2115906253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:08:50 INFO - MultiFileLogger online at 20151113 16:08:50 in /builds/slave/test-pgo 16:08:50 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 16:08:50 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:08:50 INFO - {'append_to_log': False, 16:08:50 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:08:50 INFO - 'blob_upload_branch': 'B2G-Inbound', 16:08:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:08:50 INFO - 'branch': 'B2G-Inbound', 16:08:50 INFO - 'buildbot_json_path': 'buildprops.json', 16:08:50 INFO - 'config_files': ('talos/linux_config.py',), 16:08:50 INFO - 'default_actions': ('clobber', 16:08:50 INFO - 'read-buildbot-config', 16:08:50 INFO - 'download-and-extract', 16:08:50 INFO - 'populate-webroot', 16:08:50 INFO - 'create-virtualenv', 16:08:50 INFO - 'install', 16:08:50 INFO - 'run-tests'), 16:08:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:08:50 INFO - 'download_minidump_stackwalk': True, 16:08:50 INFO - 'download_symbols': 'ondemand', 16:08:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:08:50 INFO - 'tooltool.py': '/tools/tooltool.py', 16:08:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:08:50 INFO - '/tools/misc-python/virtualenv.py')}, 16:08:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:08:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:08:50 INFO - 'installer_path': 'installer.exe', 16:08:50 INFO - 'log_level': 'info', 16:08:50 INFO - 'log_name': 'talos', 16:08:50 INFO - 'log_to_console': True, 16:08:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:08:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:08:50 INFO - 'opt_config_files': (), 16:08:50 INFO - 'pip_index': False, 16:08:50 INFO - 'sps_profile': False, 16:08:50 INFO - 'sps_profile_interval': 0, 16:08:50 INFO - 'suite': 'dromaeojs', 16:08:50 INFO - 'system_bits': '64', 16:08:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:08:50 INFO - 'title': 'talos-linux64-ix-039', 16:08:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:08:50 INFO - 'use_talos_json': True, 16:08:50 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:08:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:08:50 INFO - 'work_dir': 'build'} 16:08:50 INFO - ##### 16:08:50 INFO - ##### Running clobber step. 16:08:50 INFO - ##### 16:08:50 INFO - Running pre-action listener: _resource_record_pre_action 16:08:50 INFO - Running main action method: clobber 16:08:50 INFO - rmtree: /builds/slave/test-pgo/build 16:08:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:08:51 INFO - Running post-action listener: _resource_record_post_action 16:08:51 INFO - ##### 16:08:51 INFO - ##### Running read-buildbot-config step. 16:08:51 INFO - ##### 16:08:51 INFO - Running pre-action listener: _resource_record_pre_action 16:08:51 INFO - Running main action method: read_buildbot_config 16:08:51 INFO - Using buildbot properties: 16:08:51 INFO - { 16:08:51 INFO - "properties": { 16:08:51 INFO - "buildnumber": 43, 16:08:51 INFO - "product": "firefox", 16:08:51 INFO - "script_repo_revision": "production", 16:08:51 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 16:08:51 INFO - "repository": "", 16:08:51 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 16:08:51 INFO - "buildid": "20151113143006", 16:08:51 INFO - "slavename": "talos-linux64-ix-039", 16:08:51 INFO - "pgo_build": "True", 16:08:51 INFO - "basedir": "/builds/slave/test-pgo", 16:08:51 INFO - "project": "", 16:08:51 INFO - "platform": "ubuntu64_hw", 16:08:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:08:51 INFO - "slavebuilddir": "test", 16:08:51 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 16:08:51 INFO - "branch": "b2g-inbound", 16:08:51 INFO - "repo_path": "integration/b2g-inbound", 16:08:51 INFO - "stage_platform": "linux64-pgo", 16:08:51 INFO - "builduid": "b030d97338b14f079523f8eb2ad170b4", 16:08:51 INFO - "revision": "683059d91038fe69139456a4094ff3be47574d90" 16:08:51 INFO - }, 16:08:51 INFO - "sourcestamp": { 16:08:51 INFO - "repository": "", 16:08:51 INFO - "hasPatch": false, 16:08:51 INFO - "project": "", 16:08:51 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 16:08:51 INFO - "changes": [ 16:08:51 INFO - { 16:08:51 INFO - "category": null, 16:08:51 INFO - "files": [ 16:08:51 INFO - { 16:08:51 INFO - "url": null, 16:08:51 INFO - "name": "https://queue.taskcluster.net/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 16:08:51 INFO - } 16:08:51 INFO - ], 16:08:51 INFO - "repository": "", 16:08:51 INFO - "rev": "683059d91038fe69139456a4094ff3be47574d90", 16:08:51 INFO - "who": "sendchange", 16:08:51 INFO - "when": 1447459650, 16:08:51 INFO - "number": 6660972, 16:08:51 INFO - "comments": "", 16:08:51 INFO - "project": "", 16:08:51 INFO - "at": "Fri 13 Nov 2015 16:07:30", 16:08:51 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 16:08:51 INFO - "revlink": "", 16:08:51 INFO - "properties": [ 16:08:51 INFO - [ 16:08:51 INFO - "buildid", 16:08:51 INFO - "20151113143006", 16:08:51 INFO - "Change" 16:08:51 INFO - ], 16:08:51 INFO - [ 16:08:51 INFO - "builduid", 16:08:51 INFO - "b030d97338b14f079523f8eb2ad170b4", 16:08:51 INFO - "Change" 16:08:51 INFO - ], 16:08:51 INFO - [ 16:08:51 INFO - "pgo_build", 16:08:51 INFO - "True", 16:08:51 INFO - "Change" 16:08:51 INFO - ] 16:08:51 INFO - ], 16:08:51 INFO - "revision": "683059d91038fe69139456a4094ff3be47574d90" 16:08:51 INFO - } 16:08:51 INFO - ], 16:08:51 INFO - "revision": "683059d91038fe69139456a4094ff3be47574d90" 16:08:51 INFO - } 16:08:51 INFO - } 16:08:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 16:08:51 INFO - Running post-action listener: _resource_record_post_action 16:08:51 INFO - ##### 16:08:51 INFO - ##### Running download-and-extract step. 16:08:51 INFO - ##### 16:08:51 INFO - Running pre-action listener: _resource_record_pre_action 16:08:51 INFO - Running main action method: download_and_extract 16:08:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:08:51 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')]} 16:08:51 INFO - https://queue.taskcluster.net/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:08:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/test_packages.json 16:08:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/test_packages.json 16:08:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:08:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:08:54 INFO - Downloaded 1302 bytes. 16:08:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:08:54 INFO - Using the following test package requirements: 16:08:54 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:08:54 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:08:54 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:54 INFO - u'jsshell-linux-x86_64.zip'], 16:08:54 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:08:54 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:08:54 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:08:54 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:08:54 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:08:54 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:08:54 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:08:54 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:08: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')]} 16:08:54 INFO - https://queue.taskcluster.net/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:08:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:08:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:08:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/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 16:08:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/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 16:08:56 INFO - Downloaded 22445296 bytes. 16:08:56 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 16:08:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:08:56 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 16:08:57 INFO - Return code: 0 16:08:57 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 16:08: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')]} 16:08:57 INFO - https://queue.taskcluster.net/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:08:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:08:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:08:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/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 16:08:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/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 16:09:00 INFO - Downloaded 22445296 bytes. 16:09:00 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 16:09:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:09:00 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 16:09:01 INFO - Return code: 0 16:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:01 INFO - https://queue.taskcluster.net/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:09:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:09:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:09:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/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 16:09:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/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 16:09:02 INFO - Downloaded 11131693 bytes. 16:09:02 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 16:09:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:09:02 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 16:09:02 INFO - Return code: 0 16:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:02 INFO - https://queue.taskcluster.net/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:09:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:09:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:09:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/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 16:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecVYbl1fQs2yOHrtAYmyvg/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 16:09:03 INFO - Downloaded 57175432 bytes. 16:09:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:09:03 INFO - mkdir: /builds/slave/test-pgo/properties 16:09:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:09:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:09:03 INFO - Contents: 16:09:03 INFO - build_url:https://queue.taskcluster.net/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:09:03 INFO - Running post-action listener: _resource_record_post_action 16:09:03 INFO - Running post-action listener: set_extra_try_arguments 16:09:03 INFO - ##### 16:09:03 INFO - ##### Running populate-webroot step. 16:09:03 INFO - ##### 16:09:03 INFO - Running pre-action listener: _resource_record_pre_action 16:09:03 INFO - Running main action method: populate_webroot 16:09:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:09:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:09:03 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:09:03 INFO - '../fennec_ids.txt'], 16:09:03 INFO - 'tests': ['tcheck2']}, 16:09:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:09:03 INFO - '--tppagecycles', 16:09:03 INFO - '7'], 16:09:04 INFO - 'tests': ['tsvgm']}}, 16:09:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:09:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:09:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:09:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:09:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:09:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:09:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:09:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:04 INFO - 'talos_options': ['--e10s'], 16:09:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:09:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:04 INFO - 'tests': ['damp', 'tps']}, 16:09:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:04 INFO - 'talos_options': ['--e10s'], 16:09:04 INFO - 'tests': ['damp', 'tps']}, 16:09:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:09:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:09:04 INFO - 'other': {'tests': ['a11yr', 16:09:04 INFO - 'ts_paint', 16:09:04 INFO - 'tpaint', 16:09:04 INFO - 'sessionrestore', 16:09:04 INFO - 'sessionrestore_no_auto_restore']}, 16:09:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:09:04 INFO - 'tests': ['a11yr', 16:09:04 INFO - 'ts_paint', 16:09:04 INFO - 'tpaint', 16:09:04 INFO - 'sessionrestore', 16:09:04 INFO - 'sessionrestore_no_auto_restore']}, 16:09:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:09:04 INFO - 'tests': ['a11yr', 16:09:04 INFO - 'ts_paint', 16:09:04 INFO - 'tpaint', 16:09:04 INFO - 'sessionrestore', 16:09:04 INFO - 'sessionrestore_no_auto_restore']}, 16:09:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:09:04 INFO - 'tests': ['a11yr', 16:09:04 INFO - 'ts_paint', 16:09:04 INFO - 'tpaint', 16:09:04 INFO - 'sessionrestore', 16:09:04 INFO - 'sessionrestore_no_auto_restore']}, 16:09:04 INFO - 'other_l64': {'tests': ['a11yr', 16:09:04 INFO - 'ts_paint', 16:09:04 INFO - 'tpaint', 16:09:04 INFO - 'sessionrestore', 16:09:04 INFO - 'sessionrestore_no_auto_restore']}, 16:09:04 INFO - 'other_nol64': {'tests': ['a11yr', 16:09:04 INFO - 'ts_paint', 16:09:04 INFO - 'tpaint', 16:09:04 INFO - 'sessionrestore', 16:09:04 INFO - 'sessionrestore_no_auto_restore']}, 16:09:04 INFO - 'svgr': {'tests': ['tsvgx', 16:09:04 INFO - 'tsvgr_opacity', 16:09:04 INFO - 'tart', 16:09:04 INFO - 'tscrollx', 16:09:04 INFO - 'cart']}, 16:09:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:09:04 INFO - 'tests': ['tsvgx', 16:09:04 INFO - 'tsvgr_opacity', 16:09:04 INFO - 'tart', 16:09:04 INFO - 'tscrollx', 16:09:04 INFO - 'cart']}, 16:09:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:04 INFO - 'tests': ['tp5o']}, 16:09:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:04 INFO - 'talos_options': ['--e10s'], 16:09:04 INFO - 'tests': ['tp5o']}, 16:09:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:04 INFO - 'talos_options': ['--xperf_path', 16:09:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:09:04 INFO - 'tests': ['tp5n']}, 16:09:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:04 INFO - 'talos_options': ['--e10s', 16:09:04 INFO - '--xperf_path', 16:09:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:09:04 INFO - 'tests': ['tp5n']}}, 16:09:04 INFO - 'talos.zip': {'path': '', 16:09:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:09:04 INFO - Running post-action listener: _resource_record_post_action 16:09:04 INFO - ##### 16:09:04 INFO - ##### Running create-virtualenv step. 16:09:04 INFO - ##### 16:09:04 INFO - Running pre-action listener: _resource_record_pre_action 16:09:04 INFO - Running main action method: create_virtualenv 16:09:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:09:04 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 16:09:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:09:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:09:04 INFO - Using real prefix '/usr' 16:09:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:09:04 INFO - Installing distribute.............................................................................................................................................................................................done. 16:09:06 INFO - Installing pip.................done. 16:09:06 INFO - Return code: 0 16:09:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4696c8ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16426c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17036e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1739a90>, '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 0x178bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178c2e0>, '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': '6e558709db315bacd2260379000001b6-1447456499.376036-2115906253', '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 16:09:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:09:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:09:06 INFO - Using env: {'DISPLAY': ':0', 16:09:06 INFO - 'HOME': '/home/cltbld', 16:09:06 INFO - 'LANG': 'en_US.UTF-8', 16:09:06 INFO - 'LANGUAGE': 'en_US:en', 16:09:06 INFO - 'LOGNAME': 'cltbld', 16:09:06 INFO - 'MAIL': '/var/mail/cltbld', 16:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:06 INFO - 'MOZ_NO_REMOTE': '1', 16:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:06 INFO - 'NO_EM_RESTART': '1', 16:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:09:06 INFO - 'PWD': '/builds/slave/test-pgo', 16:09:06 INFO - 'SHELL': '/bin/bash', 16:09:06 INFO - 'SHLVL': '1', 16:09:06 INFO - 'TERM': 'linux', 16:09:06 INFO - 'TMOUT': '86400', 16:09:06 INFO - 'USER': 'cltbld', 16:09:06 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447456499.376036-2115906253', 16:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:06 INFO - '_': '/tools/buildbot/bin/python'} 16:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:07 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 16:09:07 INFO - Cleaning up... 16:09:07 INFO - Return code: 0 16:09:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:09:07 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')]} 16:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:07 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')]} 16:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:07 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 0x7f4696c8ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16426c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17036e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1739a90>, '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 0x178bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178c2e0>, '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': '6e558709db315bacd2260379000001b6-1447456499.376036-2115906253', '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 16:09:07 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 16:09:07 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 16:09:07 INFO - Using env: {'DISPLAY': ':0', 16:09:07 INFO - 'HOME': '/home/cltbld', 16:09:07 INFO - 'LANG': 'en_US.UTF-8', 16:09:07 INFO - 'LANGUAGE': 'en_US:en', 16:09:07 INFO - 'LOGNAME': 'cltbld', 16:09:07 INFO - 'MAIL': '/var/mail/cltbld', 16:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:07 INFO - 'MOZ_NO_REMOTE': '1', 16:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:07 INFO - 'NO_EM_RESTART': '1', 16:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:09:07 INFO - 'PWD': '/builds/slave/test-pgo', 16:09:07 INFO - 'SHELL': '/bin/bash', 16:09:07 INFO - 'SHLVL': '1', 16:09:07 INFO - 'TERM': 'linux', 16:09:07 INFO - 'TMOUT': '86400', 16:09:07 INFO - 'USER': 'cltbld', 16:09:07 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447456499.376036-2115906253', 16:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:07 INFO - '_': '/tools/buildbot/bin/python'} 16:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:07 INFO - Downloading/unpacking psutil>=0.7.1 16:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:08 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:09:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:09:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:09:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:09:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:09:09 INFO - Installing collected packages: psutil 16:09:09 INFO - Running setup.py install for psutil 16:09:09 INFO - building 'psutil._psutil_linux' extension 16:09:09 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 16:09:09 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 16:09:09 INFO - building 'psutil._psutil_posix' extension 16:09:09 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 16:09:09 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 16:09:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:09:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:09:09 INFO - Successfully installed psutil 16:09:09 INFO - Cleaning up... 16:09:09 INFO - Return code: 0 16:09:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f4696c8ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16426c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17036e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1739a90>, '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 0x178bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178c2e0>, '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': '6e558709db315bacd2260379000001b6-1447456499.376036-2115906253', '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 16:09:09 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 16:09:09 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 16:09:09 INFO - Using env: {'DISPLAY': ':0', 16:09:09 INFO - 'HOME': '/home/cltbld', 16:09:09 INFO - 'LANG': 'en_US.UTF-8', 16:09:09 INFO - 'LANGUAGE': 'en_US:en', 16:09:09 INFO - 'LOGNAME': 'cltbld', 16:09:09 INFO - 'MAIL': '/var/mail/cltbld', 16:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:09 INFO - 'MOZ_NO_REMOTE': '1', 16:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:09 INFO - 'NO_EM_RESTART': '1', 16:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:09:09 INFO - 'PWD': '/builds/slave/test-pgo', 16:09:09 INFO - 'SHELL': '/bin/bash', 16:09:09 INFO - 'SHLVL': '1', 16:09:09 INFO - 'TERM': 'linux', 16:09:09 INFO - 'TMOUT': '86400', 16:09:09 INFO - 'USER': 'cltbld', 16:09:09 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447456499.376036-2115906253', 16:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:09 INFO - '_': '/tools/buildbot/bin/python'} 16:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:09:09 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 16:09:09 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 16:09:09 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 16:09:09 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 16:09:09 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 16:09:09 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 16:09:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:09:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:09:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:09:11 INFO - Installing collected packages: mozsystemmonitor 16:09:11 INFO - Running setup.py install for mozsystemmonitor 16:09:11 INFO - Successfully installed mozsystemmonitor 16:09:11 INFO - Cleaning up... 16:09:11 INFO - Return code: 0 16:09:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:09:11 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')]} 16:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:11 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')]} 16:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:11 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 0x7f4696c8ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16426c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17036e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1739a90>, '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 0x178bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178c2e0>, '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': '6e558709db315bacd2260379000001b6-1447456499.376036-2115906253', '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 16:09:11 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 16:09:11 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 16:09:11 INFO - Using env: {'DISPLAY': ':0', 16:09:11 INFO - 'HOME': '/home/cltbld', 16:09:11 INFO - 'LANG': 'en_US.UTF-8', 16:09:11 INFO - 'LANGUAGE': 'en_US:en', 16:09:11 INFO - 'LOGNAME': 'cltbld', 16:09:11 INFO - 'MAIL': '/var/mail/cltbld', 16:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:11 INFO - 'MOZ_NO_REMOTE': '1', 16:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:11 INFO - 'NO_EM_RESTART': '1', 16:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:09:11 INFO - 'PWD': '/builds/slave/test-pgo', 16:09:11 INFO - 'SHELL': '/bin/bash', 16:09:11 INFO - 'SHLVL': '1', 16:09:11 INFO - 'TERM': 'linux', 16:09:11 INFO - 'TMOUT': '86400', 16:09:11 INFO - 'USER': 'cltbld', 16:09:11 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447456499.376036-2115906253', 16:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:11 INFO - '_': '/tools/buildbot/bin/python'} 16:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:11 INFO - Downloading/unpacking blobuploader==1.2.4 16:09:11 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 16:09:11 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 16:09:11 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 16:09:11 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 16:09:11 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 16:09:11 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 16:09:13 INFO - Downloading blobuploader-1.2.4.tar.gz 16:09:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:09:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:09:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:09:13 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 16:09:13 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 16:09:13 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 16:09:13 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 16:09:13 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 16:09:13 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 16:09:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:09:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:09:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:09:13 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 16:09:13 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 16:09:13 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 16:09:13 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 16:09:13 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 16:09:13 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 16:09:14 INFO - Downloading docopt-0.6.1.tar.gz 16:09:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:09:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:09:14 INFO - Installing collected packages: blobuploader, requests, docopt 16:09:14 INFO - Running setup.py install for blobuploader 16:09:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:09:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:09:14 INFO - Running setup.py install for requests 16:09:14 INFO - Running setup.py install for docopt 16:09:14 INFO - Successfully installed blobuploader requests docopt 16:09:14 INFO - Cleaning up... 16:09:14 INFO - Return code: 0 16:09:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:09:14 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')]} 16:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:14 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')]} 16:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:14 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 0x7f4696c8ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16426c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17036e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1739a90>, '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 0x178bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178c2e0>, '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': '6e558709db315bacd2260379000001b6-1447456499.376036-2115906253', '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 16:09:14 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 16:09:14 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 16:09:14 INFO - Using env: {'DISPLAY': ':0', 16:09:14 INFO - 'HOME': '/home/cltbld', 16:09:14 INFO - 'LANG': 'en_US.UTF-8', 16:09:14 INFO - 'LANGUAGE': 'en_US:en', 16:09:14 INFO - 'LOGNAME': 'cltbld', 16:09:14 INFO - 'MAIL': '/var/mail/cltbld', 16:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:14 INFO - 'MOZ_NO_REMOTE': '1', 16:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:14 INFO - 'NO_EM_RESTART': '1', 16:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:09:14 INFO - 'PWD': '/builds/slave/test-pgo', 16:09:14 INFO - 'SHELL': '/bin/bash', 16:09:14 INFO - 'SHLVL': '1', 16:09:14 INFO - 'TERM': 'linux', 16:09:14 INFO - 'TMOUT': '86400', 16:09:14 INFO - 'USER': 'cltbld', 16:09:14 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447456499.376036-2115906253', 16:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:14 INFO - '_': '/tools/buildbot/bin/python'} 16:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:09:14 INFO - Running setup.py (path:/tmp/pip-RSZ4cF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:09:15 INFO - Running setup.py (path:/tmp/pip-I0gCB3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:09:15 INFO - Running setup.py (path:/tmp/pip-Dz4UJ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:09:15 INFO - Running setup.py (path:/tmp/pip-j0BY9K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:09:15 INFO - Running setup.py (path:/tmp/pip-IYUcI0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:09:15 INFO - Running setup.py (path:/tmp/pip-5Gn0Mp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:09:15 INFO - Running setup.py (path:/tmp/pip-LZq9FW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:09:15 INFO - Running setup.py (path:/tmp/pip-W4y15j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:09:15 INFO - Running setup.py (path:/tmp/pip-nKVRmb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:09:15 INFO - Running setup.py (path:/tmp/pip-EYY8dU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:09:15 INFO - Running setup.py (path:/tmp/pip-wgQ62B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:09:15 INFO - Running setup.py (path:/tmp/pip-cQXxTj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:09:15 INFO - Running setup.py (path:/tmp/pip-s9NK4P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:09:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:09:15 INFO - Running setup.py (path:/tmp/pip-QKSzii-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:09:16 INFO - Running setup.py (path:/tmp/pip-ZXcOIH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:09:16 INFO - Running setup.py (path:/tmp/pip-UNA7XD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:09:16 INFO - Running setup.py (path:/tmp/pip-COEn7n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:09:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:09:16 INFO - Running setup.py install for manifestparser 16:09:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:09:16 INFO - Running setup.py install for mozcrash 16:09:16 INFO - Running setup.py install for mozdebug 16:09:16 INFO - Running setup.py install for mozdevice 16:09:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:09:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:09:16 INFO - Running setup.py install for mozfile 16:09:16 INFO - Running setup.py install for mozhttpd 16:09:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:09:16 INFO - Running setup.py install for mozinfo 16:09:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:09:16 INFO - Running setup.py install for mozInstall 16:09:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:09:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:09:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:09:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:09:17 INFO - Running setup.py install for mozleak 16:09:17 INFO - Running setup.py install for mozlog 16:09:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:09:17 INFO - Running setup.py install for moznetwork 16:09:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:09:17 INFO - Running setup.py install for mozprocess 16:09:17 INFO - Running setup.py install for mozprofile 16:09:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:09:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:09:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:09:17 INFO - Running setup.py install for mozrunner 16:09:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:09:17 INFO - Running setup.py install for mozscreenshot 16:09:17 INFO - Running setup.py install for moztest 16:09:17 INFO - Running setup.py install for mozversion 16:09:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:09:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:09:18 INFO - Cleaning up... 16:09:18 INFO - Return code: 0 16:09:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:09:18 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')]} 16:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:18 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')]} 16:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:18 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 0x7f4696c8ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16426c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17036e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1739a90>, '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 0x178bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178c2e0>, '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': '6e558709db315bacd2260379000001b6-1447456499.376036-2115906253', '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 16:09:18 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 16:09:18 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 16:09:18 INFO - Using env: {'DISPLAY': ':0', 16:09:18 INFO - 'HOME': '/home/cltbld', 16:09:18 INFO - 'LANG': 'en_US.UTF-8', 16:09:18 INFO - 'LANGUAGE': 'en_US:en', 16:09:18 INFO - 'LOGNAME': 'cltbld', 16:09:18 INFO - 'MAIL': '/var/mail/cltbld', 16:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:18 INFO - 'MOZ_NO_REMOTE': '1', 16:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:18 INFO - 'NO_EM_RESTART': '1', 16:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:09:18 INFO - 'PWD': '/builds/slave/test-pgo', 16:09:18 INFO - 'SHELL': '/bin/bash', 16:09:18 INFO - 'SHLVL': '1', 16:09:18 INFO - 'TERM': 'linux', 16:09:18 INFO - 'TMOUT': '86400', 16:09:18 INFO - 'USER': 'cltbld', 16:09:18 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447456499.376036-2115906253', 16:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:18 INFO - '_': '/tools/buildbot/bin/python'} 16:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:09:18 INFO - Running setup.py (path:/tmp/pip-VGrilz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:09:18 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)) 16:09:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:09:18 INFO - Running setup.py (path:/tmp/pip-ADPpJx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:09:18 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)) 16:09:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:09:18 INFO - Running setup.py (path:/tmp/pip-Hy8iSO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:09:18 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)) 16:09:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:09:18 INFO - Running setup.py (path:/tmp/pip-Rm1pDs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:09:18 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)) 16:09:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:09:18 INFO - Running setup.py (path:/tmp/pip-nUsuxc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:09:18 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)) 16:09:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:09:18 INFO - Running setup.py (path:/tmp/pip-uYHuqB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:09:18 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)) 16:09:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:09:18 INFO - Running setup.py (path:/tmp/pip-cpKeeX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:09:18 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)) 16:09:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:09:18 INFO - Running setup.py (path:/tmp/pip-5WnvsO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:09:18 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)) 16:09:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:09:18 INFO - Running setup.py (path:/tmp/pip-XiSUpG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:09:18 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)) 16:09:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:09:18 INFO - Running setup.py (path:/tmp/pip-pwR4Aj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:09:18 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)) 16:09:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:09:18 INFO - Running setup.py (path:/tmp/pip-AHgNtT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:09:19 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)) 16:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:09:19 INFO - Running setup.py (path:/tmp/pip-6JXQh8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:09:19 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)) 16:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:09:19 INFO - Running setup.py (path:/tmp/pip-7VuoJt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:09:19 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)) 16:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:09:19 INFO - Running setup.py (path:/tmp/pip-_0lnzh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:09:19 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)) 16:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:09:19 INFO - Running setup.py (path:/tmp/pip-cZC0ko-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:09:19 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)) 16:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:09:19 INFO - Running setup.py (path:/tmp/pip-oZd9NT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:09:19 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)) 16:09:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:09:19 INFO - Running setup.py (path:/tmp/pip-w67jb6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:09:19 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)) 16:09:19 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)) 16:09:19 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)) 16:09:19 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)) 16:09:19 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)) 16:09:19 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)) 16:09:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:09:19 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 16:09:19 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 16:09:19 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 16:09:19 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 16:09:19 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 16:09:19 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 16:09:21 INFO - Downloading blessings-1.5.1.tar.gz 16:09:21 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 16:09:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:09:21 INFO - Installing collected packages: blessings 16:09:21 INFO - Running setup.py install for blessings 16:09:21 INFO - Successfully installed blessings 16:09:21 INFO - Cleaning up... 16:09:21 INFO - Return code: 0 16:09:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:09:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:09:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:09:21 INFO - Reading from file tmpfile_stdout 16:09:21 INFO - Current package versions: 16:09:21 INFO - argparse == 1.2.1 16:09:21 INFO - blessings == 1.5.1 16:09:21 INFO - blobuploader == 1.2.4 16:09:21 INFO - docopt == 0.6.1 16:09:21 INFO - manifestparser == 1.1 16:09:21 INFO - mozInstall == 1.12 16:09:21 INFO - mozcrash == 0.16 16:09:21 INFO - mozdebug == 0.1 16:09:21 INFO - mozdevice == 0.47 16:09:21 INFO - mozfile == 1.2 16:09:21 INFO - mozhttpd == 0.7 16:09:21 INFO - mozinfo == 0.9 16:09:21 INFO - mozleak == 0.1 16:09:21 INFO - mozlog == 3.0 16:09:21 INFO - moznetwork == 0.27 16:09:21 INFO - mozprocess == 0.22 16:09:21 INFO - mozprofile == 0.27 16:09:21 INFO - mozrunner == 6.11 16:09:21 INFO - mozscreenshot == 0.1 16:09:21 INFO - mozsystemmonitor == 0.0 16:09:21 INFO - moztest == 0.7 16:09:21 INFO - mozversion == 1.4 16:09:21 INFO - psutil == 3.1.1 16:09:21 INFO - requests == 1.2.3 16:09:21 INFO - wsgiref == 0.1.2 16:09:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:09:21 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')]} 16:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:21 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')]} 16:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:21 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 0x7f4696c8ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16426c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17036e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1739a90>, '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 0x178bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178c2e0>, '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': '6e558709db315bacd2260379000001b6-1447456499.376036-2115906253', '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 16:09:21 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 16:09:21 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 16:09:21 INFO - Using env: {'DISPLAY': ':0', 16:09:21 INFO - 'HOME': '/home/cltbld', 16:09:21 INFO - 'LANG': 'en_US.UTF-8', 16:09:21 INFO - 'LANGUAGE': 'en_US:en', 16:09:21 INFO - 'LOGNAME': 'cltbld', 16:09:21 INFO - 'MAIL': '/var/mail/cltbld', 16:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:21 INFO - 'MOZ_NO_REMOTE': '1', 16:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:21 INFO - 'NO_EM_RESTART': '1', 16:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:09:21 INFO - 'PWD': '/builds/slave/test-pgo', 16:09:21 INFO - 'SHELL': '/bin/bash', 16:09:21 INFO - 'SHLVL': '1', 16:09:21 INFO - 'TERM': 'linux', 16:09:21 INFO - 'TMOUT': '86400', 16:09:21 INFO - 'USER': 'cltbld', 16:09:21 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447456499.376036-2115906253', 16:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:21 INFO - '_': '/tools/buildbot/bin/python'} 16:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:21 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)) 16:09:21 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)) 16:09:21 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)) 16:09:21 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)) 16:09:21 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)) 16:09:21 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)) 16:09:21 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)) 16:09:21 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)) 16:09:21 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)) 16:09:21 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)) 16:09:21 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)) 16:09:21 INFO - Cleaning up... 16:09:21 INFO - Return code: 0 16:09:21 INFO - Running post-action listener: _resource_record_post_action 16:09:21 INFO - Running post-action listener: _start_resource_monitoring 16:09:21 INFO - Starting resource monitoring. 16:09:21 INFO - ##### 16:09:21 INFO - ##### Running install step. 16:09:21 INFO - ##### 16:09:21 INFO - Running pre-action listener: _resource_record_pre_action 16:09:21 INFO - Running main action method: install 16:09:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:09:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:09:22 INFO - Reading from file tmpfile_stdout 16:09:22 INFO - Detecting whether we're running mozinstall >=1.0... 16:09:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:09:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:09:22 INFO - Reading from file tmpfile_stdout 16:09:22 INFO - Output received: 16:09:22 INFO - Usage: mozinstall [options] installer 16:09:22 INFO - Options: 16:09:22 INFO - -h, --help show this help message and exit 16:09:22 INFO - -d DEST, --destination=DEST 16:09:22 INFO - Directory to install application into. [default: 16:09:22 INFO - "/builds/slave/test-pgo"] 16:09:22 INFO - --app=APP Application being installed. [default: firefox] 16:09:22 INFO - mkdir: /builds/slave/test-pgo/build/application 16:09:22 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'] 16:09:22 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 16:09:36 INFO - Reading from file tmpfile_stdout 16:09:36 INFO - Output received: 16:09:36 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:09:36 INFO - Running post-action listener: _resource_record_post_action 16:09:36 INFO - ##### 16:09:36 INFO - ##### Running run-tests step. 16:09:36 INFO - ##### 16:09:36 INFO - Running pre-action listener: _resource_record_pre_action 16:09:36 INFO - Running main action method: run_tests 16:09:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:09:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:09:36 INFO - Python 2.7.3 16:09:36 INFO - Return code: 0 16:09:36 INFO - grabbing minidump binary from tooltool 16:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:36 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 0x1739a90>, '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 0x178bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178c2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:09:36 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 16:09:36 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 16:09:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:09:36 INFO - Return code: 0 16:09:36 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:09:36 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:09:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:09:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:09:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:09:36 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/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:09:36 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/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost 16:09:36 INFO - Using env: {'DISPLAY': ':0', 16:09:36 INFO - 'HOME': '/home/cltbld', 16:09:36 INFO - 'LANG': 'en_US.UTF-8', 16:09:36 INFO - 'LANGUAGE': 'en_US:en', 16:09:36 INFO - 'LOGNAME': 'cltbld', 16:09:36 INFO - 'MAIL': '/var/mail/cltbld', 16:09:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:09:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:36 INFO - 'MOZ_NO_REMOTE': '1', 16:09:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:36 INFO - 'NO_EM_RESTART': '1', 16:09:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:09:36 INFO - 'PWD': '/builds/slave/test-pgo', 16:09:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:09:36 INFO - 'SHELL': '/bin/bash', 16:09:36 INFO - 'SHLVL': '1', 16:09:36 INFO - 'TERM': 'linux', 16:09:36 INFO - 'TMOUT': '86400', 16:09:36 INFO - 'USER': 'cltbld', 16:09:36 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447456499.376036-2115906253', 16:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:36 INFO - '_': '/tools/buildbot/bin/python'} 16:09:36 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/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] with output_timeout 3600 16:09:36 INFO - mozversion INFO | application_buildid: 20151113143006 16:09:36 INFO - mozversion INFO | application_changeset: 683059d91038fe69139456a4094ff3be47574d90 16:09:36 INFO - mozversion INFO | application_display_name: Nightly 16:09:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:09:36 INFO - mozversion INFO | application_name: Firefox 16:09:36 INFO - mozversion INFO | application_remotingname: firefox 16:09:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 16:09:36 INFO - mozversion INFO | application_vendor: Mozilla 16:09:36 INFO - mozversion INFO | application_version: 45.0a1 16:09:36 INFO - mozversion INFO | platform_buildid: 20151113143006 16:09:36 INFO - mozversion INFO | platform_changeset: 683059d91038fe69139456a4094ff3be47574d90 16:09:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 16:09:36 INFO - mozversion INFO | platform_version: 45.0a1 16:09:36 INFO - 2015-11-13 16:09:36,708 DEBUG : using testdate: 1447459776 16:09:36 INFO - 2015-11-13 16:09:36,708 DEBUG : actual date: 1447459776 16:09:36 INFO - 2015-11-13 16:09:36,716 INFO : starting webserver on 'localhost:36041' 16:09:36 INFO - 2015-11-13 16:09:36,717 INFO : Starting test suite talos-linux64-ix-039 16:09:36 INFO - 2015-11-13 16:09:36,717 INFO : Starting test dromaeo_css 16:09:36 INFO - 2015-11-13 16:09:36,718 DEBUG : operating with platform_type : linux_ 16:09:36 INFO - 2015-11-13 16:09:36,718 INFO : Initialising browser for dromaeo_css test... 16:09:36 INFO - 2015-11-13 16:09:36,731 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCWSSNL/profile http://localhost:36041/getInfo.html 16:09:42 INFO - 2015-11-13 16:09:42,833 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:09:42 INFO - 2015-11-13 16:09:42,833 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:09:42 INFO - 2015-11-13 16:09:42,833 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:09:42 INFO - 2015-11-13 16:09:42,834 DEBUG : BROWSER_OUTPUT: __metrics 16:09:42 INFO - 2015-11-13 16:09:42,950 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:09:44 INFO - 2015-11-13 16:09:44,452 INFO : Browser initialized. 16:09:44 INFO - 2015-11-13 16:09:44,452 INFO : Running cycle 1/1 for dromaeo_css test... 16:09:44 INFO - 2015-11-13 16:09:44,453 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCWSSNL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:09:56 INFO - 2015-11-13 16:09:56,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 141754368 16:09:56 INFO - 2015-11-13 16:09:56,127 DEBUG : BROWSER_OUTPUT: 16:10:46 INFO - 2015-11-13 16:10:46,782 DEBUG : BROWSER_OUTPUT: 1447459846774 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] 16:12:56 INFO - 2015-11-13 16:12:56,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36041/tests/dromaeo/cssquery-ext.html) 16:12:57 INFO - 2015-11-13 16:12:57,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 240566272 16:12:57 INFO - 2015-11-13 16:12:57,354 DEBUG : BROWSER_OUTPUT: 16:15:59 INFO - 2015-11-13 16:15:59,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/dromaeo/cssquery-ext.html (next: http://localhost:36041/tests/dromaeo/cssquery-jquery.html) 16:16:00 INFO - 2015-11-13 16:16:00,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 222195712 16:16:00 INFO - 2015-11-13 16:16:00,182 DEBUG : BROWSER_OUTPUT: 16:19:02 INFO - 2015-11-13 16:19:02,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36041/tests/dromaeo/cssquery-mootools.html) 16:19:02 INFO - 2015-11-13 16:19:02,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 227180544 16:19:02 INFO - 2015-11-13 16:19:02,677 DEBUG : BROWSER_OUTPUT: 16:22:04 INFO - 2015-11-13 16:22:04,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36041/tests/dromaeo/cssquery-prototype.html) 16:22:05 INFO - 2015-11-13 16:22:05,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 195858432 16:22:05 INFO - 2015-11-13 16:22:05,051 DEBUG : BROWSER_OUTPUT: 16:25:07 INFO - 2015-11-13 16:25:07,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36041/tests/dromaeo/cssquery-yui.html) 16:25:08 INFO - 2015-11-13 16:25:08,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 203841536 16:25:08 INFO - 2015-11-13 16:25:08,056 DEBUG : BROWSER_OUTPUT: 16:28:10 INFO - 2015-11-13 16:28:10,652 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/dromaeo/cssquery-yui.html (next: http://localhost:36041/tests/dromaeo/cssquery-dojo.html) 16:28:10 INFO - 2015-11-13 16:28:10,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 216760320 16:28:10 INFO - 2015-11-13 16:28:10,902 DEBUG : BROWSER_OUTPUT: 16:28:10 INFO - 2015-11-13 16:28:10,902 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:28:10 INFO - 2015-11-13 16:28:10,903 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:28:10 INFO - 2015-11-13 16:28:10,903 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:28:10 INFO - 2015-11-13 16:28:10,903 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:28:10 INFO - 2015-11-13 16:28:10,903 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3195.5046967720004;3289.4079065768183;3326.168457885529;3342.4317865962785;3352.9605822195113;5278.12910869707;5397.136458166694;5444.40111587725;5471.644343117695;5511.972440137799;5282.181261904411;5365.812196573121;5399.78400863965;5491.203775452567;5602.635828671134;5008.674436161647;5088.389393272794;5126.615503837208;5129;5183.766730497136;4807.543283388072;5088.440271570143;5111.258867464216;5179.482051794809;5182.300389447433;4875.366202393701;4903;4957.355543779322;4974.0797952378925;4976.104301225778;5024.522670346311;5047.64666473347;5071.0365030644425;5078.64449488536;5091.465396133427;4900.460949295574;5019.996000799854;5037.471065538102;5038.496150384969;5054.3176671149295;5319.946800531984;5432.266644003049;5437.6465529740835;5446.809361672323;5452.073147564924;5965.463108320272;6003.0695242237525;6009.729562169713;6011.218541589609;6019.879602407971;5816.185733997244;5866.882662346772;5915.911261331084;6021.909671354933;6043.576949613529;5669.688167150805;5670.092785154356;5680.346760122557;5691.743871525791;5691.857703557403;6116.571839971249;6116.755329786759;6129.11127886454;6131.583543324803;6137.202163718688;5680.0627896397455;5787.102999035156;5789.160571717078;5901.439363260483;5950.651676450156;5947.583669143205;6018.608790428696;6021.066734656135;6034.215551978303;6034.5172386209;6003.489703375262;6004.0693692477735;6004.249468816398;6005.519558435315;6011.12838638395;5758.971205143947;5775.884482310415;5838.737256823453;5882.941170588325;5911.674857882772;4517.232070548015;4521.231390663595;4542.613877820422;4550.0217453247715;4564.269716845355;3912.7847968361443;4015.819288132041;4031.2139132869397;4036.9394459083137;4060.4721386219603;5547.583931205176;5583.832485025456;5673.404292549306;5686.9715651421475;5728.51307638847;6008.579399441997;6010.939890601038;6021.066734656135;6022.36765139654;6026.668533230627;5381.354237491526;5462.8361149165585;5665.490105890407;5671.319441667027;5673.971630141823;5126.4617215191865;5208.140656791663;5209.635325527177;5220.190870415092;5241.187615919539;6153.384661533811;6153.753849846045;6160.10678451622;6161.907571386433;6163.506919446433;5760.539156867524;5776.653400795965;5894.911576326273;5933.139694744152;5934.258217722785;6249.96875015622;6250.937490625218;6251.843703907439;6264.59280146789;6270.874582508415;5910.261217347832;5927.407259274038;5931.7627294907725;5941.851453713692;5970.432808883149;5695.7436915338085;5796.449337312949;5875.50058245054;5977.282726072899;6015.368386319374;5770.855728606818;5865.618734782225;5868.413158684098;5868.735906884286;5870.442307980735;5823.475887170175;5835.854103647443;5848.152017957287;5857.47282744555;5861.208736820645;5549.833504994856;5550.417206193291;5619.606627536196;5644.435556444323;5672.2058911751565;5790.334111577223;5810.941890581209;5817.6509409433875;5825.2135961644635;5873.5594830388745;5411.053065713563;5696.20253164549;5700.030994730989;5714.685692286964;5725.227094342377 16:28:10 INFO - 2015-11-13 16:28:10,904 DEBUG : BROWSER_OUTPUT: |1;ext.html;571.9771209151634;587.5505238492551;595.2470125291504;608.7139044649015;613.806650904965;31404;39374.40938385927;39925;39972.200555988864;40024.59975400249;44134.33798493025;44244.009019594116;44320.55679443204;44509.7774511127;44535.55464445354;7720.691172353099;7856.685732570691;8656.567171641424;8795;8840.734777956672;10446.738831529197;10683.519241634145;10683.572657093708;10684.839727404094;10685.038346548808;10319.638812641559;10356.067953884149;10409.167266618653;10411;10424.530896109693;7793.142754297051;7938.6427610757655;10303.896961030407;10468.842967355497;10737.78524429507;10223.131033862132;10354.119899808526;10362;10362.326448780805;10364.637237696645;40493;40766.796166019274;40769.592304076876;40792.79603601993;40855.38716919249;3003.519436890087;3017.1551965449707;3121.687831216883;3123.3440977394775;3131.62420509538;32601.836990815133;32934.6706532934;32994.17514562131;33068.3386332272;33214;3123.7344825689843;3174.5716906751386;3198.056573310879;3260.3968265870653;3284.4088064148445;277758;278752;279753;280105;280121;53611.73194134004;61743;62212.68893655593;62228;62248.68875655683;49928.75035624798;72752.2724772756;73805.6309718448;74274.25725742674;74309;15678.529644110695;15927.124008179662;16080.758788618181;16081.758773618405;16106.436274730562;11150.721231969266;11290.379029153475;11312.773744525064;11322.490487928064;11323.490442930088;20572.79427205739;20766.377008689764;20806.58386832255;20827.166913323297;20842.37472875816;8037.557934313552;8255.834883302301;8293.668253269801;8298.294644955246;8327.875081873777;792.3938187286731;943.9952800236092;957.4686049242737;968.8159249742667;1043.0299821166236;29002.27494312617;29023.854880725463;29260.853695731385;29330.706692932796;32304;1002.4636819301638;1023.8720159980003;1037.3257382701304;1047.8952104789612;1073.9516721747384;14958.850411495963;14962.70074598502;15086.321115549827;15369.308381122877;15382.461613843461;443866;447248;449014;449269;451611;55943.44056559464;56331.43668563344;56410;56482.7175864118;56485.43514564884;1329.7739384304691;1330.1088270858547;1354.4988354308969;1357.2535105692027;1358.2122369026138;24140.87929560341;24261.393465163514;28403.573946391232;29022.709772902002;29157;50992.23511647254;51589.484105158466;51613.22580161226;51883.74058129685;52041.21938171006;316383;318747;319216;319863;319918;28145.296367590156;28657.856710716314;31839.522407164375;31862;33483.83258083694;37799.433008505446;37855;38077;38516.229675406896;38603.80698096492;32245.67754322427;32719;32789;32848.17879552935;32999.835000824845;33202.33595328128;33628.66371336353;33820.15449613681;33821.492677610346;33954.49068264027;35177.29645407027;35702.642973569935;36111.27777444489;36201.275974480886;36210.637893620726;29997.850010749808;31004;32038.359232814746;32224.83887580547;32226.83886580552;23834;24367.26898193057;24417.51164976655;24482.265532034067;24714 16:28:10 INFO - 2015-11-13 16:28:10,905 DEBUG : BROWSER_OUTPUT: |2;jquery.html;350.0286704395303;353.1524341580207;353.19647801252154;356.905420063683;357.73527589583716;14324.785128223086;14559.272036398164;16427.014379137247;16840.410585629506;17619.735703964452;15551.53345399637;16708;16916.661666766657;17384.478465646018;17427.21577529011;5180.818671346513;5265.078611243036;5306.946930530703;5307.548858347026;5309.707966061865;3877.961220387788;3981.646240278305;5303.7082960437165;5338.386085600167;5639.492445679888;5731.254936858202;5736.799212027579;5760;5760.4527569881;5768.278965129359;5337.439568845293;5349.304590403242;5354.544863686591;5456.7544460499175;5735.397783232763;5042.067217564762;5097.490250974873;5115.693058416507;5123.897522049576;5127.410347810012;20059.39821805348;20196.79803201964;20285.695714564292;20509.589808203753;21101.788982110134;2035.1147250945885;2043.8875861827742;2118.353902059871;2129.872207667545;2446.2905757330354;13138.146020508731;13157.144785588906;13302.543647877972;13343.266120363376;13378.130421522666;1663.9084850333347;1708.3679038755615;1770.6281680847037;1863.6552237836045;1889.8204670556274;61365.386346136416;62094.37905620931;62248.68875655593;62333.68833155851;62363.06455403127;9324.207442367338;9734.805303894023;9739.220862330996;9779.168770654574;9801.803963920682;12535.623931282076;12622.431990560446;12622.495100196073;12649.810252846215;12656.746865062647;7543.547387156788;7601.581912994839;7601.695932162652;7669.1947345527915;7681.884771728429;7415.369693575999;7439.181690014094;7444.813879653052;7467.141278753013;7521.323080922633;5796.449337312949;5858.56060795442;5867.119932010232;5869.706514674249;5880.147378630075;1640.9835901640831;1681.7057015022322;1725.1632958015352;1728.2914005257785;1829.4603092087866;417.99263774303785;429.2166795598046;433.09915376017807;450.40096671426926;916.6562539047857;10314.793704125876;10387.324823886423;10422.21833362501;10438.217133715001;10716.946415267874;391.54580686403636;401.65658362100567;436.1255682356854;440.872147077344;446.6940145999935;5606.495415412633;5630.07103827872;5790.276215473066;5847.386024467455;5884.499817515559;555245;581588;591837;602584;609195;76526.23473765192;78608;78739.21260787318;78771;79013;463.69164505603396;469.01974872516604;469.1836205003338;469.55392377241077;470.03173462667013;9681.467519286507;9805.088007838403;9886.357386769838;9948.900510995087;10058.798824023332;35235.29529409449;35467;35850.46224306586;36129.83221006748;36281.91154265376;47972.76013620049;49449.505504945926;49845;49926.50073499219;49969.00061998667;6747.291534388818;6780;6872.518923675295;6941.895871562032;6962.338577835098;12448.377581121089;12782.808257876326;12806.295653738762;12907.161034532724;12910.612681619567;11008.229423940567;11215.383153926612;11248.100151987985;11260.436978150896;11261.887381126411;10672.252942293964;10810.729731756768;10985.725356866142;11024.228304018641;11232.3260604364;10937.890621093688;10993.61522346714;11067.114630829676;11111.944440277746;11177.73358267274;6688.7324507019175;6824.112865327475;6843.178818541807;6884.48366372514;6888.0356750056035;10973.945130274298;11057.336559806437;11186.83219751688;11188.776224475301;11207.831882521605 16:28:10 INFO - 2015-11-13 16:28:10,907 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1552.9844701552981;1681.8234085421032;1730.8009578898423;1742.7647267618868;1760.9295628174866;6586.670666466675;7563.848723025543;7765.456418050725;7772.689092436302;7782.610869456518;7580.241975802417;7695.038120234971;7703.46075774696;7710.884336734954;7714.768556943287;1993.362124120282;2026.0275067967384;2290.576243394969;2302.8503147295414;2323.1288266899915;2319.675245465636;2326.9418264543438;2328.6972693549815;2331.440454290975;2331.8717470539113;2214.1143542583013;2253.785890340415;2262.6492893601435;2272;2275.920342788003;1954.364831429791;1994.1026538057858;2184.748753893307;2213.822894168463;2218.0462401167492;2273.73852007018;2276.2374604507345;2295.116380193621;2299.8275129365197;2337.1936681844736;7760.650770715331;7840.13758486566;7840.725574604919;7843.098043724987;7849.8037549061155;4655.790489427984;4726.291056341542;4747.881302967419;4748.572628463455;4751.263554149078;2896.435195136949;3019.3357461358464;3022.909312720622;3053.282478617523;3063.9540406893916;892.2950868813695;903.3766700976371;926.4811705444972;940.3840484482674;959.5825815770162;10644.148468122532;10793.29843560166;10794.78410431787;10802;10808.945955270252;4148.460700108966;4200.411942328076;4205.053862880888;4227.260229459832;4314.848980285675;8746.081661425585;8753.824923501494;8756.299496040301;8758.2993360531;8762.86855697165;4658.906821863611;4673.976630116827;4675.4389473262745;4676.836310729108;4679.3916790816975;4259.0204253021975;4310.137972405531;4311.396404503372;4311.935320970188;4317.870463886088;3402.319536092791;3432.3478539077496;3436.261203841186;3442.9311413771584;3470.9826450867586;1041.068243921686;1047.4239168457318;1076.0100707349102;1089.5478376473834;1100.1803656275965;983.6606370802061;1225.9509619615294;1243.3720970909633;1245.1906260930468;1248.4194849395076;6982.1272340957385;7013.89479157813;7040.331168538981;7083.89374159388;7121.89317160243;556.8691357530977;688.3323176518769;702.2626242445514;707.3280383635566;716.4304378019488;5382.703951282639;5487.835364938978;5492.313460817398;5495.340559132929;5497.312835895513;9096.454212747256;9147.679831205876;9250.21373183287;9294.163525282756;9361.531923403803;9236.168744813;9268.119528644767;9313.674021409219;9316.767080823034;9319.347645664739;7065.258147894397;7155;7159.67781449836;7176.102987126609;7238.819029524198;6677.69950352245;6700.731970721116;6719.092922455406;6722.731090756315;6726;7726.806829829299;7920.485168464032;8030.43786934909;8045.87931181021;8046.678132874619;8211.95894020526;8341.24928756415;8456.112108228548;8497.490150590984;8530.10433904456;6410.423061924449;6447.70985305653;6530.379613936669;6542.869142617026;6558.049082883051;7341;7394.963025184839;7406.629668516661;7410.629468526445;7419.035525381882;6817.659117044029;6883.621400822803;6888.758893438706;7028.016077749017;7035.261297563682;6867.381935625817;6873.862522749617;6944.2986468315585;6974.61639609806;6992.1259842519685;6142.938570614237;6632.801015969529;6735.696893639896;6761.86476270462;6778.254392016973;6102;6223.315435302204;6277.435030847246;6281.7173227203975;6313.116163736989;6305.274893387319;6316.3367846377305;6327.715252813542;6332.873342533216;6343.238811342669 16:28:10 INFO - 2015-11-13 16:28:10,907 DEBUG : BROWSER_OUTPUT: |4;prototype.html;318.90273466592697;318.91708155879473;321.6285190604849;322.16398446032537;322.75631897917077;5866.061430171173;6022.909656355153;6030.909536356952;6079.270487541496;6080.209572755535;5942.168096466487;6037.39626037396;6058.757649694018;6059.757609695607;6062.969685151579;4333.8699839004885;4472.82108715651;4621.79201935912;4635.169108202258;4644.34979102925;4460;4527.977360113195;4535.818567257305;4545.181867263891;4549.749763762991;4501.617362524189;4521.2819128731035;4532.9093418131615;4538.659600529957;4548.2495388260895;4527.275635898273;4552.044070745131;4553.612942899857;4554.7039442436135;4554.977225113887;3868.071662800936;3961.1483531040676;3961.841526338972;3964.226975739732;3968.960310396888;5736.713164341808;5741.45456181662;5750.597458177929;5751.539876809845;5766.163906233573;5260.473952604747;5295.0468915595175;5303.071962406563;5306.5754739621125;5310.814121505768;6180.81457556274;6243.8126856194385;6261.342559031282;6401.391867772554;6403.327650596667;4339.631131353839;4342.522322544518;4363.738175709467;4371.016521282718;4379.671524635665;6714.697838597226;6718.2868368565705;6722.49581281401;6724.2603313635955;6725.93274067258;4363.672724545609;4455.287154055336;4455.509893911667;4456.77716114193;4457.910841783146;4522.095580883836;4524.276115821453;4526.207913615104;4530.07133537624;4543.954560454419;5272.523693365863;5278.419373868871;5279.8152064678325;5286.07493688603;5287.23335116406;6494.155759751202;6496.577722448026;6503.187101612299;6504.869902601921;6505.21937367519;1603.7514185301297;1611.4198888400167;1636.6808472347777;1640.8277130901322;1645.1691895592649;1041.6406339812752;1056.9735756605992;1064.0902028765295;1067.3755852826184;1072.2065671403107;6247.0629405589525;6280.968595157086;6282.1519094921605;6283.183186185766;6297.338779428185;6696.430803381767;6698;6707.329267073351;6709.060731497594;6713.12729345182;6154.907676384768;6288.339724328879;6291.150694656163;6291.213598300213;6293.842653933688;3601.081724160322;3635.163912300186;3635.654612811779;3638.3632864248652;3642.307961487309;6950.6177160256675;6965.721371145199;6980.30196980308;7008.439324853999;7017.263187365355;6673.366030227121;6784.932150678529;6793;6797.626130562867;6809.353111454404;6957.860842783116;6963.303669633097;6964.4080253179045;6989.266127056688;6995.965020174968;6482.448991835747;6576.80269591913;6612.669366531558;6808.659567021728;6809.421199198124;6707.564008339442;6719.294474080347;6726.091977583159;6727.192736871607;6739.258681545124;6953.687084081127;7042.57744535309;7094.077769889881;7104.786856394317;7110.253423390676;4518.073794872109;4519.050999290186;4526.592606665416;4527.705699129546;4534.614557762628;6786.3892249697765;6787.185537735503;6792.796216113525;6801.89797153053;6802.455803535804;6417.582857114459;6601.075849380994;6608.041833933957;6610.272869984202;6616.4045235929;6596.571222870498;6600.372964568551;6600.471962243105;6601.735930562723;6603.504737144829;6411.871762564816;6417.582857114273;6419.743210271537;6421.454176395058;6421.93578064232;6522.967385163044;6626.602403855784;6627.536072474881;6629.105070815378;6637.734490620321;6469.838254043687;6469.8706025880165;6478.546501744832;6484.221893372825;6486.286508483969 16:28:10 INFO - 2015-11-13 16:28:10,908 DEBUG : BROWSER_OUTPUT: |5;yui.html;762.5500954436883;785.4266385538555;796.6056801883069;817.4563914996531;830.0650349997521;10493.527791249393;10711.946440267788;10736.624218152367;10755.78488430233;10756.515956781945;13284.800727989088;13306.667333316647;13419.798703019438;14305.856941430582;14474.131552106881;667.4860357524703;796.1043825696078;808.3412019204329;808.5310519898475;809.2554849538409;673.0812441017999;802.0936341933607;812.8577498937663;813.6257321632056;815.0260438775665;828.0312034919159;846.3440833354169;846.8306338732248;847.3814115695546;847.9576021198947;687.7833482453036;699.622204009834;822.005373498068;825.455199568285;828.7430896422098;611.8348046027547;614.8493619063313;615.9414855588711;615.9876802463971;617.1452538234532;13198.406071726795;13656.385462654105;13665.385057672329;13691.246981416018;13715.794263086062;9271.304652151115;9360.53197340137;9362.25101991839;9494.367199828801;9652.324337296392;8618.482891026559;8752.606132724042;8867.778305542348;9077.36458447909;9186;3092.4897391930303;3108.098651391094;3125.6718044605445;3216.4210442120407;3248.431524483206;43952.78023609894;44238.557614423764;45134;45179.096418071786;45213;6368.808935731843;6392.84017899547;6411.967940160363;6534.248561415498;6607.735690572419;11666.475008624462;11698.239614425034;11703.648890533297;11709.76580468403;11713.648590542298;6317.810465686037;6398.968005159944;6410.102585638015;6453.193350831146;6540.901886471706;4153.1070819773895;4165.729227600257;4175.603317684815;4200.831966721358;4208.36874468826;2605.71337152913;2612.869356532166;2620.947581048368;2628.855412952306;2634.051741373104;423.65472140205634;424.16862948620434;424.21096760026325;436.8492869959859;441.40190042491963;499.91251530981936;531.6836482293029;569.7436153730838;596.4751019103162;638.4764493115694;7339.88990165148;7799.259070388304;7965.203479652105;8103.230193131643;8190.672373105128;558.9608727389044;571.2117278156201;598.9431004054608;616.7717944360616;629.1506466270498;3503.2292895562937;3681.0981309578788;3866.2267546490816;3896.551896531935;3898.2593307271527;58531.70734146387;58977.115343269885;59087.11369329463;59270;59847.70076149679;50709.23936140961;50980;51255.231171532454;51508.96982060338;51886.22170667443;48237;48306.5169348302;48505.272420913716;48532;48826.75586622115;7609.429292802951;7787.805304867424;7910.68357265726;8012.278894899487;8037.196280371916;32831.67168328286;34241.486377703855;34417.48373774345;34558.308833823685;35205.471917921765;42895;43669.78165109154;43708;43771.12457750891;44814.77592612016;7115.466340024623;7206.051930494104;7242.751506618287;7257.383122434652;7263.709451621876;10780.245382823441;10889.564417423215;10999;11467;11513.769724605294;9503.857442138235;9673.854892176763;9820.950895245478;9866.703998880044;10193.490325483548;9533.545057562469;9548.37935534188;9572.521373931415;9648;9952.651657191964;7990.040631478941;8766.736997890073;9271.119243671841;9703.805923881342;9708.174805141642;8390.160983901562;8490.490570565786;8541.91458085436;8615.483071015758;8716.128387161232;7732.729354472566;8117.878231826409;8162.387820913574;8227.177282271725;8411.3270938326 16:28:10 INFO - 2015-11-13 16:28:10,908 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:28:10 INFO - 2015-11-13 16:28:10,908 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:28:10 INFO - 2015-11-13 16:28:10,908 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,866 16:28:10 INFO - 2015-11-13 16:28:10,908 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:28:10 INFO - 2015-11-13 16:28:10,909 DEBUG : BROWSER_OUTPUT: __startTimestamp1447460890901__endTimestamp 16:28:10 INFO - 2015-11-13 16:28:10,909 DEBUG : BROWSER_OUTPUT: 16:28:10 INFO - 2015-11-13 16:28:10,909 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:28:10 INFO - 2015-11-13 16:28:10,909 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:28:10 INFO - 2015-11-13 16:28:10,909 DEBUG : BROWSER_OUTPUT: 16:28:10 INFO - 2015-11-13 16:28:10,909 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5515.65 Median:5696.20 stddev:630.28 (11.1%) stddev-sans-first:605.36 16:28:10 INFO - 2015-11-13 16:28:10,909 DEBUG : BROWSER_OUTPUT: Values: 3195.5 3289.4 3326.2 3342.4 3353.0 5278.1 5397.1 5444.4 5471.6 5512.0 5282.2 5365.8 5399.8 5491.2 5602.6 5008.7 5088.4 5126.6 5129.0 5183.8 4807.5 5088.4 5111.3 5179.5 5182.3 4875.4 4903.0 4957.4 4974.1 4976.1 5024.5 5047.6 5071.0 5078.6 5091.5 4900.5 5020.0 5037.5 5038.5 5054.3 5319.9 5432.3 5437.6 5446.8 5452.1 5965.5 6003.1 6009.7 6011.2 6019.9 5816.2 5866.9 5915.9 6021.9 6043.6 5669.7 5670.1 5680.3 5691.7 5691.9 6116.6 6116.8 6129.1 6131.6 6137.2 5680.1 5787.1 5789.2 5901.4 5950.7 5947.6 6018.6 6021.1 6034.2 6034.5 6003.5 6004.1 6004.2 6005.5 6011.1 5759.0 5775.9 5838.7 5882.9 5911.7 4517.2 4521.2 4542.6 4550.0 4564.3 3912.8 4015.8 4031.2 4036.9 4060.5 5547.6 5583.8 5673.4 5687.0 5728.5 6008.6 6010.9 6021.1 6022.4 6026.7 5381.4 5462.8 5665.5 5671.3 5674.0 5126.5 5208.1 5209.6 5220.2 5241.2 6153.4 6153.8 6160.1 6161.9 6163.5 5760.5 5776.7 5894.9 5933.1 5934.3 6250.0 6250.9 6251.8 6264.6 6270.9 5910.3 5927.4 5931.8 5941.9 5970.4 5695.7 5796.4 5875.5 5977.3 6015.4 5770.9 5865.6 5868.4 5868.7 5870.4 5823.5 5835.9 5848.2 5857.5 5861.2 5549.8 5550.4 5619.6 5644.4 5672.2 5790.3 5810.9 5817.7 5825.2 5873.6 5411.1 5696.2 5700.0 5714.7 5725.2 16:28:10 INFO - 2015-11-13 16:28:10,909 DEBUG : BROWSER_OUTPUT: 16:28:10 INFO - 2015-11-13 16:28:10,910 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51516.19 Median:32236.26 stddev:93992.51 (291.6%) stddev-sans-first:94178.35 16:28:10 INFO - 2015-11-13 16:28:10,911 DEBUG : BROWSER_OUTPUT: Values: 572.0 587.6 595.2 608.7 613.8 31404.0 39374.4 39925.0 39972.2 40024.6 44134.3 44244.0 44320.6 44509.8 44535.6 7720.7 7856.7 8656.6 8795.0 8840.7 10446.7 10683.5 10683.6 10684.8 10685.0 10319.6 10356.1 10409.2 10411.0 10424.5 7793.1 7938.6 10303.9 10468.8 10737.8 10223.1 10354.1 10362.0 10362.3 10364.6 40493.0 40766.8 40769.6 40792.8 40855.4 3003.5 3017.2 3121.7 3123.3 3131.6 32601.8 32934.7 32994.2 33068.3 33214.0 3123.7 3174.6 3198.1 3260.4 3284.4 277758.0 278752.0 279753.0 280105.0 280121.0 53611.7 61743.0 62212.7 62228.0 62248.7 49928.8 72752.3 73805.6 74274.3 74309.0 15678.5 15927.1 16080.8 16081.8 16106.4 11150.7 11290.4 11312.8 11322.5 11323.5 20572.8 20766.4 20806.6 20827.2 20842.4 8037.6 8255.8 8293.7 8298.3 8327.9 792.4 944.0 957.5 968.8 1043.0 29002.3 29023.9 29260.9 29330.7 32304.0 1002.5 1023.9 1037.3 1047.9 1074.0 14958.9 14962.7 15086.3 15369.3 15382.5 443866.0 447248.0 449014.0 449269.0 451611.0 55943.4 56331.4 56410.0 56482.7 56485.4 1329.8 1330.1 1354.5 1357.3 1358.2 24140.9 24261.4 28403.6 29022.7 29157.0 50992.2 51589.5 51613.2 51883.7 52041.2 316383.0 318747.0 319216.0 319863.0 319918.0 28145.3 28657.9 31839.5 31862.0 33483.8 37799.4 37855.0 38077.0 38516.2 38603.8 32245.7 32719.0 32789.0 32848.2 32999.8 33202.3 33628.7 33820.2 33821.5 33954.5 35177.3 35702.6 36111.3 36201.3 36210.6 29997.9 31004.0 32038.4 32224.8 32226.8 23834.0 24367.3 24417.5 24482.3 24714.0 16:28:10 INFO - 2015-11-13 16:28:10,911 DEBUG : BROWSER_OUTPUT: 16:28:10 INFO - 2015-11-13 16:28:10,911 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29280.47 Median:448.55 stddev:96261.53 (21460.7%) stddev-sans-first:96507.05 16:28:10 INFO - 2015-11-13 16:28:10,911 DEBUG : BROWSER_OUTPUT: Values: 350.0 353.2 353.2 356.9 357.7 14324.8 14559.3 16427.0 16840.4 17619.7 15551.5 16708.0 16916.7 17384.5 17427.2 5180.8 5265.1 5306.9 5307.5 5309.7 3878.0 3981.6 5303.7 5338.4 5639.5 5731.3 5736.8 5760.0 5760.5 5768.3 5337.4 5349.3 5354.5 5456.8 5735.4 5042.1 5097.5 5115.7 5123.9 5127.4 20059.4 20196.8 20285.7 20509.6 21101.8 2035.1 2043.9 2118.4 2129.9 2446.3 13138.1 13157.1 13302.5 13343.3 13378.1 1663.9 1708.4 1770.6 1863.7 1889.8 61365.4 62094.4 62248.7 62333.7 62363.1 9324.2 9734.8 9739.2 9779.2 9801.8 12535.6 12622.4 12622.5 12649.8 12656.7 7543.5 7601.6 7601.7 7669.2 7681.9 7415.4 7439.2 7444.8 7467.1 7521.3 5796.4 5858.6 5867.1 5869.7 5880.1 1641.0 1681.7 1725.2 1728.3 1829.5 418.0 429.2 433.1 450.4 916.7 10314.8 10387.3 10422.2 10438.2 10716.9 391.5 401.7 436.1 440.9 446.7 5606.5 5630.1 5790.3 5847.4 5884.5 555245.0 581588.0 591837.0 602584.0 609195.0 76526.2 78608.0 78739.2 78771.0 79013.0 463.7 469.0 469.2 469.6 470.0 9681.5 9805.1 9886.4 9948.9 10058.8 35235.3 35467.0 35850.5 36129.8 36281.9 47972.8 49449.5 49845.0 49926.5 49969.0 6747.3 6780.0 6872.5 6941.9 6962.3 12448.4 12782.8 12806.3 12907.2 12910.6 11008.2 11215.4 11248.1 11260.4 11261.9 10672.3 10810.7 10985.7 11024.2 11232.3 10937.9 10993.6 11067.1 11111.9 11177.7 6688.7 6824.1 6843.2 6884.5 6888.0 10973.9 11057.3 11186.8 11188.8 11207.8 16:28:10 INFO - 2015-11-13 16:28:10,911 DEBUG : BROWSER_OUTPUT: 16:28:10 INFO - 2015-11-13 16:28:10,912 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5328.49 Median:6376.83 stddev:2783.54 (43.7%) stddev-sans-first:2776.88 16:28:10 INFO - 2015-11-13 16:28:10,913 DEBUG : BROWSER_OUTPUT: Values: 1553.0 1681.8 1730.8 1742.8 1760.9 6586.7 7563.8 7765.5 7772.7 7782.6 7580.2 7695.0 7703.5 7710.9 7714.8 1993.4 2026.0 2290.6 2302.9 2323.1 2319.7 2326.9 2328.7 2331.4 2331.9 2214.1 2253.8 2262.6 2272.0 2275.9 1954.4 1994.1 2184.7 2213.8 2218.0 2273.7 2276.2 2295.1 2299.8 2337.2 7760.7 7840.1 7840.7 7843.1 7849.8 4655.8 4726.3 4747.9 4748.6 4751.3 2896.4 3019.3 3022.9 3053.3 3064.0 892.3 903.4 926.5 940.4 959.6 10644.1 10793.3 10794.8 10802.0 10808.9 4148.5 4200.4 4205.1 4227.3 4314.8 8746.1 8753.8 8756.3 8758.3 8762.9 4658.9 4674.0 4675.4 4676.8 4679.4 4259.0 4310.1 4311.4 4311.9 4317.9 3402.3 3432.3 3436.3 3442.9 3471.0 1041.1 1047.4 1076.0 1089.5 1100.2 983.7 1226.0 1243.4 1245.2 1248.4 6982.1 7013.9 7040.3 7083.9 7121.9 556.9 688.3 702.3 707.3 716.4 5382.7 5487.8 5492.3 5495.3 5497.3 9096.5 9147.7 9250.2 9294.2 9361.5 9236.2 9268.1 9313.7 9316.8 9319.3 7065.3 7155.0 7159.7 7176.1 7238.8 6677.7 6700.7 6719.1 6722.7 6726.0 7726.8 7920.5 8030.4 8045.9 8046.7 8212.0 8341.2 8456.1 8497.5 8530.1 6410.4 6447.7 6530.4 6542.9 6558.0 7341.0 7395.0 7406.6 7410.6 7419.0 6817.7 6883.6 6888.8 7028.0 7035.3 6867.4 6873.9 6944.3 6974.6 6992.1 6142.9 6632.8 6735.7 6761.9 6778.3 6102.0 6223.3 6277.4 6281.7 6313.1 6305.3 6316.3 6327.7 6332.9 6343.2 16:28:10 INFO - 2015-11-13 16:28:10,913 DEBUG : BROWSER_OUTPUT: 16:28:10 INFO - 2015-11-13 16:28:10,913 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5398.95 Median:6167.86 stddev:1671.25 (27.1%) stddev-sans-first:1631.86 16:28:10 INFO - 2015-11-13 16:28:10,913 DEBUG : BROWSER_OUTPUT: Values: 318.9 318.9 321.6 322.2 322.8 5866.1 6022.9 6030.9 6079.3 6080.2 5942.2 6037.4 6058.8 6059.8 6063.0 4333.9 4472.8 4621.8 4635.2 4644.3 4460.0 4528.0 4535.8 4545.2 4549.7 4501.6 4521.3 4532.9 4538.7 4548.2 4527.3 4552.0 4553.6 4554.7 4555.0 3868.1 3961.1 3961.8 3964.2 3969.0 5736.7 5741.5 5750.6 5751.5 5766.2 5260.5 5295.0 5303.1 5306.6 5310.8 6180.8 6243.8 6261.3 6401.4 6403.3 4339.6 4342.5 4363.7 4371.0 4379.7 6714.7 6718.3 6722.5 6724.3 6725.9 4363.7 4455.3 4455.5 4456.8 4457.9 4522.1 4524.3 4526.2 4530.1 4544.0 5272.5 5278.4 5279.8 5286.1 5287.2 6494.2 6496.6 6503.2 6504.9 6505.2 1603.8 1611.4 1636.7 1640.8 1645.2 1041.6 1057.0 1064.1 1067.4 1072.2 6247.1 6281.0 6282.2 6283.2 6297.3 6696.4 6698.0 6707.3 6709.1 6713.1 6154.9 6288.3 6291.2 6291.2 6293.8 3601.1 3635.2 3635.7 3638.4 3642.3 6950.6 6965.7 6980.3 7008.4 7017.3 6673.4 6784.9 6793.0 6797.6 6809.4 6957.9 6963.3 6964.4 6989.3 6996.0 6482.4 6576.8 6612.7 6808.7 6809.4 6707.6 6719.3 6726.1 6727.2 6739.3 6953.7 7042.6 7094.1 7104.8 7110.3 4518.1 4519.1 4526.6 4527.7 4534.6 6786.4 6787.2 6792.8 6801.9 6802.5 6417.6 6601.1 6608.0 6610.3 6616.4 6596.6 6600.4 6600.5 6601.7 6603.5 6411.9 6417.6 6419.7 6421.5 6421.9 6523.0 6626.6 6627.5 6629.1 6637.7 6469.8 6469.9 6478.5 6484.2 6486.3 16:28:10 INFO - 2015-11-13 16:28:10,913 DEBUG : BROWSER_OUTPUT: 16:28:10 INFO - 2015-11-13 16:28:10,913 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12829.14 Median:615.96 stddev:16105.32 (2614.7%) stddev-sans-first:16125.01 16:28:10 INFO - 2015-11-13 16:28:10,915 DEBUG : BROWSER_OUTPUT: Values: 762.6 785.4 796.6 817.5 830.1 10493.5 10711.9 10736.6 10755.8 10756.5 13284.8 13306.7 13419.8 14305.9 14474.1 667.5 796.1 808.3 808.5 809.3 673.1 802.1 812.9 813.6 815.0 828.0 846.3 846.8 847.4 848.0 687.8 699.6 822.0 825.5 828.7 611.8 614.8 615.9 616.0 617.1 13198.4 13656.4 13665.4 13691.2 13715.8 9271.3 9360.5 9362.3 9494.4 9652.3 8618.5 8752.6 8867.8 9077.4 9186.0 3092.5 3108.1 3125.7 3216.4 3248.4 43952.8 44238.6 45134.0 45179.1 45213.0 6368.8 6392.8 6412.0 6534.2 6607.7 11666.5 11698.2 11703.6 11709.8 11713.6 6317.8 6399.0 6410.1 6453.2 6540.9 4153.1 4165.7 4175.6 4200.8 4208.4 2605.7 2612.9 2620.9 2628.9 2634.1 423.7 424.2 424.2 436.8 441.4 499.9 531.7 569.7 596.5 638.5 7339.9 7799.3 7965.2 8103.2 8190.7 559.0 571.2 598.9 616.8 629.2 3503.2 3681.1 3866.2 3896.6 3898.3 58531.7 58977.1 59087.1 59270.0 59847.7 50709.2 50980.0 51255.2 51509.0 51886.2 48237.0 48306.5 48505.3 48532.0 48826.8 7609.4 7787.8 7910.7 8012.3 8037.2 32831.7 34241.5 34417.5 34558.3 35205.5 42895.0 43669.8 43708.0 43771.1 44814.8 7115.5 7206.1 7242.8 7257.4 7263.7 10780.2 10889.6 10999.0 11467.0 11513.8 9503.9 9673.9 9821.0 9866.7 10193.5 9533.5 9548.4 9572.5 9648.0 9952.7 7990.0 8766.7 9271.1 9703.8 9708.2 8390.2 8490.5 8541.9 8615.5 8716.1 7732.7 8117.9 8162.4 8227.2 8411.3 16:28:10 INFO - 2015-11-13 16:28:10,915 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:28:10 INFO - 2015-11-13 16:28:10,915 DEBUG : BROWSER_OUTPUT: 16:28:11 INFO - 2015-11-13 16:28:11,601 INFO : Browser exited with error code: 0 16:28:11 INFO - 2015-11-13 16:28:11,620 INFO : Completed test dromaeo_css (00:18:34) 16:28:11 INFO - 2015-11-13 16:28:11,620 INFO : Starting test kraken 16:28:11 INFO - 2015-11-13 16:28:11,620 DEBUG : operating with platform_type : linux_ 16:28:11 INFO - 2015-11-13 16:28:11,620 INFO : Initialising browser for kraken test... 16:28:11 INFO - 2015-11-13 16:28:11,626 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphp5ZiB/profile http://localhost:36041/getInfo.html 16:28:15 INFO - 2015-11-13 16:28:15,325 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:28:15 INFO - 2015-11-13 16:28:15,325 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:28:15 INFO - 2015-11-13 16:28:15,325 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:28:15 INFO - 2015-11-13 16:28:15,325 DEBUG : BROWSER_OUTPUT: __metrics 16:28:15 INFO - 2015-11-13 16:28:15,430 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:28:16 INFO - 2015-11-13 16:28:16,845 INFO : Browser initialized. 16:28:16 INFO - 2015-11-13 16:28:16,846 INFO : Running cycle 1/1 for kraken test... 16:28:16 INFO - 2015-11-13 16:28:16,846 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphp5ZiB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:28:28 INFO - 2015-11-13 16:28:28,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 141164544 16:28:28 INFO - 2015-11-13 16:28:28,538 DEBUG : BROWSER_OUTPUT: 16:28:31 INFO - 2015-11-13 16:28:31,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36041/tests/kraken/driver.html?testName=audio-beat-detection) 16:28:31 INFO - 2015-11-13 16:28:31,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 180789248 16:28:31 INFO - 2015-11-13 16:28:31,606 DEBUG : BROWSER_OUTPUT: 16:28:34 INFO - 2015-11-13 16:28:34,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36041/tests/kraken/driver.html?testName=audio-dft) 16:28:34 INFO - 2015-11-13 16:28:34,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 170475520 16:28:34 INFO - 2015-11-13 16:28:34,730 DEBUG : BROWSER_OUTPUT: 16:28:37 INFO - 2015-11-13 16:28:37,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36041/tests/kraken/driver.html?testName=audio-fft) 16:28:38 INFO - 2015-11-13 16:28:38,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 151764992 16:28:38 INFO - 2015-11-13 16:28:38,172 DEBUG : BROWSER_OUTPUT: 16:28:40 INFO - 2015-11-13 16:28:40,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36041/tests/kraken/driver.html?testName=audio-oscillator) 16:28:40 INFO - 2015-11-13 16:28:40,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 152625152 16:28:40 INFO - 2015-11-13 16:28:40,695 DEBUG : BROWSER_OUTPUT: 16:28:42 INFO - 2015-11-13 16:28:42,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36041/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:28:43 INFO - 2015-11-13 16:28:43,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 155533312 16:28:43 INFO - 2015-11-13 16:28:43,414 DEBUG : BROWSER_OUTPUT: 16:28:46 INFO - 2015-11-13 16:28:46,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36041/tests/kraken/driver.html?testName=imaging-darkroom) 16:28:46 INFO - 2015-11-13 16:28:46,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 156008448 16:28:46 INFO - 2015-11-13 16:28:46,925 DEBUG : BROWSER_OUTPUT: 16:28:50 INFO - 2015-11-13 16:28:50,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36041/tests/kraken/driver.html?testName=imaging-desaturate) 16:28:50 INFO - 2015-11-13 16:28:50,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 157761536 16:28:50 INFO - 2015-11-13 16:28:50,926 DEBUG : BROWSER_OUTPUT: 16:28:53 INFO - 2015-11-13 16:28:53,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36041/tests/kraken/driver.html?testName=json-parse-financial) 16:28:54 INFO - 2015-11-13 16:28:54,270 DEBUG : BROWSER_OUTPUT: RSS: Main: 156815360 16:28:54 INFO - 2015-11-13 16:28:54,270 DEBUG : BROWSER_OUTPUT: 16:28:55 INFO - 2015-11-13 16:28:55,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36041/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:28:56 INFO - 2015-11-13 16:28:56,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 164708352 16:28:56 INFO - 2015-11-13 16:28:56,385 DEBUG : BROWSER_OUTPUT: 16:28:58 INFO - 2015-11-13 16:28:58,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36041/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:28:58 INFO - 2015-11-13 16:28:58,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 164618240 16:28:58 INFO - 2015-11-13 16:28:58,764 DEBUG : BROWSER_OUTPUT: 16:29:00 INFO - 2015-11-13 16:29:00,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36041/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:29:01 INFO - 2015-11-13 16:29:01,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 177790976 16:29:01 INFO - 2015-11-13 16:29:01,371 DEBUG : BROWSER_OUTPUT: 16:29:03 INFO - 2015-11-13 16:29:03,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36041/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:29:04 INFO - 2015-11-13 16:29:04,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 180502528 16:29:04 INFO - 2015-11-13 16:29:04,354 DEBUG : BROWSER_OUTPUT: 16:29:06 INFO - 2015-11-13 16:29:06,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36041/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:29:07 INFO - 2015-11-13 16:29:07,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 178315264 16:29:07 INFO - 2015-11-13 16:29:07,460 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36041/tests/kraken/driver.html?testName=ai-astar) 16:29:09 INFO - 2015-11-13 16:29:09,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 237699072 16:29:09 INFO - 2015-11-13 16:29:09,380 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,380 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:29:09 INFO - 2015-11-13 16:29:09,380 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:29:09 INFO - 2015-11-13 16:29:09,380 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:29:09 INFO - 2015-11-13 16:29:09,380 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:29:09 INFO - 2015-11-13 16:29:09,380 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;104;110;110;111;98;108;109;108 16:29:09 INFO - 2015-11-13 16:29:09,381 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;123;146;159;129;156;148;125;162;124 16:29:09 INFO - 2015-11-13 16:29:09,381 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;161;160;160;160;160;162;161;160 16:29:09 INFO - 2015-11-13 16:29:09,381 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;82;95;73;71;72;102;95;73 16:29:09 INFO - 2015-11-13 16:29:09,381 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;89;136;90;90;90;129;90;90;132 16:29:09 INFO - 2015-11-13 16:29:09,381 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;109;109;110;110 16:29:09 INFO - 2015-11-13 16:29:09,381 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;145;145;144;144;146;146 16:29:09 INFO - 2015-11-13 16:29:09,382 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;97;96;96;95;95 16:29:09 INFO - 2015-11-13 16:29:09,382 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;56;58;57;60;59;58;65;55;55 16:29:09 INFO - 2015-11-13 16:29:09,382 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;66;68;68;68;68;68;67;67;68 16:29:09 INFO - 2015-11-13 16:29:09,383 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;84;85;84;86;84;83;85;84 16:29:09 INFO - 2015-11-13 16:29:09,383 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;130;116;130;123;115;114;121;125;116 16:29:09 INFO - 2015-11-13 16:29:09,383 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;149;146;147;161;137;146;145;147;137 16:29:09 INFO - 2015-11-13 16:29:09,383 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;65;66;66;64;64;66;68;65 16:29:09 INFO - 2015-11-13 16:29:09,383 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:29:09 INFO - 2015-11-13 16:29:09,383 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:29:09 INFO - 2015-11-13 16:29:09,383 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,915 16:29:09 INFO - 2015-11-13 16:29:09,383 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:29:09 INFO - 2015-11-13 16:29:09,384 DEBUG : BROWSER_OUTPUT: __startTimestamp1447460949379__endTimestamp 16:29:09 INFO - 2015-11-13 16:29:09,384 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,384 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:29:09 INFO - 2015-11-13 16:29:09,384 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:29:09 INFO - 2015-11-13 16:29:09,384 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,384 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.50 Median:109.50 stddev:3.84 (3.5%) stddev-sans-first:4.07 16:29:09 INFO - 2015-11-13 16:29:09,384 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 104.0 110.0 110.0 111.0 98.0 108.0 109.0 108.0 16:29:09 INFO - 2015-11-13 16:29:09,384 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,384 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.10 Median:148.50 stddev:15.38 (10.4%) stddev-sans-first:16.11 16:29:09 INFO - 2015-11-13 16:29:09,384 DEBUG : BROWSER_OUTPUT: Values: 149.0 123.0 146.0 159.0 129.0 156.0 148.0 125.0 162.0 124.0 16:29:09 INFO - 2015-11-13 16:29:09,384 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,386 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.73 16:29:09 INFO - 2015-11-13 16:29:09,386 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 161.0 160.0 160.0 160.0 160.0 162.0 161.0 160.0 16:29:09 INFO - 2015-11-13 16:29:09,386 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,386 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.70 Median:73.00 stddev:12.04 (16.5%) stddev-sans-first:12.35 16:29:09 INFO - 2015-11-13 16:29:09,386 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 82.0 95.0 73.0 71.0 72.0 102.0 95.0 73.0 16:29:09 INFO - 2015-11-13 16:29:09,386 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,386 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.70 Median:90.00 stddev:20.52 (22.8%) stddev-sans-first:21.32 16:29:09 INFO - 2015-11-13 16:29:09,386 DEBUG : BROWSER_OUTPUT: Values: 91.0 89.0 136.0 90.0 90.0 90.0 129.0 90.0 90.0 132.0 16:29:09 INFO - 2015-11-13 16:29:09,386 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,386 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 16:29:09 INFO - 2015-11-13 16:29:09,386 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 16:29:09 INFO - 2015-11-13 16:29:09,386 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,386 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 16:29:09 INFO - 2015-11-13 16:29:09,387 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 145.0 145.0 144.0 144.0 146.0 146.0 16:29:09 INFO - 2015-11-13 16:29:09,387 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,387 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:29:09 INFO - 2015-11-13 16:29:09,387 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 95.0 95.0 16:29:09 INFO - 2015-11-13 16:29:09,387 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,387 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:2.92 (5.0%) stddev-sans-first:3.10 16:29:09 INFO - 2015-11-13 16:29:09,387 DEBUG : BROWSER_OUTPUT: Values: 58.0 56.0 58.0 57.0 60.0 59.0 58.0 65.0 55.0 55.0 16:29:09 INFO - 2015-11-13 16:29:09,387 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,388 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.71 (1.0%) stddev-sans-first:0.73 16:29:09 INFO - 2015-11-13 16:29:09,388 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 68.0 68.0 68.0 68.0 68.0 67.0 67.0 68.0 16:29:09 INFO - 2015-11-13 16:29:09,388 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,388 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 16:29:09 INFO - 2015-11-13 16:29:09,388 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 84.0 85.0 84.0 86.0 84.0 83.0 85.0 84.0 16:29:09 INFO - 2015-11-13 16:29:09,388 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,388 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:122.00 stddev:6.35 (5.2%) stddev-sans-first:6.29 16:29:09 INFO - 2015-11-13 16:29:09,389 DEBUG : BROWSER_OUTPUT: Values: 114.0 130.0 116.0 130.0 123.0 115.0 114.0 121.0 125.0 116.0 16:29:09 INFO - 2015-11-13 16:29:09,389 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,389 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:147.00 stddev:6.72 (4.6%) stddev-sans-first:7.06 16:29:09 INFO - 2015-11-13 16:29:09,389 DEBUG : BROWSER_OUTPUT: Values: 149.0 149.0 146.0 147.0 161.0 137.0 146.0 145.0 147.0 137.0 16:29:09 INFO - 2015-11-13 16:29:09,389 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-13 16:29:09,389 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.17 (1.8%) stddev-sans-first:1.24 16:29:09 INFO - 2015-11-13 16:29:09,389 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 65.0 66.0 66.0 64.0 64.0 66.0 68.0 65.0 16:29:09 INFO - 2015-11-13 16:29:09,390 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:29:09 INFO - 2015-11-13 16:29:09,390 DEBUG : BROWSER_OUTPUT: 16:29:10 INFO - 2015-11-13 16:29:10,273 INFO : Browser exited with error code: 0 16:29:10 INFO - 2015-11-13 16:29:10,328 INFO : Completed test kraken (00:00:58) 16:29:10 INFO - 2015-11-13 16:29:10,329 INFO : Starting test v8_7 16:29:10 INFO - 2015-11-13 16:29:10,329 DEBUG : operating with platform_type : linux_ 16:29:10 INFO - 2015-11-13 16:29:10,329 INFO : Initialising browser for v8_7 test... 16:29:10 INFO - 2015-11-13 16:29:10,335 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9vYpq8/profile http://localhost:36041/getInfo.html 16:29:14 INFO - 2015-11-13 16:29:14,209 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:29:14 INFO - 2015-11-13 16:29:14,209 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:29:14 INFO - 2015-11-13 16:29:14,209 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:29:14 INFO - 2015-11-13 16:29:14,209 DEBUG : BROWSER_OUTPUT: __metrics 16:29:14 INFO - 2015-11-13 16:29:14,346 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:29:15 INFO - 2015-11-13 16:29:15,604 INFO : Browser initialized. 16:29:15 INFO - 2015-11-13 16:29:15,604 INFO : Running cycle 1/1 for v8_7 test... 16:29:15 INFO - 2015-11-13 16:29:15,605 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9vYpq8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:29:27 INFO - 2015-11-13 16:29:27,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 140804096 16:29:27 INFO - 2015-11-13 16:29:27,328 DEBUG : BROWSER_OUTPUT: 16:29:48 INFO - 2015-11-13 16:29:48,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36041/tests/v8_7/run.html (next: http://localhost:36041/tests/v8_7/run.html) 16:29:49 INFO - 2015-11-13 16:29:49,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 612884480 16:29:49 INFO - 2015-11-13 16:29:49,028 DEBUG : BROWSER_OUTPUT: 16:29:49 INFO - 2015-11-13 16:29:49,028 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:29:49 INFO - 2015-11-13 16:29:49,028 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:29:49 INFO - 2015-11-13 16:29:49,028 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:29:49 INFO - 2015-11-13 16:29:49,028 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:29:49 INFO - 2015-11-13 16:29:49,029 DEBUG : BROWSER_OUTPUT: |0;Richards;165.0982334489021 16:29:49 INFO - 2015-11-13 16:29:49,029 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.93845263360987 16:29:49 INFO - 2015-11-13 16:29:49,029 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.4858757062147 16:29:49 INFO - 2015-11-13 16:29:49,029 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 16:29:49 INFO - 2015-11-13 16:29:49,029 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1098.901098901099 16:29:49 INFO - 2015-11-13 16:29:49,029 DEBUG : BROWSER_OUTPUT: |5;Earley;800.1598721023181 16:29:49 INFO - 2015-11-13 16:29:49,029 DEBUG : BROWSER_OUTPUT: |6;Boyer;11790.697674418605 16:29:49 INFO - 2015-11-13 16:29:49,029 DEBUG : BROWSER_OUTPUT: |7;RegExp;25500 16:29:49 INFO - 2015-11-13 16:29:49,029 DEBUG : BROWSER_OUTPUT: |8;Splay;660.5019815059445 16:29:49 INFO - 2015-11-13 16:29:49,030 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 16:29:49 INFO - 2015-11-13 16:29:49,030 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:29:49 INFO - 2015-11-13 16:29:49,030 DEBUG : BROWSER_OUTPUT: __startTimestamp1447460989027__endTimestamp 16:29:49 INFO - 2015-11-13 16:29:49,030 DEBUG : BROWSER_OUTPUT: 16:29:49 INFO - 2015-11-13 16:29:49,030 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:29:49 INFO - 2015-11-13 16:29:49,030 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:29:49 INFO - 2015-11-13 16:29:49,030 DEBUG : BROWSER_OUTPUT: 16:29:49 INFO - 2015-11-13 16:29:49,030 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.10 Median:165.10 stddev:0.00 (0.0%) 16:29:49 INFO - 2015-11-13 16:29:49,030 DEBUG : BROWSER_OUTPUT: Values: 165.1 16:29:49 INFO - 2015-11-13 16:29:49,030 DEBUG : BROWSER_OUTPUT: 16:29:49 INFO - 2015-11-13 16:29:49,030 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.94 Median:192.94 stddev:0.00 (0.0%) 16:29:49 INFO - 2015-11-13 16:29:49,031 DEBUG : BROWSER_OUTPUT: Values: 192.9 16:29:49 INFO - 2015-11-13 16:29:49,031 DEBUG : BROWSER_OUTPUT: 16:29:49 INFO - 2015-11-13 16:29:49,031 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.49 Median:282.49 stddev:0.00 (0.0%) 16:29:49 INFO - 2015-11-13 16:29:49,031 DEBUG : BROWSER_OUTPUT: Values: 282.5 16:29:49 INFO - 2015-11-13 16:29:49,031 DEBUG : BROWSER_OUTPUT: 16:29:49 INFO - 2015-11-13 16:29:49,031 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 16:29:49 INFO - 2015-11-13 16:29:49,031 DEBUG : BROWSER_OUTPUT: Values: 5030.2 16:29:49 INFO - 2015-11-13 16:29:49,031 DEBUG : BROWSER_OUTPUT: 16:29:49 INFO - 2015-11-13 16:29:49,031 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1098.90 Median:1098.90 stddev:0.00 (0.0%) 16:29:49 INFO - 2015-11-13 16:29:49,031 DEBUG : BROWSER_OUTPUT: Values: 1098.9 16:29:49 INFO - 2015-11-13 16:29:49,031 DEBUG : BROWSER_OUTPUT: 16:29:49 INFO - 2015-11-13 16:29:49,031 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:800.16 Median:800.16 stddev:0.00 (0.0%) 16:29:49 INFO - 2015-11-13 16:29:49,032 DEBUG : BROWSER_OUTPUT: Values: 800.2 16:29:49 INFO - 2015-11-13 16:29:49,032 DEBUG : BROWSER_OUTPUT: 16:29:49 INFO - 2015-11-13 16:29:49,032 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11790.70 Median:11790.70 stddev:0.00 (0.0%) 16:29:49 INFO - 2015-11-13 16:29:49,032 DEBUG : BROWSER_OUTPUT: Values: 11790.7 16:29:49 INFO - 2015-11-13 16:29:49,032 DEBUG : BROWSER_OUTPUT: 16:29:49 INFO - 2015-11-13 16:29:49,032 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25500.00 Median:25500.00 stddev:0.00 (0.0%) 16:29:49 INFO - 2015-11-13 16:29:49,032 DEBUG : BROWSER_OUTPUT: Values: 25500.0 16:29:49 INFO - 2015-11-13 16:29:49,032 DEBUG : BROWSER_OUTPUT: 16:29:49 INFO - 2015-11-13 16:29:49,032 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:660.50 Median:660.50 stddev:0.00 (0.0%) 16:29:49 INFO - 2015-11-13 16:29:49,032 DEBUG : BROWSER_OUTPUT: Values: 660.5 16:29:49 INFO - 2015-11-13 16:29:49,032 DEBUG : BROWSER_OUTPUT: 16:29:49 INFO - 2015-11-13 16:29:49,032 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 16:29:49 INFO - 2015-11-13 16:29:49,032 DEBUG : BROWSER_OUTPUT: Values: 4830.9 16:29:49 INFO - 2015-11-13 16:29:49,032 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:29:49 INFO - 2015-11-13 16:29:49,032 DEBUG : BROWSER_OUTPUT: 16:29:49 INFO - 2015-11-13 16:29:49,893 INFO : Browser exited with error code: 0 16:29:49 INFO - 2015-11-13 16:29:49,908 INFO : Completed test v8_7 (00:00:39) 16:29:49 INFO - 2015-11-13 16:29:49,981 INFO : Completed test suite (00:20:13) 16:29:49 INFO - 2015-11-13 16:29:49,982 DEBUG : Working with test: dromaeo_css 16:29:49 INFO - 2015-11-13 16:29:49,982 DEBUG : Generating results file: dromaeo_css 16:29:49 INFO - 2015-11-13 16:29:49,983 DEBUG : Working with test: kraken 16:29:49 INFO - 2015-11-13 16:29:49,983 DEBUG : Generating results file: kraken 16:29:49 INFO - 2015-11-13 16:29:49,984 INFO : javascript benchmark 16:29:49 INFO - 2015-11-13 16:29:49,984 DEBUG : Working with test: v8_7 16:29:49 INFO - 2015-11-13 16:29:49,984 DEBUG : Generating results file: v8_7 16:29:49 INFO - 2015-11-13 16:29:49,984 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:29:50 INFO - 2015-11-13 16:29:50,046 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 16:29:50 INFO - 2015-11-13 16:29:50,047 DEBUG : process_Request line: dromaeo_css 6744.78 graph.html#tests=[[72,201,35]] 16:29:50 INFO - 2015-11-13 16:29:50,047 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:29:50 INFO - 2015-11-13 16:29:50,080 DEBUG : process_Request line: kraken 1486.10 graph.html#tests=[[232,201,35]] 16:29:50 INFO - 2015-11-13 16:29:50,080 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:29:50 INFO - 2015-11-13 16:29:50,113 DEBUG : process_Request line: v8_7 20952.41 graph.html#tests=[[230,201,35]] 16:29:50 INFO - 2015-11-13 16:29:50,114 INFO : javascript benchmark 16:29:50 INFO - 2015-11-13 16:29:50,118 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [350.0286704395303, 353.1524341580207, 353.19647801252154, 356.905420063683, 357.73527589583716, 14324.785128223086, 14559.272036398164, 16427.014379137247, 16840.410585629506, 17619.735703964452, 15551.53345399637, 16708.0, 16916.661666766657, 17384.478465646018, 17427.21577529011, 5180.818671346513, 5265.078611243036, 5306.946930530703, 5307.548858347026, 5309.707966061865, 3877.961220387788, 3981.646240278305, 5303.7082960437165, 5338.386085600167, 5639.492445679888, 5731.254936858202, 5736.799212027579, 5760.0, 5760.4527569881, 5768.278965129359, 5337.439568845293, 5349.304590403242, 5354.544863686591, 5456.7544460499175, 5735.397783232763, 5042.067217564762, 5097.490250974873, 5115.693058416507, 5123.897522049576, 5127.410347810012, 20059.39821805348, 20196.79803201964, 20285.695714564292, 20509.589808203753, 21101.788982110134, 2035.1147250945885, 2043.8875861827742, 2118.353902059871, 2129.872207667545, 2446.2905757330354, 13138.146020508731, 13157.144785588906, 13302.543647877972, 13343.266120363376, 13378.130421522666, 1663.9084850333347, 1708.3679038755615, 1770.6281680847037, 1863.6552237836045, 1889.8204670556274, 61365.386346136416, 62094.37905620931, 62248.68875655593, 62333.68833155851, 62363.06455403127, 9324.207442367338, 9734.805303894023, 9739.220862330996, 9779.168770654574, 9801.803963920682, 12535.623931282076, 12622.431990560446, 12622.495100196073, 12649.810252846215, 12656.746865062647, 7543.547387156788, 7601.581912994839, 7601.695932162652, 7669.1947345527915, 7681.884771728429, 7415.369693575999, 7439.181690014094, 7444.813879653052, 7467.141278753013, 7521.323080922633, 5796.449337312949, 5858.56060795442, 5867.119932010232, 5869.706514674249, 5880.147378630075, 1640.9835901640831, 1681.7057015022322, 1725.1632958015352, 1728.2914005257785, 1829.4603092087866, 417.99263774303785, 429.2166795598046, 433.09915376017807, 450.40096671426926, 916.6562539047857, 10314.793704125876, 10387.324823886423, 10422.21833362501, 10438.217133715001, 10716.946415267874, 391.54580686403636, 401.65658362100567, 436.1255682356854, 440.872147077344, 446.6940145999935, 5606.495415412633, 5630.07103827872, 5790.276215473066, 5847.386024467455, 5884.499817515559, 555245.0, 581588.0, 591837.0, 602584.0, 609195.0, 76526.23473765192, 78608.0, 78739.21260787318, 78771.0, 79013.0, 463.69164505603396, 469.01974872516604, 469.1836205003338, 469.55392377241077, 470.03173462667013, 9681.467519286507, 9805.088007838403, 9886.357386769838, 9948.900510995087, 10058.798824023332, 35235.29529409449, 35467.0, 35850.46224306586, 36129.83221006748, 36281.91154265376, 47972.76013620049, 49449.505504945926, 49845.0, 49926.50073499219, 49969.00061998667, 6747.291534388818, 6780.0, 6872.518923675295, 6941.895871562032, 6962.338577835098, 12448.377581121089, 12782.808257876326, 12806.295653738762, 12907.161034532724, 12910.612681619567, 11008.229423940567, 11215.383153926612, 11248.100151987985, 11260.436978150896, 11261.887381126411, 10672.252942293964, 10810.729731756768, 10985.725356866142, 11024.228304018641, 11232.3260604364, 10937.890621093688, 10993.61522346714, 11067.114630829676, 11111.944440277746, 11177.73358267274, 6688.7324507019175, 6824.112865327475, 6843.178818541807, 6884.48366372514, 6888.0356750056035, 10973.945130274298, 11057.336559806437, 11186.83219751688, 11188.776224475301, 11207.831882521605], "dojo.html": [3195.5046967720004, 3289.4079065768183, 3326.168457885529, 3342.4317865962785, 3352.9605822195113, 5278.12910869707, 5397.136458166694, 5444.40111587725, 5471.644343117695, 5511.972440137799, 5282.181261904411, 5365.812196573121, 5399.78400863965, 5491.203775452567, 5602.635828671134, 5008.674436161647, 5088.389393272794, 5126.615503837208, 5129.0, 5183.766730497136, 4807.543283388072, 5088.440271570143, 5111.258867464216, 5179.482051794809, 5182.300389447433, 4875.366202393701, 4903.0, 4957.355543779322, 4974.0797952378925, 4976.104301225778, 5024.522670346311, 5047.64666473347, 5071.0365030644425, 5078.64449488536, 5091.465396133427, 4900.460949295574, 5019.996000799854, 5037.471065538102, 5038.496150384969, 5054.3176671149295, 5319.946800531984, 5432.266644003049, 5437.6465529740835, 5446.809361672323, 5452.073147564924, 5965.463108320272, 6003.0695242237525, 6009.729562169713, 6011.218541589609, 6019.879602407971, 5816.185733997244, 5866.882662346772, 5915.911261331084, 6021.909671354933, 6043.576949613529, 5669.688167150805, 5670.092785154356, 5680.346760122557, 5691.743871525791, 5691.857703557403, 6116.571839971249, 6116.755329786759, 6129.11127886454, 6131.583543324803, 6137.202163718688, 5680.0627896397455, 5787.102999035156, 5789.160571717078, 5901.439363260483, 5950.651676450156, 5947.583669143205, 6018.608790428696, 6021.066734656135, 6034.215551978303, 6034.5172386209, 6003.489703375262, 6004.0693692477735, 6004.249468816398, 6005.519558435315, 6011.12838638395, 5758.971205143947, 5775.884482310415, 5838.737256823453, 5882.941170588325, 5911.674857882772, 4517.232070548015, 4521.231390663595, 4542.613877820422, 4550.0217453247715, 4564.269716845355, 3912.7847968361443, 4015.819288132041, 4031.2139132869397, 4036.9394459083137, 4060.4721386219603, 5547.583931205176, 5583.832485025456, 5673.404292549306, 5686.9715651421475, 5728.51307638847, 6008.579399441997, 6010.939890601038, 6021.066734656135, 6022.36765139654, 6026.668533230627, 5381.354237491526, 5462.8361149165585, 5665.490105890407, 5671.319441667027, 5673.971630141823, 5126.4617215191865, 5208.140656791663, 5209.635325527177, 5220.190870415092, 5241.187615919539, 6153.384661533811, 6153.753849846045, 6160.10678451622, 6161.907571386433, 6163.506919446433, 5760.539156867524, 5776.653400795965, 5894.911576326273, 5933.139694744152, 5934.258217722785, 6249.96875015622, 6250.937490625218, 6251.843703907439, 6264.59280146789, 6270.874582508415, 5910.261217347832, 5927.407259274038, 5931.7627294907725, 5941.851453713692, 5970.432808883149, 5695.7436915338085, 5796.449337312949, 5875.50058245054, 5977.282726072899, 6015.368386319374, 5770.855728606818, 5865.618734782225, 5868.413158684098, 5868.735906884286, 5870.442307980735, 5823.475887170175, 5835.854103647443, 5848.152017957287, 5857.47282744555, 5861.208736820645, 5549.833504994856, 5550.417206193291, 5619.606627536196, 5644.435556444323, 5672.2058911751565, 5790.334111577223, 5810.941890581209, 5817.6509409433875, 5825.2135961644635, 5873.5594830388745, 5411.053065713563, 5696.20253164549, 5700.030994730989, 5714.685692286964, 5725.227094342377], "mootools.html": [1552.9844701552981, 1681.8234085421032, 1730.8009578898423, 1742.7647267618868, 1760.9295628174866, 6586.670666466675, 7563.848723025543, 7765.456418050725, 7772.689092436302, 7782.610869456518, 7580.241975802417, 7695.038120234971, 7703.46075774696, 7710.884336734954, 7714.768556943287, 1993.362124120282, 2026.0275067967384, 2290.576243394969, 2302.8503147295414, 2323.1288266899915, 2319.675245465636, 2326.9418264543438, 2328.6972693549815, 2331.440454290975, 2331.8717470539113, 2214.1143542583013, 2253.785890340415, 2262.6492893601435, 2272.0, 2275.920342788003, 1954.364831429791, 1994.1026538057858, 2184.748753893307, 2213.822894168463, 2218.0462401167492, 2273.73852007018, 2276.2374604507345, 2295.116380193621, 2299.8275129365197, 2337.1936681844736, 7760.650770715331, 7840.13758486566, 7840.725574604919, 7843.098043724987, 7849.8037549061155, 4655.790489427984, 4726.291056341542, 4747.881302967419, 4748.572628463455, 4751.263554149078, 2896.435195136949, 3019.3357461358464, 3022.909312720622, 3053.282478617523, 3063.9540406893916, 892.2950868813695, 903.3766700976371, 926.4811705444972, 940.3840484482674, 959.5825815770162, 10644.148468122532, 10793.29843560166, 10794.78410431787, 10802.0, 10808.945955270252, 4148.460700108966, 4200.411942328076, 4205.053862880888, 4227.260229459832, 4314.848980285675, 8746.081661425585, 8753.824923501494, 8756.299496040301, 8758.2993360531, 8762.86855697165, 4658.906821863611, 4673.976630116827, 4675.4389473262745, 4676.836310729108, 4679.3916790816975, 4259.0204253021975, 4310.137972405531, 4311.396404503372, 4311.935320970188, 4317.870463886088, 3402.319536092791, 3432.3478539077496, 3436.261203841186, 3442.9311413771584, 3470.9826450867586, 1041.068243921686, 1047.4239168457318, 1076.0100707349102, 1089.5478376473834, 1100.1803656275965, 983.6606370802061, 1225.9509619615294, 1243.3720970909633, 1245.1906260930468, 1248.4194849395076, 6982.1272340957385, 7013.89479157813, 7040.331168538981, 7083.89374159388, 7121.89317160243, 556.8691357530977, 688.3323176518769, 702.2626242445514, 707.3280383635566, 716.4304378019488, 5382.703951282639, 5487.835364938978, 5492.313460817398, 5495.340559132929, 5497.312835895513, 9096.454212747256, 9147.679831205876, 9250.21373183287, 9294.163525282756, 9361.531923403803, 9236.168744813, 9268.119528644767, 9313.674021409219, 9316.767080823034, 9319.347645664739, 7065.258147894397, 7155.0, 7159.67781449836, 7176.102987126609, 7238.819029524198, 6677.69950352245, 6700.731970721116, 6719.092922455406, 6722.731090756315, 6726.0, 7726.806829829299, 7920.485168464032, 8030.43786934909, 8045.87931181021, 8046.678132874619, 8211.95894020526, 8341.24928756415, 8456.112108228548, 8497.490150590984, 8530.10433904456, 6410.423061924449, 6447.70985305653, 6530.379613936669, 6542.869142617026, 6558.049082883051, 7341.0, 7394.963025184839, 7406.629668516661, 7410.629468526445, 7419.035525381882, 6817.659117044029, 6883.621400822803, 6888.758893438706, 7028.016077749017, 7035.261297563682, 6867.381935625817, 6873.862522749617, 6944.2986468315585, 6974.61639609806, 6992.1259842519685, 6142.938570614237, 6632.801015969529, 6735.696893639896, 6761.86476270462, 6778.254392016973, 6102.0, 6223.315435302204, 6277.435030847246, 6281.7173227203975, 6313.116163736989, 6305.274893387319, 6316.3367846377305, 6327.715252813542, 6332.873342533216, 6343.238811342669], "ext.html": [571.9771209151634, 587.5505238492551, 595.2470125291504, 608.7139044649015, 613.806650904965, 31404.0, 39374.40938385927, 39925.0, 39972.200555988864, 40024.59975400249, 44134.33798493025, 44244.009019594116, 44320.55679443204, 44509.7774511127, 44535.55464445354, 7720.691172353099, 7856.685732570691, 8656.567171641424, 8795.0, 8840.734777956672, 10446.738831529197, 10683.519241634145, 10683.572657093708, 10684.839727404094, 10685.038346548808, 10319.638812641559, 10356.067953884149, 10409.167266618653, 10411.0, 10424.530896109693, 7793.142754297051, 7938.6427610757655, 10303.896961030407, 10468.842967355497, 10737.78524429507, 10223.131033862132, 10354.119899808526, 10362.0, 10362.326448780805, 10364.637237696645, 40493.0, 40766.796166019274, 40769.592304076876, 40792.79603601993, 40855.38716919249, 3003.519436890087, 3017.1551965449707, 3121.687831216883, 3123.3440977394775, 3131.62420509538, 32601.836990815133, 32934.6706532934, 32994.17514562131, 33068.3386332272, 33214.0, 3123.7344825689843, 3174.5716906751386, 3198.056573310879, 3260.3968265870653, 3284.4088064148445, 277758.0, 278752.0, 279753.0, 280105.0, 280121.0, 53611.73194134004, 61743.0, 62212.68893655593, 62228.0, 62248.68875655683, 49928.75035624798, 72752.2724772756, 73805.6309718448, 74274.25725742674, 74309.0, 15678.529644110695, 15927.124008179662, 16080.758788618181, 16081.758773618405, 16106.436274730562, 11150.721231969266, 11290.379029153475, 11312.773744525064, 11322.490487928064, 11323.490442930088, 20572.79427205739, 20766.377008689764, 20806.58386832255, 20827.166913323297, 20842.37472875816, 8037.557934313552, 8255.834883302301, 8293.668253269801, 8298.294644955246, 8327.875081873777, 792.3938187286731, 943.9952800236092, 957.4686049242737, 968.8159249742667, 1043.0299821166236, 29002.27494312617, 29023.854880725463, 29260.853695731385, 29330.706692932796, 32304.0, 1002.4636819301638, 1023.8720159980003, 1037.3257382701304, 1047.8952104789612, 1073.9516721747384, 14958.850411495963, 14962.70074598502, 15086.321115549827, 15369.308381122877, 15382.461613843461, 443866.0, 447248.0, 449014.0, 449269.0, 451611.0, 55943.44056559464, 56331.43668563344, 56410.0, 56482.7175864118, 56485.43514564884, 1329.7739384304691, 1330.1088270858547, 1354.4988354308969, 1357.2535105692027, 1358.2122369026138, 24140.87929560341, 24261.393465163514, 28403.573946391232, 29022.709772902002, 29157.0, 50992.23511647254, 51589.484105158466, 51613.22580161226, 51883.74058129685, 52041.21938171006, 316383.0, 318747.0, 319216.0, 319863.0, 319918.0, 28145.296367590156, 28657.856710716314, 31839.522407164375, 31862.0, 33483.83258083694, 37799.433008505446, 37855.0, 38077.0, 38516.229675406896, 38603.80698096492, 32245.67754322427, 32719.0, 32789.0, 32848.17879552935, 32999.835000824845, 33202.33595328128, 33628.66371336353, 33820.15449613681, 33821.492677610346, 33954.49068264027, 35177.29645407027, 35702.642973569935, 36111.27777444489, 36201.275974480886, 36210.637893620726, 29997.850010749808, 31004.0, 32038.359232814746, 32224.83887580547, 32226.83886580552, 23834.0, 24367.26898193057, 24417.51164976655, 24482.265532034067, 24714.0], "prototype.html": [318.90273466592697, 318.91708155879473, 321.6285190604849, 322.16398446032537, 322.75631897917077, 5866.061430171173, 6022.909656355153, 6030.909536356952, 6079.270487541496, 6080.209572755535, 5942.168096466487, 6037.39626037396, 6058.757649694018, 6059.757609695607, 6062.969685151579, 4333.8699839004885, 4472.82108715651, 4621.79201935912, 4635.169108202258, 4644.34979102925, 4460.0, 4527.977360113195, 4535.818567257305, 4545.181867263891, 4549.749763762991, 4501.617362524189, 4521.2819128731035, 4532.9093418131615, 4538.659600529957, 4548.2495388260895, 4527.275635898273, 4552.044070745131, 4553.612942899857, 4554.7039442436135, 4554.977225113887, 3868.071662800936, 3961.1483531040676, 3961.841526338972, 3964.226975739732, 3968.960310396888, 5736.713164341808, 5741.45456181662, 5750.597458177929, 5751.539876809845, 5766.163906233573, 5260.473952604747, 5295.0468915595175, 5303.071962406563, 5306.5754739621125, 5310.814121505768, 6180.81457556274, 6243.8126856194385, 6261.342559031282, 6401.391867772554, 6403.327650596667, 4339.631131353839, 4342.522322544518, 4363.738175709467, 4371.016521282718, 4379.671524635665, 6714.697838597226, 6718.2868368565705, 6722.49581281401, 6724.2603313635955, 6725.93274067258, 4363.672724545609, 4455.287154055336, 4455.509893911667, 4456.77716114193, 4457.910841783146, 4522.095580883836, 4524.276115821453, 4526.207913615104, 4530.07133537624, 4543.954560454419, 5272.523693365863, 5278.419373868871, 5279.8152064678325, 5286.07493688603, 5287.23335116406, 6494.155759751202, 6496.577722448026, 6503.187101612299, 6504.869902601921, 6505.21937367519, 1603.7514185301297, 1611.4198888400167, 1636.6808472347777, 1640.8277130901322, 1645.1691895592649, 1041.6406339812752, 1056.9735756605992, 1064.0902028765295, 1067.3755852826184, 1072.2065671403107, 6247.0629405589525, 6280.968595157086, 6282.1519094921605, 6283.183186185766, 6297.338779428185, 6696.430803381767, 6698.0, 6707.329267073351, 6709.060731497594, 6713.12729345182, 6154.907676384768, 6288.339724328879, 6291.150694656163, 6291.213598300213, 6293.842653933688, 3601.081724160322, 3635.163912300186, 3635.654612811779, 3638.3632864248652, 3642.307961487309, 6950.6177160256675, 6965.721371145199, 6980.30196980308, 7008.439324853999, 7017.263187365355, 6673.366030227121, 6784.932150678529, 6793.0, 6797.626130562867, 6809.353111454404, 6957.860842783116, 6963.303669633097, 6964.4080253179045, 6989.266127056688, 6995.965020174968, 6482.448991835747, 6576.80269591913, 6612.669366531558, 6808.659567021728, 6809.421199198124, 6707.564008339442, 6719.294474080347, 6726.091977583159, 6727.192736871607, 6739.258681545124, 6953.687084081127, 7042.57744535309, 7094.077769889881, 7104.786856394317, 7110.253423390676, 4518.073794872109, 4519.050999290186, 4526.592606665416, 4527.705699129546, 4534.614557762628, 6786.3892249697765, 6787.185537735503, 6792.796216113525, 6801.89797153053, 6802.455803535804, 6417.582857114459, 6601.075849380994, 6608.041833933957, 6610.272869984202, 6616.4045235929, 6596.571222870498, 6600.372964568551, 6600.471962243105, 6601.735930562723, 6603.504737144829, 6411.871762564816, 6417.582857114273, 6419.743210271537, 6421.454176395058, 6421.93578064232, 6522.967385163044, 6626.602403855784, 6627.536072474881, 6629.105070815378, 6637.734490620321, 6469.838254043687, 6469.8706025880165, 6478.546501744832, 6484.221893372825, 6486.286508483969], "yui.html": [762.5500954436883, 785.4266385538555, 796.6056801883069, 817.4563914996531, 830.0650349997521, 10493.527791249393, 10711.946440267788, 10736.624218152367, 10755.78488430233, 10756.515956781945, 13284.800727989088, 13306.667333316647, 13419.798703019438, 14305.856941430582, 14474.131552106881, 667.4860357524703, 796.1043825696078, 808.3412019204329, 808.5310519898475, 809.2554849538409, 673.0812441017999, 802.0936341933607, 812.8577498937663, 813.6257321632056, 815.0260438775665, 828.0312034919159, 846.3440833354169, 846.8306338732248, 847.3814115695546, 847.9576021198947, 687.7833482453036, 699.622204009834, 822.005373498068, 825.455199568285, 828.7430896422098, 611.8348046027547, 614.8493619063313, 615.9414855588711, 615.9876802463971, 617.1452538234532, 13198.406071726795, 13656.385462654105, 13665.385057672329, 13691.246981416018, 13715.794263086062, 9271.304652151115, 9360.53197340137, 9362.25101991839, 9494.367199828801, 9652.324337296392, 8618.482891026559, 8752.606132724042, 8867.778305542348, 9077.36458447909, 9186.0, 3092.4897391930303, 3108.098651391094, 3125.6718044605445, 3216.4210442120407, 3248.431524483206, 43952.78023609894, 44238.557614423764, 45134.0, 45179.096418071786, 45213.0, 6368.808935731843, 6392.84017899547, 6411.967940160363, 6534.248561415498, 6607.735690572419, 11666.475008624462, 11698.239614425034, 11703.648890533297, 11709.76580468403, 11713.648590542298, 6317.810465686037, 6398.968005159944, 6410.102585638015, 6453.193350831146, 6540.901886471706, 4153.1070819773895, 4165.729227600257, 4175.603317684815, 4200.831966721358, 4208.36874468826, 2605.71337152913, 2612.869356532166, 2620.947581048368, 2628.855412952306, 2634.051741373104, 423.65472140205634, 424.16862948620434, 424.21096760026325, 436.8492869959859, 441.40190042491963, 499.91251530981936, 531.6836482293029, 569.7436153730838, 596.4751019103162, 638.4764493115694, 7339.88990165148, 7799.259070388304, 7965.203479652105, 8103.230193131643, 8190.672373105128, 558.9608727389044, 571.2117278156201, 598.9431004054608, 616.7717944360616, 629.1506466270498, 3503.2292895562937, 3681.0981309578788, 3866.2267546490816, 3896.551896531935, 3898.2593307271527, 58531.70734146387, 58977.115343269885, 59087.11369329463, 59270.0, 59847.70076149679, 50709.23936140961, 50980.0, 51255.231171532454, 51508.96982060338, 51886.22170667443, 48237.0, 48306.5169348302, 48505.272420913716, 48532.0, 48826.75586622115, 7609.429292802951, 7787.805304867424, 7910.68357265726, 8012.278894899487, 8037.196280371916, 32831.67168328286, 34241.486377703855, 34417.48373774345, 34558.308833823685, 35205.471917921765, 42895.0, 43669.78165109154, 43708.0, 43771.12457750891, 44814.77592612016, 7115.466340024623, 7206.051930494104, 7242.751506618287, 7257.383122434652, 7263.709451621876, 10780.245382823441, 10889.564417423215, 10999.0, 11467.0, 11513.769724605294, 9503.857442138235, 9673.854892176763, 9820.950895245478, 9866.703998880044, 10193.490325483548, 9533.545057562469, 9548.37935534188, 9572.521373931415, 9648.0, 9952.651657191964, 7990.040631478941, 8766.736997890073, 9271.119243671841, 9703.805923881342, 9708.174805141642, 8390.160983901562, 8490.490570565786, 8541.91458085436, 8615.483071015758, 8716.128387161232, 7732.729354472566, 8117.878231826409, 8162.387820913574, 8227.177282271725, 8411.3270938326]}, "summary": {"lowerIsBetter": false, "suite": 6744.784496726397, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7696.190915391, "unit": "ms", "value": 7696.190915391}, "dojo.html": {"lowerIsBetter": false, "filtered": 5473.742485235333, "unit": "ms", "value": 5473.742485235333}, "mootools.html": {"lowerIsBetter": false, "filtered": 4333.974500827786, "unit": "ms", "value": 4333.974500827786}, "ext.html": {"lowerIsBetter": false, "filtered": 18974.379537255787, "unit": "ms", "value": 18974.379537255787}, "prototype.html": {"lowerIsBetter": false, "filtered": 4847.501000472527, "unit": "ms", "value": 4847.501000472527}, "yui.html": {"lowerIsBetter": false, "filtered": 5605.790320769616, "unit": "ms", "value": 5605.790320769616}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-039"}, "testrun": {"date": 1447459776, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113143006", "branch": "B2G-Inbound", "revision": "683059d91038fe69139456a4094ff3be47574d90"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 160.0, 161.0, 160.0, 160.0, 160.0, 160.0, 162.0, 161.0, 160.0], "ai-astar": [108.0, 109.0, 104.0, 110.0, 110.0, 111.0, 98.0, 108.0, 109.0, 108.0], "imaging-gaussian-blur": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0], "audio-beat-detection": [149.0, 123.0, 146.0, 159.0, 129.0, 156.0, 148.0, 125.0, 162.0, 124.0], "json-stringify-tinderbox": [67.0, 66.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 68.0], "stanford-crypto-pbkdf2": [149.0, 149.0, 146.0, 147.0, 161.0, 137.0, 146.0, 145.0, 147.0, 137.0], "json-parse-financial": [58.0, 56.0, 58.0, 57.0, 60.0, 59.0, 58.0, 65.0, 55.0, 55.0], "stanford-crypto-sha256-iterative": [66.0, 66.0, 65.0, 66.0, 66.0, 64.0, 64.0, 66.0, 68.0, 65.0], "audio-fft": [72.0, 72.0, 82.0, 95.0, 73.0, 71.0, 72.0, 102.0, 95.0, 73.0], "imaging-darkroom": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0, 144.0, 146.0, 146.0], "stanford-crypto-ccm": [114.0, 130.0, 116.0, 130.0, 123.0, 115.0, 114.0, 121.0, 125.0, 116.0], "audio-oscillator": [91.0, 89.0, 136.0, 90.0, 90.0, 90.0, 129.0, 90.0, 90.0, 132.0], "stanford-crypto-aes": [84.0, 84.0, 84.0, 85.0, 84.0, 86.0, 84.0, 83.0, 85.0, 84.0], "imaging-desaturate": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1486.1000000000001, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.7, "unit": "ms", "value": 80.7}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 146.4, "unit": "ms", "value": 146.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 142.1, "unit": "ms", "value": 142.1}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 120.4, "unit": "ms", "value": 120.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.0, "unit": "ms", "value": 145.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 58.1, "unit": "ms", "value": 58.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.7, "unit": "ms", "value": 102.7}, "ai-astar": {"lowerIsBetter": true, "filtered": 107.5, "unit": "ms", "value": 107.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.6, "unit": "ms", "value": 160.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 65.6, "unit": "ms", "value": 65.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.5, "unit": "ms", "value": 67.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.3, "unit": "ms", "value": 109.3}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.3, "unit": "ms", "value": 84.3}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.9, "unit": "ms", "value": 95.9}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-039"}, "testrun": {"date": 1447459776, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113143006", "branch": "B2G-Inbound", "revision": "683059d91038fe69139456a4094ff3be47574d90"}}, {"talos_counters": {}, "results": {"DeltaBlue": [192.93845263360987], "Encrypt": [282.4858757062147], "NavierStokes": [4830.917874396136], "Decrypt": [5030.150753768844], "Splay": [660.5019815059445], "Richards": [165.0982334489021], "RegExp": [25500.0], "Earley": [800.1598721023181], "Boyer": [11790.697674418605], "RayTrace": [1098.901098901099]}, "summary": {"lowerIsBetter": false, "suite": 20952.414083975647, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 342.689594, "unit": "score", "value": 342.689594}, "Encrypt": {"lowerIsBetter": false, "filtered": 942.2807399999999, "unit": "score", "value": 942.2807399999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.91710189810189, "unit": "score", "value": 52.91710189810189}, "Splay": {"lowerIsBetter": false, "filtered": 123.37737399999997, "unit": "score", "value": 123.37737399999997}, "RegExp": {"lowerIsBetter": false, "filtered": 35.72490196078431, "unit": "score", "value": 35.72490196078431}, "Richards": {"lowerIsBetter": false, "filtered": 213.824214, "unit": "score", "value": 213.824214}, "Earley": {"lowerIsBetter": false, "filtered": 832.9123006993004, "unit": "score", "value": 832.9123006993004}, "Boyer": {"lowerIsBetter": false, "filtered": 56.524475345167694, "unit": "score", "value": 56.524475345167694}, "RayTrace": {"lowerIsBetter": false, "filtered": 673.3899900000001, "unit": "score", "value": 673.3899900000001}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-039"}, "testrun": {"date": 1447459776, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113143006", "branch": "B2G-Inbound", "revision": "683059d91038fe69139456a4094ff3be47574d90"}}] 16:29:50 INFO - RETURN: dromaeo_css: 6744.78 16:29:50 INFO - RETURN: kraken: 1486.10 16:29:50 INFO - RETURN: v8_7: 20952.41 16:29:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20952.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1486.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6744.78"}}} 16:29:50 INFO - Return code: 0 16:29:50 INFO - # TBPL SUCCESS # 16:29:50 INFO - Running post-action listener: _resource_record_post_action 16:29:50 INFO - Running post-run listener: _resource_record_post_run 16:29:51 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8192; Write bytes: 510558208; Read time: 752; Write time: 759916 16:29:51 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 161775616; Read time: 0; Write time: 157460 16:29:51 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8192; Write bytes: 305864704; Read time: 752; Write time: 470000 16:29:51 INFO - Running post-run listener: _upload_blobber_files 16:29:51 INFO - Blob upload gear active. 16:29:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:29:51 INFO - Copying logs to upload dir... 16:29:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1260.735869 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-13 16:29:51.181171) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 16:29:51.184555) ========= 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=6e558709db315bacd2260379000001b6-1447456499.376036-2115906253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010295 build_url: 'https://queue.taskcluster.net/v1/task/ecVYbl1fQs2yOHrtAYmyvg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 16:29:51.241500) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 16:29:51.242282) ========= 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=6e558709db315bacd2260379000001b6-1447456499.376036-2115906253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 16:29:51.294050) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 16:29:51.294770) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 16:29:51.295427) ========= ========= Total master_lag: 0.23 =========