builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1447673269.2 results: success (0) buildid: 20151116013046 builduid: 954ab97b260d4137a304438355743b65 revision: 74a949559633b776a2509e7cd6ffd5b3d81e1ff3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:49.201702) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:49.202248) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:49.202553) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009005 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:49.242931) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:49.243259) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:49.269039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:49.269467) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015388 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:49.319973) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:49.320330) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:49.320726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:49.321032) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 03:27: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2015-11-16 03:27:49 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.202482 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:49.537543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:49.537897) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.038153 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:49.589067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:49.589473) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 74a949559633b776a2509e7cd6ffd5b3d81e1ff3 --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/mozilla-inbound --rev 74a949559633b776a2509e7cd6ffd5b3d81e1ff3 --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=fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 03:27:49,953 truncating revision to first 12 chars 2015-11-16 03:27:49,954 Setting DEBUG logging. 2015-11-16 03:27:49,954 attempt 1/10 2015-11-16 03:27:49,954 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/74a949559633?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 03:27:50,202 unpacking tar archive at: mozilla-inbound-74a949559633/testing/mozharness/ program finished with exit code 0 elapsedTime=0.518438 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:50.122109) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:50.122433) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:50.144367) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:50.144769) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 03:27:50.145227) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-11-16 03:27:50.145523) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-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=fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:27:50 INFO - MultiFileLogger online at 20151116 03:27:50 in /builds/slave/test-pgo 03:27:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:27:50 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:27:50 INFO - {'append_to_log': False, 03:27:50 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:27:50 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:27:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:27:50 INFO - 'branch': 'Mozilla-Inbound', 03:27:50 INFO - 'buildbot_json_path': 'buildprops.json', 03:27:50 INFO - 'config_files': ('talos/linux_config.py',), 03:27:50 INFO - 'default_actions': ('clobber', 03:27:50 INFO - 'read-buildbot-config', 03:27:50 INFO - 'download-and-extract', 03:27:50 INFO - 'populate-webroot', 03:27:50 INFO - 'create-virtualenv', 03:27:50 INFO - 'install', 03:27:50 INFO - 'run-tests'), 03:27:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:27:50 INFO - 'download_minidump_stackwalk': True, 03:27:50 INFO - 'download_symbols': 'ondemand', 03:27:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:27:50 INFO - 'tooltool.py': '/tools/tooltool.py', 03:27:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:27:50 INFO - '/tools/misc-python/virtualenv.py')}, 03:27:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:27:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:27:50 INFO - 'installer_path': 'installer.exe', 03:27:50 INFO - 'log_level': 'info', 03:27:50 INFO - 'log_name': 'talos', 03:27:50 INFO - 'log_to_console': True, 03:27:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:27:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:27:50 INFO - 'opt_config_files': (), 03:27:50 INFO - 'pip_index': False, 03:27:50 INFO - 'sps_profile': False, 03:27:50 INFO - 'sps_profile_interval': 0, 03:27:50 INFO - 'suite': 'dromaeojs-e10s', 03:27:50 INFO - 'system_bits': '64', 03:27:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:27:50 INFO - 'title': 'talos-linux64-ix-020', 03:27:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:27:50 INFO - 'use_talos_json': True, 03:27:50 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:27:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:27:50 INFO - 'work_dir': 'build'} 03:27:50 INFO - ##### 03:27:50 INFO - ##### Running clobber step. 03:27:50 INFO - ##### 03:27:50 INFO - Running pre-action listener: _resource_record_pre_action 03:27:50 INFO - Running main action method: clobber 03:27:50 INFO - rmtree: /builds/slave/test-pgo/build 03:27:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:27:51 INFO - Running post-action listener: _resource_record_post_action 03:27:51 INFO - ##### 03:27:51 INFO - ##### Running read-buildbot-config step. 03:27:51 INFO - ##### 03:27:51 INFO - Running pre-action listener: _resource_record_pre_action 03:27:51 INFO - Running main action method: read_buildbot_config 03:27:51 INFO - Using buildbot properties: 03:27:51 INFO - { 03:27:51 INFO - "properties": { 03:27:51 INFO - "buildnumber": 191, 03:27:51 INFO - "product": "firefox", 03:27:51 INFO - "script_repo_revision": "production", 03:27:51 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 03:27:51 INFO - "repository": "", 03:27:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 03:27:51 INFO - "buildid": "20151116013046", 03:27:51 INFO - "slavename": "talos-linux64-ix-020", 03:27:51 INFO - "pgo_build": "True", 03:27:51 INFO - "basedir": "/builds/slave/test-pgo", 03:27:51 INFO - "project": "", 03:27:51 INFO - "platform": "ubuntu64_hw", 03:27:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:27:51 INFO - "slavebuilddir": "test", 03:27:51 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:27:51 INFO - "branch": "mozilla-inbound", 03:27:51 INFO - "repo_path": "integration/mozilla-inbound", 03:27:51 INFO - "stage_platform": "linux64-pgo", 03:27:51 INFO - "builduid": "954ab97b260d4137a304438355743b65", 03:27:51 INFO - "revision": "74a949559633b776a2509e7cd6ffd5b3d81e1ff3" 03:27:51 INFO - }, 03:27:51 INFO - "sourcestamp": { 03:27:51 INFO - "repository": "", 03:27:51 INFO - "hasPatch": false, 03:27:51 INFO - "project": "", 03:27:51 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 03:27:51 INFO - "changes": [ 03:27:51 INFO - { 03:27:51 INFO - "category": null, 03:27:51 INFO - "files": [ 03:27:51 INFO - { 03:27:51 INFO - "url": null, 03:27:51 INFO - "name": "https://queue.taskcluster.net/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:27:51 INFO - } 03:27:51 INFO - ], 03:27:51 INFO - "repository": "", 03:27:51 INFO - "rev": "74a949559633b776a2509e7cd6ffd5b3d81e1ff3", 03:27:51 INFO - "who": "sendchange", 03:27:51 INFO - "when": 1447673201, 03:27:51 INFO - "number": 6665500, 03:27:51 INFO - "comments": "", 03:27:51 INFO - "project": "", 03:27:51 INFO - "at": "Mon 16 Nov 2015 03:26:41", 03:27:51 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 03:27:51 INFO - "revlink": "", 03:27:51 INFO - "properties": [ 03:27:51 INFO - [ 03:27:51 INFO - "buildid", 03:27:51 INFO - "20151116013046", 03:27:51 INFO - "Change" 03:27:51 INFO - ], 03:27:51 INFO - [ 03:27:51 INFO - "builduid", 03:27:51 INFO - "954ab97b260d4137a304438355743b65", 03:27:51 INFO - "Change" 03:27:51 INFO - ], 03:27:51 INFO - [ 03:27:51 INFO - "pgo_build", 03:27:51 INFO - "True", 03:27:51 INFO - "Change" 03:27:51 INFO - ] 03:27:51 INFO - ], 03:27:51 INFO - "revision": "74a949559633b776a2509e7cd6ffd5b3d81e1ff3" 03:27:51 INFO - } 03:27:51 INFO - ], 03:27:51 INFO - "revision": "74a949559633b776a2509e7cd6ffd5b3d81e1ff3" 03:27:51 INFO - } 03:27:51 INFO - } 03:27:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:27:51 INFO - Running post-action listener: _resource_record_post_action 03:27:51 INFO - ##### 03:27:51 INFO - ##### Running download-and-extract step. 03:27:51 INFO - ##### 03:27:51 INFO - Running pre-action listener: _resource_record_pre_action 03:27:51 INFO - Running main action method: download_and_extract 03:27:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:27: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')]} 03:27:51 INFO - https://queue.taskcluster.net/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:27:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/test_packages.json 03:27:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/test_packages.json 03:27:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:27:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:27:56 INFO - Downloaded 1302 bytes. 03:27:56 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:27:56 INFO - Using the following test package requirements: 03:27:56 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:27:56 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:27:56 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:56 INFO - u'jsshell-linux-x86_64.zip'], 03:27:56 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:27:56 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:27:56 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:27:56 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:27:56 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:27:56 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:27:56 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:27:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:56 INFO - https://queue.taskcluster.net/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:27:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:27:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:27:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/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 03:27:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/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 03:28:05 INFO - Downloaded 22462169 bytes. 03:28:05 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 03:28:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:28:05 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 03:28:06 INFO - Return code: 0 03:28:06 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 03:28: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')]} 03:28:06 INFO - https://queue.taskcluster.net/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:28:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:28:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:28:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/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 03:28:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/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 03:28:09 INFO - Downloaded 22462169 bytes. 03:28:09 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 03:28:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:28:09 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 03:28:10 INFO - Return code: 0 03:28:10 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')]} 03:28:10 INFO - https://queue.taskcluster.net/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:28:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:28:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:28:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/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 03:28:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/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 03:28:11 INFO - Downloaded 11131693 bytes. 03:28:11 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 03:28:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:28:11 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 03:28:11 INFO - Return code: 0 03:28: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')]} 03:28:11 INFO - https://queue.taskcluster.net/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:28:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:28:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:28:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/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 03:28:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eC-NysARQSikkaht8LNKrg/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 03:28:15 INFO - Downloaded 57154026 bytes. 03:28:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:28:15 INFO - mkdir: /builds/slave/test-pgo/properties 03:28:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:28:15 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:28:15 INFO - Contents: 03:28:15 INFO - build_url:https://queue.taskcluster.net/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:28:15 INFO - Running post-action listener: _resource_record_post_action 03:28:15 INFO - Running post-action listener: set_extra_try_arguments 03:28:15 INFO - ##### 03:28:15 INFO - ##### Running populate-webroot step. 03:28:15 INFO - ##### 03:28:15 INFO - Running pre-action listener: _resource_record_pre_action 03:28:15 INFO - Running main action method: populate_webroot 03:28:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:28:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:28:15 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:28:15 INFO - '../fennec_ids.txt'], 03:28:15 INFO - 'tests': ['tcheck2']}, 03:28:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:28:15 INFO - '--tppagecycles', 03:28:15 INFO - '7'], 03:28:15 INFO - 'tests': ['tsvgm']}}, 03:28:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:28:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:28:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:28:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:28:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:28:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:28:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:15 INFO - 'talos_options': ['--e10s'], 03:28:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:15 INFO - 'tests': ['damp', 'tps']}, 03:28:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:15 INFO - 'talos_options': ['--e10s'], 03:28:15 INFO - 'tests': ['damp', 'tps']}, 03:28:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:28:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:15 INFO - 'other': {'tests': ['a11yr', 03:28:15 INFO - 'ts_paint', 03:28:15 INFO - 'tpaint', 03:28:15 INFO - 'sessionrestore', 03:28:15 INFO - 'sessionrestore_no_auto_restore']}, 03:28:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:28:15 INFO - 'tests': ['a11yr', 03:28:15 INFO - 'ts_paint', 03:28:15 INFO - 'tpaint', 03:28:15 INFO - 'sessionrestore', 03:28:15 INFO - 'sessionrestore_no_auto_restore']}, 03:28:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:28:15 INFO - 'tests': ['a11yr', 03:28:15 INFO - 'ts_paint', 03:28:15 INFO - 'tpaint', 03:28:15 INFO - 'sessionrestore', 03:28:15 INFO - 'sessionrestore_no_auto_restore']}, 03:28:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:28:15 INFO - 'tests': ['a11yr', 03:28:15 INFO - 'ts_paint', 03:28:15 INFO - 'tpaint', 03:28:15 INFO - 'sessionrestore', 03:28:15 INFO - 'sessionrestore_no_auto_restore']}, 03:28:15 INFO - 'other_l64': {'tests': ['a11yr', 03:28:15 INFO - 'ts_paint', 03:28:15 INFO - 'tpaint', 03:28:15 INFO - 'sessionrestore', 03:28:15 INFO - 'sessionrestore_no_auto_restore']}, 03:28:15 INFO - 'other_nol64': {'tests': ['a11yr', 03:28:15 INFO - 'ts_paint', 03:28:15 INFO - 'tpaint', 03:28:15 INFO - 'sessionrestore', 03:28:15 INFO - 'sessionrestore_no_auto_restore']}, 03:28:15 INFO - 'svgr': {'tests': ['tsvgx', 03:28:15 INFO - 'tsvgr_opacity', 03:28:15 INFO - 'tart', 03:28:15 INFO - 'tscrollx', 03:28:15 INFO - 'cart']}, 03:28:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:28:15 INFO - 'tests': ['tsvgx', 03:28:15 INFO - 'tsvgr_opacity', 03:28:15 INFO - 'tart', 03:28:15 INFO - 'tscrollx', 03:28:15 INFO - 'cart']}, 03:28:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:15 INFO - 'tests': ['tp5o']}, 03:28:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:15 INFO - 'talos_options': ['--e10s'], 03:28:15 INFO - 'tests': ['tp5o']}, 03:28:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:15 INFO - 'talos_options': ['--xperf_path', 03:28:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:15 INFO - 'tests': ['tp5n']}, 03:28:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:15 INFO - 'talos_options': ['--e10s', 03:28:15 INFO - '--xperf_path', 03:28:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:15 INFO - 'tests': ['tp5n']}}, 03:28:15 INFO - 'talos.zip': {'path': '', 03:28:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:28:15 INFO - Running post-action listener: _resource_record_post_action 03:28:15 INFO - ##### 03:28:15 INFO - ##### Running create-virtualenv step. 03:28:15 INFO - ##### 03:28:15 INFO - Running pre-action listener: _resource_record_pre_action 03:28:15 INFO - Running main action method: create_virtualenv 03:28:15 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:28:15 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 03:28:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:28:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:15 INFO - Using real prefix '/usr' 03:28:15 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:28:16 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:18 INFO - Installing pip.................done. 03:28:18 INFO - Return code: 0 03:28:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:28: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')]} 03:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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', '--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 0x7ff42bfe5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d078c0>, '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 0x2cb4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb48b0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094', '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 03:28:18 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 03:28:18 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 03:28:18 INFO - Using env: {'DISPLAY': ':0', 03:28:18 INFO - 'HOME': '/home/cltbld', 03:28:18 INFO - 'LANG': 'en_US.UTF-8', 03:28:18 INFO - 'LANGUAGE': 'en_US:en', 03:28:18 INFO - 'LOGNAME': 'cltbld', 03:28:18 INFO - 'MAIL': '/var/mail/cltbld', 03:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:18 INFO - 'MOZ_NO_REMOTE': '1', 03:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:18 INFO - 'NO_EM_RESTART': '1', 03:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:28:18 INFO - 'PWD': '/builds/slave/test-pgo', 03:28:18 INFO - 'SHELL': '/bin/bash', 03:28:18 INFO - 'SHLVL': '1', 03:28:18 INFO - 'TERM': 'linux', 03:28:18 INFO - 'TMOUT': '86400', 03:28:18 INFO - 'USER': 'cltbld', 03:28:18 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094', 03:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:18 INFO - '_': '/tools/buildbot/bin/python'} 03:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:18 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 03:28:18 INFO - Cleaning up... 03:28:18 INFO - Return code: 0 03:28:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:28: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')]} 03:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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', '--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 0x7ff42bfe5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d078c0>, '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 0x2cb4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb48b0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094', '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 03:28:18 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 03:28:18 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 03:28:18 INFO - Using env: {'DISPLAY': ':0', 03:28:18 INFO - 'HOME': '/home/cltbld', 03:28:18 INFO - 'LANG': 'en_US.UTF-8', 03:28:18 INFO - 'LANGUAGE': 'en_US:en', 03:28:18 INFO - 'LOGNAME': 'cltbld', 03:28:18 INFO - 'MAIL': '/var/mail/cltbld', 03:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:18 INFO - 'MOZ_NO_REMOTE': '1', 03:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:18 INFO - 'NO_EM_RESTART': '1', 03:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:28:18 INFO - 'PWD': '/builds/slave/test-pgo', 03:28:18 INFO - 'SHELL': '/bin/bash', 03:28:18 INFO - 'SHLVL': '1', 03:28:18 INFO - 'TERM': 'linux', 03:28:18 INFO - 'TMOUT': '86400', 03:28:18 INFO - 'USER': 'cltbld', 03:28:18 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094', 03:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:18 INFO - '_': '/tools/buildbot/bin/python'} 03:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:18 INFO - Downloading/unpacking psutil>=0.7.1 03:28:18 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 03:28:18 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 03:28:18 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 03:28:18 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 03:28:18 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 03:28:18 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 03:28:20 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:28:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:28:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:20 INFO - Installing collected packages: psutil 03:28:20 INFO - Running setup.py install for psutil 03:28:20 INFO - building 'psutil._psutil_linux' extension 03:28:20 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 03:28:20 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 03:28:20 INFO - building 'psutil._psutil_posix' extension 03:28:20 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 03:28:20 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 03:28:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:21 INFO - Successfully installed psutil 03:28:21 INFO - Cleaning up... 03:28:21 INFO - Return code: 0 03:28:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:28: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')]} 03:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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', '--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 0x7ff42bfe5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d078c0>, '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 0x2cb4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb48b0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094', '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 03:28:21 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 03:28:21 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 03:28:21 INFO - Using env: {'DISPLAY': ':0', 03:28:21 INFO - 'HOME': '/home/cltbld', 03:28:21 INFO - 'LANG': 'en_US.UTF-8', 03:28:21 INFO - 'LANGUAGE': 'en_US:en', 03:28:21 INFO - 'LOGNAME': 'cltbld', 03:28:21 INFO - 'MAIL': '/var/mail/cltbld', 03:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:21 INFO - 'MOZ_NO_REMOTE': '1', 03:28:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:21 INFO - 'NO_EM_RESTART': '1', 03:28:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:28:21 INFO - 'PWD': '/builds/slave/test-pgo', 03:28:21 INFO - 'SHELL': '/bin/bash', 03:28:21 INFO - 'SHLVL': '1', 03:28:21 INFO - 'TERM': 'linux', 03:28:21 INFO - 'TMOUT': '86400', 03:28:21 INFO - 'USER': 'cltbld', 03:28:21 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094', 03:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:21 INFO - '_': '/tools/buildbot/bin/python'} 03:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:28:21 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 03:28:21 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 03:28:21 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 03:28:21 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 03:28:21 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 03:28:21 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 03:28:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:28:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:28:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:28:23 INFO - Installing collected packages: mozsystemmonitor 03:28:23 INFO - Running setup.py install for mozsystemmonitor 03:28:23 INFO - Successfully installed mozsystemmonitor 03:28:23 INFO - Cleaning up... 03:28:23 INFO - Return code: 0 03:28:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:28:23 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')]} 03:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:23 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')]} 03:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:23 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 0x7ff42bfe5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d078c0>, '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 0x2cb4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb48b0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094', '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 03:28:23 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 03:28:23 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 03:28:23 INFO - Using env: {'DISPLAY': ':0', 03:28:23 INFO - 'HOME': '/home/cltbld', 03:28:23 INFO - 'LANG': 'en_US.UTF-8', 03:28:23 INFO - 'LANGUAGE': 'en_US:en', 03:28:23 INFO - 'LOGNAME': 'cltbld', 03:28:23 INFO - 'MAIL': '/var/mail/cltbld', 03:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:23 INFO - 'MOZ_NO_REMOTE': '1', 03:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:23 INFO - 'NO_EM_RESTART': '1', 03:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:28:23 INFO - 'PWD': '/builds/slave/test-pgo', 03:28:23 INFO - 'SHELL': '/bin/bash', 03:28:23 INFO - 'SHLVL': '1', 03:28:23 INFO - 'TERM': 'linux', 03:28:23 INFO - 'TMOUT': '86400', 03:28:23 INFO - 'USER': 'cltbld', 03:28:23 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094', 03:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:23 INFO - '_': '/tools/buildbot/bin/python'} 03:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:23 INFO - Downloading/unpacking blobuploader==1.2.4 03:28:23 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 03:28:23 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 03:28:23 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 03:28:23 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 03:28:23 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 03:28:23 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 03:28:24 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:28:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28:25 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 03:28:25 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 03:28:25 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 03:28:25 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 03:28:25 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 03:28:25 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 03:28:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:28:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:28:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28:25 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 03:28:25 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 03:28:25 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 03:28:25 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 03:28:25 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 03:28:25 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 03:28:25 INFO - Downloading docopt-0.6.1.tar.gz 03:28:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:28:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:25 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:25 INFO - Running setup.py install for blobuploader 03:28:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:25 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:28:25 INFO - Running setup.py install for requests 03:28:26 INFO - Running setup.py install for docopt 03:28:26 INFO - Successfully installed blobuploader requests docopt 03:28:26 INFO - Cleaning up... 03:28:26 INFO - Return code: 0 03:28:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:28:26 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')]} 03:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:26 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')]} 03:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:26 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 0x7ff42bfe5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d078c0>, '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 0x2cb4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb48b0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094', '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 03:28:26 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 03:28:26 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 03:28:26 INFO - Using env: {'DISPLAY': ':0', 03:28:26 INFO - 'HOME': '/home/cltbld', 03:28:26 INFO - 'LANG': 'en_US.UTF-8', 03:28:26 INFO - 'LANGUAGE': 'en_US:en', 03:28:26 INFO - 'LOGNAME': 'cltbld', 03:28:26 INFO - 'MAIL': '/var/mail/cltbld', 03:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:26 INFO - 'MOZ_NO_REMOTE': '1', 03:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:26 INFO - 'NO_EM_RESTART': '1', 03:28:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:28:26 INFO - 'PWD': '/builds/slave/test-pgo', 03:28:26 INFO - 'SHELL': '/bin/bash', 03:28:26 INFO - 'SHLVL': '1', 03:28:26 INFO - 'TERM': 'linux', 03:28:26 INFO - 'TMOUT': '86400', 03:28:26 INFO - 'USER': 'cltbld', 03:28:26 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094', 03:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:26 INFO - '_': '/tools/buildbot/bin/python'} 03:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:28:26 INFO - Running setup.py (path:/tmp/pip-e7oKAh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:28:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:28:26 INFO - Running setup.py (path:/tmp/pip-l8ASYl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:28:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:28:26 INFO - Running setup.py (path:/tmp/pip-gmNtLB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:28:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:28:26 INFO - Running setup.py (path:/tmp/pip-QR7y9X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:28:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:28:26 INFO - Running setup.py (path:/tmp/pip-lmXlGs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:28:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:28:26 INFO - Running setup.py (path:/tmp/pip-COpAC0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:28:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:28:26 INFO - Running setup.py (path:/tmp/pip-4WwOxC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:28:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:28:26 INFO - Running setup.py (path:/tmp/pip-yBPFjr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:28:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:28:27 INFO - Running setup.py (path:/tmp/pip-Zr3dhI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:28:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:28:27 INFO - Running setup.py (path:/tmp/pip-8DEQLF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:28:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:28:27 INFO - Running setup.py (path:/tmp/pip-csBoLu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:28:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:28:27 INFO - Running setup.py (path:/tmp/pip-rUsHUz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:28:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:28:27 INFO - Running setup.py (path:/tmp/pip-GZFgZn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:28:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:28:27 INFO - Running setup.py (path:/tmp/pip-lz_cFp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:28:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:28:27 INFO - Running setup.py (path:/tmp/pip-AAWNSi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:28:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:28:27 INFO - Running setup.py (path:/tmp/pip-MZnGkF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:28:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:28:27 INFO - Running setup.py (path:/tmp/pip-Y3NoCR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:28:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:27 INFO - Running setup.py install for manifestparser 03:28:27 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:28:27 INFO - Running setup.py install for mozcrash 03:28:27 INFO - Running setup.py install for mozdebug 03:28:27 INFO - Running setup.py install for mozdevice 03:28:28 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:28:28 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:28:28 INFO - Running setup.py install for mozfile 03:28:28 INFO - Running setup.py install for mozhttpd 03:28:28 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:28:28 INFO - Running setup.py install for mozinfo 03:28:28 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:28:28 INFO - Running setup.py install for mozInstall 03:28:28 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:28:28 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:28:28 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:28:28 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:28:28 INFO - Running setup.py install for mozleak 03:28:28 INFO - Running setup.py install for mozlog 03:28:28 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:28:28 INFO - Running setup.py install for moznetwork 03:28:28 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:28:28 INFO - Running setup.py install for mozprocess 03:28:28 INFO - Running setup.py install for mozprofile 03:28:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:28:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:28:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:28:29 INFO - Running setup.py install for mozrunner 03:28:29 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:28:29 INFO - Running setup.py install for mozscreenshot 03:28:29 INFO - Running setup.py install for moztest 03:28:29 INFO - Running setup.py install for mozversion 03:28:29 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:28:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:29 INFO - Cleaning up... 03:28:29 INFO - Return code: 0 03:28:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:28:29 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')]} 03:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:29 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')]} 03:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:29 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 0x7ff42bfe5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d078c0>, '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 0x2cb4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb48b0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094', '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 03:28:29 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 03:28:29 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 03:28:29 INFO - Using env: {'DISPLAY': ':0', 03:28:29 INFO - 'HOME': '/home/cltbld', 03:28:29 INFO - 'LANG': 'en_US.UTF-8', 03:28:29 INFO - 'LANGUAGE': 'en_US:en', 03:28:29 INFO - 'LOGNAME': 'cltbld', 03:28:29 INFO - 'MAIL': '/var/mail/cltbld', 03:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:29 INFO - 'MOZ_NO_REMOTE': '1', 03:28:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:29 INFO - 'NO_EM_RESTART': '1', 03:28:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:28:29 INFO - 'PWD': '/builds/slave/test-pgo', 03:28:29 INFO - 'SHELL': '/bin/bash', 03:28:29 INFO - 'SHLVL': '1', 03:28:29 INFO - 'TERM': 'linux', 03:28:29 INFO - 'TMOUT': '86400', 03:28:29 INFO - 'USER': 'cltbld', 03:28:29 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094', 03:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:29 INFO - '_': '/tools/buildbot/bin/python'} 03:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:28:29 INFO - Running setup.py (path:/tmp/pip-fBArVE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:28:29 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)) 03:28:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:28:29 INFO - Running setup.py (path:/tmp/pip-LPV7uJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:28:29 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)) 03:28:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:28:29 INFO - Running setup.py (path:/tmp/pip-a9V_de-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:28:29 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)) 03:28:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:28:29 INFO - Running setup.py (path:/tmp/pip-NWkQK0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:28:29 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)) 03:28:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:28:29 INFO - Running setup.py (path:/tmp/pip-sALfQx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:28:30 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)) 03:28:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:28:30 INFO - Running setup.py (path:/tmp/pip-kjkVzD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:28:30 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)) 03:28:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:28:30 INFO - Running setup.py (path:/tmp/pip-nGns1K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:28:30 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)) 03:28:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:28:30 INFO - Running setup.py (path:/tmp/pip-QWXdpp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:28:30 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)) 03:28:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:28:30 INFO - Running setup.py (path:/tmp/pip-Vo0qEd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:28:30 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)) 03:28:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:28:30 INFO - Running setup.py (path:/tmp/pip-20m6K1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:28:30 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)) 03:28:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:28:30 INFO - Running setup.py (path:/tmp/pip-BHrzSt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:28:30 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)) 03:28:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:28:30 INFO - Running setup.py (path:/tmp/pip-GJuuV7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:28:30 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)) 03:28:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:28:30 INFO - Running setup.py (path:/tmp/pip-UN1CG7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:28:30 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)) 03:28:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:28:30 INFO - Running setup.py (path:/tmp/pip-7MGQSB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:28:30 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)) 03:28:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:28:30 INFO - Running setup.py (path:/tmp/pip-6y4Oni-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:28:30 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)) 03:28:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:28:30 INFO - Running setup.py (path:/tmp/pip-42AFZI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:28:30 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)) 03:28:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:28:30 INFO - Running setup.py (path:/tmp/pip-VokXXo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:28:30 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)) 03:28:30 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)) 03:28:30 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)) 03:28:30 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)) 03:28:30 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)) 03:28:30 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)) 03:28:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:30 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 03:28:30 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 03:28:30 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 03:28:30 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 03:28:30 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 03:28:30 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 03:28:32 INFO - Downloading blessings-1.5.1.tar.gz 03:28:32 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 03:28:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:32 INFO - Installing collected packages: blessings 03:28:32 INFO - Running setup.py install for blessings 03:28:32 INFO - Successfully installed blessings 03:28:32 INFO - Cleaning up... 03:28:32 INFO - Return code: 0 03:28:32 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:28:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:28:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:28:32 INFO - Reading from file tmpfile_stdout 03:28:32 INFO - Current package versions: 03:28:32 INFO - argparse == 1.2.1 03:28:32 INFO - blessings == 1.5.1 03:28:32 INFO - blobuploader == 1.2.4 03:28:32 INFO - docopt == 0.6.1 03:28:32 INFO - manifestparser == 1.1 03:28:32 INFO - mozInstall == 1.12 03:28:32 INFO - mozcrash == 0.16 03:28:32 INFO - mozdebug == 0.1 03:28:32 INFO - mozdevice == 0.47 03:28:32 INFO - mozfile == 1.2 03:28:32 INFO - mozhttpd == 0.7 03:28:32 INFO - mozinfo == 0.9 03:28:32 INFO - mozleak == 0.1 03:28:32 INFO - mozlog == 3.0 03:28:32 INFO - moznetwork == 0.27 03:28:32 INFO - mozprocess == 0.22 03:28:32 INFO - mozprofile == 0.27 03:28:32 INFO - mozrunner == 6.11 03:28:32 INFO - mozscreenshot == 0.1 03:28:32 INFO - mozsystemmonitor == 0.0 03:28:32 INFO - moztest == 0.7 03:28:32 INFO - mozversion == 1.4 03:28:32 INFO - psutil == 3.1.1 03:28:32 INFO - requests == 1.2.3 03:28:32 INFO - wsgiref == 0.1.2 03:28:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:28:32 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')]} 03:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:32 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')]} 03:28:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:32 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 0x7ff42bfe5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d078c0>, '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 0x2cb4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb48b0>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094', '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 03:28:32 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 03:28:32 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 03:28:32 INFO - Using env: {'DISPLAY': ':0', 03:28:32 INFO - 'HOME': '/home/cltbld', 03:28:32 INFO - 'LANG': 'en_US.UTF-8', 03:28:32 INFO - 'LANGUAGE': 'en_US:en', 03:28:32 INFO - 'LOGNAME': 'cltbld', 03:28:32 INFO - 'MAIL': '/var/mail/cltbld', 03:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:32 INFO - 'MOZ_NO_REMOTE': '1', 03:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:32 INFO - 'NO_EM_RESTART': '1', 03:28:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:28:32 INFO - 'PWD': '/builds/slave/test-pgo', 03:28:32 INFO - 'SHELL': '/bin/bash', 03:28:32 INFO - 'SHLVL': '1', 03:28:32 INFO - 'TERM': 'linux', 03:28:32 INFO - 'TMOUT': '86400', 03:28:32 INFO - 'USER': 'cltbld', 03:28:32 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094', 03:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:32 INFO - '_': '/tools/buildbot/bin/python'} 03:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:33 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)) 03:28:33 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)) 03:28:33 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)) 03:28:33 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)) 03:28:33 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)) 03:28:33 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)) 03:28:33 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)) 03:28:33 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)) 03:28:33 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)) 03:28:33 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)) 03:28:33 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)) 03:28:33 INFO - Cleaning up... 03:28:33 INFO - Return code: 0 03:28:33 INFO - Running post-action listener: _resource_record_post_action 03:28:33 INFO - Running post-action listener: _start_resource_monitoring 03:28:33 INFO - Starting resource monitoring. 03:28:33 INFO - ##### 03:28:33 INFO - ##### Running install step. 03:28:33 INFO - ##### 03:28:33 INFO - Running pre-action listener: _resource_record_pre_action 03:28:33 INFO - Running main action method: install 03:28:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:28:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:28:33 INFO - Reading from file tmpfile_stdout 03:28:33 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:28:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:28:33 INFO - Reading from file tmpfile_stdout 03:28:33 INFO - Output received: 03:28:33 INFO - Usage: mozinstall [options] installer 03:28:33 INFO - Options: 03:28:33 INFO - -h, --help show this help message and exit 03:28:33 INFO - -d DEST, --destination=DEST 03:28:33 INFO - Directory to install application into. [default: 03:28:33 INFO - "/builds/slave/test-pgo"] 03:28:33 INFO - --app=APP Application being installed. [default: firefox] 03:28:33 INFO - mkdir: /builds/slave/test-pgo/build/application 03:28:33 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'] 03:28:33 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 03:28:47 INFO - Reading from file tmpfile_stdout 03:28:47 INFO - Output received: 03:28:47 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:28:47 INFO - Running post-action listener: _resource_record_post_action 03:28:47 INFO - ##### 03:28:47 INFO - ##### Running run-tests step. 03:28:47 INFO - ##### 03:28:47 INFO - Running pre-action listener: _resource_record_pre_action 03:28:47 INFO - Running main action method: run_tests 03:28:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:28:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:28:47 INFO - Python 2.7.3 03:28:47 INFO - Return code: 0 03:28:47 INFO - grabbing minidump binary from tooltool 03:28:47 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')]} 03:28:47 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 0x2d078c0>, '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 0x2cb4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb48b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:28:47 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 03:28:47 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 03:28:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:28:47 INFO - Return code: 0 03:28:47 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:28:47 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:28:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:28:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:28:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:28:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:28:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost 03:28:47 INFO - Using env: {'DISPLAY': ':0', 03:28:47 INFO - 'HOME': '/home/cltbld', 03:28:47 INFO - 'LANG': 'en_US.UTF-8', 03:28:47 INFO - 'LANGUAGE': 'en_US:en', 03:28:47 INFO - 'LOGNAME': 'cltbld', 03:28:47 INFO - 'MAIL': '/var/mail/cltbld', 03:28:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:28:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:47 INFO - 'MOZ_NO_REMOTE': '1', 03:28:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:47 INFO - 'NO_EM_RESTART': '1', 03:28:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:28:47 INFO - 'PWD': '/builds/slave/test-pgo', 03:28:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:28:47 INFO - 'SHELL': '/bin/bash', 03:28:47 INFO - 'SHLVL': '1', 03:28:47 INFO - 'TERM': 'linux', 03:28:47 INFO - 'TMOUT': '86400', 03:28:47 INFO - 'USER': 'cltbld', 03:28:47 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094', 03:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:47 INFO - '_': '/tools/buildbot/bin/python'} 03:28:47 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] with output_timeout 3600 03:28:48 INFO - mozversion INFO | application_buildid: 20151116013046 03:28:48 INFO - mozversion INFO | application_changeset: 74a949559633b776a2509e7cd6ffd5b3d81e1ff3 03:28:48 INFO - mozversion INFO | application_display_name: Nightly 03:28:48 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:28:48 INFO - mozversion INFO | application_name: Firefox 03:28:48 INFO - mozversion INFO | application_remotingname: firefox 03:28:48 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:28:48 INFO - mozversion INFO | application_vendor: Mozilla 03:28:48 INFO - mozversion INFO | application_version: 45.0a1 03:28:48 INFO - mozversion INFO | platform_buildid: 20151116013046 03:28:48 INFO - mozversion INFO | platform_changeset: 74a949559633b776a2509e7cd6ffd5b3d81e1ff3 03:28:48 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:28:48 INFO - mozversion INFO | platform_version: 45.0a1 03:28:48 INFO - 2015-11-16 03:28:48,158 DEBUG : using testdate: 1447673328 03:28:48 INFO - 2015-11-16 03:28:48,158 DEBUG : actual date: 1447673328 03:28:48 INFO - 2015-11-16 03:28:48,208 INFO : starting webserver on 'localhost:41035' 03:28:48 INFO - 2015-11-16 03:28:48,209 INFO : Starting test suite talos-linux64-ix-020.e 03:28:48 INFO - 2015-11-16 03:28:48,209 INFO : Starting test dromaeo_css 03:28:48 INFO - 2015-11-16 03:28:48,209 DEBUG : operating with platform_type : linux_ 03:28:48 INFO - 2015-11-16 03:28:48,209 INFO : Initialising browser for dromaeo_css test... 03:28:48 INFO - 2015-11-16 03:28:48,226 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsofbFh/profile http://localhost:41035/getInfo.html 03:28:55 INFO - 2015-11-16 03:28:55,480 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:28:55 INFO - 2015-11-16 03:28:55,480 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:28:55 INFO - 2015-11-16 03:28:55,480 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:28:55 INFO - 2015-11-16 03:28:55,480 DEBUG : BROWSER_OUTPUT: __metrics 03:28:56 INFO - 2015-11-16 03:28:56,549 INFO : Browser initialized. 03:28:56 INFO - 2015-11-16 03:28:56,550 INFO : Running cycle 1/1 for dromaeo_css test... 03:28:56 INFO - 2015-11-16 03:28:56,550 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsofbFh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:29:08 INFO - 2015-11-16 03:29:08,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 140906496 03:29:08 INFO - 2015-11-16 03:29:08,343 DEBUG : BROWSER_OUTPUT: 03:29:57 INFO - 2015-11-16 03:29:57,971 DEBUG : BROWSER_OUTPUT: 1447673397965 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] 03:32:05 INFO - 2015-11-16 03:32:05,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41035/tests/dromaeo/cssquery-ext.html) 03:32:06 INFO - 2015-11-16 03:32:06,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 146051072 03:32:06 INFO - 2015-11-16 03:32:06,870 DEBUG : BROWSER_OUTPUT: 03:35:08 INFO - 2015-11-16 03:35:08,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/dromaeo/cssquery-ext.html (next: http://localhost:41035/tests/dromaeo/cssquery-jquery.html) 03:35:09 INFO - 2015-11-16 03:35:09,427 DEBUG : BROWSER_OUTPUT: RSS: Main: 140685312 03:35:09 INFO - 2015-11-16 03:35:09,427 DEBUG : BROWSER_OUTPUT: 03:38:11 INFO - 2015-11-16 03:38:11,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41035/tests/dromaeo/cssquery-mootools.html) 03:38:11 INFO - 2015-11-16 03:38:11,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 142139392 03:38:11 INFO - 2015-11-16 03:38:11,635 DEBUG : BROWSER_OUTPUT: 03:41:13 INFO - 2015-11-16 03:41:13,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41035/tests/dromaeo/cssquery-prototype.html) 03:41:13 INFO - 2015-11-16 03:41:13,860 DEBUG : BROWSER_OUTPUT: RSS: Main: 139739136 03:41:13 INFO - 2015-11-16 03:41:13,860 DEBUG : BROWSER_OUTPUT: 03:44:16 INFO - 2015-11-16 03:44:16,164 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41035/tests/dromaeo/cssquery-yui.html) 03:44:16 INFO - 2015-11-16 03:44:16,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 141828096 03:44:16 INFO - 2015-11-16 03:44:16,767 DEBUG : BROWSER_OUTPUT: 03:47:19 INFO - 2015-11-16 03:47:19,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/dromaeo/cssquery-yui.html (next: http://localhost:41035/tests/dromaeo/cssquery-dojo.html) 03:47:19 INFO - 2015-11-16 03:47:19,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 144285696 03:47:19 INFO - 2015-11-16 03:47:19,272 DEBUG : BROWSER_OUTPUT: 03:47:19 INFO - 2015-11-16 03:47:19,272 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:47:19 INFO - 2015-11-16 03:47:19,272 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:47:19 INFO - 2015-11-16 03:47:19,273 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:47:19 INFO - 2015-11-16 03:47:19,273 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:47:19 INFO - 2015-11-16 03:47:19,277 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3263.1352691536745;3274.0505253476485;3281.5241789940474;3303.372359251742;3312.022953228797;5248.7638056287515;5379;5397.433269506704;5408.378036525801;5417.052015897217;5489.451054894508;5511.090670039449;5512.724363781805;5521.254630624864;5530.115181570949;4959.876003099925;4962.751862406865;5090.898182036357;5126.794928202868;5176.352955880515;5122.359705036871;5140.203268493389;5149.227615857614;5168.767405466744;5205;36.158861165747105;5087.643864929457;5101.438841727407;5199.298094757216;5239.030779305822;5081.974590127063;5098.388193416777;5107.336046313955;5111.335526381584;5125.513076257749;5060.316857224265;5077.746112694351;5083.771230294646;5087;5140.537351638371;5195.090859099642;5208.374995000586;5216.426193118754;5416.945830541684;5438.564914806806;5907.084401917709;5926.199963004982;5931.970340148272;5938.257717785277;5962.552808539377;5978.192943952554;6007.339192688801;6012.879742405171;6018.307894592091;6024.337322894478;5434.592405569598;5541.6674999499755;5562.276904002454;5601.775928962837;5604.8038318659055;6049.485793707496;6102.458955353584;6111.895622426848;6119.197913140417;6120.294761999619;5812.3025236971835;5826.563007774434;5870.5010074144175;5888.4700376966275;5958.255218097738;5681.204631351614;5791.768329266866;5799.942000580025;5905;5924.7037648118285;5942.1383899335215;6010.849728756729;6011.338752737195;6015.218021657157;6035.668038257938;5960.642361458326;6002.969985150046;6011.789587364508;6014.51883849291;6018.187544681412;4413.360062790877;4475.619572336388;4505.797239124247;4571.5428457154685;4589.128065667513;4075.3275709508193;4080.1023774770097;4092.8567500137947;4095.140020595649;4097.8975525612095;5670.5180059695385;5686.232358631614;5709.460978522085;5718.914216286759;5754.971225143848;5775.797847075332;5892.204552385459;5927.081302398135;6035.78874739382;6088.573799833969;5709.286339207599;5739.540836733051;5747.597668163188;5769.9711501442225;5772.94227057724;5031.396232452056;5152.6650767699975;5192.143296356135;5202.947970520322;5210.739463026834;6110.816675499742;6122.215193971453;6127.220070483952;6130.5204358993005;6141.477974372139;5987.670678112571;5990.9700451497465;5994.820155395345;6030.6080104793045;6057.18228039209;6251.4061164189325;6252.531060170414;6255.280642725963;6255.655938923403;6266.404691554295;5783.768649253982;5793.333766616893;5882.176495290748;5924.822255332347;5943.078822782476;6051.576389652682;6058;6064.605800622945;6072.666003369857;6090.269167699905;5757.453041961007;5910.349861515144;5924.11138329254;5926.170336153028;5926.703664816656;5838.532917366516;5853.326867410302;5961.225040744849;5974.4324289192455;6004.369541198112;5664.291963504562;5689.914651280317;5702.8289151325525;5729;5734.741936612946;5649.152627105967;5831.446012628793;5912.763489460545;5915.142304365929;5918.437748413894;5660.632058916157;5681.659100453986;5692.288463942007;5697.886042279214;5761.366249712444 03:47:19 INFO - 2015-11-16 03:47:19,277 DEBUG : BROWSER_OUTPUT: |1;ext.html;576.9423057694229;581.0586849304127;585.9765609375623;603.8037637767724;611.168810417832;39201.21597568047;40145;40438.98902527442;40445.39331910016;40546.18907621849;43347.34978975318;43495;43903;44080.89797755058;44084;8694.087120852315;8841.646334146626;8867.822643547126;8889.95555022224;8905.332100092486;8743.606537705788;8767.430117042404;8784.341174411913;8817.559122043904;8821.955890220539;8733.7816554586;8738;8800.691975780848;8802.295816334678;8802.471851688888;8775.341849361292;8865.867011994826;8871.37900346976;8877.422967507091;8887.822243555158;8622.051574326819;8844.159804818531;8848.867266991001;8851.77870553235;8858.86711699325;41026.38460423096;41616.37575436371;41694;41772.79113604413;41788.58211417908;3266.591676040495;3337.5327454156195;3353.547271118392;3379.611344695367;3381.712554432876;29863.701362986525;30522.694773052208;30612.693873061206;30774.38451230985;31444.21389465259;3065.708757668018;3086.8302243376606;3089.1350421881907;3094.4430002599524;3119.5944527211545;265325;265651;265752;266592;267176.9999999981;42218.78890605527;42898;56713.716431418405;56910.7154464225;56954;40158.79920600437;40376.19247615031;40506;40632.79683601622;40742.388864167064;13897.513587024609;14021.158730476203;14022.439102435788;14030.579082627537;14084.22536760488;11609.129315301387;11714.062874970152;11724.648260552027;11743.354115523558;11743.706407339885;14258.215798130996;14301.499447519494;14393.92803035978;14439.2058436787;14491.637709057359;5736.741846616912;5846.736896839652;5879.941200588025;5889.263842019747;5895.734691938873;868.2272777228272;931.5761328595473;950.6054987180243;956.5934477846887;968.7841758592921;28462.430751384858;28747.724155131564;28851.56722649162;29009.854950725112;29229.26926826804;1019.4291196929743;1049.8477720730452;1060.289605964006;1062.9681109566725;1160.5589875847124;14878.92560537212;16474.258658360402;17146.142692865305;17180.484585462455;17235.827641723674;414579;418897;421750;422810;423050;54428.45571544313;54628.45371546234;54689.1796623051;54845;55439.72280138574;1320.4784110276387;1339.0626561407055;1347.696768227141;1352.4387379237703;1357.497725841445;28449.857750711115;29363.265918351357;29501.26246843846;29522.557161642162;29876;45484.54515454803;46267.305990410845;46504.069918602116;46596.30105548487;46613.533864660916;311763;312309;313916;314145;315153;31887.202819929687;46361.53638463572;46513.767431162625;47487;47522;43369.56630433655;43593;43655;43721.78139109284;44226.33660495031;37244.81377593095;37710;38354.232915342094;38572.80713596414;39068.6093139065;37623;37684;37814.2437151261;38073.619263807006;38375.23249534938;35937.28125437424;36261.27477450489;36709.63290367169;36746;36836.81581592182;32437.351252974335;33830.15424614306;34236.82881585576;34860;34872.30255394827;25662.743372566783;25929.48141037131;26076.73923260743;26185.345366365993;26414.471710566064 03:47:19 INFO - 2015-11-16 03:47:19,280 DEBUG : BROWSER_OUTPUT: |2;jquery.html;348.12273071858914;349.2996541933423;349.38159457759764;349.8775428599992;352.8253514510317;12341.074419418557;12835.743285134315;17377.73933391;17675;18300.72548911764;11794.587189448372;11916.523339066449;11986.340751258676;12349.382530873465;12376.195547289442;4567.155076310884;4669.159551280785;4707.152712511746;4710.128626204146;4720.221163508017;4735.100330937111;4855.660103792736;4865.124277630025;4869.780859861315;4874.951250487486;4744.383230180089;4769.856904292877;4770.403699537558;4825.7587120644;4888.24232244001;4802.59177969873;4815.975920120412;4816.951830481703;4834.178189707741;4858.149823780842;4170.52039015511;4185.6232939035635;4337.262665346899;4352.238358287287;4360.280553708634;12990.220586764824;13298.933505332509;13362;13442.663933401744;13522.797158042637;1841.0150569445416;1889.3198448558508;1918.2518817661123;1926.2006267399013;1929.9603125078058;9490.240780737524;9798.363106398061;9937.304388692794;10006.149477294439;10246.38521688701;1710.6835235481476;1723.0609317921762;1729.3687803951593;1751.9211635476433;1768.5932235585758;59055.40944590542;61108.388916110714;61216.38783612196;62318.688406557674;62424.68787656078;7027.332403421667;7100.5029647925185;7120.928790712027;7167.7132914682825;7181.281871812777;8478.576071196416;8499.405041647025;8527.70153044653;8555.82888342242;8601.22588966996;5679.034564124109;5714.571407144481;5727.5131613812455;5738.081906894877;5760.452756988079;5857.355690874;5879.088741245114;5908.172855800191;5926.674032928144;5967.045272756338;3334.183125134309;3350.547676063749;3354;3359.0258824940984;3384.1708781348234;1158.9652310430702;1161.4134861894688;1164.2141554450711;1165.7493638867516;1198.3049831097942;408.0858876117475;412.6451251923344;419.0801191384881;419.3583816760362;481.7422678866789;9597.568109435093;9920.603175872884;10026.147777438999;10208.183345332356;10250.794984100276;408.45267341762184;410.4423712012918;415.33546325878353;416.74578507110635;422.85622888218154;5369.704666243394;5391.676499409969;5446.183072539151;5467.699276539828;5474.2609747683555;523553;525317;526945;546522;551971;76105.61947190229;78586.6070669643;78698.21301786909;79489.60255198802;79537.60231198923;451.41316288824396;455.29202090748544;455.37158720964857;455.67419295204087;455.7356733094731;9520.571574279036;9537.666181683608;9689.515524223902;9728.367656102331;9984.950075249577;35090.473642895886;35755.821220893726;36024.09939751423;36372.45441318435;36818.447723283636;44400.333994990746;45397.54602454065;46146.76926615345;46484.53515464938;46584.30123548217;6598.505112116706;6682.799516014527;6839.589624622538;6870.27862074475;6948.166220053626;12681.112322137362;12810.423530940943;12814.295213763333;12900.096993210385;12958.416871240628;10811;10832.5125369357;10851.186161037796;11081.889181108085;11095.278806877526;9787.46168960714;10874.510647021061;11076.612318569134;11233.831492527455;11361.772764544497;11012.559497620005;11141.16441266892;11149.609763658233;11274.492647831032;11306.717332066764;6609.339066093352;6611.2727599963;6618.338166183343;6620.205575330991;6687.866242675216;10423.322484038514;10820.458977051274;10936.671899843017;11287.492062857027;11291.378974156172 03:47:19 INFO - 2015-11-16 03:47:19,282 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1494.6711723420844;1717.647882184152;1744.4243399678107;1779.8131196224388;1788.4187639017314;7487.887681684772;7747.031621047369;7829.882551761728;7853.960730196348;7951.244631759988;7918.0894197167345;7939.880901786478;7987.361011119111;8014.998125234346;8017.3986950978615;2248.100759696118;2291.9312420627407;2299.816014718827;2300.5168914527967;2308.7575804540534;2277.7949984501392;2301.5742087713743;2317.860928344296;2325.802306803924;2328.313147621447;2218.1127548980376;2234.0728597632046;2253.0762387421078;2262.875541845198;2279.4757205842666;2259.887005649719;2277.54449110177;2348.2955113466064;2351.6825228594175;2360.5396947595227;2288.416453804286;2306.3888069661552;2319.188284100568;2323.7908588226974;2324.395657129142;7737.883931741028;7738.226177382273;7746.0317460317465;7806.882896756553;7832.921670783277;4746.715197088186;4818.229083346648;4837.879053023667;4849.272609108627;4853.320535125085;3033.924151896198;3047.4514587374265;3132.8903488377796;3133.4673105572106;3145.622525296956;1017.4963393120453;1035.984460233097;1055.166418529361;1058.30680904008;1064.41989115932;10507.31702439339;10540.736481587945;10541.525631346607;10581.470926453647;10593.78812423755;4187.309093999517;4201.4538110046105;4279.315309550457;4286.807093680792;4304.4834619845815;8426.831463370698;8464.44981076228;8467.57662116904;8474.322054235647;8489.702860399857;4744.146053710365;4759.143354196209;4763.237881938942;4777.8327758528285;4786.2581299898575;4356.106998065389;4360.607545320936;4375.868723938287;4397.780110994501;4405.29515277554;3425.3320602482777;3462.601800792941;3477.739169562293;3483.89548313551;3531.3290474809705;1083.4582708645678;1093.8632670916136;1107.9556817727362;1111.3165403276926;1114.7046032801313;990.7622170678985;1028.681108856257;1130.9990658267493;1233.8272641830151;1355.5052405871786;7026.578405295699;7057.788266352018;7086.39765619928;7111.608861512666;7322.231165727629;1162.593092417647;1171.7890779659572;1180.2505409065304;1181.3089342734424;1193.8448001759716;5796.275465566804;5833.7083145842535;5857.26784151981;5878.29460464747;5884.323302820145;9457.952710236405;9500.619975201053;9529;9608.13526782593;9663.130318271249;9264.861027084464;9385.296102792317;9401.247900168108;9417.576209070472;9511.66709165176;7113.786586402416;7129.180144283474;7135;7139.571625702474;7275.199728029913;7032.718691252498;7152.034475345762;7168.139823221247;7177;7192.640367981685;8185.140560241089;8259.174082591693;8297.336213102817;8346.540940248344;8348.666053357798;8444.66221351139;8530.872036919576;8533.104024077382;8607.569621518775;8659.740207793777;6576.638284894377;6603.867922641616;6612.834679132868;6632.137822083291;6675.7997260082275;7335.193128755939;7339.889901651586;7353.264673532818;7361.8159546011775;7402.185759566336;6770.424513916175;6782.152230971129;7023.33278338557;7079.115110611174;7114.466415018997;7030.27758199224;7115.1106111736035;7159.17669467997;7177.892331615134;7245.456590755609;7146.642667866482;7151.749688760869;7175.31834475724;7179.210286868336;7210.89183662256;6584.341565843377;6602.702878370581;6606.405423511907;6608.966955165193;6631.3700198481065;6488.318726533646;6600.07598936159;6632.568883022588;6649.301823308483;6660.666966651745 03:47:19 INFO - 2015-11-16 03:47:19,283 DEBUG : BROWSER_OUTPUT: |4;prototype.html;317.5094479029899;320.21387493702963;323.7232166497643;325.83545309618637;326.94441944869385;6254.249490061194;6406.423421892029;6421.26155492118;6424.6145231286155;6516.315786842384;6341.619502829833;6365.649889256089;6368.5223608229335;6384.58500197488;6390.297067322603;4571.085782843428;4666.743329116897;4680.719156850583;4725.952740472603;4753.239481682923;4681.408321170801;4695.976520117411;4711.175544279755;4720.763961801913;4722.527747225285;4678.812847486097;4683.46140193877;4684.484706682262;4687.554682305175;4688.906221875561;4680.485146633868;4682.484926658082;4691.71849689018;4696.412948381452;4713.811447542094;3879.7090218233743;3997.8001099944886;4008.198360327917;4035.9798201009103;4038.5557588665515;5953.404659534012;5961.552883533753;5966.850828729316;5972.492338151263;5992.460678538952;5404.000259951882;5440.265564148829;5447.782088716446;5453.7818487260465;5467.6719396836315;6584.967075164642;6629.171353580802;6669.43309818666;6692.464602831762;6693.263740988487;4431.756253406062;4465.062336909253;4466.955330446686;4473.060657261979;4473.329000649896;6919.654017299165;6966.512344135862;6995.755148569827;6997.580145191305;7008.509404341698;4451.421315228999;4453.46558412986;4454.1982443159895;4455.26488129455;4459.44256967879;4451.287793952952;4498.122866041156;4499.10017996402;4507.639388848885;4509.098180363941;5419.539339156137;5421.918671219935;5428.538574221236;5430.809921652803;5438.809641662523;6778.288279730656;6780.864382712417;6789.490788190906;6799.586146917872;6802.489813264025;1633.3956436118474;1641.1712085397037;1646.6459711162158;1652.165656343563;1654.710425675502;1065.717584840018;1065.9786804263872;1069.0859315285475;1071.0788721699332;1097.1551905033239;6524.934750652527;6527.738890444424;6560.179977502812;6561.671916404256;6654.73381064752;7075.92924070763;7105.538140020882;7110.431165506747;7119.92880071203;7146.464015198881;6595.76914807989;6596.175478065242;6654;6665.333466653296;6672.933270667231;3765.359888818907;3783.0164157318745;3834.616538346199;3844.36567966288;3850.5764365919727;7443.181250062489;7452.403807695479;7464.328210461084;7471.9626401867645;7472.327490525879;7243;7303.926960730431;7308;7331.450141239428;7332.266773322732;7185.640717964081;7414.073240844895;7414.258574142543;7416.703331866773;7435.925640743523;7004.334588214111;7057.082579264663;7079.39825114871;7116.466265030247;7132.072830532205;6850.623215723183;6982.476314276551;6993.965030174817;7012.509124361246;7040.979058036659;7399.593022383605;7414.666340014604;7423.962880185564;7450.105987281561;7460.0674915635545;4581.862544123682;4607.838725644587;4612.377329060668;4613.0312634347165;4632.4672662644225;6918.8616227676175;6994.370506654425;7037.437005039482;7068.71725130989;7078.504504684623;6843.418309443753;6858.862822743417;6860.5540639858245;6861.348171923659;6862.965685171542;6781.559198652072;6801.081853949851;6820.556663816836;6826.761063362758;6849.212340580897;6416.262129855127;6611.801645950629;6645.401913827779;6647.867042659216;6676.9666151668935;6707;6814.352636499525;6897.55165914214;6902.102726645504;6922.273161317989;6634.834129146617;6708.496862735216;6718.22740384862;6734.865302693821;6743.9325606743305 03:47:19 INFO - 2015-11-16 03:47:19,287 DEBUG : BROWSER_OUTPUT: |5;yui.html;702.6597856292178;756.5196100476197;804.2440106300078;806.4274365200707;809.850177717122;13752.793708094374;14013.229272390014;14093.577192684223;14110.929445352784;14128.434862605509;12420.192687475308;12657;12740.235585864855;12751.489940402373;12791.16857404268;803.1165717710516;805.1425232127795;816.4407380944043;819.7704642700054;820.2494717333633;818.472085504849;819.2913130142414;824.517657170553;826.305903041445;826.4215049465369;858.5235194467068;859.2696208222992;861.2894362151251;863.6502216602286;865.2429124516049;847.6694089305176;847.8346722389167;851.6082602003086;854.8290341931607;855.3072011670536;619.8574327904562;623.23031056645;626.6396821827467;627.8461776864651;627.8524546731514;13463.192208467426;13470.93264533671;13558.457661693521;13622;13647.863521364858;10032.79934401308;10285.948570257176;10318.742031449274;10536.736581585445;10593.629222977235;9107.225885799715;9108.596386738125;9815.165710914582;9829.066238707312;9993.550290236957;3195.2970346523725;3207.342494788563;3251.9674803252137;3303.752218583616;3330.4171769940162;46344.7682761584;46418;46505.76747116276;46669.066618667435;46835.531644683455;7107.360337569644;7435.628218589049;7509.962450187714;7687.34657554103;7733.535987840635;11800.291982481078;11820.23168494045;11846.348450835114;11850.822237666442;11893.524259029542;6698.7320507179165;6856.040154378391;6906.689198986058;6923.099997000358;7031.367176953996;4187.811548480326;4247.086876321606;4262.573742625713;4285.357196420562;4300.634446072057;2632.5129850977632;2668.0795125681607;2677.0496473751537;2679.8928042878065;2781.207355903558;481.30211193769173;483.6203580189534;488.9144399730033;503.07936476248375;503.9622028347815;485.4199231917824;642.6882961763541;657.7500549791145;657.9111819904348;683.888680893548;8651.697190598425;8657.740267791976;8658.696945607;8805.559722013873;8814.250788682906;505.24970418927865;525.324957429701;534.6872079833341;551.3218740948655;678.482828705508;4035.515738111387;4089.5501494835544;4276.337167739005;4371.256886329332;4422.358757980139;59651;60278.397216027275;60540.69729651324;61062.38937610567;61124.69437652872;53096.73451632717;53585.1962220567;54073;54301.72849135729;54423;47695.1843852491;47867;48140.518594813606;48342.75828620834;49310.75344623182;8583.313334933066;8592.35557333215;8629.180227878342;8664.39349245572;8684.39209255346;35070.649293506736;35269;35700;36178.8191059043;36236.4564531527;46050;46390.536094639974;47037;47189;48612;8153.388495862715;8174.918250817415;8322;8463.195996380335;8599.097094805205;12031.338276394883;12054;12122.75754484923;12196.81704774447;12238.938805305916;11110.888891110986;11192.272502287326;11196.160287978271;11631.709207269885;11643.941780291383;11241.831372529583;11397.601083962021;11479.196456247982;11659.941700291443;12022.158448908493;11451.656450306504;11541.653750387502;11640.94179529097;11666.183367164216;11933.045356371644;10000.949995249977;10109.696709098738;10141.645042423776;10246.282760207012;10365.63720269787;9408.858867117136;9613.086756758097;9779.168770654289;9794.804103918024;9858.654947076819 03:47:19 INFO - 2015-11-16 03:47:19,287 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:47:19 INFO - 2015-11-16 03:47:19,287 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:47:19 INFO - 2015-11-16 03:47:19,287 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,298 03:47:19 INFO - 2015-11-16 03:47:19,288 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:47:19 INFO - 2015-11-16 03:47:19,288 DEBUG : BROWSER_OUTPUT: __startTimestamp1447674439271__endTimestamp 03:47:19 INFO - 2015-11-16 03:47:19,288 DEBUG : BROWSER_OUTPUT: 03:47:19 INFO - 2015-11-16 03:47:19,288 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:47:19 INFO - 2015-11-16 03:47:19,288 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:47:19 INFO - 2015-11-16 03:47:19,288 DEBUG : BROWSER_OUTPUT: 03:47:19 INFO - 2015-11-16 03:47:19,289 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5510.58 Median:5747.60 stddev:759.20 (13.2%) stddev-sans-first:740.78 03:47:19 INFO - 2015-11-16 03:47:19,289 DEBUG : BROWSER_OUTPUT: Values: 3263.1 3274.1 3281.5 3303.4 3312.0 5248.8 5379.0 5397.4 5408.4 5417.1 5489.5 5511.1 5512.7 5521.3 5530.1 4959.9 4962.8 5090.9 5126.8 5176.4 5122.4 5140.2 5149.2 5168.8 5205.0 36.2 5087.6 5101.4 5199.3 5239.0 5082.0 5098.4 5107.3 5111.3 5125.5 5060.3 5077.7 5083.8 5087.0 5140.5 5195.1 5208.4 5216.4 5416.9 5438.6 5907.1 5926.2 5932.0 5938.3 5962.6 5978.2 6007.3 6012.9 6018.3 6024.3 5434.6 5541.7 5562.3 5601.8 5604.8 6049.5 6102.5 6111.9 6119.2 6120.3 5812.3 5826.6 5870.5 5888.5 5958.3 5681.2 5791.8 5799.9 5905.0 5924.7 5942.1 6010.8 6011.3 6015.2 6035.7 5960.6 6003.0 6011.8 6014.5 6018.2 4413.4 4475.6 4505.8 4571.5 4589.1 4075.3 4080.1 4092.9 4095.1 4097.9 5670.5 5686.2 5709.5 5718.9 5755.0 5775.8 5892.2 5927.1 6035.8 6088.6 5709.3 5739.5 5747.6 5770.0 5772.9 5031.4 5152.7 5192.1 5202.9 5210.7 6110.8 6122.2 6127.2 6130.5 6141.5 5987.7 5991.0 5994.8 6030.6 6057.2 6251.4 6252.5 6255.3 6255.7 6266.4 5783.8 5793.3 5882.2 5924.8 5943.1 6051.6 6058.0 6064.6 6072.7 6090.3 5757.5 5910.3 5924.1 5926.2 5926.7 5838.5 5853.3 5961.2 5974.4 6004.4 5664.3 5689.9 5702.8 5729.0 5734.7 5649.2 5831.4 5912.8 5915.1 5918.4 5660.6 5681.7 5692.3 5697.9 5761.4 03:47:19 INFO - 2015-11-16 03:47:19,289 DEBUG : BROWSER_OUTPUT: 03:47:19 INFO - 2015-11-16 03:47:19,289 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49561.01 Median:39134.91 stddev:89346.67 (228.3%) stddev-sans-first:89521.62 03:47:19 INFO - 2015-11-16 03:47:19,289 DEBUG : BROWSER_OUTPUT: Values: 576.9 581.1 586.0 603.8 611.2 39201.2 40145.0 40439.0 40445.4 40546.2 43347.3 43495.0 43903.0 44080.9 44084.0 8694.1 8841.6 8867.8 8890.0 8905.3 8743.6 8767.4 8784.3 8817.6 8822.0 8733.8 8738.0 8800.7 8802.3 8802.5 8775.3 8865.9 8871.4 8877.4 8887.8 8622.1 8844.2 8848.9 8851.8 8858.9 41026.4 41616.4 41694.0 41772.8 41788.6 3266.6 3337.5 3353.5 3379.6 3381.7 29863.7 30522.7 30612.7 30774.4 31444.2 3065.7 3086.8 3089.1 3094.4 3119.6 265325.0 265651.0 265752.0 266592.0 267177.0 42218.8 42898.0 56713.7 56910.7 56954.0 40158.8 40376.2 40506.0 40632.8 40742.4 13897.5 14021.2 14022.4 14030.6 14084.2 11609.1 11714.1 11724.6 11743.4 11743.7 14258.2 14301.5 14393.9 14439.2 14491.6 5736.7 5846.7 5879.9 5889.3 5895.7 868.2 931.6 950.6 956.6 968.8 28462.4 28747.7 28851.6 29009.9 29229.3 1019.4 1049.8 1060.3 1063.0 1160.6 14878.9 16474.3 17146.1 17180.5 17235.8 414579.0 418897.0 421750.0 422810.0 423050.0 54428.5 54628.5 54689.2 54845.0 55439.7 1320.5 1339.1 1347.7 1352.4 1357.5 28449.9 29363.3 29501.3 29522.6 29876.0 45484.5 46267.3 46504.1 46596.3 46613.5 311763.0 312309.0 313916.0 314145.0 315153.0 31887.2 46361.5 46513.8 47487.0 47522.0 43369.6 43593.0 43655.0 43721.8 44226.3 37244.8 37710.0 38354.2 38572.8 39068.6 37623.0 37684.0 37814.2 38073.6 38375.2 35937.3 36261.3 36709.6 36746.0 36836.8 32437.4 33830.2 34236.8 34860.0 34872.3 25662.7 25929.5 26076.7 26185.3 26414.5 03:47:19 INFO - 2015-11-16 03:47:19,289 DEBUG : BROWSER_OUTPUT: 03:47:19 INFO - 2015-11-16 03:47:19,289 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26755.94 Median:22926.42 stddev:87757.83 (382.8%) stddev-sans-first:87981.61 03:47:19 INFO - 2015-11-16 03:47:19,290 DEBUG : BROWSER_OUTPUT: Values: 348.1 349.3 349.4 349.9 352.8 12341.1 12835.7 17377.7 17675.0 18300.7 11794.6 11916.5 11986.3 12349.4 12376.2 4567.2 4669.2 4707.2 4710.1 4720.2 4735.1 4855.7 4865.1 4869.8 4875.0 4744.4 4769.9 4770.4 4825.8 4888.2 4802.6 4816.0 4817.0 4834.2 4858.1 4170.5 4185.6 4337.3 4352.2 4360.3 12990.2 13298.9 13362.0 13442.7 13522.8 1841.0 1889.3 1918.3 1926.2 1930.0 9490.2 9798.4 9937.3 10006.1 10246.4 1710.7 1723.1 1729.4 1751.9 1768.6 59055.4 61108.4 61216.4 62318.7 62424.7 7027.3 7100.5 7120.9 7167.7 7181.3 8478.6 8499.4 8527.7 8555.8 8601.2 5679.0 5714.6 5727.5 5738.1 5760.5 5857.4 5879.1 5908.2 5926.7 5967.0 3334.2 3350.5 3354.0 3359.0 3384.2 1159.0 1161.4 1164.2 1165.7 1198.3 408.1 412.6 419.1 419.4 481.7 9597.6 9920.6 10026.1 10208.2 10250.8 408.5 410.4 415.3 416.7 422.9 5369.7 5391.7 5446.2 5467.7 5474.3 523553.0 525317.0 526945.0 546522.0 551971.0 76105.6 78586.6 78698.2 79489.6 79537.6 451.4 455.3 455.4 455.7 455.7 9520.6 9537.7 9689.5 9728.4 9985.0 35090.5 35755.8 36024.1 36372.5 36818.4 44400.3 45397.5 46146.8 46484.5 46584.3 6598.5 6682.8 6839.6 6870.3 6948.2 12681.1 12810.4 12814.3 12900.1 12958.4 10811.0 10832.5 10851.2 11081.9 11095.3 9787.5 10874.5 11076.6 11233.8 11361.8 11012.6 11141.2 11149.6 11274.5 11306.7 6609.3 6611.3 6618.3 6620.2 6687.9 10423.3 10820.5 10936.7 11287.5 11291.4 03:47:19 INFO - 2015-11-16 03:47:19,290 DEBUG : BROWSER_OUTPUT: 03:47:19 INFO - 2015-11-16 03:47:19,290 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5458.94 Median:6580.49 stddev:2790.37 (42.4%) stddev-sans-first:2782.29 03:47:19 INFO - 2015-11-16 03:47:19,291 DEBUG : BROWSER_OUTPUT: Values: 1494.7 1717.6 1744.4 1779.8 1788.4 7487.9 7747.0 7829.9 7854.0 7951.2 7918.1 7939.9 7987.4 8015.0 8017.4 2248.1 2291.9 2299.8 2300.5 2308.8 2277.8 2301.6 2317.9 2325.8 2328.3 2218.1 2234.1 2253.1 2262.9 2279.5 2259.9 2277.5 2348.3 2351.7 2360.5 2288.4 2306.4 2319.2 2323.8 2324.4 7737.9 7738.2 7746.0 7806.9 7832.9 4746.7 4818.2 4837.9 4849.3 4853.3 3033.9 3047.5 3132.9 3133.5 3145.6 1017.5 1036.0 1055.2 1058.3 1064.4 10507.3 10540.7 10541.5 10581.5 10593.8 4187.3 4201.5 4279.3 4286.8 4304.5 8426.8 8464.4 8467.6 8474.3 8489.7 4744.1 4759.1 4763.2 4777.8 4786.3 4356.1 4360.6 4375.9 4397.8 4405.3 3425.3 3462.6 3477.7 3483.9 3531.3 1083.5 1093.9 1108.0 1111.3 1114.7 990.8 1028.7 1131.0 1233.8 1355.5 7026.6 7057.8 7086.4 7111.6 7322.2 1162.6 1171.8 1180.3 1181.3 1193.8 5796.3 5833.7 5857.3 5878.3 5884.3 9458.0 9500.6 9529.0 9608.1 9663.1 9264.9 9385.3 9401.2 9417.6 9511.7 7113.8 7129.2 7135.0 7139.6 7275.2 7032.7 7152.0 7168.1 7177.0 7192.6 8185.1 8259.2 8297.3 8346.5 8348.7 8444.7 8530.9 8533.1 8607.6 8659.7 6576.6 6603.9 6612.8 6632.1 6675.8 7335.2 7339.9 7353.3 7361.8 7402.2 6770.4 6782.2 7023.3 7079.1 7114.5 7030.3 7115.1 7159.2 7177.9 7245.5 7146.6 7151.7 7175.3 7179.2 7210.9 6584.3 6602.7 6606.4 6609.0 6631.4 6488.3 6600.1 6632.6 6649.3 6660.7 03:47:19 INFO - 2015-11-16 03:47:19,291 DEBUG : BROWSER_OUTPUT: 03:47:19 INFO - 2015-11-16 03:47:19,291 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5623.73 Median:6520.63 stddev:1783.29 (27.3%) stddev-sans-first:1743.25 03:47:19 INFO - 2015-11-16 03:47:19,292 DEBUG : BROWSER_OUTPUT: Values: 317.5 320.2 323.7 325.8 326.9 6254.2 6406.4 6421.3 6424.6 6516.3 6341.6 6365.6 6368.5 6384.6 6390.3 4571.1 4666.7 4680.7 4726.0 4753.2 4681.4 4696.0 4711.2 4720.8 4722.5 4678.8 4683.5 4684.5 4687.6 4688.9 4680.5 4682.5 4691.7 4696.4 4713.8 3879.7 3997.8 4008.2 4036.0 4038.6 5953.4 5961.6 5966.9 5972.5 5992.5 5404.0 5440.3 5447.8 5453.8 5467.7 6585.0 6629.2 6669.4 6692.5 6693.3 4431.8 4465.1 4467.0 4473.1 4473.3 6919.7 6966.5 6995.8 6997.6 7008.5 4451.4 4453.5 4454.2 4455.3 4459.4 4451.3 4498.1 4499.1 4507.6 4509.1 5419.5 5421.9 5428.5 5430.8 5438.8 6778.3 6780.9 6789.5 6799.6 6802.5 1633.4 1641.2 1646.6 1652.2 1654.7 1065.7 1066.0 1069.1 1071.1 1097.2 6524.9 6527.7 6560.2 6561.7 6654.7 7075.9 7105.5 7110.4 7119.9 7146.5 6595.8 6596.2 6654.0 6665.3 6672.9 3765.4 3783.0 3834.6 3844.4 3850.6 7443.2 7452.4 7464.3 7472.0 7472.3 7243.0 7303.9 7308.0 7331.5 7332.3 7185.6 7414.1 7414.3 7416.7 7435.9 7004.3 7057.1 7079.4 7116.5 7132.1 6850.6 6982.5 6994.0 7012.5 7041.0 7399.6 7414.7 7424.0 7450.1 7460.1 4581.9 4607.8 4612.4 4613.0 4632.5 6918.9 6994.4 7037.4 7068.7 7078.5 6843.4 6858.9 6860.6 6861.3 6863.0 6781.6 6801.1 6820.6 6826.8 6849.2 6416.3 6611.8 6645.4 6647.9 6677.0 6707.0 6814.4 6897.6 6902.1 6922.3 6634.8 6708.5 6718.2 6734.9 6743.9 03:47:19 INFO - 2015-11-16 03:47:19,292 DEBUG : BROWSER_OUTPUT: 03:47:19 INFO - 2015-11-16 03:47:19,292 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13652.83 Median:24548.71 stddev:16588.42 (67.6%) stddev-sans-first:16606.45 03:47:19 INFO - 2015-11-16 03:47:19,293 DEBUG : BROWSER_OUTPUT: Values: 702.7 756.5 804.2 806.4 809.9 13752.8 14013.2 14093.6 14110.9 14128.4 12420.2 12657.0 12740.2 12751.5 12791.2 803.1 805.1 816.4 819.8 820.2 818.5 819.3 824.5 826.3 826.4 858.5 859.3 861.3 863.7 865.2 847.7 847.8 851.6 854.8 855.3 619.9 623.2 626.6 627.8 627.9 13463.2 13470.9 13558.5 13622.0 13647.9 10032.8 10285.9 10318.7 10536.7 10593.6 9107.2 9108.6 9815.2 9829.1 9993.6 3195.3 3207.3 3252.0 3303.8 3330.4 46344.8 46418.0 46505.8 46669.1 46835.5 7107.4 7435.6 7510.0 7687.3 7733.5 11800.3 11820.2 11846.3 11850.8 11893.5 6698.7 6856.0 6906.7 6923.1 7031.4 4187.8 4247.1 4262.6 4285.4 4300.6 2632.5 2668.1 2677.0 2679.9 2781.2 481.3 483.6 488.9 503.1 504.0 485.4 642.7 657.8 657.9 683.9 8651.7 8657.7 8658.7 8805.6 8814.3 505.2 525.3 534.7 551.3 678.5 4035.5 4089.6 4276.3 4371.3 4422.4 59651.0 60278.4 60540.7 61062.4 61124.7 53096.7 53585.2 54073.0 54301.7 54423.0 47695.2 47867.0 48140.5 48342.8 49310.8 8583.3 8592.4 8629.2 8664.4 8684.4 35070.6 35269.0 35700.0 36178.8 36236.5 46050.0 46390.5 47037.0 47189.0 48612.0 8153.4 8174.9 8322.0 8463.2 8599.1 12031.3 12054.0 12122.8 12196.8 12238.9 11110.9 11192.3 11196.2 11631.7 11643.9 11241.8 11397.6 11479.2 11659.9 12022.2 11451.7 11541.7 11640.9 11666.2 11933.0 10000.9 10109.7 10141.6 10246.3 10365.6 9408.9 9613.1 9779.2 9794.8 9858.7 03:47:19 INFO - 2015-11-16 03:47:19,293 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:47:19 INFO - 2015-11-16 03:47:19,293 DEBUG : BROWSER_OUTPUT: 03:47:20 INFO - 2015-11-16 03:47:20,002 INFO : Browser exited with error code: 0 03:47:20 INFO - 2015-11-16 03:47:20,025 INFO : Completed test dromaeo_css (00:18:31) 03:47:20 INFO - 2015-11-16 03:47:20,025 INFO : Starting test kraken 03:47:20 INFO - 2015-11-16 03:47:20,025 DEBUG : operating with platform_type : linux_ 03:47:20 INFO - 2015-11-16 03:47:20,026 INFO : Initialising browser for kraken test... 03:47:20 INFO - 2015-11-16 03:47:20,032 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpX9cUVV/profile http://localhost:41035/getInfo.html 03:47:25 INFO - 2015-11-16 03:47:25,871 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:47:25 INFO - 2015-11-16 03:47:25,872 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:47:25 INFO - 2015-11-16 03:47:25,873 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:47:25 INFO - 2015-11-16 03:47:25,873 DEBUG : BROWSER_OUTPUT: __metrics 03:47:27 INFO - 2015-11-16 03:47:27,401 INFO : Browser initialized. 03:47:27 INFO - 2015-11-16 03:47:27,402 INFO : Running cycle 1/1 for kraken test... 03:47:27 INFO - 2015-11-16 03:47:27,402 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpX9cUVV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:47:39 INFO - 2015-11-16 03:47:39,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 141312000 03:47:39 INFO - 2015-11-16 03:47:39,172 DEBUG : BROWSER_OUTPUT: 03:47:41 INFO - 2015-11-16 03:47:41,652 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41035/tests/kraken/driver.html?testName=audio-beat-detection) 03:47:42 INFO - 2015-11-16 03:47:42,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 141418496 03:47:42 INFO - 2015-11-16 03:47:42,266 DEBUG : BROWSER_OUTPUT: 03:47:44 INFO - 2015-11-16 03:47:44,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41035/tests/kraken/driver.html?testName=audio-dft) 03:47:45 INFO - 2015-11-16 03:47:45,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 141881344 03:47:45 INFO - 2015-11-16 03:47:45,551 DEBUG : BROWSER_OUTPUT: 03:47:48 INFO - 2015-11-16 03:47:48,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41035/tests/kraken/driver.html?testName=audio-fft) 03:47:48 INFO - 2015-11-16 03:47:48,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 136130560 03:47:48 INFO - 2015-11-16 03:47:48,970 DEBUG : BROWSER_OUTPUT: 03:47:50 INFO - 2015-11-16 03:47:50,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41035/tests/kraken/driver.html?testName=audio-oscillator) 03:47:51 INFO - 2015-11-16 03:47:51,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 137687040 03:47:51 INFO - 2015-11-16 03:47:51,523 DEBUG : BROWSER_OUTPUT: 03:47:53 INFO - 2015-11-16 03:47:53,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41035/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:47:54 INFO - 2015-11-16 03:47:54,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 138235904 03:47:54 INFO - 2015-11-16 03:47:54,249 DEBUG : BROWSER_OUTPUT: 03:47:57 INFO - 2015-11-16 03:47:57,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41035/tests/kraken/driver.html?testName=imaging-darkroom) 03:47:57 INFO - 2015-11-16 03:47:57,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 139476992 03:47:57 INFO - 2015-11-16 03:47:57,846 DEBUG : BROWSER_OUTPUT: 03:48:01 INFO - 2015-11-16 03:48:01,268 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41035/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:01 INFO - 2015-11-16 03:48:01,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 139849728 03:48:01 INFO - 2015-11-16 03:48:01,855 DEBUG : BROWSER_OUTPUT: 03:48:04 INFO - 2015-11-16 03:48:04,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41035/tests/kraken/driver.html?testName=json-parse-financial) 03:48:05 INFO - 2015-11-16 03:48:05,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 137732096 03:48:05 INFO - 2015-11-16 03:48:05,326 DEBUG : BROWSER_OUTPUT: 03:48:06 INFO - 2015-11-16 03:48:06,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41035/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:48:07 INFO - 2015-11-16 03:48:07,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 139063296 03:48:07 INFO - 2015-11-16 03:48:07,480 DEBUG : BROWSER_OUTPUT: 03:48:09 INFO - 2015-11-16 03:48:09,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41035/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:48:09 INFO - 2015-11-16 03:48:09,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 139005952 03:48:09 INFO - 2015-11-16 03:48:09,923 DEBUG : BROWSER_OUTPUT: 03:48:12 INFO - 2015-11-16 03:48:12,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41035/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:12 INFO - 2015-11-16 03:48:12,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 139538432 03:48:12 INFO - 2015-11-16 03:48:12,610 DEBUG : BROWSER_OUTPUT: 03:48:15 INFO - 2015-11-16 03:48:15,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41035/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:15 INFO - 2015-11-16 03:48:15,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 139423744 03:48:15 INFO - 2015-11-16 03:48:15,687 DEBUG : BROWSER_OUTPUT: 03:48:18 INFO - 2015-11-16 03:48:18,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41035/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:48:18 INFO - 2015-11-16 03:48:18,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 138940416 03:48:18 INFO - 2015-11-16 03:48:18,822 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41035/tests/kraken/driver.html?testName=ai-astar) 03:48:20 INFO - 2015-11-16 03:48:20,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 138248192 03:48:20 INFO - 2015-11-16 03:48:20,766 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,767 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:48:20 INFO - 2015-11-16 03:48:20,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:48:20 INFO - 2015-11-16 03:48:20,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:48:20 INFO - 2015-11-16 03:48:20,767 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:48:20 INFO - 2015-11-16 03:48:20,768 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;104;111;110;112;122;110;112;109;109 03:48:20 INFO - 2015-11-16 03:48:20,768 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;139;159;158;125;163;150;134;166;125 03:48:20 INFO - 2015-11-16 03:48:20,768 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;161;162;163;160;160;163;169;164 03:48:20 INFO - 2015-11-16 03:48:20,768 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;76;73;75;74;159;72;72;72;72 03:48:20 INFO - 2015-11-16 03:48:20,769 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;89;133;90;90;90;132;91;91;138 03:48:20 INFO - 2015-11-16 03:48:20,769 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;111;111;109;110;113;110;110 03:48:20 INFO - 2015-11-16 03:48:20,769 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;146;145;148;147;147;146;147;149 03:48:20 INFO - 2015-11-16 03:48:20,769 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;97;95;95;98;97;96;95;96 03:48:20 INFO - 2015-11-16 03:48:20,770 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;65;60;60;61;61;60;69;57;58 03:48:20 INFO - 2015-11-16 03:48:20,770 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;73;67;68;68;69;67;68;68 03:48:20 INFO - 2015-11-16 03:48:20,770 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;87;85;86;94;85;98;83;93;86 03:48:20 INFO - 2015-11-16 03:48:20,771 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;124;120;119;127;119;128;114;126;116 03:48:20 INFO - 2015-11-16 03:48:20,771 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;154;151;149;140;137;138;145;147;146 03:48:20 INFO - 2015-11-16 03:48:20,772 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;65;68;74;66;65;67;66;67 03:48:20 INFO - 2015-11-16 03:48:20,772 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:48:20 INFO - 2015-11-16 03:48:20,773 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:48:20 INFO - 2015-11-16 03:48:20,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,705 03:48:20 INFO - 2015-11-16 03:48:20,773 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:48:20 INFO - 2015-11-16 03:48:20,773 DEBUG : BROWSER_OUTPUT: __startTimestamp1447674500765__endTimestamp 03:48:20 INFO - 2015-11-16 03:48:20,773 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,774 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:48:20 INFO - 2015-11-16 03:48:20,774 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:48:20 INFO - 2015-11-16 03:48:20,774 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,774 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:111.50 stddev:4.51 (4.0%) stddev-sans-first:4.77 03:48:20 INFO - 2015-11-16 03:48:20,774 DEBUG : BROWSER_OUTPUT: Values: 112.0 104.0 111.0 110.0 112.0 122.0 110.0 112.0 109.0 109.0 03:48:20 INFO - 2015-11-16 03:48:20,774 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,774 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.00 Median:154.50 stddev:15.30 (9.9%) stddev-sans-first:16.16 03:48:20 INFO - 2015-11-16 03:48:20,775 DEBUG : BROWSER_OUTPUT: Values: 151.0 139.0 159.0 158.0 125.0 163.0 150.0 134.0 166.0 125.0 03:48:20 INFO - 2015-11-16 03:48:20,775 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,776 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:2.58 (1.6%) stddev-sans-first:2.74 03:48:20 INFO - 2015-11-16 03:48:20,776 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 161.0 162.0 163.0 160.0 160.0 163.0 169.0 164.0 03:48:20 INFO - 2015-11-16 03:48:20,776 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,776 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.80 Median:73.00 stddev:27.16 (37.2%) stddev-sans-first:28.62 03:48:20 INFO - 2015-11-16 03:48:20,776 DEBUG : BROWSER_OUTPUT: Values: 73.0 76.0 73.0 75.0 74.0 159.0 72.0 72.0 72.0 72.0 03:48:20 INFO - 2015-11-16 03:48:20,776 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,777 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.50 Median:90.00 stddev:21.34 (23.7%) stddev-sans-first:22.15 03:48:20 INFO - 2015-11-16 03:48:20,777 DEBUG : BROWSER_OUTPUT: Values: 91.0 89.0 133.0 90.0 90.0 90.0 132.0 91.0 91.0 138.0 03:48:20 INFO - 2015-11-16 03:48:20,777 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,777 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:110.50 stddev:1.08 (1.0%) stddev-sans-first:1.13 03:48:20 INFO - 2015-11-16 03:48:20,777 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 111.0 111.0 109.0 110.0 113.0 110.0 110.0 03:48:20 INFO - 2015-11-16 03:48:20,777 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,777 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:1.20 03:48:20 INFO - 2015-11-16 03:48:20,777 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 146.0 145.0 148.0 147.0 147.0 146.0 147.0 149.0 03:48:20 INFO - 2015-11-16 03:48:20,778 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,778 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.50 stddev:1.03 (1.1%) stddev-sans-first:1.05 03:48:20 INFO - 2015-11-16 03:48:20,778 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 97.0 95.0 95.0 98.0 97.0 96.0 95.0 96.0 03:48:20 INFO - 2015-11-16 03:48:20,778 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,778 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.20 Median:61.00 stddev:3.46 (5.7%) stddev-sans-first:3.67 03:48:20 INFO - 2015-11-16 03:48:20,778 DEBUG : BROWSER_OUTPUT: Values: 61.0 65.0 60.0 60.0 61.0 61.0 60.0 69.0 57.0 58.0 03:48:20 INFO - 2015-11-16 03:48:20,778 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,778 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.00 stddev:1.71 (2.5%) stddev-sans-first:1.81 03:48:20 INFO - 2015-11-16 03:48:20,779 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 73.0 67.0 68.0 68.0 69.0 67.0 68.0 68.0 03:48:20 INFO - 2015-11-16 03:48:20,779 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,779 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:86.50 stddev:4.96 (5.7%) stddev-sans-first:5.13 03:48:20 INFO - 2015-11-16 03:48:20,779 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 85.0 86.0 94.0 85.0 98.0 83.0 93.0 86.0 03:48:20 INFO - 2015-11-16 03:48:20,779 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,779 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:122.50 stddev:4.72 (3.9%) stddev-sans-first:5.00 03:48:20 INFO - 2015-11-16 03:48:20,779 DEBUG : BROWSER_OUTPUT: Values: 121.0 124.0 120.0 119.0 127.0 119.0 128.0 114.0 126.0 116.0 03:48:20 INFO - 2015-11-16 03:48:20,779 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,779 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.10 Median:146.50 stddev:5.55 (3.8%) stddev-sans-first:5.87 03:48:20 INFO - 2015-11-16 03:48:20,780 DEBUG : BROWSER_OUTPUT: Values: 144.0 154.0 151.0 149.0 140.0 137.0 138.0 145.0 147.0 146.0 03:48:20 INFO - 2015-11-16 03:48:20,780 DEBUG : BROWSER_OUTPUT: 03:48:20 INFO - 2015-11-16 03:48:20,780 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:2.57 (3.8%) stddev-sans-first:2.73 03:48:20 INFO - 2015-11-16 03:48:20,780 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 65.0 68.0 74.0 66.0 65.0 67.0 66.0 67.0 03:48:20 INFO - 2015-11-16 03:48:20,780 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:48:20 INFO - 2015-11-16 03:48:20,780 DEBUG : BROWSER_OUTPUT: 03:48:21 INFO - 2015-11-16 03:48:21,698 INFO : Browser exited with error code: 0 03:48:21 INFO - 2015-11-16 03:48:21,748 INFO : Completed test kraken (00:01:01) 03:48:21 INFO - 2015-11-16 03:48:21,748 INFO : Starting test v8_7 03:48:21 INFO - 2015-11-16 03:48:21,748 DEBUG : operating with platform_type : linux_ 03:48:21 INFO - 2015-11-16 03:48:21,749 INFO : Initialising browser for v8_7 test... 03:48:21 INFO - 2015-11-16 03:48:21,755 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRn4Z5e/profile http://localhost:41035/getInfo.html 03:48:27 INFO - 2015-11-16 03:48:27,022 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:48:27 INFO - 2015-11-16 03:48:27,023 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:48:27 INFO - 2015-11-16 03:48:27,023 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:48:27 INFO - 2015-11-16 03:48:27,023 DEBUG : BROWSER_OUTPUT: __metrics 03:48:28 INFO - 2015-11-16 03:48:28,441 INFO : Browser initialized. 03:48:28 INFO - 2015-11-16 03:48:28,442 INFO : Running cycle 1/1 for v8_7 test... 03:48:28 INFO - 2015-11-16 03:48:28,442 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRn4Z5e/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:48:40 INFO - 2015-11-16 03:48:40,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 141639680 03:48:40 INFO - 2015-11-16 03:48:40,219 DEBUG : BROWSER_OUTPUT: 03:49:01 INFO - 2015-11-16 03:49:01,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41035/tests/v8_7/run.html (next: http://localhost:41035/tests/v8_7/run.html) 03:49:01 INFO - 2015-11-16 03:49:01,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 138620928 03:49:01 INFO - 2015-11-16 03:49:01,832 DEBUG : BROWSER_OUTPUT: 03:49:01 INFO - 2015-11-16 03:49:01,834 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:49:01 INFO - 2015-11-16 03:49:01,834 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:49:01 INFO - 2015-11-16 03:49:01,834 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:49:01 INFO - 2015-11-16 03:49:01,834 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:49:01 INFO - 2015-11-16 03:49:01,834 DEBUG : BROWSER_OUTPUT: |0;Richards;163.371998039536 03:49:01 INFO - 2015-11-16 03:49:01,834 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.12295869356387 03:49:01 INFO - 2015-11-16 03:49:01,834 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.8199943836001 03:49:01 INFO - 2015-11-16 03:49:01,834 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 03:49:01 INFO - 2015-11-16 03:49:01,834 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1055.9662090813094 03:49:01 INFO - 2015-11-16 03:49:01,834 DEBUG : BROWSER_OUTPUT: |5;Earley;741.839762611276 03:49:01 INFO - 2015-11-16 03:49:01,834 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 03:49:01 INFO - 2015-11-16 03:49:01,834 DEBUG : BROWSER_OUTPUT: |7;RegExp;25075 03:49:01 INFO - 2015-11-16 03:49:01,835 DEBUG : BROWSER_OUTPUT: |8;Splay;617.9012345679013 03:49:01 INFO - 2015-11-16 03:49:01,835 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 03:49:01 INFO - 2015-11-16 03:49:01,835 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:49:01 INFO - 2015-11-16 03:49:01,835 DEBUG : BROWSER_OUTPUT: __startTimestamp1447674541832__endTimestamp 03:49:01 INFO - 2015-11-16 03:49:01,835 DEBUG : BROWSER_OUTPUT: 03:49:01 INFO - 2015-11-16 03:49:01,835 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:49:01 INFO - 2015-11-16 03:49:01,835 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:49:01 INFO - 2015-11-16 03:49:01,835 DEBUG : BROWSER_OUTPUT: 03:49:01 INFO - 2015-11-16 03:49:01,835 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.37 Median:163.37 stddev:0.00 (0.0%) 03:49:01 INFO - 2015-11-16 03:49:01,835 DEBUG : BROWSER_OUTPUT: Values: 163.4 03:49:01 INFO - 2015-11-16 03:49:01,835 DEBUG : BROWSER_OUTPUT: 03:49:01 INFO - 2015-11-16 03:49:01,836 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.12 Median:192.12 stddev:0.00 (0.0%) 03:49:01 INFO - 2015-11-16 03:49:01,836 DEBUG : BROWSER_OUTPUT: Values: 192.1 03:49:01 INFO - 2015-11-16 03:49:01,836 DEBUG : BROWSER_OUTPUT: 03:49:01 INFO - 2015-11-16 03:49:01,836 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.82 Median:280.82 stddev:0.00 (0.0%) 03:49:01 INFO - 2015-11-16 03:49:01,836 DEBUG : BROWSER_OUTPUT: Values: 280.8 03:49:01 INFO - 2015-11-16 03:49:01,836 DEBUG : BROWSER_OUTPUT: 03:49:01 INFO - 2015-11-16 03:49:01,836 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 03:49:01 INFO - 2015-11-16 03:49:01,836 DEBUG : BROWSER_OUTPUT: Values: 5035.2 03:49:01 INFO - 2015-11-16 03:49:01,837 DEBUG : BROWSER_OUTPUT: 03:49:01 INFO - 2015-11-16 03:49:01,837 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1055.97 Median:1055.97 stddev:0.00 (0.0%) 03:49:01 INFO - 2015-11-16 03:49:01,837 DEBUG : BROWSER_OUTPUT: Values: 1056.0 03:49:01 INFO - 2015-11-16 03:49:01,837 DEBUG : BROWSER_OUTPUT: 03:49:01 INFO - 2015-11-16 03:49:01,838 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:741.84 Median:741.84 stddev:0.00 (0.0%) 03:49:01 INFO - 2015-11-16 03:49:01,838 DEBUG : BROWSER_OUTPUT: Values: 741.8 03:49:01 INFO - 2015-11-16 03:49:01,838 DEBUG : BROWSER_OUTPUT: 03:49:01 INFO - 2015-11-16 03:49:01,838 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 03:49:01 INFO - 2015-11-16 03:49:01,838 DEBUG : BROWSER_OUTPUT: Values: 12207.3 03:49:01 INFO - 2015-11-16 03:49:01,838 DEBUG : BROWSER_OUTPUT: 03:49:01 INFO - 2015-11-16 03:49:01,838 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25075.00 Median:25075.00 stddev:0.00 (0.0%) 03:49:01 INFO - 2015-11-16 03:49:01,839 DEBUG : BROWSER_OUTPUT: Values: 25075.0 03:49:01 INFO - 2015-11-16 03:49:01,839 DEBUG : BROWSER_OUTPUT: 03:49:01 INFO - 2015-11-16 03:49:01,839 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:617.90 Median:617.90 stddev:0.00 (0.0%) 03:49:01 INFO - 2015-11-16 03:49:01,839 DEBUG : BROWSER_OUTPUT: Values: 617.9 03:49:01 INFO - 2015-11-16 03:49:01,839 DEBUG : BROWSER_OUTPUT: 03:49:01 INFO - 2015-11-16 03:49:01,839 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 03:49:01 INFO - 2015-11-16 03:49:01,839 DEBUG : BROWSER_OUTPUT: Values: 4835.7 03:49:01 INFO - 2015-11-16 03:49:01,839 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:49:01 INFO - 2015-11-16 03:49:01,839 DEBUG : BROWSER_OUTPUT: 03:49:02 INFO - 2015-11-16 03:49:02,770 INFO : Browser exited with error code: 0 03:49:02 INFO - 2015-11-16 03:49:02,786 INFO : Completed test v8_7 (00:00:41) 03:49:02 INFO - 2015-11-16 03:49:02,905 INFO : Completed test suite (00:20:14) 03:49:02 INFO - 2015-11-16 03:49:02,905 DEBUG : Working with test: dromaeo_css 03:49:02 INFO - 2015-11-16 03:49:02,905 DEBUG : Generating results file: dromaeo_css 03:49:02 INFO - 2015-11-16 03:49:02,907 DEBUG : Working with test: kraken 03:49:02 INFO - 2015-11-16 03:49:02,907 DEBUG : Generating results file: kraken 03:49:02 INFO - 2015-11-16 03:49:02,907 INFO : javascript benchmark 03:49:02 INFO - 2015-11-16 03:49:02,907 DEBUG : Working with test: v8_7 03:49:02 INFO - 2015-11-16 03:49:02,907 DEBUG : Generating results file: v8_7 03:49:02 INFO - 2015-11-16 03:49:02,908 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:49:02 INFO - 2015-11-16 03:49:02,965 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 03:49:02 INFO - 2015-11-16 03:49:02,966 DEBUG : process_Request line: dromaeo_css 6731.64 graph.html#tests=[[72,63,43]] 03:49:02 INFO - 2015-11-16 03:49:02,966 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:49:02 INFO - 2015-11-16 03:49:02,998 DEBUG : process_Request line: kraken 1511.20 graph.html#tests=[[232,63,43]] 03:49:02 INFO - 2015-11-16 03:49:02,998 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:49:03 INFO - 2015-11-16 03:49:03,036 DEBUG : process_Request line: v8_7 21339.93 graph.html#tests=[[230,63,43]] 03:49:03 INFO - 2015-11-16 03:49:03,037 INFO : javascript benchmark 03:49:03 INFO - 2015-11-16 03:49:03,041 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [348.12273071858914, 349.2996541933423, 349.38159457759764, 349.8775428599992, 352.8253514510317, 12341.074419418557, 12835.743285134315, 17377.73933391, 17675.0, 18300.72548911764, 11794.587189448372, 11916.523339066449, 11986.340751258676, 12349.382530873465, 12376.195547289442, 4567.155076310884, 4669.159551280785, 4707.152712511746, 4710.128626204146, 4720.221163508017, 4735.100330937111, 4855.660103792736, 4865.124277630025, 4869.780859861315, 4874.951250487486, 4744.383230180089, 4769.856904292877, 4770.403699537558, 4825.7587120644, 4888.24232244001, 4802.59177969873, 4815.975920120412, 4816.951830481703, 4834.178189707741, 4858.149823780842, 4170.52039015511, 4185.6232939035635, 4337.262665346899, 4352.238358287287, 4360.280553708634, 12990.220586764824, 13298.933505332509, 13362.0, 13442.663933401744, 13522.797158042637, 1841.0150569445416, 1889.3198448558508, 1918.2518817661123, 1926.2006267399013, 1929.9603125078058, 9490.240780737524, 9798.363106398061, 9937.304388692794, 10006.149477294439, 10246.38521688701, 1710.6835235481476, 1723.0609317921762, 1729.3687803951593, 1751.9211635476433, 1768.5932235585758, 59055.40944590542, 61108.388916110714, 61216.38783612196, 62318.688406557674, 62424.68787656078, 7027.332403421667, 7100.5029647925185, 7120.928790712027, 7167.7132914682825, 7181.281871812777, 8478.576071196416, 8499.405041647025, 8527.70153044653, 8555.82888342242, 8601.22588966996, 5679.034564124109, 5714.571407144481, 5727.5131613812455, 5738.081906894877, 5760.452756988079, 5857.355690874, 5879.088741245114, 5908.172855800191, 5926.674032928144, 5967.045272756338, 3334.183125134309, 3350.547676063749, 3354.0, 3359.0258824940984, 3384.1708781348234, 1158.9652310430702, 1161.4134861894688, 1164.2141554450711, 1165.7493638867516, 1198.3049831097942, 408.0858876117475, 412.6451251923344, 419.0801191384881, 419.3583816760362, 481.7422678866789, 9597.568109435093, 9920.603175872884, 10026.147777438999, 10208.183345332356, 10250.794984100276, 408.45267341762184, 410.4423712012918, 415.33546325878353, 416.74578507110635, 422.85622888218154, 5369.704666243394, 5391.676499409969, 5446.183072539151, 5467.699276539828, 5474.2609747683555, 523553.0, 525317.0, 526945.0, 546522.0, 551971.0, 76105.61947190229, 78586.6070669643, 78698.21301786909, 79489.60255198802, 79537.60231198923, 451.41316288824396, 455.29202090748544, 455.37158720964857, 455.67419295204087, 455.7356733094731, 9520.571574279036, 9537.666181683608, 9689.515524223902, 9728.367656102331, 9984.950075249577, 35090.473642895886, 35755.821220893726, 36024.09939751423, 36372.45441318435, 36818.447723283636, 44400.333994990746, 45397.54602454065, 46146.76926615345, 46484.53515464938, 46584.30123548217, 6598.505112116706, 6682.799516014527, 6839.589624622538, 6870.27862074475, 6948.166220053626, 12681.112322137362, 12810.423530940943, 12814.295213763333, 12900.096993210385, 12958.416871240628, 10811.0, 10832.5125369357, 10851.186161037796, 11081.889181108085, 11095.278806877526, 9787.46168960714, 10874.510647021061, 11076.612318569134, 11233.831492527455, 11361.772764544497, 11012.559497620005, 11141.16441266892, 11149.609763658233, 11274.492647831032, 11306.717332066764, 6609.339066093352, 6611.2727599963, 6618.338166183343, 6620.205575330991, 6687.866242675216, 10423.322484038514, 10820.458977051274, 10936.671899843017, 11287.492062857027, 11291.378974156172], "dojo.html": [3263.1352691536745, 3274.0505253476485, 3281.5241789940474, 3303.372359251742, 3312.022953228797, 5248.7638056287515, 5379.0, 5397.433269506704, 5408.378036525801, 5417.052015897217, 5489.451054894508, 5511.090670039449, 5512.724363781805, 5521.254630624864, 5530.115181570949, 4959.876003099925, 4962.751862406865, 5090.898182036357, 5126.794928202868, 5176.352955880515, 5122.359705036871, 5140.203268493389, 5149.227615857614, 5168.767405466744, 5205.0, 36.158861165747105, 5087.643864929457, 5101.438841727407, 5199.298094757216, 5239.030779305822, 5081.974590127063, 5098.388193416777, 5107.336046313955, 5111.335526381584, 5125.513076257749, 5060.316857224265, 5077.746112694351, 5083.771230294646, 5087.0, 5140.537351638371, 5195.090859099642, 5208.374995000586, 5216.426193118754, 5416.945830541684, 5438.564914806806, 5907.084401917709, 5926.199963004982, 5931.970340148272, 5938.257717785277, 5962.552808539377, 5978.192943952554, 6007.339192688801, 6012.879742405171, 6018.307894592091, 6024.337322894478, 5434.592405569598, 5541.6674999499755, 5562.276904002454, 5601.775928962837, 5604.8038318659055, 6049.485793707496, 6102.458955353584, 6111.895622426848, 6119.197913140417, 6120.294761999619, 5812.3025236971835, 5826.563007774434, 5870.5010074144175, 5888.4700376966275, 5958.255218097738, 5681.204631351614, 5791.768329266866, 5799.942000580025, 5905.0, 5924.7037648118285, 5942.1383899335215, 6010.849728756729, 6011.338752737195, 6015.218021657157, 6035.668038257938, 5960.642361458326, 6002.969985150046, 6011.789587364508, 6014.51883849291, 6018.187544681412, 4413.360062790877, 4475.619572336388, 4505.797239124247, 4571.5428457154685, 4589.128065667513, 4075.3275709508193, 4080.1023774770097, 4092.8567500137947, 4095.140020595649, 4097.8975525612095, 5670.5180059695385, 5686.232358631614, 5709.460978522085, 5718.914216286759, 5754.971225143848, 5775.797847075332, 5892.204552385459, 5927.081302398135, 6035.78874739382, 6088.573799833969, 5709.286339207599, 5739.540836733051, 5747.597668163188, 5769.9711501442225, 5772.94227057724, 5031.396232452056, 5152.6650767699975, 5192.143296356135, 5202.947970520322, 5210.739463026834, 6110.816675499742, 6122.215193971453, 6127.220070483952, 6130.5204358993005, 6141.477974372139, 5987.670678112571, 5990.9700451497465, 5994.820155395345, 6030.6080104793045, 6057.18228039209, 6251.4061164189325, 6252.531060170414, 6255.280642725963, 6255.655938923403, 6266.404691554295, 5783.768649253982, 5793.333766616893, 5882.176495290748, 5924.822255332347, 5943.078822782476, 6051.576389652682, 6058.0, 6064.605800622945, 6072.666003369857, 6090.269167699905, 5757.453041961007, 5910.349861515144, 5924.11138329254, 5926.170336153028, 5926.703664816656, 5838.532917366516, 5853.326867410302, 5961.225040744849, 5974.4324289192455, 6004.369541198112, 5664.291963504562, 5689.914651280317, 5702.8289151325525, 5729.0, 5734.741936612946, 5649.152627105967, 5831.446012628793, 5912.763489460545, 5915.142304365929, 5918.437748413894, 5660.632058916157, 5681.659100453986, 5692.288463942007, 5697.886042279214, 5761.366249712444], "mootools.html": [1494.6711723420844, 1717.647882184152, 1744.4243399678107, 1779.8131196224388, 1788.4187639017314, 7487.887681684772, 7747.031621047369, 7829.882551761728, 7853.960730196348, 7951.244631759988, 7918.0894197167345, 7939.880901786478, 7987.361011119111, 8014.998125234346, 8017.3986950978615, 2248.100759696118, 2291.9312420627407, 2299.816014718827, 2300.5168914527967, 2308.7575804540534, 2277.7949984501392, 2301.5742087713743, 2317.860928344296, 2325.802306803924, 2328.313147621447, 2218.1127548980376, 2234.0728597632046, 2253.0762387421078, 2262.875541845198, 2279.4757205842666, 2259.887005649719, 2277.54449110177, 2348.2955113466064, 2351.6825228594175, 2360.5396947595227, 2288.416453804286, 2306.3888069661552, 2319.188284100568, 2323.7908588226974, 2324.395657129142, 7737.883931741028, 7738.226177382273, 7746.0317460317465, 7806.882896756553, 7832.921670783277, 4746.715197088186, 4818.229083346648, 4837.879053023667, 4849.272609108627, 4853.320535125085, 3033.924151896198, 3047.4514587374265, 3132.8903488377796, 3133.4673105572106, 3145.622525296956, 1017.4963393120453, 1035.984460233097, 1055.166418529361, 1058.30680904008, 1064.41989115932, 10507.31702439339, 10540.736481587945, 10541.525631346607, 10581.470926453647, 10593.78812423755, 4187.309093999517, 4201.4538110046105, 4279.315309550457, 4286.807093680792, 4304.4834619845815, 8426.831463370698, 8464.44981076228, 8467.57662116904, 8474.322054235647, 8489.702860399857, 4744.146053710365, 4759.143354196209, 4763.237881938942, 4777.8327758528285, 4786.2581299898575, 4356.106998065389, 4360.607545320936, 4375.868723938287, 4397.780110994501, 4405.29515277554, 3425.3320602482777, 3462.601800792941, 3477.739169562293, 3483.89548313551, 3531.3290474809705, 1083.4582708645678, 1093.8632670916136, 1107.9556817727362, 1111.3165403276926, 1114.7046032801313, 990.7622170678985, 1028.681108856257, 1130.9990658267493, 1233.8272641830151, 1355.5052405871786, 7026.578405295699, 7057.788266352018, 7086.39765619928, 7111.608861512666, 7322.231165727629, 1162.593092417647, 1171.7890779659572, 1180.2505409065304, 1181.3089342734424, 1193.8448001759716, 5796.275465566804, 5833.7083145842535, 5857.26784151981, 5878.29460464747, 5884.323302820145, 9457.952710236405, 9500.619975201053, 9529.0, 9608.13526782593, 9663.130318271249, 9264.861027084464, 9385.296102792317, 9401.247900168108, 9417.576209070472, 9511.66709165176, 7113.786586402416, 7129.180144283474, 7135.0, 7139.571625702474, 7275.199728029913, 7032.718691252498, 7152.034475345762, 7168.139823221247, 7177.0, 7192.640367981685, 8185.140560241089, 8259.174082591693, 8297.336213102817, 8346.540940248344, 8348.666053357798, 8444.66221351139, 8530.872036919576, 8533.104024077382, 8607.569621518775, 8659.740207793777, 6576.638284894377, 6603.867922641616, 6612.834679132868, 6632.137822083291, 6675.7997260082275, 7335.193128755939, 7339.889901651586, 7353.264673532818, 7361.8159546011775, 7402.185759566336, 6770.424513916175, 6782.152230971129, 7023.33278338557, 7079.115110611174, 7114.466415018997, 7030.27758199224, 7115.1106111736035, 7159.17669467997, 7177.892331615134, 7245.456590755609, 7146.642667866482, 7151.749688760869, 7175.31834475724, 7179.210286868336, 7210.89183662256, 6584.341565843377, 6602.702878370581, 6606.405423511907, 6608.966955165193, 6631.3700198481065, 6488.318726533646, 6600.07598936159, 6632.568883022588, 6649.301823308483, 6660.666966651745], "ext.html": [576.9423057694229, 581.0586849304127, 585.9765609375623, 603.8037637767724, 611.168810417832, 39201.21597568047, 40145.0, 40438.98902527442, 40445.39331910016, 40546.18907621849, 43347.34978975318, 43495.0, 43903.0, 44080.89797755058, 44084.0, 8694.087120852315, 8841.646334146626, 8867.822643547126, 8889.95555022224, 8905.332100092486, 8743.606537705788, 8767.430117042404, 8784.341174411913, 8817.559122043904, 8821.955890220539, 8733.7816554586, 8738.0, 8800.691975780848, 8802.295816334678, 8802.471851688888, 8775.341849361292, 8865.867011994826, 8871.37900346976, 8877.422967507091, 8887.822243555158, 8622.051574326819, 8844.159804818531, 8848.867266991001, 8851.77870553235, 8858.86711699325, 41026.38460423096, 41616.37575436371, 41694.0, 41772.79113604413, 41788.58211417908, 3266.591676040495, 3337.5327454156195, 3353.547271118392, 3379.611344695367, 3381.712554432876, 29863.701362986525, 30522.694773052208, 30612.693873061206, 30774.38451230985, 31444.21389465259, 3065.708757668018, 3086.8302243376606, 3089.1350421881907, 3094.4430002599524, 3119.5944527211545, 265325.0, 265651.0, 265752.0, 266592.0, 267176.9999999981, 42218.78890605527, 42898.0, 56713.716431418405, 56910.7154464225, 56954.0, 40158.79920600437, 40376.19247615031, 40506.0, 40632.79683601622, 40742.388864167064, 13897.513587024609, 14021.158730476203, 14022.439102435788, 14030.579082627537, 14084.22536760488, 11609.129315301387, 11714.062874970152, 11724.648260552027, 11743.354115523558, 11743.706407339885, 14258.215798130996, 14301.499447519494, 14393.92803035978, 14439.2058436787, 14491.637709057359, 5736.741846616912, 5846.736896839652, 5879.941200588025, 5889.263842019747, 5895.734691938873, 868.2272777228272, 931.5761328595473, 950.6054987180243, 956.5934477846887, 968.7841758592921, 28462.430751384858, 28747.724155131564, 28851.56722649162, 29009.854950725112, 29229.26926826804, 1019.4291196929743, 1049.8477720730452, 1060.289605964006, 1062.9681109566725, 1160.5589875847124, 14878.92560537212, 16474.258658360402, 17146.142692865305, 17180.484585462455, 17235.827641723674, 414579.0, 418897.0, 421750.0, 422810.0, 423050.0, 54428.45571544313, 54628.45371546234, 54689.1796623051, 54845.0, 55439.72280138574, 1320.4784110276387, 1339.0626561407055, 1347.696768227141, 1352.4387379237703, 1357.497725841445, 28449.857750711115, 29363.265918351357, 29501.26246843846, 29522.557161642162, 29876.0, 45484.54515454803, 46267.305990410845, 46504.069918602116, 46596.30105548487, 46613.533864660916, 311763.0, 312309.0, 313916.0, 314145.0, 315153.0, 31887.202819929687, 46361.53638463572, 46513.767431162625, 47487.0, 47522.0, 43369.56630433655, 43593.0, 43655.0, 43721.78139109284, 44226.33660495031, 37244.81377593095, 37710.0, 38354.232915342094, 38572.80713596414, 39068.6093139065, 37623.0, 37684.0, 37814.2437151261, 38073.619263807006, 38375.23249534938, 35937.28125437424, 36261.27477450489, 36709.63290367169, 36746.0, 36836.81581592182, 32437.351252974335, 33830.15424614306, 34236.82881585576, 34860.0, 34872.30255394827, 25662.743372566783, 25929.48141037131, 26076.73923260743, 26185.345366365993, 26414.471710566064], "prototype.html": [317.5094479029899, 320.21387493702963, 323.7232166497643, 325.83545309618637, 326.94441944869385, 6254.249490061194, 6406.423421892029, 6421.26155492118, 6424.6145231286155, 6516.315786842384, 6341.619502829833, 6365.649889256089, 6368.5223608229335, 6384.58500197488, 6390.297067322603, 4571.085782843428, 4666.743329116897, 4680.719156850583, 4725.952740472603, 4753.239481682923, 4681.408321170801, 4695.976520117411, 4711.175544279755, 4720.763961801913, 4722.527747225285, 4678.812847486097, 4683.46140193877, 4684.484706682262, 4687.554682305175, 4688.906221875561, 4680.485146633868, 4682.484926658082, 4691.71849689018, 4696.412948381452, 4713.811447542094, 3879.7090218233743, 3997.8001099944886, 4008.198360327917, 4035.9798201009103, 4038.5557588665515, 5953.404659534012, 5961.552883533753, 5966.850828729316, 5972.492338151263, 5992.460678538952, 5404.000259951882, 5440.265564148829, 5447.782088716446, 5453.7818487260465, 5467.6719396836315, 6584.967075164642, 6629.171353580802, 6669.43309818666, 6692.464602831762, 6693.263740988487, 4431.756253406062, 4465.062336909253, 4466.955330446686, 4473.060657261979, 4473.329000649896, 6919.654017299165, 6966.512344135862, 6995.755148569827, 6997.580145191305, 7008.509404341698, 4451.421315228999, 4453.46558412986, 4454.1982443159895, 4455.26488129455, 4459.44256967879, 4451.287793952952, 4498.122866041156, 4499.10017996402, 4507.639388848885, 4509.098180363941, 5419.539339156137, 5421.918671219935, 5428.538574221236, 5430.809921652803, 5438.809641662523, 6778.288279730656, 6780.864382712417, 6789.490788190906, 6799.586146917872, 6802.489813264025, 1633.3956436118474, 1641.1712085397037, 1646.6459711162158, 1652.165656343563, 1654.710425675502, 1065.717584840018, 1065.9786804263872, 1069.0859315285475, 1071.0788721699332, 1097.1551905033239, 6524.934750652527, 6527.738890444424, 6560.179977502812, 6561.671916404256, 6654.73381064752, 7075.92924070763, 7105.538140020882, 7110.431165506747, 7119.92880071203, 7146.464015198881, 6595.76914807989, 6596.175478065242, 6654.0, 6665.333466653296, 6672.933270667231, 3765.359888818907, 3783.0164157318745, 3834.616538346199, 3844.36567966288, 3850.5764365919727, 7443.181250062489, 7452.403807695479, 7464.328210461084, 7471.9626401867645, 7472.327490525879, 7243.0, 7303.926960730431, 7308.0, 7331.450141239428, 7332.266773322732, 7185.640717964081, 7414.073240844895, 7414.258574142543, 7416.703331866773, 7435.925640743523, 7004.334588214111, 7057.082579264663, 7079.39825114871, 7116.466265030247, 7132.072830532205, 6850.623215723183, 6982.476314276551, 6993.965030174817, 7012.509124361246, 7040.979058036659, 7399.593022383605, 7414.666340014604, 7423.962880185564, 7450.105987281561, 7460.0674915635545, 4581.862544123682, 4607.838725644587, 4612.377329060668, 4613.0312634347165, 4632.4672662644225, 6918.8616227676175, 6994.370506654425, 7037.437005039482, 7068.71725130989, 7078.504504684623, 6843.418309443753, 6858.862822743417, 6860.5540639858245, 6861.348171923659, 6862.965685171542, 6781.559198652072, 6801.081853949851, 6820.556663816836, 6826.761063362758, 6849.212340580897, 6416.262129855127, 6611.801645950629, 6645.401913827779, 6647.867042659216, 6676.9666151668935, 6707.0, 6814.352636499525, 6897.55165914214, 6902.102726645504, 6922.273161317989, 6634.834129146617, 6708.496862735216, 6718.22740384862, 6734.865302693821, 6743.9325606743305], "yui.html": [702.6597856292178, 756.5196100476197, 804.2440106300078, 806.4274365200707, 809.850177717122, 13752.793708094374, 14013.229272390014, 14093.577192684223, 14110.929445352784, 14128.434862605509, 12420.192687475308, 12657.0, 12740.235585864855, 12751.489940402373, 12791.16857404268, 803.1165717710516, 805.1425232127795, 816.4407380944043, 819.7704642700054, 820.2494717333633, 818.472085504849, 819.2913130142414, 824.517657170553, 826.305903041445, 826.4215049465369, 858.5235194467068, 859.2696208222992, 861.2894362151251, 863.6502216602286, 865.2429124516049, 847.6694089305176, 847.8346722389167, 851.6082602003086, 854.8290341931607, 855.3072011670536, 619.8574327904562, 623.23031056645, 626.6396821827467, 627.8461776864651, 627.8524546731514, 13463.192208467426, 13470.93264533671, 13558.457661693521, 13622.0, 13647.863521364858, 10032.79934401308, 10285.948570257176, 10318.742031449274, 10536.736581585445, 10593.629222977235, 9107.225885799715, 9108.596386738125, 9815.165710914582, 9829.066238707312, 9993.550290236957, 3195.2970346523725, 3207.342494788563, 3251.9674803252137, 3303.752218583616, 3330.4171769940162, 46344.7682761584, 46418.0, 46505.76747116276, 46669.066618667435, 46835.531644683455, 7107.360337569644, 7435.628218589049, 7509.962450187714, 7687.34657554103, 7733.535987840635, 11800.291982481078, 11820.23168494045, 11846.348450835114, 11850.822237666442, 11893.524259029542, 6698.7320507179165, 6856.040154378391, 6906.689198986058, 6923.099997000358, 7031.367176953996, 4187.811548480326, 4247.086876321606, 4262.573742625713, 4285.357196420562, 4300.634446072057, 2632.5129850977632, 2668.0795125681607, 2677.0496473751537, 2679.8928042878065, 2781.207355903558, 481.30211193769173, 483.6203580189534, 488.9144399730033, 503.07936476248375, 503.9622028347815, 485.4199231917824, 642.6882961763541, 657.7500549791145, 657.9111819904348, 683.888680893548, 8651.697190598425, 8657.740267791976, 8658.696945607, 8805.559722013873, 8814.250788682906, 505.24970418927865, 525.324957429701, 534.6872079833341, 551.3218740948655, 678.482828705508, 4035.515738111387, 4089.5501494835544, 4276.337167739005, 4371.256886329332, 4422.358757980139, 59651.0, 60278.397216027275, 60540.69729651324, 61062.38937610567, 61124.69437652872, 53096.73451632717, 53585.1962220567, 54073.0, 54301.72849135729, 54423.0, 47695.1843852491, 47867.0, 48140.518594813606, 48342.75828620834, 49310.75344623182, 8583.313334933066, 8592.35557333215, 8629.180227878342, 8664.39349245572, 8684.39209255346, 35070.649293506736, 35269.0, 35700.0, 36178.8191059043, 36236.4564531527, 46050.0, 46390.536094639974, 47037.0, 47189.0, 48612.0, 8153.388495862715, 8174.918250817415, 8322.0, 8463.195996380335, 8599.097094805205, 12031.338276394883, 12054.0, 12122.75754484923, 12196.81704774447, 12238.938805305916, 11110.888891110986, 11192.272502287326, 11196.160287978271, 11631.709207269885, 11643.941780291383, 11241.831372529583, 11397.601083962021, 11479.196456247982, 11659.941700291443, 12022.158448908493, 11451.656450306504, 11541.653750387502, 11640.94179529097, 11666.183367164216, 11933.045356371644, 10000.949995249977, 10109.696709098738, 10141.645042423776, 10246.282760207012, 10365.63720269787, 9408.858867117136, 9613.086756758097, 9779.168770654289, 9794.804103918024, 9858.654947076819]}, "summary": {"lowerIsBetter": false, "suite": 6731.641432314527, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6770.691194033371, "unit": "ms", "value": 6770.691194033371}, "dojo.html": {"lowerIsBetter": false, "filtered": 5463.1476384242915, "unit": "ms", "value": 5463.1476384242915}, "mootools.html": {"lowerIsBetter": false, "filtered": 4507.026369319424, "unit": "ms", "value": 4507.026369319424}, "ext.html": {"lowerIsBetter": false, "filtered": 18360.513920963454, "unit": "ms", "value": 18360.513920963454}, "prototype.html": {"lowerIsBetter": false, "filtered": 5028.904962587224, "unit": "ms", "value": 5028.904962587224}, "yui.html": {"lowerIsBetter": false, "filtered": 6044.589135132013, "unit": "ms", "value": 6044.589135132013}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-020.e"}, "testrun": {"date": 1447673328, "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": "20151116013046", "branch": "Mozilla-Inbound", "revision": "74a949559633b776a2509e7cd6ffd5b3d81e1ff3"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 162.0, 161.0, 162.0, 163.0, 160.0, 160.0, 163.0, 169.0, 164.0], "ai-astar": [112.0, 104.0, 111.0, 110.0, 112.0, 122.0, 110.0, 112.0, 109.0, 109.0], "imaging-gaussian-blur": [111.0, 110.0, 110.0, 111.0, 111.0, 109.0, 110.0, 113.0, 110.0, 110.0], "audio-beat-detection": [151.0, 139.0, 159.0, 158.0, 125.0, 163.0, 150.0, 134.0, 166.0, 125.0], "json-stringify-tinderbox": [68.0, 68.0, 73.0, 67.0, 68.0, 68.0, 69.0, 67.0, 68.0, 68.0], "stanford-crypto-pbkdf2": [144.0, 154.0, 151.0, 149.0, 140.0, 137.0, 138.0, 145.0, 147.0, 146.0], "json-parse-financial": [61.0, 65.0, 60.0, 60.0, 61.0, 61.0, 60.0, 69.0, 57.0, 58.0], "stanford-crypto-sha256-iterative": [67.0, 67.0, 65.0, 68.0, 74.0, 66.0, 65.0, 67.0, 66.0, 67.0], "audio-fft": [73.0, 76.0, 73.0, 75.0, 74.0, 159.0, 72.0, 72.0, 72.0, 72.0], "imaging-darkroom": [148.0, 146.0, 146.0, 145.0, 148.0, 147.0, 147.0, 146.0, 147.0, 149.0], "stanford-crypto-ccm": [121.0, 124.0, 120.0, 119.0, 127.0, 119.0, 128.0, 114.0, 126.0, 116.0], "audio-oscillator": [91.0, 89.0, 133.0, 90.0, 90.0, 90.0, 132.0, 91.0, 91.0, 138.0], "stanford-crypto-aes": [85.0, 87.0, 85.0, 86.0, 94.0, 85.0, 98.0, 83.0, 93.0, 86.0], "imaging-desaturate": [97.0, 96.0, 97.0, 95.0, 95.0, 98.0, 97.0, 96.0, 95.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1511.2000000000003, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 81.8, "unit": "ms", "value": 81.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 145.1, "unit": "ms", "value": 145.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 147.0, "unit": "ms", "value": 147.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.4, "unit": "ms", "value": 121.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.9, "unit": "ms", "value": 146.9}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 61.2, "unit": "ms", "value": 61.2}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.5, "unit": "ms", "value": 103.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.1, "unit": "ms", "value": 111.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.7, "unit": "ms", "value": 162.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.2, "unit": "ms", "value": 67.2}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.4, "unit": "ms", "value": 68.4}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.5, "unit": "ms", "value": 110.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 88.2, "unit": "ms", "value": 88.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.2, "unit": "ms", "value": 96.2}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-020.e"}, "testrun": {"date": 1447673328, "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": "20151116013046", "branch": "Mozilla-Inbound", "revision": "74a949559633b776a2509e7cd6ffd5b3d81e1ff3"}}, {"talos_counters": {}, "results": {"DeltaBlue": [192.12295869356387], "Encrypt": [280.8199943836001], "NavierStokes": [4835.748792270531], "Decrypt": [5035.175879396985], "Splay": [617.9012345679013], "Richards": [163.371998039536], "RegExp": [25075.0], "Earley": [741.839762611276], "Boyer": [12207.317073170732], "RayTrace": [1055.9662090813094]}, "summary": {"lowerIsBetter": false, "suite": 21339.934797124606, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 344.1441900000001, "unit": "score", "value": 344.1441900000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 947.8705409999999, "unit": "score", "value": 947.8705409999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.881118881119, "unit": "score", "value": 306.881118881119}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 131.88353646353647, "unit": "score", "value": 131.88353646353647}, "RegExp": {"lowerIsBetter": false, "filtered": 36.33040877367896, "unit": "score", "value": 36.33040877367896}, "Richards": {"lowerIsBetter": false, "filtered": 216.08354200000005, "unit": "score", "value": 216.08354200000005}, "Earley": {"lowerIsBetter": false, "filtered": 898.3921239999999, "unit": "score", "value": 898.3921239999999}, "Boyer": {"lowerIsBetter": false, "filtered": 54.595370629370635, "unit": "score", "value": 54.595370629370635}, "RayTrace": {"lowerIsBetter": false, "filtered": 700.7695829999997, "unit": "score", "value": 700.7695829999997}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-020.e"}, "testrun": {"date": 1447673328, "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": "20151116013046", "branch": "Mozilla-Inbound", "revision": "74a949559633b776a2509e7cd6ffd5b3d81e1ff3"}}] 03:49:03 INFO - RETURN: dromaeo_css: 6731.64 03:49:03 INFO - RETURN: kraken: 1511.20 03:49:03 INFO - RETURN: v8_7: 21339.93 03:49:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21339.93"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1511.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6731.64"}}} 03:49:03 INFO - Return code: 0 03:49:03 INFO - # TBPL SUCCESS # 03:49:03 INFO - Running post-action listener: _resource_record_post_action 03:49:03 INFO - Running post-run listener: _resource_record_post_run 03:49:04 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 20480; Write bytes: 502968320; Read time: 828; Write time: 901896 03:49:04 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 155131904; Read time: 0; Write time: 304220 03:49:04 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 20480; Write bytes: 299511808; Read time: 828; Write time: 463856 03:49:04 INFO - Running post-run listener: _upload_blobber_files 03:49:04 INFO - Blob upload gear active. 03:49:04 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:49:04 INFO - Copying logs to upload dir... 03:49:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.760187 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-11-16 03:49:03.923705) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 03:49:03.927567) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009989 build_url: 'https://queue.taskcluster.net/v1/task/eC-NysARQSikkaht8LNKrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 03:49:03.981782) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:49:03.982155) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447665066.900191-225146094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004580 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:49:04.034268) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 03:49:04.034961) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 03:49:04.035653) ========= ========= Total master_lag: 0.22 =========