builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1447608229.05 results: success (0) buildid: 20151115073848 builduid: ff875c7608f2422d9686a090ec8e11ae revision: 4922c78419fa8a7c6a81f0f504406b85c6cee763 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:49.049463) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:49.049924) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:49.050285) ========= 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=3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009091 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:49.098690) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:49.099002) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:49.126402) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:49.126691) ========= 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=3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.010318 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:49.180876) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:49.181185) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:49.181590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:49.181920) ========= 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=3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-15 09:23: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% 213M=0s 2015-11-15 09:23:49 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175318 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:49.379084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:49.379418) ========= 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=3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.150246 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:49.547207) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:49.547608) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4922c78419fa8a7c6a81f0f504406b85c6cee763 --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 4922c78419fa8a7c6a81f0f504406b85c6cee763 --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=3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-15 09:23:50,145 truncating revision to first 12 chars 2015-11-15 09:23:50,145 Setting DEBUG logging. 2015-11-15 09:23:50,145 attempt 1/10 2015-11-15 09:23:50,145 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4922c78419fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 09:23:50,390 unpacking tar archive at: mozilla-inbound-4922c78419fa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.517969 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:50.082015) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:50.082386) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:50.093173) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:50.093724) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 09:23:50.094570) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2015-11-15 09:23:50.095201) ========= /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=3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:23:50 INFO - MultiFileLogger online at 20151115 09:23:50 in /builds/slave/test-pgo 09:23: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 09:23:50 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:23:50 INFO - {'append_to_log': False, 09:23:50 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:23:50 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:23:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:23:50 INFO - 'branch': 'Mozilla-Inbound', 09:23:50 INFO - 'buildbot_json_path': 'buildprops.json', 09:23:50 INFO - 'config_files': ('talos/linux_config.py',), 09:23:50 INFO - 'default_actions': ('clobber', 09:23:50 INFO - 'read-buildbot-config', 09:23:50 INFO - 'download-and-extract', 09:23:50 INFO - 'populate-webroot', 09:23:50 INFO - 'create-virtualenv', 09:23:50 INFO - 'install', 09:23:50 INFO - 'run-tests'), 09:23:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:23:50 INFO - 'download_minidump_stackwalk': True, 09:23:50 INFO - 'download_symbols': 'ondemand', 09:23:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:23:50 INFO - 'tooltool.py': '/tools/tooltool.py', 09:23:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:23:50 INFO - '/tools/misc-python/virtualenv.py')}, 09:23:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:23:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:23:50 INFO - 'installer_path': 'installer.exe', 09:23:50 INFO - 'log_level': 'info', 09:23:50 INFO - 'log_name': 'talos', 09:23:50 INFO - 'log_to_console': True, 09:23:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:23:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:23:50 INFO - 'opt_config_files': (), 09:23:50 INFO - 'pip_index': False, 09:23:50 INFO - 'sps_profile': False, 09:23:50 INFO - 'sps_profile_interval': 0, 09:23:50 INFO - 'suite': 'dromaeojs-e10s', 09:23:50 INFO - 'system_bits': '64', 09:23:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:23:50 INFO - 'title': 'talos-linux64-ix-062', 09:23:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:23:50 INFO - 'use_talos_json': True, 09:23:50 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:23:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:23:50 INFO - 'work_dir': 'build'} 09:23:50 INFO - ##### 09:23:50 INFO - ##### Running clobber step. 09:23:50 INFO - ##### 09:23:50 INFO - Running pre-action listener: _resource_record_pre_action 09:23:50 INFO - Running main action method: clobber 09:23:50 INFO - rmtree: /builds/slave/test-pgo/build 09:23:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:23:51 INFO - Running post-action listener: _resource_record_post_action 09:23:51 INFO - ##### 09:23:51 INFO - ##### Running read-buildbot-config step. 09:23:51 INFO - ##### 09:23:51 INFO - Running pre-action listener: _resource_record_pre_action 09:23:51 INFO - Running main action method: read_buildbot_config 09:23:51 INFO - Using buildbot properties: 09:23:51 INFO - { 09:23:51 INFO - "properties": { 09:23:51 INFO - "buildnumber": 190, 09:23:51 INFO - "product": "firefox", 09:23:51 INFO - "script_repo_revision": "production", 09:23:51 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 09:23:51 INFO - "repository": "", 09:23:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 09:23:51 INFO - "buildid": "20151115073848", 09:23:51 INFO - "slavename": "talos-linux64-ix-062", 09:23:51 INFO - "pgo_build": "True", 09:23:51 INFO - "basedir": "/builds/slave/test-pgo", 09:23:51 INFO - "project": "", 09:23:51 INFO - "platform": "ubuntu64_hw", 09:23:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:23:51 INFO - "slavebuilddir": "test", 09:23:51 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:23:51 INFO - "branch": "mozilla-inbound", 09:23:51 INFO - "repo_path": "integration/mozilla-inbound", 09:23:51 INFO - "stage_platform": "linux64-pgo", 09:23:51 INFO - "builduid": "ff875c7608f2422d9686a090ec8e11ae", 09:23:51 INFO - "revision": "4922c78419fa8a7c6a81f0f504406b85c6cee763" 09:23:51 INFO - }, 09:23:51 INFO - "sourcestamp": { 09:23:51 INFO - "repository": "", 09:23:51 INFO - "hasPatch": false, 09:23:51 INFO - "project": "", 09:23:51 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 09:23:51 INFO - "changes": [ 09:23:51 INFO - { 09:23:51 INFO - "category": null, 09:23:51 INFO - "files": [ 09:23:51 INFO - { 09:23:51 INFO - "url": null, 09:23:51 INFO - "name": "https://queue.taskcluster.net/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:23:51 INFO - } 09:23:51 INFO - ], 09:23:51 INFO - "repository": "", 09:23:51 INFO - "rev": "4922c78419fa8a7c6a81f0f504406b85c6cee763", 09:23:51 INFO - "who": "sendchange", 09:23:51 INFO - "when": 1447608144, 09:23:51 INFO - "number": 6663634, 09:23:51 INFO - "comments": "", 09:23:51 INFO - "project": "", 09:23:51 INFO - "at": "Sun 15 Nov 2015 09:22:24", 09:23:51 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 09:23:51 INFO - "revlink": "", 09:23:51 INFO - "properties": [ 09:23:51 INFO - [ 09:23:51 INFO - "buildid", 09:23:51 INFO - "20151115073848", 09:23:51 INFO - "Change" 09:23:51 INFO - ], 09:23:51 INFO - [ 09:23:51 INFO - "builduid", 09:23:51 INFO - "ff875c7608f2422d9686a090ec8e11ae", 09:23:51 INFO - "Change" 09:23:51 INFO - ], 09:23:51 INFO - [ 09:23:51 INFO - "pgo_build", 09:23:51 INFO - "True", 09:23:51 INFO - "Change" 09:23:51 INFO - ] 09:23:51 INFO - ], 09:23:51 INFO - "revision": "4922c78419fa8a7c6a81f0f504406b85c6cee763" 09:23:51 INFO - } 09:23:51 INFO - ], 09:23:51 INFO - "revision": "4922c78419fa8a7c6a81f0f504406b85c6cee763" 09:23:51 INFO - } 09:23:51 INFO - } 09:23:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:23:51 INFO - Running post-action listener: _resource_record_post_action 09:23:51 INFO - ##### 09:23:51 INFO - ##### Running download-and-extract step. 09:23:51 INFO - ##### 09:23:51 INFO - Running pre-action listener: _resource_record_pre_action 09:23:51 INFO - Running main action method: download_and_extract 09:23:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:23: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')]} 09:23:51 INFO - https://queue.taskcluster.net/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:23:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/test_packages.json 09:23:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/test_packages.json 09:23:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:23:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:23:52 INFO - Downloaded 1302 bytes. 09:23:52 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:23:52 INFO - Using the following test package requirements: 09:23:52 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:23:52 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:23:52 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:52 INFO - u'jsshell-linux-x86_64.zip'], 09:23:52 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:23:52 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:23:52 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:23:52 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:23:52 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:23:52 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:23:52 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:23:52 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:52 INFO - https://queue.taskcluster.net/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:23:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:23:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:23:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/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 09:23:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/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 09:23:53 INFO - Downloaded 22462216 bytes. 09:23:53 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 09:23:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:23:53 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 09:23:54 INFO - Return code: 0 09:23:54 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 09:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:54 INFO - https://queue.taskcluster.net/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:23:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:23:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:23:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/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 09:23:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/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 09:23:55 INFO - Downloaded 22462216 bytes. 09:23:55 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 09:23:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:23:55 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 09:23:57 INFO - Return code: 0 09:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:57 INFO - https://queue.taskcluster.net/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:23:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:23:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:23:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/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 09:23:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/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 09:23:58 INFO - Downloaded 11131693 bytes. 09:23:58 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 09:23:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:23:58 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 09:23:58 INFO - Return code: 0 09:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:58 INFO - https://queue.taskcluster.net/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:23:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:23:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:23:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/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 09:23:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/41xWOCFTSZyx6Os0Im_03A/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 09:23:59 INFO - Downloaded 57140939 bytes. 09:23:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:23:59 INFO - mkdir: /builds/slave/test-pgo/properties 09:23:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:23:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:23:59 INFO - Contents: 09:23:59 INFO - build_url:https://queue.taskcluster.net/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:23:59 INFO - Running post-action listener: _resource_record_post_action 09:23:59 INFO - Running post-action listener: set_extra_try_arguments 09:23:59 INFO - ##### 09:23:59 INFO - ##### Running populate-webroot step. 09:23:59 INFO - ##### 09:23:59 INFO - Running pre-action listener: _resource_record_pre_action 09:23:59 INFO - Running main action method: populate_webroot 09:23:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:23:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:23:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:23:59 INFO - '../fennec_ids.txt'], 09:23:59 INFO - 'tests': ['tcheck2']}, 09:23:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:23:59 INFO - '--tppagecycles', 09:23:59 INFO - '7'], 09:23:59 INFO - 'tests': ['tsvgm']}}, 09:23:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:23:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:23:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:23:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:23:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:23:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:23:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:59 INFO - 'talos_options': ['--e10s'], 09:23:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:59 INFO - 'tests': ['damp', 'tps']}, 09:23:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:59 INFO - 'talos_options': ['--e10s'], 09:23:59 INFO - 'tests': ['damp', 'tps']}, 09:23:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:23:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:59 INFO - 'other': {'tests': ['a11yr', 09:23:59 INFO - 'ts_paint', 09:23:59 INFO - 'tpaint', 09:23:59 INFO - 'sessionrestore', 09:23:59 INFO - 'sessionrestore_no_auto_restore']}, 09:23:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:23:59 INFO - 'tests': ['a11yr', 09:23:59 INFO - 'ts_paint', 09:23:59 INFO - 'tpaint', 09:23:59 INFO - 'sessionrestore', 09:23:59 INFO - 'sessionrestore_no_auto_restore']}, 09:23:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:23:59 INFO - 'tests': ['a11yr', 09:23:59 INFO - 'ts_paint', 09:23:59 INFO - 'tpaint', 09:23:59 INFO - 'sessionrestore', 09:23:59 INFO - 'sessionrestore_no_auto_restore']}, 09:23:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:23:59 INFO - 'tests': ['a11yr', 09:23:59 INFO - 'ts_paint', 09:23:59 INFO - 'tpaint', 09:23:59 INFO - 'sessionrestore', 09:23:59 INFO - 'sessionrestore_no_auto_restore']}, 09:23:59 INFO - 'other_l64': {'tests': ['a11yr', 09:23:59 INFO - 'ts_paint', 09:23:59 INFO - 'tpaint', 09:23:59 INFO - 'sessionrestore', 09:23:59 INFO - 'sessionrestore_no_auto_restore']}, 09:23:59 INFO - 'other_nol64': {'tests': ['a11yr', 09:23:59 INFO - 'ts_paint', 09:23:59 INFO - 'tpaint', 09:23:59 INFO - 'sessionrestore', 09:23:59 INFO - 'sessionrestore_no_auto_restore']}, 09:23:59 INFO - 'svgr': {'tests': ['tsvgx', 09:23:59 INFO - 'tsvgr_opacity', 09:23:59 INFO - 'tart', 09:23:59 INFO - 'tscrollx', 09:23:59 INFO - 'cart']}, 09:23:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:23:59 INFO - 'tests': ['tsvgx', 09:23:59 INFO - 'tsvgr_opacity', 09:23:59 INFO - 'tart', 09:23:59 INFO - 'tscrollx', 09:23:59 INFO - 'cart']}, 09:23:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:59 INFO - 'tests': ['tp5o']}, 09:23:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:59 INFO - 'talos_options': ['--e10s'], 09:23:59 INFO - 'tests': ['tp5o']}, 09:23:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:59 INFO - 'talos_options': ['--xperf_path', 09:23:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:59 INFO - 'tests': ['tp5n']}, 09:23:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:59 INFO - 'talos_options': ['--e10s', 09:23:59 INFO - '--xperf_path', 09:23:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:59 INFO - 'tests': ['tp5n']}}, 09:23:59 INFO - 'talos.zip': {'path': '', 09:23:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:23:59 INFO - Running post-action listener: _resource_record_post_action 09:23:59 INFO - ##### 09:23:59 INFO - ##### Running create-virtualenv step. 09:23:59 INFO - ##### 09:23:59 INFO - Running pre-action listener: _resource_record_pre_action 09:23:59 INFO - Running main action method: create_virtualenv 09:23:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:23:59 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 09:23:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:23:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:59 INFO - Using real prefix '/usr' 09:23:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:24:00 INFO - Installing distribute.............................................................................................................................................................................................done. 09:24:02 INFO - Installing pip.................done. 09:24:02 INFO - Return code: 0 09:24:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:02 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 0x7f58dd92dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f316c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff26e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2028a90>, '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 0x207af70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b2e0>, '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': '3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396', '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 09:24:02 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 09:24:02 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 09:24:02 INFO - Using env: {'DISPLAY': ':0', 09:24:02 INFO - 'HOME': '/home/cltbld', 09:24:02 INFO - 'LANG': 'en_US.UTF-8', 09:24:02 INFO - 'LANGUAGE': 'en_US:en', 09:24:02 INFO - 'LOGNAME': 'cltbld', 09:24:02 INFO - 'MAIL': '/var/mail/cltbld', 09:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:02 INFO - 'MOZ_NO_REMOTE': '1', 09:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:02 INFO - 'NO_EM_RESTART': '1', 09:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:24:02 INFO - 'PWD': '/builds/slave/test-pgo', 09:24:02 INFO - 'SHELL': '/bin/bash', 09:24:02 INFO - 'SHLVL': '1', 09:24:02 INFO - 'TERM': 'linux', 09:24:02 INFO - 'TMOUT': '86400', 09:24:02 INFO - 'USER': 'cltbld', 09:24:02 INFO - 'XDG_SESSION_COOKIE': '3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396', 09:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:02 INFO - '_': '/tools/buildbot/bin/python'} 09:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:02 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 09:24:02 INFO - Cleaning up... 09:24:02 INFO - Return code: 0 09:24:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:02 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 0x7f58dd92dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f316c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff26e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2028a90>, '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 0x207af70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b2e0>, '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': '3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396', '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 09:24:02 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 09:24:02 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 09:24:02 INFO - Using env: {'DISPLAY': ':0', 09:24:02 INFO - 'HOME': '/home/cltbld', 09:24:02 INFO - 'LANG': 'en_US.UTF-8', 09:24:02 INFO - 'LANGUAGE': 'en_US:en', 09:24:02 INFO - 'LOGNAME': 'cltbld', 09:24:02 INFO - 'MAIL': '/var/mail/cltbld', 09:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:02 INFO - 'MOZ_NO_REMOTE': '1', 09:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:02 INFO - 'NO_EM_RESTART': '1', 09:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:24:02 INFO - 'PWD': '/builds/slave/test-pgo', 09:24:02 INFO - 'SHELL': '/bin/bash', 09:24:02 INFO - 'SHLVL': '1', 09:24:02 INFO - 'TERM': 'linux', 09:24:02 INFO - 'TMOUT': '86400', 09:24:02 INFO - 'USER': 'cltbld', 09:24:02 INFO - 'XDG_SESSION_COOKIE': '3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396', 09:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:02 INFO - '_': '/tools/buildbot/bin/python'} 09:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:02 INFO - Downloading/unpacking psutil>=0.7.1 09:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:04 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:24:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:24:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:24:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:04 INFO - Installing collected packages: psutil 09:24:04 INFO - Running setup.py install for psutil 09:24:04 INFO - building 'psutil._psutil_linux' extension 09:24:04 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 09:24:04 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 09:24:04 INFO - building 'psutil._psutil_posix' extension 09:24:04 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 09:24:04 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 09:24:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:05 INFO - Successfully installed psutil 09:24:05 INFO - Cleaning up... 09:24:05 INFO - Return code: 0 09:24:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f58dd92dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f316c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff26e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2028a90>, '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 0x207af70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b2e0>, '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': '3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396', '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 09:24:05 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 09:24:05 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 09:24:05 INFO - Using env: {'DISPLAY': ':0', 09:24:05 INFO - 'HOME': '/home/cltbld', 09:24:05 INFO - 'LANG': 'en_US.UTF-8', 09:24:05 INFO - 'LANGUAGE': 'en_US:en', 09:24:05 INFO - 'LOGNAME': 'cltbld', 09:24:05 INFO - 'MAIL': '/var/mail/cltbld', 09:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:05 INFO - 'MOZ_NO_REMOTE': '1', 09:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:05 INFO - 'NO_EM_RESTART': '1', 09:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:24:05 INFO - 'PWD': '/builds/slave/test-pgo', 09:24:05 INFO - 'SHELL': '/bin/bash', 09:24:05 INFO - 'SHLVL': '1', 09:24:05 INFO - 'TERM': 'linux', 09:24:05 INFO - 'TMOUT': '86400', 09:24:05 INFO - 'USER': 'cltbld', 09:24:05 INFO - 'XDG_SESSION_COOKIE': '3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396', 09:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:05 INFO - '_': '/tools/buildbot/bin/python'} 09:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:24:05 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 09:24:05 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 09:24:05 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 09:24:05 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 09:24:05 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 09:24:05 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 09:24:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:24:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:24:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:24:07 INFO - Installing collected packages: mozsystemmonitor 09:24:07 INFO - Running setup.py install for mozsystemmonitor 09:24:07 INFO - Successfully installed mozsystemmonitor 09:24:07 INFO - Cleaning up... 09:24:07 INFO - Return code: 0 09:24:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f58dd92dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f316c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff26e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2028a90>, '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 0x207af70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b2e0>, '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': '3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396', '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 09:24:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:24:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:24:07 INFO - Using env: {'DISPLAY': ':0', 09:24:07 INFO - 'HOME': '/home/cltbld', 09:24:07 INFO - 'LANG': 'en_US.UTF-8', 09:24:07 INFO - 'LANGUAGE': 'en_US:en', 09:24:07 INFO - 'LOGNAME': 'cltbld', 09:24:07 INFO - 'MAIL': '/var/mail/cltbld', 09:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:07 INFO - 'MOZ_NO_REMOTE': '1', 09:24:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:07 INFO - 'NO_EM_RESTART': '1', 09:24:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:24:07 INFO - 'PWD': '/builds/slave/test-pgo', 09:24:07 INFO - 'SHELL': '/bin/bash', 09:24:07 INFO - 'SHLVL': '1', 09:24:07 INFO - 'TERM': 'linux', 09:24:07 INFO - 'TMOUT': '86400', 09:24:07 INFO - 'USER': 'cltbld', 09:24:07 INFO - 'XDG_SESSION_COOKIE': '3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396', 09:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:07 INFO - '_': '/tools/buildbot/bin/python'} 09:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:07 INFO - Downloading/unpacking blobuploader==1.2.4 09:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:09 INFO - Downloading blobuploader-1.2.4.tar.gz 09:24:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:24:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:24:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:24:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:24:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:09 INFO - Downloading docopt-0.6.1.tar.gz 09:24:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:24:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:09 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:09 INFO - Running setup.py install for blobuploader 09:24:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:24:09 INFO - Running setup.py install for requests 09:24:10 INFO - Running setup.py install for docopt 09:24:10 INFO - Successfully installed blobuploader requests docopt 09:24:10 INFO - Cleaning up... 09:24:10 INFO - Return code: 0 09:24:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:24: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')]} 09:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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')]} 09:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:10 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 0x7f58dd92dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f316c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff26e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2028a90>, '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 0x207af70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b2e0>, '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': '3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396', '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 09:24:10 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 09:24:10 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 09:24:10 INFO - Using env: {'DISPLAY': ':0', 09:24:10 INFO - 'HOME': '/home/cltbld', 09:24:10 INFO - 'LANG': 'en_US.UTF-8', 09:24:10 INFO - 'LANGUAGE': 'en_US:en', 09:24:10 INFO - 'LOGNAME': 'cltbld', 09:24:10 INFO - 'MAIL': '/var/mail/cltbld', 09:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:10 INFO - 'MOZ_NO_REMOTE': '1', 09:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:10 INFO - 'NO_EM_RESTART': '1', 09:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:24:10 INFO - 'PWD': '/builds/slave/test-pgo', 09:24:10 INFO - 'SHELL': '/bin/bash', 09:24:10 INFO - 'SHLVL': '1', 09:24:10 INFO - 'TERM': 'linux', 09:24:10 INFO - 'TMOUT': '86400', 09:24:10 INFO - 'USER': 'cltbld', 09:24:10 INFO - 'XDG_SESSION_COOKIE': '3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396', 09:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:10 INFO - '_': '/tools/buildbot/bin/python'} 09:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:24:10 INFO - Running setup.py (path:/tmp/pip-pQB40j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:24:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:24:10 INFO - Running setup.py (path:/tmp/pip-AomNpq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:24:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:24:10 INFO - Running setup.py (path:/tmp/pip-Nl50ce-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:24:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:24:10 INFO - Running setup.py (path:/tmp/pip-EUZRRg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:24:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:24:10 INFO - Running setup.py (path:/tmp/pip-bsh_9f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:24:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:24:10 INFO - Running setup.py (path:/tmp/pip-9usnR0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:24:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:24:11 INFO - Running setup.py (path:/tmp/pip-Iv_u7m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:24:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:24:11 INFO - Running setup.py (path:/tmp/pip-zAkYtS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:24:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:24:11 INFO - Running setup.py (path:/tmp/pip-1yvfar-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:24:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:24:11 INFO - Running setup.py (path:/tmp/pip-N2dxdq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:24:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:24:11 INFO - Running setup.py (path:/tmp/pip-xkT0QB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:24:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:24:11 INFO - Running setup.py (path:/tmp/pip-oAGMWX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:24:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:24:11 INFO - Running setup.py (path:/tmp/pip-KjE7_m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:24:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:24:11 INFO - Running setup.py (path:/tmp/pip-jyPoZF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:24:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:24:11 INFO - Running setup.py (path:/tmp/pip-gtCjZk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:24:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:24:11 INFO - Running setup.py (path:/tmp/pip-fEa8wD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:24:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:24:11 INFO - Running setup.py (path:/tmp/pip-TfyIO8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:24:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:24:11 INFO - Running setup.py install for manifestparser 09:24:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:24:11 INFO - Running setup.py install for mozcrash 09:24:12 INFO - Running setup.py install for mozdebug 09:24:12 INFO - Running setup.py install for mozdevice 09:24:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:24:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:24:12 INFO - Running setup.py install for mozfile 09:24:12 INFO - Running setup.py install for mozhttpd 09:24:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:24:12 INFO - Running setup.py install for mozinfo 09:24:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:24:12 INFO - Running setup.py install for mozInstall 09:24:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:24:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:24:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:24:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:24:12 INFO - Running setup.py install for mozleak 09:24:12 INFO - Running setup.py install for mozlog 09:24:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:24:12 INFO - Running setup.py install for moznetwork 09:24:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:24:12 INFO - Running setup.py install for mozprocess 09:24:13 INFO - Running setup.py install for mozprofile 09:24:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:24:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:24:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:24:13 INFO - Running setup.py install for mozrunner 09:24:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:24:13 INFO - Running setup.py install for mozscreenshot 09:24:13 INFO - Running setup.py install for moztest 09:24:13 INFO - Running setup.py install for mozversion 09:24:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:24:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:24:13 INFO - Cleaning up... 09:24:13 INFO - Return code: 0 09:24:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:24:13 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')]} 09:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:13 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')]} 09:24:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:13 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 0x7f58dd92dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f316c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff26e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2028a90>, '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 0x207af70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b2e0>, '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': '3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396', '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 09:24:13 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 09:24:13 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 09:24:13 INFO - Using env: {'DISPLAY': ':0', 09:24:13 INFO - 'HOME': '/home/cltbld', 09:24:13 INFO - 'LANG': 'en_US.UTF-8', 09:24:13 INFO - 'LANGUAGE': 'en_US:en', 09:24:13 INFO - 'LOGNAME': 'cltbld', 09:24:13 INFO - 'MAIL': '/var/mail/cltbld', 09:24:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:13 INFO - 'MOZ_NO_REMOTE': '1', 09:24:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:13 INFO - 'NO_EM_RESTART': '1', 09:24:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:24:13 INFO - 'PWD': '/builds/slave/test-pgo', 09:24:13 INFO - 'SHELL': '/bin/bash', 09:24:13 INFO - 'SHLVL': '1', 09:24:13 INFO - 'TERM': 'linux', 09:24:13 INFO - 'TMOUT': '86400', 09:24:13 INFO - 'USER': 'cltbld', 09:24:13 INFO - 'XDG_SESSION_COOKIE': '3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396', 09:24:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:13 INFO - '_': '/tools/buildbot/bin/python'} 09:24:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:24:13 INFO - Running setup.py (path:/tmp/pip-MN_iSq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:24:13 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)) 09:24:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:24:13 INFO - Running setup.py (path:/tmp/pip-IpYgAY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:24:14 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)) 09:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:24:14 INFO - Running setup.py (path:/tmp/pip-7dI72t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:24:14 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)) 09:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:24:14 INFO - Running setup.py (path:/tmp/pip-umuMfu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:24:14 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)) 09:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:24:14 INFO - Running setup.py (path:/tmp/pip-a5TJB_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:24:14 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)) 09:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:24:14 INFO - Running setup.py (path:/tmp/pip-SPw1Eb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:24:14 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)) 09:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:24:14 INFO - Running setup.py (path:/tmp/pip-ZF_9e7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:24:14 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)) 09:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:24:14 INFO - Running setup.py (path:/tmp/pip-wxKai_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:24:14 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)) 09:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:24:14 INFO - Running setup.py (path:/tmp/pip-AQlYxm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:24:14 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)) 09:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:24:14 INFO - Running setup.py (path:/tmp/pip-oQDtXv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:24:14 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)) 09:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:24:14 INFO - Running setup.py (path:/tmp/pip-YWkn5T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:24:14 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)) 09:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:24:14 INFO - Running setup.py (path:/tmp/pip-WOdZF6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:24:14 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)) 09:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:24:14 INFO - Running setup.py (path:/tmp/pip-O0vVkX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:24:14 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)) 09:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:24:14 INFO - Running setup.py (path:/tmp/pip-RBVAba-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:24:14 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)) 09:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:24:14 INFO - Running setup.py (path:/tmp/pip-zc3reX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:24:14 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)) 09:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:24:14 INFO - Running setup.py (path:/tmp/pip-mWAGN_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:24:15 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)) 09:24:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:24:15 INFO - Running setup.py (path:/tmp/pip-j33jmW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:24:15 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)) 09:24:15 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)) 09:24:15 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)) 09:24:15 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)) 09:24:15 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)) 09:24:15 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)) 09:24:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:15 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 09:24:15 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 09:24:15 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 09:24:15 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 09:24:15 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 09:24:15 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 09:24:16 INFO - Downloading blessings-1.5.1.tar.gz 09:24:16 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 09:24:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:24:16 INFO - Installing collected packages: blessings 09:24:16 INFO - Running setup.py install for blessings 09:24:16 INFO - Successfully installed blessings 09:24:16 INFO - Cleaning up... 09:24:16 INFO - Return code: 0 09:24:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:24:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:24:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:24:17 INFO - Reading from file tmpfile_stdout 09:24:17 INFO - Current package versions: 09:24:17 INFO - argparse == 1.2.1 09:24:17 INFO - blessings == 1.5.1 09:24:17 INFO - blobuploader == 1.2.4 09:24:17 INFO - docopt == 0.6.1 09:24:17 INFO - manifestparser == 1.1 09:24:17 INFO - mozInstall == 1.12 09:24:17 INFO - mozcrash == 0.16 09:24:17 INFO - mozdebug == 0.1 09:24:17 INFO - mozdevice == 0.47 09:24:17 INFO - mozfile == 1.2 09:24:17 INFO - mozhttpd == 0.7 09:24:17 INFO - mozinfo == 0.9 09:24:17 INFO - mozleak == 0.1 09:24:17 INFO - mozlog == 3.0 09:24:17 INFO - moznetwork == 0.27 09:24:17 INFO - mozprocess == 0.22 09:24:17 INFO - mozprofile == 0.27 09:24:17 INFO - mozrunner == 6.11 09:24:17 INFO - mozscreenshot == 0.1 09:24:17 INFO - mozsystemmonitor == 0.0 09:24:17 INFO - moztest == 0.7 09:24:17 INFO - mozversion == 1.4 09:24:17 INFO - psutil == 3.1.1 09:24:17 INFO - requests == 1.2.3 09:24:17 INFO - wsgiref == 0.1.2 09:24:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:24:17 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')]} 09:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:17 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')]} 09:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:17 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 0x7f58dd92dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f316c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff26e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2028a90>, '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 0x207af70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b2e0>, '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': '3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396', '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 09:24:17 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 09:24:17 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 09:24:17 INFO - Using env: {'DISPLAY': ':0', 09:24:17 INFO - 'HOME': '/home/cltbld', 09:24:17 INFO - 'LANG': 'en_US.UTF-8', 09:24:17 INFO - 'LANGUAGE': 'en_US:en', 09:24:17 INFO - 'LOGNAME': 'cltbld', 09:24:17 INFO - 'MAIL': '/var/mail/cltbld', 09:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:17 INFO - 'MOZ_NO_REMOTE': '1', 09:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:17 INFO - 'NO_EM_RESTART': '1', 09:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:24:17 INFO - 'PWD': '/builds/slave/test-pgo', 09:24:17 INFO - 'SHELL': '/bin/bash', 09:24:17 INFO - 'SHLVL': '1', 09:24:17 INFO - 'TERM': 'linux', 09:24:17 INFO - 'TMOUT': '86400', 09:24:17 INFO - 'USER': 'cltbld', 09:24:17 INFO - 'XDG_SESSION_COOKIE': '3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396', 09:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:17 INFO - '_': '/tools/buildbot/bin/python'} 09:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:17 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)) 09:24:17 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)) 09:24:17 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)) 09:24:17 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)) 09:24:17 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)) 09:24:17 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)) 09:24:17 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)) 09:24:17 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)) 09:24:17 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)) 09:24:17 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)) 09:24:17 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)) 09:24:17 INFO - Cleaning up... 09:24:17 INFO - Return code: 0 09:24:17 INFO - Running post-action listener: _resource_record_post_action 09:24:17 INFO - Running post-action listener: _start_resource_monitoring 09:24:17 INFO - Starting resource monitoring. 09:24:17 INFO - ##### 09:24:17 INFO - ##### Running install step. 09:24:17 INFO - ##### 09:24:17 INFO - Running pre-action listener: _resource_record_pre_action 09:24:17 INFO - Running main action method: install 09:24:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:24:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:24:17 INFO - Reading from file tmpfile_stdout 09:24:17 INFO - Detecting whether we're running mozinstall >=1.0... 09:24:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:24:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:24:17 INFO - Reading from file tmpfile_stdout 09:24:17 INFO - Output received: 09:24:17 INFO - Usage: mozinstall [options] installer 09:24:17 INFO - Options: 09:24:17 INFO - -h, --help show this help message and exit 09:24:17 INFO - -d DEST, --destination=DEST 09:24:17 INFO - Directory to install application into. [default: 09:24:17 INFO - "/builds/slave/test-pgo"] 09:24:17 INFO - --app=APP Application being installed. [default: firefox] 09:24:17 INFO - mkdir: /builds/slave/test-pgo/build/application 09:24:17 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'] 09:24:17 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 09:24:32 INFO - Reading from file tmpfile_stdout 09:24:32 INFO - Output received: 09:24:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:24:32 INFO - Running post-action listener: _resource_record_post_action 09:24:32 INFO - ##### 09:24:32 INFO - ##### Running run-tests step. 09:24:32 INFO - ##### 09:24:32 INFO - Running pre-action listener: _resource_record_pre_action 09:24:32 INFO - Running main action method: run_tests 09:24:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:24:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:24:32 INFO - Python 2.7.3 09:24:32 INFO - Return code: 0 09:24:32 INFO - grabbing minidump binary from tooltool 09:24: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')]} 09:24:32 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 0x2028a90>, '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 0x207af70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:24:32 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 09:24:32 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 09:24:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:24:32 INFO - Return code: 0 09:24:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:24:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:24:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:24:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:24:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:24:32 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/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:24:32 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/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost 09:24:32 INFO - Using env: {'DISPLAY': ':0', 09:24:32 INFO - 'HOME': '/home/cltbld', 09:24:32 INFO - 'LANG': 'en_US.UTF-8', 09:24:32 INFO - 'LANGUAGE': 'en_US:en', 09:24:32 INFO - 'LOGNAME': 'cltbld', 09:24:32 INFO - 'MAIL': '/var/mail/cltbld', 09:24:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:24:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:32 INFO - 'MOZ_NO_REMOTE': '1', 09:24:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:24:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:32 INFO - 'NO_EM_RESTART': '1', 09:24:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:24:32 INFO - 'PWD': '/builds/slave/test-pgo', 09:24:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:24:32 INFO - 'SHELL': '/bin/bash', 09:24:32 INFO - 'SHLVL': '1', 09:24:32 INFO - 'TERM': 'linux', 09:24:32 INFO - 'TMOUT': '86400', 09:24:32 INFO - 'USER': 'cltbld', 09:24:32 INFO - 'XDG_SESSION_COOKIE': '3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396', 09:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:32 INFO - '_': '/tools/buildbot/bin/python'} 09:24:32 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/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost'] with output_timeout 3600 09:24:32 INFO - mozversion INFO | application_buildid: 20151115073848 09:24:32 INFO - mozversion INFO | application_changeset: 4922c78419fa8a7c6a81f0f504406b85c6cee763 09:24:32 INFO - mozversion INFO | application_display_name: Nightly 09:24:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:24:32 INFO - mozversion INFO | application_name: Firefox 09:24:32 INFO - mozversion INFO | application_remotingname: firefox 09:24:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:24:32 INFO - mozversion INFO | application_vendor: Mozilla 09:24:32 INFO - mozversion INFO | application_version: 45.0a1 09:24:32 INFO - mozversion INFO | platform_buildid: 20151115073848 09:24:32 INFO - mozversion INFO | platform_changeset: 4922c78419fa8a7c6a81f0f504406b85c6cee763 09:24:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:24:32 INFO - mozversion INFO | platform_version: 45.0a1 09:24:32 INFO - 2015-11-15 09:24:32,557 DEBUG : using testdate: 1447608272 09:24:32 INFO - 2015-11-15 09:24:32,557 DEBUG : actual date: 1447608272 09:24:32 INFO - 2015-11-15 09:24:32,656 INFO : starting webserver on 'localhost:56940' 09:24:32 INFO - 2015-11-15 09:24:32,657 INFO : Starting test suite talos-linux64-ix-062.e 09:24:32 INFO - 2015-11-15 09:24:32,657 INFO : Starting test dromaeo_css 09:24:32 INFO - 2015-11-15 09:24:32,657 DEBUG : operating with platform_type : linux_ 09:24:32 INFO - 2015-11-15 09:24:32,658 INFO : Initialising browser for dromaeo_css test... 09:24:32 INFO - 2015-11-15 09:24:32,674 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph6GExJ/profile http://localhost:56940/getInfo.html 09:24:37 INFO - 2015-11-15 09:24:37,174 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:24:37 INFO - 2015-11-15 09:24:37,174 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:24:37 INFO - 2015-11-15 09:24:37,174 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:24:37 INFO - 2015-11-15 09:24:37,174 DEBUG : BROWSER_OUTPUT: __metrics 09:24:38 INFO - 2015-11-15 09:24:38,318 INFO : Browser initialized. 09:24:38 INFO - 2015-11-15 09:24:38,319 INFO : Running cycle 1/1 for dromaeo_css test... 09:24:38 INFO - 2015-11-15 09:24:38,319 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph6GExJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:24:50 INFO - 2015-11-15 09:24:50,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 140947456 09:24:50 INFO - 2015-11-15 09:24:50,036 DEBUG : BROWSER_OUTPUT: 09:25:39 INFO - 2015-11-15 09:25:39,662 DEBUG : BROWSER_OUTPUT: 1447608339660 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] 09:27:48 INFO - 2015-11-15 09:27:48,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56940/tests/dromaeo/cssquery-ext.html) 09:27:49 INFO - 2015-11-15 09:27:49,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 145973248 09:27:49 INFO - 2015-11-15 09:27:49,512 DEBUG : BROWSER_OUTPUT: 09:30:51 INFO - 2015-11-15 09:30:51,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/dromaeo/cssquery-ext.html (next: http://localhost:56940/tests/dromaeo/cssquery-jquery.html) 09:30:52 INFO - 2015-11-15 09:30:52,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 140005376 09:30:52 INFO - 2015-11-15 09:30:52,062 DEBUG : BROWSER_OUTPUT: 09:33:53 INFO - 2015-11-15 09:33:53,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56940/tests/dromaeo/cssquery-mootools.html) 09:33:54 INFO - 2015-11-15 09:33:54,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 141422592 09:33:54 INFO - 2015-11-15 09:33:54,345 DEBUG : BROWSER_OUTPUT: 09:36:56 INFO - 2015-11-15 09:36:56,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56940/tests/dromaeo/cssquery-prototype.html) 09:36:56 INFO - 2015-11-15 09:36:56,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 140689408 09:36:56 INFO - 2015-11-15 09:36:56,600 DEBUG : BROWSER_OUTPUT: 09:39:58 INFO - 2015-11-15 09:39:58,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56940/tests/dromaeo/cssquery-yui.html) 09:39:59 INFO - 2015-11-15 09:39:59,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 140697600 09:39:59 INFO - 2015-11-15 09:39:59,610 DEBUG : BROWSER_OUTPUT: 09:43:01 INFO - 2015-11-15 09:43:01,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/dromaeo/cssquery-yui.html (next: http://localhost:56940/tests/dromaeo/cssquery-dojo.html) 09:43:02 INFO - 2015-11-15 09:43:02,245 DEBUG : BROWSER_OUTPUT: RSS: Main: 143085568 09:43:02 INFO - 2015-11-15 09:43:02,245 DEBUG : BROWSER_OUTPUT: 09:43:02 INFO - 2015-11-15 09:43:02,245 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:43:02 INFO - 2015-11-15 09:43:02,245 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:43:02 INFO - 2015-11-15 09:43:02,245 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:43:02 INFO - 2015-11-15 09:43:02,245 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:43:02 INFO - 2015-11-15 09:43:02,246 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3247.577814884065;3263.6083669959608;3275.39405210036;3305.8512366943487;3340.6492318306578;5313.946860531393;5327.067763141445;5370.462953704628;5404.918926216105;5415.593830462716;5387.353517577886;5387.892242155154;5390.272313237711;5452.563794896399;5571.331440227178;4907.411110666725;4998.125328067574;5037.697738135724;5076.898462030757;5099.209622508499;5009.2486127080865;5101.234814777795;5143.794248230066;5171.22431635254;5189.221616757479;4930.087933732271;5013.523715247045;5106.234064890259;5118.129917913963;5147.202183661539;4931.334269873557;4977.42759582649;4990.575801056914;5006.74966251686;5051.797928082872;4979.0788704089855;4992.650514463989;5012.423571289312;5015.699058056528;5026;5189.818356357509;5190.6107041972;5227.26818245446;5268.868278293035;5269.314989051437;5709.74306156224;5848.210491583624;5855;5916.4379383958885;5946;5991.131285963555;6002.519798416116;6004.489618382443;6008.369121242294;6023.789167379121;5330;5544.750486228129;5597.552195824365;5600;5617.634853734494;5967.98544247479;5976.432238937294;6048.243969503812;6052.364501727343;6067.908981365283;5855.560832937546;5862.091375836752;5865.296164460292;5870.090136028923;5874.794382196603;5826;5856.765729370777;5926.644401335848;5929.911051334234;5939.762409503572;5823.88352232953;5916.290045194604;5919.230500034968;5939.22790037301;5953.1070339449425;5872.853178670567;5897.970510147507;5926.496247818897;5951.1073338999495;5980;4490.932636010462;4514.706544074625;4528.569785870337;4566.406367172246;4572.177008138567;3918.0988372674447;3999.060220848098;4033.717639765247;4061.756294622332;4101.876943691694;5656.208130861601;5719.828405147852;5727.083666613322;5745.109508026263;5769.538436925036;5650.237217975603;5949.25634295713;5980.55145864062;5989.880202395928;5992.951233534114;5555.138953462139;5618.213450116987;5620.297462817148;5640.32316122068;5684.573656975661;5119.411267704188;5131.435542090367;5155.432902380735;5157.484251574888;5210.84367468969;5928.7332070056955;6124.081387791778;6128.479079278222;6213.875722485525;6223.471004964629;5886.793962211302;6000.069989151689;6015.338312785502;6034.336223015553;6037.426444487766;6194.38056194395;6217.183770883019;6253.906191407042;6260.467860231931;6261.092141639346;5655.434456554476;5770.451807078321;5775.393583673654;5905.143754155709;5956.315023772322;5956.315023772148;5960.314563825215;5965.492933100735;5971.0744834550715;5994.760209591742;5777.45114214149;5782.479576838105;5828.358880523224;5834.920539700169;5842.737076831468;5686.43135686428;5695.544356451557;5766.971165144148;5787.479126878601;5879.794207202727;5741.97129014369;5759.7408116634015;5760.481556659921;5761.740721667619;5772.94227057724;5829.562782791392;5856.326522449803;5860.677662728421;5861.1794348792055;5865.120231965239;5436.293281873332;5538.972305138448;5573.414791446839;5687.232223649754;5705.515031222227 09:43:02 INFO - 2015-11-15 09:43:02,246 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.2476394485473;595.2648479128278;600.8497875531117;607.271274470635;609.1684850179504;39537.40693889587;39578.80210598947;39719.80140099303;40126.39810402843;40334.596654033485;41657.791711041406;41735.791321043354;41938.37092443608;41943.370849437284;41981.37027944583;8678.86981695275;8732.912670873306;8740.956295218515;8831.425957312786;8834.249088827457;8609.053004169537;8780.69267575635;8819.470831750083;8826.646934122627;8841.602127904227;8753.3872628916;8795.164459376381;8807.207351338378;8862.911370886273;8875.955620221923;8759.99260085092;8776.912230877737;8798.780030499225;8816.206541411304;8854.955725221396;8711.259542938858;8844.955775221148;8858.379913406065;8876.334274929406;8878.778030549223;39762.801185994176;40463;40907.386389204185;41000.58999409997;41146.177076458305;3177.1421716136515;3187;3298.884539041122;3306.156929982863;3843;29510.26224344387;30024.8498757507;30052.69947300521;30107.397852043054;30274.243143921358;3358.345122701074;3405.7105146062613;3412.84642191102;3482.181687303482;3487.1456493159085;264872.13458990847;265134;266389;267464;267721;52129.2180617291;54758.17862732062;61524.38475615186;61941.69029154826;62176.68911655413;57975;58066;58337.4166258332;58352.124718129264;58531.41468585345;14632.707345853023;14716.852831471762;14829.77755333671;14897.70204595902;14904.329305181293;10570.260081794355;10607.41659208751;10610.045095941403;10815.026647601597;11009.449527523591;20055.498612534804;20254.797452025585;20365;20419.693704594443;20451.4887127823;7409.851802963911;7541.622918854036;7596.772096837104;7609.809754756065;7719.073711154698;978.5938835383379;1004.6031817432073;1006.0191313469455;1028.9897101029044;1072.3994563044564;28356.858215708788;28568.142955711362;28574.285642859093;28729.707163177707;28943.276418089717;1027.897210278981;1046.2937517175876;1092.3937214845837;1110.6168371911679;1188.1564089496553;14679;14693.706125877636;14773.92613036928;14988.62528436776;15005.549833505012;330897;331351;335519;335728;337385;51880.48119518832;52356.214656780176;52455.47544524506;52484.47515524872;52664.473355266724;1298.727267273864;1342.053852034333;1344.610063081715;1347.6630842289428;1353.5939218234491;27268.181954541396;28074.157775266776;28341.858290708413;28442.857785710938;29398.265043374086;44060.779696101315;44613;44648.776756116014;44859.327110094026;45034.54965450303;220929;221140;222367;222583;223864;27936.44127117487;28421.289467763472;29881.402371952005;31479.527807082453;32118.19704507406;37889.43165852459;38133.23733525258;39191.60808391879;39264.6073539261;39394.803025984686;32541;32614.347713045132;33202.667973319956;33285.833570831994;33929.151771205914;33379.83310083434;33388.83305583456;33534.32931341311;34055.31889362248;34065.31869362648;33064.83467582743;34659.65340346564;34729.1317717049;34855.65144348524;35008.649913500536;30733.69266307308;31996.20009499781;32564;33257;33339.33321333608;24469.75530244746;24905.252842414757;24979.375515612253;25608.487830242917;26471.60292595574 09:43:02 INFO - 2015-11-15 09:43:02,246 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.5413806016727;335.8690110856766;349.51068504094263;349.9790012599244;351.4763003125344;14318.570442886705;14702.48541301052;16673.58316042098;17070.23183956722;18098.095095245233;14796;15249.771253431207;16594.83405165948;16630.50108496744;16730;5057.721825299607;5313.468653134694;5350.91973620396;5391.379991301012;5406.648567843097;4730.455997560291;4862.416510018785;4869.878253043685;4881.316615673809;5349.465053494659;4618.676692631517;4748.406449193851;4781.306710526971;4833.033393321332;4837.782299796518;4963.925541116886;5031.42138654054;5031.798728050873;5041.621878359138;5043.167877300278;4279.972806526443;4302.139572085564;4309.375140604626;4339.327404252346;4343.370211319372;13468.25924574148;14020.43918243269;14065.71868562623;14076.366563504667;14121.717565648732;1993.4219076467807;2018.0313449544153;2044.468438206077;2059.268959519379;2071.3164655663595;10017.849732254022;10022.849657255147;10096.14182794456;10413.323133996266;10505.789884202273;1644.079315583277;1667.1247595012594;1738.9652206955916;1748.5890815658438;1785.5536115971008;58625;60374.99999999956;61408.692956534935;61614;62339.37660623381;6890.827729306707;6978.232394436608;7042.366187043191;7078.079849619517;7097.432205423657;8308.875366869503;8325.167483251747;8354.206350396702;8362.958185209156;8397.832043359098;5388.245645609618;5476.863078422992;5486.725663716878;5501.752421141058;5531.8340449785765;5532.30846144232;5542.5565954723525;5638.23883775685;5648.039833228361;5665.291838520185;3202.503611940153;3216.34065016671;3273.345330933823;3297.8351082445784;3310.470324748029;1152.8962393384636;1156.780211759763;1156.8900954409319;1157.6816375496805;1189.5658084799159;465.5530690537055;473.2522614269446;478.5453818872085;481.5232919409759;495.5911373117121;11460.426978651034;11678.416079196177;11704.88295117055;11775.705607359885;11818.113641476752;425.76157351883046;437.4881388775141;438.2571541237572;449.16231228758784;455.65597973530436;4961.206207006861;5719.3136823581435;5774.162746401748;5808.070708686674;5850.1224816277045;521616.9191540408;531055;533244;534923;550527;75549.62225188839;75572;75985.6200719004;76714.6164269175;76827.23172768313;467.7988464960032;473.583246742871;476.15482518529194;477.0482886641173;478.46650984153115;10174.389536627827;10215.795684086128;10216.489175541044;10227;10313.793724125626;34761.47857782186;35946;36359.81820090883;36473.08817279589;36730.081747956516;47590;48079.75960120177;48200.5179948196;48377.03245935132;48696.513034870615;7690.154083050748;8041.638126284448;8045.436819422584;8122.390820688353;8367.874481882654;11514.251573647685;12175.695607609527;12201.755964880831;12225.266484010988;12228.388580570758;10580.36517808934;10642.308249963728;10884.61903833362;10916.235863489479;10980.505877235704;9803.313768036169;10218.386896786216;10509.579616815241;10520.368777873353;10718.624848130277;10255.282130250811;10390.740231494274;10433.21750868703;11064.944675276573;11087.556497740323;8261.297789687944;8271.586420678821;8402.579871006303;8614.61234244473;8616.83672704177;10573.52419141125;10878.184136189659;10886.67339979802;10925.508352124332;11260.268082574607 09:43:02 INFO - 2015-11-15 09:43:02,246 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1413.9151650900947;1417.8794802441791;1524.2454984782535;1692.8137904830467;1716.3220527891476;6950.582965022102;7096.361327480526;7203.495755297131;7428.405727541797;7444.553326800389;7462.962685186567;7488.513246638965;7567.091948966132;7587.203343648906;7624.733134340299;2192.999999999996;2219.7447293561204;2225.877576733279;2227.454273702945;2228.320362289501;2200.7359116905996;2233.3634914049417;2233.6649502574583;2235.910563577455;2238.104758096758;2156.6764985252257;2200.141944641591;2201.1855613422977;2226.3209721035078;2232.285668586053;2179.934601961944;2184.7050648162453;2223.3885681437573;2226.7773222677765;2229.7658745831695;2188.3325585696516;2223;2226.2764601504578;2231.509068005036;2240.1599400224914;7324.414046876237;7402.370798482136;7421.666025028887;7424.591647459441;7432.665530051161;4456.977715111404;4468.75421851798;4485.237509623339;4557.840475583372;4577.244754615484;2948.616679831608;2972.895948641809;2988.6712461629204;2993.8054026488207;2999.3851260491547;946.0539460539461;963.2342287881081;971.3491960386558;991.7124034030122;1001.659435791827;9980.850287245697;10071.69784906454;10072.143867771176;10072.697819065366;10080.092791648787;3930.5479869814767;4015.91968160641;4036.535798383165;4037.273290807624;4084.387341898739;8129.715459958873;8253.8349233015;8284.005919289724;8286.502809831429;8306.667733290722;4238.385434112037;4249.383839343278;4251.277282861921;4255.723377980421;4265.658747300208;3841.7310788245113;3865.710071744574;3884.3590807516443;3887.436321733333;3912.158885839501;3311.172206948263;3315.3203593263324;3348.6772724774064;3379.90153200206;3383.6954674078956;1024.329064462778;1029.8146333659863;1030.9587616495255;1034.99482502587;1049.6273822792798;1054.5570860238718;1054.6097943760703;1096.9725756856142;1204.6085022367765;1337.7993301004733;6653.866922661519;6766.932330676728;6773.762918297836;6813.046173535709;6814.62519561419;1042.1975079188983;1065.2436769893307;1112.7533678704945;1125.319181894958;1143.845580846575;5614.410486898817;5633.042382794934;5641.605087643826;5665.745041473144;5670.347909990322;8583.227509524173;8618.698345557876;8619.439736417113;8639.438436501732;8650.178233067849;8636.697715579925;8686.739397818075;8705.564721763887;8708.956455217683;8710.738677839676;6808.2510923798345;6837.623930683761;6851.143607049119;6858.6570671466225;6875.278095799969;6882.070920425678;6931.653417329013;6938.028675985467;6946.8610627788175;6956.686949087202;7012.053372794608;7182.461315401261;7218.386437152901;7222.96388518054;7902.723404681038;7818.609069546614;7874.0157480314965;7916.089649690129;7924.6037698116015;7969.8406031880195;6667.566608170453;6693.631850248283;6694.397504224448;6765.526413151032;6769.289224631343;7210.459215558959;7240.203577606564;7287.344139027513;7323.560586364835;7335.303146201102;6427.967860160669;6728.596284222962;6908.3437073477935;7016.789496315118;7036.472264580075;6701.229358623821;6751.696173672099;6771.966140169267;6847.965760171366;6860.382565569123;6606.108175396452;6668.633225172662;6726.39462448382;6751.662416879235;6774.966125169342;6264.404881536247;6309.526785491014;6329.7151628175925;6336.461400780985;6337.841553961188;6350;6357.014662727284;6362.109304697438;6363.331850155667;6386.457151142205 09:43:02 INFO - 2015-11-15 09:43:02,246 DEBUG : BROWSER_OUTPUT: |4;prototype.html;319.2274695237525;325.34443097159226;329.2591668745323;337.85472246933824;338.46353529655494;6310.337414571467;6367.17226760521;6372.267189273235;6377.776777812784;6508.674566271679;6242.1885154929905;6281.968590157055;6306.59007164534;6331.240251169855;6340.302566717657;4817.397825271841;4834.830780922668;4835.734034628094;4835.806567737286;4838.177509823338;4839.201531747258;4844.055409195208;4848.175810112271;4853.878653033667;4865.975670121662;4689.695169813968;4757;4790.281457781326;4791.760411979404;4797.496262892399;4750.3349531065505;4751.619870410359;4767.952320476786;4776.331313616097;4777.952220477786;4114.732542384735;4133.81397837098;4146.170765846812;4153.356229784358;4155.480564929384;5945.621751299472;5999.400059994009;6005.759769609211;6014.669193194372;6021.3677563856045;5439.265699130607;5597.412271711452;5603.439656034364;5607.7476513556985;5620.269364982526;6662.56693314933;6673.5662181958505;6676.26561078281;6680.766173183915;6691.665416729144;4573.382593349922;4585.403897493305;4591.51789062147;4637.930431043537;4644.396228490308;6802.047713320139;6919.238883722836;6995.82510437238;7001.579905205704;7020.92979070213;4571.062932098912;4619.95380046202;4624.653151013687;4627.1439783640135;4627.676062675648;4611.5619016193405;4664.416947881515;4676.0647870426055;4691.1555919934735;4695.741734204583;5474.206240095244;5493.890122197534;5519;5545.861353466195;5547.639403438763;6687.665616719242;6826.214985276657;6827.556208846409;6828.453723702092;6853.760118395832;1689.6451745133413;1716.262007336857;1743.2939659437948;1743.4159556548698;1748.7814023247095;1121.9439028048564;1127.7180704823795;1135.3358285402967;1140.6292954789726;1146.3721515448083;6510.44661203803;6513.348665133543;6518.674066296761;6518.837029074311;6554.082428460019;6872.2819295176205;6892;6899.344562266577;6902.861942761117;6905.1713794345;6408.455281301049;6499.122618446449;6499.675016249169;6500.122483464766;6533.085368048477;3768.6231376862092;3784.924301513954;3807.485989391452;3818.8090595470117;3824.4454554089502;7356.926430735624;7396.704131834666;7398.741044063432;7426.220246874109;7427.888581671279;7064;7153.856922861513;7270.272972702687;7276.235995220532;7286.927130728731;7315.451341149435;7326.157491888394;7354.080739907512;7356.77929662111;7370.152432470334;6900.378965893094;6915.031895534528;6939.930600693929;6967.8606427870145;6970.059042029261;6806.217285012089;6931.09895713554;6980.232174460703;7013.368796808311;7022.824429389306;7377.8155546111775;7387.519811212254;7387.630618468947;7406.18531961473;7422.443316751157;4679.953200467951;4702.952970470252;4708.4349878014855;4716.268978308368;4722.079194557028;6833.555818871758;6853.348931851466;6990.825229369307;7016;7036.120484939383;6703.497237707289;6743.291954344723;6770.796876093725;6774.899781067885;6781.694823732845;6763.492738044568;6790.117284752951;6795.966020169867;6806.42145417645;6816.522843400914;6503.739850405931;6661.666916654245;6679.899801503078;6683.899741503784;6684.364985326386;6817.079694241214;6817.943218801094;6854.725810967506;6855.931440685529;6873.450123989969;6651.33486651331;6678.666066696548;6696.19645642526;6711.731530738716;6726.461883049442 09:43:02 INFO - 2015-11-15 09:43:02,247 DEBUG : BROWSER_OUTPUT: |5;yui.html;781.3007358414219;797.6968751874286;835.4653022065879;860.27736701171;864.438115225104;13730.10754300971;14103.506377276797;14112.647183820396;14167.29163541824;14176.519109155895;13223.471061157567;13304.800427993589;13338.93330533346;13438.798418023738;13467.595972120827;803.0203152154362;815.4780940198278;817.9713710020151;819.8032472206687;820.4134044158411;808.5754978636204;820.1142765812908;821.6302663801314;824.4476200945381;827.2637352756052;847.7244895408986;852.995735021324;854.2055888024136;855.4867079752161;857.9699710510133;845.4546817302836;847.1570787066846;853.4495250563383;855.2132038524572;856.1609622569854;620.7672122953892;622.17561730707;622.900335946251;623.1462895832693;623.7785586116954;12813.551525696555;12843.614691559269;12893.935530322382;12914.741705165938;13009.804852927213;10035.448050357227;10405.323653962469;10405.947970260177;10422.166226701846;10587.735306617396;10180.796384072277;10243.539040743184;10286.32289338912;10315.226358023177;10358.792824143475;3199.488081906907;3256.6417694053634;3258.5438038674606;3304.7521435892163;3383.2725963917874;46534.30198547024;46668.766656166845;46717.532824671995;46793;47120.76439617814;7799.398672316072;7852.371810255166;7926.801829954182;7932.854478352379;8052.919470805217;12594.37028148589;12617.369131543386;12617.93691031539;12632.178908370926;12661.303628300348;6332.303446620868;6414.807555773335;6572.11276477679;6621.073049773036;6660.56706314088;4315.762633055149;4347.5217726050105;4364.258076127066;4395.692301538862;4418.690691651554;2681.3832818451865;2691.690455597631;2694.676638803356;2703.094463354759;2709.444563864403;428.57999160822567;433.66174383979916;437.89052736815796;446.80117347779924;446.84583818582536;517.1286382445592;534.4014703531991;580.7473748919234;589.7876764364826;660.6282406192249;8314.916850831536;8720.694775682947;9071.81856362869;9599.664011759554;9690.37012594179;596.5406636889571;644.1979735229576;666.3037126203129;699.6047233313263;745.5750222373304;4156.625903668684;4372.803223854934;4488.169688607618;4529.592336689714;4671.929921051187;59603.40396596065;60052.39685618877;60627.393726063056;61632.075518867256;63104.68447657732;50983;51229.48770512322;51524.227136592985;52476.47523524716;55311.44688553063;49304.260436093486;49823.25265121026;49936;50141.24788128108;50208.246876296886;9420.811583768424;9424.95287523558;9458.858117128111;9459;9464.479453629841;33187.668123319425;34067.14832129217;34550.30899381948;36336.63663363332;37238.06904827401;44784.328235075845;44907.10185796331;44975.10049799051;45623.08753824971;46523;11019.83470247931;11338.943305283421;12331.876681233072;12388;12922.676933076747;12849.357532123544;12977.805332920203;13176;13454.663633409244;13469.663258418617;11851.70370740704;12060.577879774166;12075.456604452645;12260.570880019157;12743.10798244114;11663.533458661559;11919.1096903572;12056.794320567873;12070.517179312728;12550.497980080694;11650.184487085822;12193.51225950952;12238.571649992207;12239.571614993432;12559.497620095093;10004.399736015863;10073;10198.541065652213;10263.384196947909;10666.946665266623;9140.725778226664;9266.305027123128;9496.667616633385;9883.998093119293;10119.190464762949 09:43:02 INFO - 2015-11-15 09:43:02,247 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:43:02 INFO - 2015-11-15 09:43:02,247 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:43:02 INFO - 2015-11-15 09:43:02,247 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,298 09:43:02 INFO - 2015-11-15 09:43:02,247 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:43:02 INFO - 2015-11-15 09:43:02,247 DEBUG : BROWSER_OUTPUT: __startTimestamp1447609382239__endTimestamp 09:43:02 INFO - 2015-11-15 09:43:02,248 DEBUG : BROWSER_OUTPUT: 09:43:02 INFO - 2015-11-15 09:43:02,248 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:43:02 INFO - 2015-11-15 09:43:02,248 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:43:02 INFO - 2015-11-15 09:43:02,248 DEBUG : BROWSER_OUTPUT: 09:43:02 INFO - 2015-11-15 09:43:02,248 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5498.02 Median:5727.08 stddev:624.86 (10.9%) stddev-sans-first:601.32 09:43:02 INFO - 2015-11-15 09:43:02,249 DEBUG : BROWSER_OUTPUT: Values: 3247.6 3263.6 3275.4 3305.9 3340.6 5313.9 5327.1 5370.5 5404.9 5415.6 5387.4 5387.9 5390.3 5452.6 5571.3 4907.4 4998.1 5037.7 5076.9 5099.2 5009.2 5101.2 5143.8 5171.2 5189.2 4930.1 5013.5 5106.2 5118.1 5147.2 4931.3 4977.4 4990.6 5006.7 5051.8 4979.1 4992.7 5012.4 5015.7 5026.0 5189.8 5190.6 5227.3 5268.9 5269.3 5709.7 5848.2 5855.0 5916.4 5946.0 5991.1 6002.5 6004.5 6008.4 6023.8 5330.0 5544.8 5597.6 5600.0 5617.6 5968.0 5976.4 6048.2 6052.4 6067.9 5855.6 5862.1 5865.3 5870.1 5874.8 5826.0 5856.8 5926.6 5929.9 5939.8 5823.9 5916.3 5919.2 5939.2 5953.1 5872.9 5898.0 5926.5 5951.1 5980.0 4490.9 4514.7 4528.6 4566.4 4572.2 3918.1 3999.1 4033.7 4061.8 4101.9 5656.2 5719.8 5727.1 5745.1 5769.5 5650.2 5949.3 5980.6 5989.9 5993.0 5555.1 5618.2 5620.3 5640.3 5684.6 5119.4 5131.4 5155.4 5157.5 5210.8 5928.7 6124.1 6128.5 6213.9 6223.5 5886.8 6000.1 6015.3 6034.3 6037.4 6194.4 6217.2 6253.9 6260.5 6261.1 5655.4 5770.5 5775.4 5905.1 5956.3 5956.3 5960.3 5965.5 5971.1 5994.8 5777.5 5782.5 5828.4 5834.9 5842.7 5686.4 5695.5 5767.0 5787.5 5879.8 5742.0 5759.7 5760.5 5761.7 5772.9 5829.6 5856.3 5860.7 5861.2 5865.1 5436.3 5539.0 5573.4 5687.2 5705.5 09:43:02 INFO - 2015-11-15 09:43:02,249 DEBUG : BROWSER_OUTPUT: 09:43:02 INFO - 2015-11-15 09:43:02,249 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44346.32 Median:170371.67 stddev:72699.08 (42.7%) stddev-sans-first:72828.66 09:43:02 INFO - 2015-11-15 09:43:02,249 DEBUG : BROWSER_OUTPUT: Values: 555.2 595.3 600.8 607.3 609.2 39537.4 39578.8 39719.8 40126.4 40334.6 41657.8 41735.8 41938.4 41943.4 41981.4 8678.9 8732.9 8741.0 8831.4 8834.2 8609.1 8780.7 8819.5 8826.6 8841.6 8753.4 8795.2 8807.2 8862.9 8876.0 8760.0 8776.9 8798.8 8816.2 8855.0 8711.3 8845.0 8858.4 8876.3 8878.8 39762.8 40463.0 40907.4 41000.6 41146.2 3177.1 3187.0 3298.9 3306.2 3843.0 29510.3 30024.8 30052.7 30107.4 30274.2 3358.3 3405.7 3412.8 3482.2 3487.1 264872.1 265134.0 266389.0 267464.0 267721.0 52129.2 54758.2 61524.4 61941.7 62176.7 57975.0 58066.0 58337.4 58352.1 58531.4 14632.7 14716.9 14829.8 14897.7 14904.3 10570.3 10607.4 10610.0 10815.0 11009.4 20055.5 20254.8 20365.0 20419.7 20451.5 7409.9 7541.6 7596.8 7609.8 7719.1 978.6 1004.6 1006.0 1029.0 1072.4 28356.9 28568.1 28574.3 28729.7 28943.3 1027.9 1046.3 1092.4 1110.6 1188.2 14679.0 14693.7 14773.9 14988.6 15005.5 330897.0 331351.0 335519.0 335728.0 337385.0 51880.5 52356.2 52455.5 52484.5 52664.5 1298.7 1342.1 1344.6 1347.7 1353.6 27268.2 28074.2 28341.9 28442.9 29398.3 44060.8 44613.0 44648.8 44859.3 45034.5 220929.0 221140.0 222367.0 222583.0 223864.0 27936.4 28421.3 29881.4 31479.5 32118.2 37889.4 38133.2 39191.6 39264.6 39394.8 32541.0 32614.3 33202.7 33285.8 33929.2 33379.8 33388.8 33534.3 34055.3 34065.3 33064.8 34659.7 34729.1 34855.7 35008.6 30733.7 31996.2 32564.0 33257.0 33339.3 24469.8 24905.3 24979.4 25608.5 26471.6 09:43:02 INFO - 2015-11-15 09:43:02,249 DEBUG : BROWSER_OUTPUT: 09:43:02 INFO - 2015-11-15 09:43:02,249 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26982.32 Median:437.87 stddev:87580.95 (20001.5%) stddev-sans-first:87803.77 09:43:02 INFO - 2015-11-15 09:43:02,251 DEBUG : BROWSER_OUTPUT: Values: 333.5 335.9 349.5 350.0 351.5 14318.6 14702.5 16673.6 17070.2 18098.1 14796.0 15249.8 16594.8 16630.5 16730.0 5057.7 5313.5 5350.9 5391.4 5406.6 4730.5 4862.4 4869.9 4881.3 5349.5 4618.7 4748.4 4781.3 4833.0 4837.8 4963.9 5031.4 5031.8 5041.6 5043.2 4280.0 4302.1 4309.4 4339.3 4343.4 13468.3 14020.4 14065.7 14076.4 14121.7 1993.4 2018.0 2044.5 2059.3 2071.3 10017.8 10022.8 10096.1 10413.3 10505.8 1644.1 1667.1 1739.0 1748.6 1785.6 58625.0 60375.0 61408.7 61614.0 62339.4 6890.8 6978.2 7042.4 7078.1 7097.4 8308.9 8325.2 8354.2 8363.0 8397.8 5388.2 5476.9 5486.7 5501.8 5531.8 5532.3 5542.6 5638.2 5648.0 5665.3 3202.5 3216.3 3273.3 3297.8 3310.5 1152.9 1156.8 1156.9 1157.7 1189.6 465.6 473.3 478.5 481.5 495.6 11460.4 11678.4 11704.9 11775.7 11818.1 425.8 437.5 438.3 449.2 455.7 4961.2 5719.3 5774.2 5808.1 5850.1 521616.9 531055.0 533244.0 534923.0 550527.0 75549.6 75572.0 75985.6 76714.6 76827.2 467.8 473.6 476.2 477.0 478.5 10174.4 10215.8 10216.5 10227.0 10313.8 34761.5 35946.0 36359.8 36473.1 36730.1 47590.0 48079.8 48200.5 48377.0 48696.5 7690.2 8041.6 8045.4 8122.4 8367.9 11514.3 12175.7 12201.8 12225.3 12228.4 10580.4 10642.3 10884.6 10916.2 10980.5 9803.3 10218.4 10509.6 10520.4 10718.6 10255.3 10390.7 10433.2 11064.9 11087.6 8261.3 8271.6 8402.6 8614.6 8616.8 10573.5 10878.2 10886.7 10925.5 11260.3 09:43:02 INFO - 2015-11-15 09:43:02,251 DEBUG : BROWSER_OUTPUT: 09:43:02 INFO - 2015-11-15 09:43:02,251 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5168.30 Median:6353.51 stddev:2628.31 (41.4%) stddev-sans-first:2620.53 09:43:02 INFO - 2015-11-15 09:43:02,251 DEBUG : BROWSER_OUTPUT: Values: 1413.9 1417.9 1524.2 1692.8 1716.3 6950.6 7096.4 7203.5 7428.4 7444.6 7463.0 7488.5 7567.1 7587.2 7624.7 2193.0 2219.7 2225.9 2227.5 2228.3 2200.7 2233.4 2233.7 2235.9 2238.1 2156.7 2200.1 2201.2 2226.3 2232.3 2179.9 2184.7 2223.4 2226.8 2229.8 2188.3 2223.0 2226.3 2231.5 2240.2 7324.4 7402.4 7421.7 7424.6 7432.7 4457.0 4468.8 4485.2 4557.8 4577.2 2948.6 2972.9 2988.7 2993.8 2999.4 946.1 963.2 971.3 991.7 1001.7 9980.9 10071.7 10072.1 10072.7 10080.1 3930.5 4015.9 4036.5 4037.3 4084.4 8129.7 8253.8 8284.0 8286.5 8306.7 4238.4 4249.4 4251.3 4255.7 4265.7 3841.7 3865.7 3884.4 3887.4 3912.2 3311.2 3315.3 3348.7 3379.9 3383.7 1024.3 1029.8 1031.0 1035.0 1049.6 1054.6 1054.6 1097.0 1204.6 1337.8 6653.9 6766.9 6773.8 6813.0 6814.6 1042.2 1065.2 1112.8 1125.3 1143.8 5614.4 5633.0 5641.6 5665.7 5670.3 8583.2 8618.7 8619.4 8639.4 8650.2 8636.7 8686.7 8705.6 8709.0 8710.7 6808.3 6837.6 6851.1 6858.7 6875.3 6882.1 6931.7 6938.0 6946.9 6956.7 7012.1 7182.5 7218.4 7223.0 7902.7 7818.6 7874.0 7916.1 7924.6 7969.8 6667.6 6693.6 6694.4 6765.5 6769.3 7210.5 7240.2 7287.3 7323.6 7335.3 6428.0 6728.6 6908.3 7016.8 7036.5 6701.2 6751.7 6772.0 6848.0 6860.4 6606.1 6668.6 6726.4 6751.7 6775.0 6264.4 6309.5 6329.7 6336.5 6337.8 6350.0 6357.0 6362.1 6363.3 6386.5 09:43:02 INFO - 2015-11-15 09:43:02,251 DEBUG : BROWSER_OUTPUT: 09:43:02 INFO - 2015-11-15 09:43:02,251 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5638.00 Median:6499.40 stddev:1732.03 (26.6%) stddev-sans-first:1690.26 09:43:02 INFO - 2015-11-15 09:43:02,252 DEBUG : BROWSER_OUTPUT: Values: 319.2 325.3 329.3 337.9 338.5 6310.3 6367.2 6372.3 6377.8 6508.7 6242.2 6282.0 6306.6 6331.2 6340.3 4817.4 4834.8 4835.7 4835.8 4838.2 4839.2 4844.1 4848.2 4853.9 4866.0 4689.7 4757.0 4790.3 4791.8 4797.5 4750.3 4751.6 4768.0 4776.3 4778.0 4114.7 4133.8 4146.2 4153.4 4155.5 5945.6 5999.4 6005.8 6014.7 6021.4 5439.3 5597.4 5603.4 5607.7 5620.3 6662.6 6673.6 6676.3 6680.8 6691.7 4573.4 4585.4 4591.5 4637.9 4644.4 6802.0 6919.2 6995.8 7001.6 7020.9 4571.1 4620.0 4624.7 4627.1 4627.7 4611.6 4664.4 4676.1 4691.2 4695.7 5474.2 5493.9 5519.0 5545.9 5547.6 6687.7 6826.2 6827.6 6828.5 6853.8 1689.6 1716.3 1743.3 1743.4 1748.8 1121.9 1127.7 1135.3 1140.6 1146.4 6510.4 6513.3 6518.7 6518.8 6554.1 6872.3 6892.0 6899.3 6902.9 6905.2 6408.5 6499.1 6499.7 6500.1 6533.1 3768.6 3784.9 3807.5 3818.8 3824.4 7356.9 7396.7 7398.7 7426.2 7427.9 7064.0 7153.9 7270.3 7276.2 7286.9 7315.5 7326.2 7354.1 7356.8 7370.2 6900.4 6915.0 6939.9 6967.9 6970.1 6806.2 6931.1 6980.2 7013.4 7022.8 7377.8 7387.5 7387.6 7406.2 7422.4 4680.0 4703.0 4708.4 4716.3 4722.1 6833.6 6853.3 6990.8 7016.0 7036.1 6703.5 6743.3 6770.8 6774.9 6781.7 6763.5 6790.1 6796.0 6806.4 6816.5 6503.7 6661.7 6679.9 6683.9 6684.4 6817.1 6817.9 6854.7 6855.9 6873.5 6651.3 6678.7 6696.2 6711.7 6726.5 09:43:02 INFO - 2015-11-15 09:43:02,252 DEBUG : BROWSER_OUTPUT: 09:43:02 INFO - 2015-11-15 09:43:02,252 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13878.80 Median:44941.10 stddev:16464.70 (36.6%) stddev-sans-first:16481.51 09:43:02 INFO - 2015-11-15 09:43:02,253 DEBUG : BROWSER_OUTPUT: Values: 781.3 797.7 835.5 860.3 864.4 13730.1 14103.5 14112.6 14167.3 14176.5 13223.5 13304.8 13338.9 13438.8 13467.6 803.0 815.5 818.0 819.8 820.4 808.6 820.1 821.6 824.4 827.3 847.7 853.0 854.2 855.5 858.0 845.5 847.2 853.4 855.2 856.2 620.8 622.2 622.9 623.1 623.8 12813.6 12843.6 12893.9 12914.7 13009.8 10035.4 10405.3 10405.9 10422.2 10587.7 10180.8 10243.5 10286.3 10315.2 10358.8 3199.5 3256.6 3258.5 3304.8 3383.3 46534.3 46668.8 46717.5 46793.0 47120.8 7799.4 7852.4 7926.8 7932.9 8052.9 12594.4 12617.4 12617.9 12632.2 12661.3 6332.3 6414.8 6572.1 6621.1 6660.6 4315.8 4347.5 4364.3 4395.7 4418.7 2681.4 2691.7 2694.7 2703.1 2709.4 428.6 433.7 437.9 446.8 446.8 517.1 534.4 580.7 589.8 660.6 8314.9 8720.7 9071.8 9599.7 9690.4 596.5 644.2 666.3 699.6 745.6 4156.6 4372.8 4488.2 4529.6 4671.9 59603.4 60052.4 60627.4 61632.1 63104.7 50983.0 51229.5 51524.2 52476.5 55311.4 49304.3 49823.3 49936.0 50141.2 50208.2 9420.8 9425.0 9458.9 9459.0 9464.5 33187.7 34067.1 34550.3 36336.6 37238.1 44784.3 44907.1 44975.1 45623.1 46523.0 11019.8 11338.9 12331.9 12388.0 12922.7 12849.4 12977.8 13176.0 13454.7 13469.7 11851.7 12060.6 12075.5 12260.6 12743.1 11663.5 11919.1 12056.8 12070.5 12550.5 11650.2 12193.5 12238.6 12239.6 12559.5 10004.4 10073.0 10198.5 10263.4 10666.9 9140.7 9266.3 9496.7 9884.0 10119.2 09:43:02 INFO - 2015-11-15 09:43:02,253 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:43:02 INFO - 2015-11-15 09:43:02,253 DEBUG : BROWSER_OUTPUT: 09:43:02 INFO - 2015-11-15 09:43:02,882 INFO : Browser exited with error code: 0 09:43:02 INFO - 2015-11-15 09:43:02,901 INFO : Completed test dromaeo_css (00:18:30) 09:43:02 INFO - 2015-11-15 09:43:02,901 INFO : Starting test kraken 09:43:02 INFO - 2015-11-15 09:43:02,901 DEBUG : operating with platform_type : linux_ 09:43:02 INFO - 2015-11-15 09:43:02,902 INFO : Initialising browser for kraken test... 09:43:02 INFO - 2015-11-15 09:43:02,908 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3Cihwd/profile http://localhost:56940/getInfo.html 09:43:07 INFO - 2015-11-15 09:43:07,375 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:43:07 INFO - 2015-11-15 09:43:07,376 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:43:07 INFO - 2015-11-15 09:43:07,376 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:43:07 INFO - 2015-11-15 09:43:07,376 DEBUG : BROWSER_OUTPUT: __metrics 09:43:08 INFO - 2015-11-15 09:43:08,482 INFO : Browser initialized. 09:43:08 INFO - 2015-11-15 09:43:08,483 INFO : Running cycle 1/1 for kraken test... 09:43:08 INFO - 2015-11-15 09:43:08,483 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3Cihwd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:43:20 INFO - 2015-11-15 09:43:20,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 141328384 09:43:20 INFO - 2015-11-15 09:43:20,261 DEBUG : BROWSER_OUTPUT: 09:43:22 INFO - 2015-11-15 09:43:22,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56940/tests/kraken/driver.html?testName=audio-beat-detection) 09:43:23 INFO - 2015-11-15 09:43:23,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 141946880 09:43:23 INFO - 2015-11-15 09:43:23,371 DEBUG : BROWSER_OUTPUT: 09:43:26 INFO - 2015-11-15 09:43:26,013 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56940/tests/kraken/driver.html?testName=audio-dft) 09:43:26 INFO - 2015-11-15 09:43:26,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 141365248 09:43:26 INFO - 2015-11-15 09:43:26,604 DEBUG : BROWSER_OUTPUT: 09:43:29 INFO - 2015-11-15 09:43:29,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56940/tests/kraken/driver.html?testName=audio-fft) 09:43:30 INFO - 2015-11-15 09:43:30,049 DEBUG : BROWSER_OUTPUT: RSS: Main: 137244672 09:43:30 INFO - 2015-11-15 09:43:30,050 DEBUG : BROWSER_OUTPUT: 09:43:32 INFO - 2015-11-15 09:43:32,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56940/tests/kraken/driver.html?testName=audio-oscillator) 09:43:32 INFO - 2015-11-15 09:43:32,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 136708096 09:43:32 INFO - 2015-11-15 09:43:32,652 DEBUG : BROWSER_OUTPUT: 09:43:34 INFO - 2015-11-15 09:43:34,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56940/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:43:35 INFO - 2015-11-15 09:43:35,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 137248768 09:43:35 INFO - 2015-11-15 09:43:35,472 DEBUG : BROWSER_OUTPUT: 09:43:38 INFO - 2015-11-15 09:43:38,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56940/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:39 INFO - 2015-11-15 09:43:39,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 137703424 09:43:39 INFO - 2015-11-15 09:43:39,099 DEBUG : BROWSER_OUTPUT: 09:43:42 INFO - 2015-11-15 09:43:42,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56940/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:43 INFO - 2015-11-15 09:43:43,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 138166272 09:43:43 INFO - 2015-11-15 09:43:43,120 DEBUG : BROWSER_OUTPUT: 09:43:45 INFO - 2015-11-15 09:43:45,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56940/tests/kraken/driver.html?testName=json-parse-financial) 09:43:46 INFO - 2015-11-15 09:43:46,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 138403840 09:43:46 INFO - 2015-11-15 09:43:46,556 DEBUG : BROWSER_OUTPUT: 09:43:48 INFO - 2015-11-15 09:43:48,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56940/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:43:48 INFO - 2015-11-15 09:43:48,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 139128832 09:43:48 INFO - 2015-11-15 09:43:48,747 DEBUG : BROWSER_OUTPUT: 09:43:50 INFO - 2015-11-15 09:43:50,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56940/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:43:51 INFO - 2015-11-15 09:43:51,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 139022336 09:43:51 INFO - 2015-11-15 09:43:51,190 DEBUG : BROWSER_OUTPUT: 09:43:53 INFO - 2015-11-15 09:43:53,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56940/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:43:53 INFO - 2015-11-15 09:43:53,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 139931648 09:43:53 INFO - 2015-11-15 09:43:53,850 DEBUG : BROWSER_OUTPUT: 09:43:56 INFO - 2015-11-15 09:43:56,339 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56940/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:43:56 INFO - 2015-11-15 09:43:56,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 140062720 09:43:56 INFO - 2015-11-15 09:43:56,941 DEBUG : BROWSER_OUTPUT: 09:43:59 INFO - 2015-11-15 09:43:59,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56940/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:44:00 INFO - 2015-11-15 09:44:00,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 137867264 09:44:00 INFO - 2015-11-15 09:44:00,146 DEBUG : BROWSER_OUTPUT: 09:44:01 INFO - 2015-11-15 09:44:01,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56940/tests/kraken/driver.html?testName=ai-astar) 09:44:02 INFO - 2015-11-15 09:44:02,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 138690560 09:44:02 INFO - 2015-11-15 09:44:02,071 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,071 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:44:02 INFO - 2015-11-15 09:44:02,071 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:44:02 INFO - 2015-11-15 09:44:02,071 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:44:02 INFO - 2015-11-15 09:44:02,071 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:44:02 INFO - 2015-11-15 09:44:02,071 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;106;111;110;111;123;111;110;109;111 09:44:02 INFO - 2015-11-15 09:44:02,072 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;131;150;161;133;148;154;129;169;133 09:44:02 INFO - 2015-11-15 09:44:02,072 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;162;162;162;170;161;165;169;163 09:44:02 INFO - 2015-11-15 09:44:02,072 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;81;72;73;74;138;74;72;72 09:44:02 INFO - 2015-11-15 09:44:02,072 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;134;91;91;92;141;91;91;133 09:44:02 INFO - 2015-11-15 09:44:02,072 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;109;111;110;111;110;110;112;111 09:44:02 INFO - 2015-11-15 09:44:02,072 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;148;147;151;146;148;147;147;145 09:44:02 INFO - 2015-11-15 09:44:02,072 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;98;98;96;98;97;97;97;96;96 09:44:02 INFO - 2015-11-15 09:44:02,072 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;62;65;67;63;62;69;63;65;60 09:44:02 INFO - 2015-11-15 09:44:02,073 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;70;69;74;69;70;70 09:44:02 INFO - 2015-11-15 09:44:02,073 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;83;85;86;85;86;86;87;87;87 09:44:02 INFO - 2015-11-15 09:44:02,073 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;126;119;136;124;124;130;126;128;130 09:44:02 INFO - 2015-11-15 09:44:02,073 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;155;143;149;152;139;164;163;151;147 09:44:02 INFO - 2015-11-15 09:44:02,073 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;66;68;66;68;68;69;67;69;70 09:44:02 INFO - 2015-11-15 09:44:02,073 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:44:02 INFO - 2015-11-15 09:44:02,073 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:44:02 INFO - 2015-11-15 09:44:02,074 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,711 09:44:02 INFO - 2015-11-15 09:44:02,074 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:44:02 INFO - 2015-11-15 09:44:02,074 DEBUG : BROWSER_OUTPUT: __startTimestamp1447609442069__endTimestamp 09:44:02 INFO - 2015-11-15 09:44:02,074 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,077 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:44:02 INFO - 2015-11-15 09:44:02,078 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:44:02 INFO - 2015-11-15 09:44:02,078 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,078 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:4.40 (4.0%) stddev-sans-first:4.66 09:44:02 INFO - 2015-11-15 09:44:02,078 DEBUG : BROWSER_OUTPUT: Values: 111.0 106.0 111.0 110.0 111.0 123.0 111.0 110.0 109.0 111.0 09:44:02 INFO - 2015-11-15 09:44:02,078 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,078 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.20 Median:152.00 stddev:13.96 (9.2%) stddev-sans-first:14.52 09:44:02 INFO - 2015-11-15 09:44:02,078 DEBUG : BROWSER_OUTPUT: Values: 154.0 131.0 150.0 161.0 133.0 148.0 154.0 129.0 169.0 133.0 09:44:02 INFO - 2015-11-15 09:44:02,079 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,079 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:3.14 (1.9%) stddev-sans-first:3.26 09:44:02 INFO - 2015-11-15 09:44:02,079 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 162.0 162.0 162.0 170.0 161.0 165.0 169.0 163.0 09:44:02 INFO - 2015-11-15 09:44:02,079 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,079 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:73.50 stddev:20.49 (27.9%) stddev-sans-first:21.51 09:44:02 INFO - 2015-11-15 09:44:02,079 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 81.0 72.0 73.0 74.0 138.0 74.0 72.0 72.0 09:44:02 INFO - 2015-11-15 09:44:02,079 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,080 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.60 Median:91.00 stddev:21.77 (23.9%) stddev-sans-first:22.52 09:44:02 INFO - 2015-11-15 09:44:02,080 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 134.0 91.0 91.0 92.0 141.0 91.0 91.0 133.0 09:44:02 INFO - 2015-11-15 09:44:02,080 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,080 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:111.00 stddev:0.85 (0.8%) stddev-sans-first:0.88 09:44:02 INFO - 2015-11-15 09:44:02,080 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 109.0 111.0 110.0 111.0 110.0 110.0 112.0 111.0 09:44:02 INFO - 2015-11-15 09:44:02,080 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,080 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.57 (1.1%) stddev-sans-first:1.66 09:44:02 INFO - 2015-11-15 09:44:02,080 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 148.0 147.0 151.0 146.0 148.0 147.0 147.0 145.0 09:44:02 INFO - 2015-11-15 09:44:02,080 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,080 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 09:44:02 INFO - 2015-11-15 09:44:02,081 DEBUG : BROWSER_OUTPUT: Values: 96.0 98.0 98.0 96.0 98.0 97.0 97.0 97.0 96.0 96.0 09:44:02 INFO - 2015-11-15 09:44:02,081 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,081 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:2.79 (4.4%) stddev-sans-first:2.78 09:44:02 INFO - 2015-11-15 09:44:02,081 DEBUG : BROWSER_OUTPUT: Values: 61.0 62.0 65.0 67.0 63.0 62.0 69.0 63.0 65.0 60.0 09:44:02 INFO - 2015-11-15 09:44:02,081 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,081 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.50 stddev:1.71 (2.5%) stddev-sans-first:1.72 09:44:02 INFO - 2015-11-15 09:44:02,081 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 70.0 69.0 74.0 69.0 70.0 70.0 09:44:02 INFO - 2015-11-15 09:44:02,081 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,081 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:1.23 (1.4%) stddev-sans-first:1.30 09:44:02 INFO - 2015-11-15 09:44:02,081 DEBUG : BROWSER_OUTPUT: Values: 86.0 83.0 85.0 86.0 85.0 86.0 86.0 87.0 87.0 87.0 09:44:02 INFO - 2015-11-15 09:44:02,081 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,082 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:127.00 stddev:5.34 (4.2%) stddev-sans-first:4.80 09:44:02 INFO - 2015-11-15 09:44:02,082 DEBUG : BROWSER_OUTPUT: Values: 118.0 126.0 119.0 136.0 124.0 124.0 130.0 126.0 128.0 130.0 09:44:02 INFO - 2015-11-15 09:44:02,082 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,082 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.40 Median:151.50 stddev:7.86 (5.2%) stddev-sans-first:8.34 09:44:02 INFO - 2015-11-15 09:44:02,082 DEBUG : BROWSER_OUTPUT: Values: 151.0 155.0 143.0 149.0 152.0 139.0 164.0 163.0 151.0 147.0 09:44:02 INFO - 2015-11-15 09:44:02,082 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,082 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.33 (1.9%) stddev-sans-first:1.36 09:44:02 INFO - 2015-11-15 09:44:02,082 DEBUG : BROWSER_OUTPUT: Values: 69.0 66.0 68.0 66.0 68.0 68.0 69.0 67.0 69.0 70.0 09:44:02 INFO - 2015-11-15 09:44:02,082 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:44:02 INFO - 2015-11-15 09:44:02,082 DEBUG : BROWSER_OUTPUT: 09:44:02 INFO - 2015-11-15 09:44:02,954 INFO : Browser exited with error code: 0 09:44:03 INFO - 2015-11-15 09:44:03,002 INFO : Completed test kraken (00:01:00) 09:44:03 INFO - 2015-11-15 09:44:03,002 INFO : Starting test v8_7 09:44:03 INFO - 2015-11-15 09:44:03,002 DEBUG : operating with platform_type : linux_ 09:44:03 INFO - 2015-11-15 09:44:03,003 INFO : Initialising browser for v8_7 test... 09:44:03 INFO - 2015-11-15 09:44:03,009 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzsZRSo/profile http://localhost:56940/getInfo.html 09:44:07 INFO - 2015-11-15 09:44:07,534 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:44:07 INFO - 2015-11-15 09:44:07,534 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:44:07 INFO - 2015-11-15 09:44:07,534 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:44:07 INFO - 2015-11-15 09:44:07,534 DEBUG : BROWSER_OUTPUT: __metrics 09:44:08 INFO - 2015-11-15 09:44:08,614 INFO : Browser initialized. 09:44:08 INFO - 2015-11-15 09:44:08,615 INFO : Running cycle 1/1 for v8_7 test... 09:44:08 INFO - 2015-11-15 09:44:08,615 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzsZRSo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:44:20 INFO - 2015-11-15 09:44:20,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 141045760 09:44:20 INFO - 2015-11-15 09:44:20,413 DEBUG : BROWSER_OUTPUT: 09:44:41 INFO - 2015-11-15 09:44:41,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56940/tests/v8_7/run.html (next: http://localhost:56940/tests/v8_7/run.html) 09:44:42 INFO - 2015-11-15 09:44:42,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 138551296 09:44:42 INFO - 2015-11-15 09:44:42,022 DEBUG : BROWSER_OUTPUT: 09:44:42 INFO - 2015-11-15 09:44:42,022 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:44:42 INFO - 2015-11-15 09:44:42,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:44:42 INFO - 2015-11-15 09:44:42,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:44:42 INFO - 2015-11-15 09:44:42,023 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:44:42 INFO - 2015-11-15 09:44:42,023 DEBUG : BROWSER_OUTPUT: |0;Richards;164.446637066272 09:44:42 INFO - 2015-11-15 09:44:42,023 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.1850679575498 09:44:42 INFO - 2015-11-15 09:44:42,023 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.7380410022779 09:44:42 INFO - 2015-11-15 09:44:42,023 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5020 09:44:42 INFO - 2015-11-15 09:44:42,023 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1062.6992561105208 09:44:42 INFO - 2015-11-15 09:44:42,023 DEBUG : BROWSER_OUTPUT: |5;Earley;736.0294117647059 09:44:42 INFO - 2015-11-15 09:44:42,023 DEBUG : BROWSER_OUTPUT: |6;Boyer;12180.722891566265 09:44:42 INFO - 2015-11-15 09:44:42,023 DEBUG : BROWSER_OUTPUT: |7;RegExp;24829.268292682926 09:44:42 INFO - 2015-11-15 09:44:42,023 DEBUG : BROWSER_OUTPUT: |8;Splay;619.1358024691358 09:44:42 INFO - 2015-11-15 09:44:42,023 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 09:44:42 INFO - 2015-11-15 09:44:42,024 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:44:42 INFO - 2015-11-15 09:44:42,024 DEBUG : BROWSER_OUTPUT: __startTimestamp1447609482021__endTimestamp 09:44:42 INFO - 2015-11-15 09:44:42,024 DEBUG : BROWSER_OUTPUT: 09:44:42 INFO - 2015-11-15 09:44:42,024 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:44:42 INFO - 2015-11-15 09:44:42,024 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:44:42 INFO - 2015-11-15 09:44:42,024 DEBUG : BROWSER_OUTPUT: 09:44:42 INFO - 2015-11-15 09:44:42,024 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.45 Median:164.45 stddev:0.00 (0.0%) 09:44:42 INFO - 2015-11-15 09:44:42,024 DEBUG : BROWSER_OUTPUT: Values: 164.4 09:44:42 INFO - 2015-11-15 09:44:42,024 DEBUG : BROWSER_OUTPUT: 09:44:42 INFO - 2015-11-15 09:44:42,024 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.19 Median:186.19 stddev:0.00 (0.0%) 09:44:42 INFO - 2015-11-15 09:44:42,024 DEBUG : BROWSER_OUTPUT: Values: 186.2 09:44:42 INFO - 2015-11-15 09:44:42,025 DEBUG : BROWSER_OUTPUT: 09:44:42 INFO - 2015-11-15 09:44:42,025 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.74 Median:284.74 stddev:0.00 (0.0%) 09:44:42 INFO - 2015-11-15 09:44:42,025 DEBUG : BROWSER_OUTPUT: Values: 284.7 09:44:42 INFO - 2015-11-15 09:44:42,025 DEBUG : BROWSER_OUTPUT: 09:44:42 INFO - 2015-11-15 09:44:42,025 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5020.00 Median:5020.00 stddev:0.00 (0.0%) 09:44:42 INFO - 2015-11-15 09:44:42,025 DEBUG : BROWSER_OUTPUT: Values: 5020.0 09:44:42 INFO - 2015-11-15 09:44:42,025 DEBUG : BROWSER_OUTPUT: 09:44:42 INFO - 2015-11-15 09:44:42,025 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 09:44:42 INFO - 2015-11-15 09:44:42,025 DEBUG : BROWSER_OUTPUT: Values: 1062.7 09:44:42 INFO - 2015-11-15 09:44:42,025 DEBUG : BROWSER_OUTPUT: 09:44:42 INFO - 2015-11-15 09:44:42,025 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:736.03 Median:736.03 stddev:0.00 (0.0%) 09:44:42 INFO - 2015-11-15 09:44:42,026 DEBUG : BROWSER_OUTPUT: Values: 736.0 09:44:42 INFO - 2015-11-15 09:44:42,026 DEBUG : BROWSER_OUTPUT: 09:44:42 INFO - 2015-11-15 09:44:42,026 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12180.72 Median:12180.72 stddev:0.00 (0.0%) 09:44:42 INFO - 2015-11-15 09:44:42,026 DEBUG : BROWSER_OUTPUT: Values: 12180.7 09:44:42 INFO - 2015-11-15 09:44:42,026 DEBUG : BROWSER_OUTPUT: 09:44:42 INFO - 2015-11-15 09:44:42,026 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24829.27 Median:24829.27 stddev:0.00 (0.0%) 09:44:42 INFO - 2015-11-15 09:44:42,026 DEBUG : BROWSER_OUTPUT: Values: 24829.3 09:44:42 INFO - 2015-11-15 09:44:42,027 DEBUG : BROWSER_OUTPUT: 09:44:42 INFO - 2015-11-15 09:44:42,027 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:619.14 Median:619.14 stddev:0.00 (0.0%) 09:44:42 INFO - 2015-11-15 09:44:42,027 DEBUG : BROWSER_OUTPUT: Values: 619.1 09:44:42 INFO - 2015-11-15 09:44:42,027 DEBUG : BROWSER_OUTPUT: 09:44:42 INFO - 2015-11-15 09:44:42,027 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 09:44:42 INFO - 2015-11-15 09:44:42,027 DEBUG : BROWSER_OUTPUT: Values: 4830.9 09:44:42 INFO - 2015-11-15 09:44:42,027 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:44:42 INFO - 2015-11-15 09:44:42,027 DEBUG : BROWSER_OUTPUT: 09:44:42 INFO - 2015-11-15 09:44:42,858 INFO : Browser exited with error code: 0 09:44:42 INFO - 2015-11-15 09:44:42,877 INFO : Completed test v8_7 (00:00:39) 09:44:43 INFO - 2015-11-15 09:44:43,079 INFO : Completed test suite (00:20:10) 09:44:43 INFO - 2015-11-15 09:44:43,079 DEBUG : Working with test: dromaeo_css 09:44:43 INFO - 2015-11-15 09:44:43,079 DEBUG : Generating results file: dromaeo_css 09:44:43 INFO - 2015-11-15 09:44:43,080 DEBUG : Working with test: kraken 09:44:43 INFO - 2015-11-15 09:44:43,080 DEBUG : Generating results file: kraken 09:44:43 INFO - 2015-11-15 09:44:43,080 INFO : javascript benchmark 09:44:43 INFO - 2015-11-15 09:44:43,081 DEBUG : Working with test: v8_7 09:44:43 INFO - 2015-11-15 09:44:43,081 DEBUG : Generating results file: v8_7 09:44:43 INFO - 2015-11-15 09:44:43,081 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:44:43 INFO - 2015-11-15 09:44:43,142 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 09:44:43 INFO - 2015-11-15 09:44:43,142 DEBUG : process_Request line: dromaeo_css 6728.11 graph.html#tests=[[72,63,43]] 09:44:43 INFO - 2015-11-15 09:44:43,142 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:44:43 INFO - 2015-11-15 09:44:43,175 DEBUG : process_Request line: kraken 1525.50 graph.html#tests=[[232,63,43]] 09:44:43 INFO - 2015-11-15 09:44:43,175 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:44:43 INFO - 2015-11-15 09:44:43,213 DEBUG : process_Request line: v8_7 21396.08 graph.html#tests=[[230,63,43]] 09:44:43 INFO - 2015-11-15 09:44:43,214 INFO : javascript benchmark 09:44:43 INFO - 2015-11-15 09:44:43,218 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [333.5413806016727, 335.8690110856766, 349.51068504094263, 349.9790012599244, 351.4763003125344, 14318.570442886705, 14702.48541301052, 16673.58316042098, 17070.23183956722, 18098.095095245233, 14796.0, 15249.771253431207, 16594.83405165948, 16630.50108496744, 16730.0, 5057.721825299607, 5313.468653134694, 5350.91973620396, 5391.379991301012, 5406.648567843097, 4730.455997560291, 4862.416510018785, 4869.878253043685, 4881.316615673809, 5349.465053494659, 4618.676692631517, 4748.406449193851, 4781.306710526971, 4833.033393321332, 4837.782299796518, 4963.925541116886, 5031.42138654054, 5031.798728050873, 5041.621878359138, 5043.167877300278, 4279.972806526443, 4302.139572085564, 4309.375140604626, 4339.327404252346, 4343.370211319372, 13468.25924574148, 14020.43918243269, 14065.71868562623, 14076.366563504667, 14121.717565648732, 1993.4219076467807, 2018.0313449544153, 2044.468438206077, 2059.268959519379, 2071.3164655663595, 10017.849732254022, 10022.849657255147, 10096.14182794456, 10413.323133996266, 10505.789884202273, 1644.079315583277, 1667.1247595012594, 1738.9652206955916, 1748.5890815658438, 1785.5536115971008, 58625.0, 60374.99999999956, 61408.692956534935, 61614.0, 62339.37660623381, 6890.827729306707, 6978.232394436608, 7042.366187043191, 7078.079849619517, 7097.432205423657, 8308.875366869503, 8325.167483251747, 8354.206350396702, 8362.958185209156, 8397.832043359098, 5388.245645609618, 5476.863078422992, 5486.725663716878, 5501.752421141058, 5531.8340449785765, 5532.30846144232, 5542.5565954723525, 5638.23883775685, 5648.039833228361, 5665.291838520185, 3202.503611940153, 3216.34065016671, 3273.345330933823, 3297.8351082445784, 3310.470324748029, 1152.8962393384636, 1156.780211759763, 1156.8900954409319, 1157.6816375496805, 1189.5658084799159, 465.5530690537055, 473.2522614269446, 478.5453818872085, 481.5232919409759, 495.5911373117121, 11460.426978651034, 11678.416079196177, 11704.88295117055, 11775.705607359885, 11818.113641476752, 425.76157351883046, 437.4881388775141, 438.2571541237572, 449.16231228758784, 455.65597973530436, 4961.206207006861, 5719.3136823581435, 5774.162746401748, 5808.070708686674, 5850.1224816277045, 521616.9191540408, 531055.0, 533244.0, 534923.0, 550527.0, 75549.62225188839, 75572.0, 75985.6200719004, 76714.6164269175, 76827.23172768313, 467.7988464960032, 473.583246742871, 476.15482518529194, 477.0482886641173, 478.46650984153115, 10174.389536627827, 10215.795684086128, 10216.489175541044, 10227.0, 10313.793724125626, 34761.47857782186, 35946.0, 36359.81820090883, 36473.08817279589, 36730.081747956516, 47590.0, 48079.75960120177, 48200.5179948196, 48377.03245935132, 48696.513034870615, 7690.154083050748, 8041.638126284448, 8045.436819422584, 8122.390820688353, 8367.874481882654, 11514.251573647685, 12175.695607609527, 12201.755964880831, 12225.266484010988, 12228.388580570758, 10580.36517808934, 10642.308249963728, 10884.61903833362, 10916.235863489479, 10980.505877235704, 9803.313768036169, 10218.386896786216, 10509.579616815241, 10520.368777873353, 10718.624848130277, 10255.282130250811, 10390.740231494274, 10433.21750868703, 11064.944675276573, 11087.556497740323, 8261.297789687944, 8271.586420678821, 8402.579871006303, 8614.61234244473, 8616.83672704177, 10573.52419141125, 10878.184136189659, 10886.67339979802, 10925.508352124332, 11260.268082574607], "dojo.html": [3247.577814884065, 3263.6083669959608, 3275.39405210036, 3305.8512366943487, 3340.6492318306578, 5313.946860531393, 5327.067763141445, 5370.462953704628, 5404.918926216105, 5415.593830462716, 5387.353517577886, 5387.892242155154, 5390.272313237711, 5452.563794896399, 5571.331440227178, 4907.411110666725, 4998.125328067574, 5037.697738135724, 5076.898462030757, 5099.209622508499, 5009.2486127080865, 5101.234814777795, 5143.794248230066, 5171.22431635254, 5189.221616757479, 4930.087933732271, 5013.523715247045, 5106.234064890259, 5118.129917913963, 5147.202183661539, 4931.334269873557, 4977.42759582649, 4990.575801056914, 5006.74966251686, 5051.797928082872, 4979.0788704089855, 4992.650514463989, 5012.423571289312, 5015.699058056528, 5026.0, 5189.818356357509, 5190.6107041972, 5227.26818245446, 5268.868278293035, 5269.314989051437, 5709.74306156224, 5848.210491583624, 5855.0, 5916.4379383958885, 5946.0, 5991.131285963555, 6002.519798416116, 6004.489618382443, 6008.369121242294, 6023.789167379121, 5330.0, 5544.750486228129, 5597.552195824365, 5600.0, 5617.634853734494, 5967.98544247479, 5976.432238937294, 6048.243969503812, 6052.364501727343, 6067.908981365283, 5855.560832937546, 5862.091375836752, 5865.296164460292, 5870.090136028923, 5874.794382196603, 5826.0, 5856.765729370777, 5926.644401335848, 5929.911051334234, 5939.762409503572, 5823.88352232953, 5916.290045194604, 5919.230500034968, 5939.22790037301, 5953.1070339449425, 5872.853178670567, 5897.970510147507, 5926.496247818897, 5951.1073338999495, 5980.0, 4490.932636010462, 4514.706544074625, 4528.569785870337, 4566.406367172246, 4572.177008138567, 3918.0988372674447, 3999.060220848098, 4033.717639765247, 4061.756294622332, 4101.876943691694, 5656.208130861601, 5719.828405147852, 5727.083666613322, 5745.109508026263, 5769.538436925036, 5650.237217975603, 5949.25634295713, 5980.55145864062, 5989.880202395928, 5992.951233534114, 5555.138953462139, 5618.213450116987, 5620.297462817148, 5640.32316122068, 5684.573656975661, 5119.411267704188, 5131.435542090367, 5155.432902380735, 5157.484251574888, 5210.84367468969, 5928.7332070056955, 6124.081387791778, 6128.479079278222, 6213.875722485525, 6223.471004964629, 5886.793962211302, 6000.069989151689, 6015.338312785502, 6034.336223015553, 6037.426444487766, 6194.38056194395, 6217.183770883019, 6253.906191407042, 6260.467860231931, 6261.092141639346, 5655.434456554476, 5770.451807078321, 5775.393583673654, 5905.143754155709, 5956.315023772322, 5956.315023772148, 5960.314563825215, 5965.492933100735, 5971.0744834550715, 5994.760209591742, 5777.45114214149, 5782.479576838105, 5828.358880523224, 5834.920539700169, 5842.737076831468, 5686.43135686428, 5695.544356451557, 5766.971165144148, 5787.479126878601, 5879.794207202727, 5741.97129014369, 5759.7408116634015, 5760.481556659921, 5761.740721667619, 5772.94227057724, 5829.562782791392, 5856.326522449803, 5860.677662728421, 5861.1794348792055, 5865.120231965239, 5436.293281873332, 5538.972305138448, 5573.414791446839, 5687.232223649754, 5705.515031222227], "mootools.html": [1413.9151650900947, 1417.8794802441791, 1524.2454984782535, 1692.8137904830467, 1716.3220527891476, 6950.582965022102, 7096.361327480526, 7203.495755297131, 7428.405727541797, 7444.553326800389, 7462.962685186567, 7488.513246638965, 7567.091948966132, 7587.203343648906, 7624.733134340299, 2192.999999999996, 2219.7447293561204, 2225.877576733279, 2227.454273702945, 2228.320362289501, 2200.7359116905996, 2233.3634914049417, 2233.6649502574583, 2235.910563577455, 2238.104758096758, 2156.6764985252257, 2200.141944641591, 2201.1855613422977, 2226.3209721035078, 2232.285668586053, 2179.934601961944, 2184.7050648162453, 2223.3885681437573, 2226.7773222677765, 2229.7658745831695, 2188.3325585696516, 2223.0, 2226.2764601504578, 2231.509068005036, 2240.1599400224914, 7324.414046876237, 7402.370798482136, 7421.666025028887, 7424.591647459441, 7432.665530051161, 4456.977715111404, 4468.75421851798, 4485.237509623339, 4557.840475583372, 4577.244754615484, 2948.616679831608, 2972.895948641809, 2988.6712461629204, 2993.8054026488207, 2999.3851260491547, 946.0539460539461, 963.2342287881081, 971.3491960386558, 991.7124034030122, 1001.659435791827, 9980.850287245697, 10071.69784906454, 10072.143867771176, 10072.697819065366, 10080.092791648787, 3930.5479869814767, 4015.91968160641, 4036.535798383165, 4037.273290807624, 4084.387341898739, 8129.715459958873, 8253.8349233015, 8284.005919289724, 8286.502809831429, 8306.667733290722, 4238.385434112037, 4249.383839343278, 4251.277282861921, 4255.723377980421, 4265.658747300208, 3841.7310788245113, 3865.710071744574, 3884.3590807516443, 3887.436321733333, 3912.158885839501, 3311.172206948263, 3315.3203593263324, 3348.6772724774064, 3379.90153200206, 3383.6954674078956, 1024.329064462778, 1029.8146333659863, 1030.9587616495255, 1034.99482502587, 1049.6273822792798, 1054.5570860238718, 1054.6097943760703, 1096.9725756856142, 1204.6085022367765, 1337.7993301004733, 6653.866922661519, 6766.932330676728, 6773.762918297836, 6813.046173535709, 6814.62519561419, 1042.1975079188983, 1065.2436769893307, 1112.7533678704945, 1125.319181894958, 1143.845580846575, 5614.410486898817, 5633.042382794934, 5641.605087643826, 5665.745041473144, 5670.347909990322, 8583.227509524173, 8618.698345557876, 8619.439736417113, 8639.438436501732, 8650.178233067849, 8636.697715579925, 8686.739397818075, 8705.564721763887, 8708.956455217683, 8710.738677839676, 6808.2510923798345, 6837.623930683761, 6851.143607049119, 6858.6570671466225, 6875.278095799969, 6882.070920425678, 6931.653417329013, 6938.028675985467, 6946.8610627788175, 6956.686949087202, 7012.053372794608, 7182.461315401261, 7218.386437152901, 7222.96388518054, 7902.723404681038, 7818.609069546614, 7874.0157480314965, 7916.089649690129, 7924.6037698116015, 7969.8406031880195, 6667.566608170453, 6693.631850248283, 6694.397504224448, 6765.526413151032, 6769.289224631343, 7210.459215558959, 7240.203577606564, 7287.344139027513, 7323.560586364835, 7335.303146201102, 6427.967860160669, 6728.596284222962, 6908.3437073477935, 7016.789496315118, 7036.472264580075, 6701.229358623821, 6751.696173672099, 6771.966140169267, 6847.965760171366, 6860.382565569123, 6606.108175396452, 6668.633225172662, 6726.39462448382, 6751.662416879235, 6774.966125169342, 6264.404881536247, 6309.526785491014, 6329.7151628175925, 6336.461400780985, 6337.841553961188, 6350.0, 6357.014662727284, 6362.109304697438, 6363.331850155667, 6386.457151142205], "ext.html": [555.2476394485473, 595.2648479128278, 600.8497875531117, 607.271274470635, 609.1684850179504, 39537.40693889587, 39578.80210598947, 39719.80140099303, 40126.39810402843, 40334.596654033485, 41657.791711041406, 41735.791321043354, 41938.37092443608, 41943.370849437284, 41981.37027944583, 8678.86981695275, 8732.912670873306, 8740.956295218515, 8831.425957312786, 8834.249088827457, 8609.053004169537, 8780.69267575635, 8819.470831750083, 8826.646934122627, 8841.602127904227, 8753.3872628916, 8795.164459376381, 8807.207351338378, 8862.911370886273, 8875.955620221923, 8759.99260085092, 8776.912230877737, 8798.780030499225, 8816.206541411304, 8854.955725221396, 8711.259542938858, 8844.955775221148, 8858.379913406065, 8876.334274929406, 8878.778030549223, 39762.801185994176, 40463.0, 40907.386389204185, 41000.58999409997, 41146.177076458305, 3177.1421716136515, 3187.0, 3298.884539041122, 3306.156929982863, 3843.0, 29510.26224344387, 30024.8498757507, 30052.69947300521, 30107.397852043054, 30274.243143921358, 3358.345122701074, 3405.7105146062613, 3412.84642191102, 3482.181687303482, 3487.1456493159085, 264872.13458990847, 265134.0, 266389.0, 267464.0, 267721.0, 52129.2180617291, 54758.17862732062, 61524.38475615186, 61941.69029154826, 62176.68911655413, 57975.0, 58066.0, 58337.4166258332, 58352.124718129264, 58531.41468585345, 14632.707345853023, 14716.852831471762, 14829.77755333671, 14897.70204595902, 14904.329305181293, 10570.260081794355, 10607.41659208751, 10610.045095941403, 10815.026647601597, 11009.449527523591, 20055.498612534804, 20254.797452025585, 20365.0, 20419.693704594443, 20451.4887127823, 7409.851802963911, 7541.622918854036, 7596.772096837104, 7609.809754756065, 7719.073711154698, 978.5938835383379, 1004.6031817432073, 1006.0191313469455, 1028.9897101029044, 1072.3994563044564, 28356.858215708788, 28568.142955711362, 28574.285642859093, 28729.707163177707, 28943.276418089717, 1027.897210278981, 1046.2937517175876, 1092.3937214845837, 1110.6168371911679, 1188.1564089496553, 14679.0, 14693.706125877636, 14773.92613036928, 14988.62528436776, 15005.549833505012, 330897.0, 331351.0, 335519.0, 335728.0, 337385.0, 51880.48119518832, 52356.214656780176, 52455.47544524506, 52484.47515524872, 52664.473355266724, 1298.727267273864, 1342.053852034333, 1344.610063081715, 1347.6630842289428, 1353.5939218234491, 27268.181954541396, 28074.157775266776, 28341.858290708413, 28442.857785710938, 29398.265043374086, 44060.779696101315, 44613.0, 44648.776756116014, 44859.327110094026, 45034.54965450303, 220929.0, 221140.0, 222367.0, 222583.0, 223864.0, 27936.44127117487, 28421.289467763472, 29881.402371952005, 31479.527807082453, 32118.19704507406, 37889.43165852459, 38133.23733525258, 39191.60808391879, 39264.6073539261, 39394.803025984686, 32541.0, 32614.347713045132, 33202.667973319956, 33285.833570831994, 33929.151771205914, 33379.83310083434, 33388.83305583456, 33534.32931341311, 34055.31889362248, 34065.31869362648, 33064.83467582743, 34659.65340346564, 34729.1317717049, 34855.65144348524, 35008.649913500536, 30733.69266307308, 31996.20009499781, 32564.0, 33257.0, 33339.33321333608, 24469.75530244746, 24905.252842414757, 24979.375515612253, 25608.487830242917, 26471.60292595574], "prototype.html": [319.2274695237525, 325.34443097159226, 329.2591668745323, 337.85472246933824, 338.46353529655494, 6310.337414571467, 6367.17226760521, 6372.267189273235, 6377.776777812784, 6508.674566271679, 6242.1885154929905, 6281.968590157055, 6306.59007164534, 6331.240251169855, 6340.302566717657, 4817.397825271841, 4834.830780922668, 4835.734034628094, 4835.806567737286, 4838.177509823338, 4839.201531747258, 4844.055409195208, 4848.175810112271, 4853.878653033667, 4865.975670121662, 4689.695169813968, 4757.0, 4790.281457781326, 4791.760411979404, 4797.496262892399, 4750.3349531065505, 4751.619870410359, 4767.952320476786, 4776.331313616097, 4777.952220477786, 4114.732542384735, 4133.81397837098, 4146.170765846812, 4153.356229784358, 4155.480564929384, 5945.621751299472, 5999.400059994009, 6005.759769609211, 6014.669193194372, 6021.3677563856045, 5439.265699130607, 5597.412271711452, 5603.439656034364, 5607.7476513556985, 5620.269364982526, 6662.56693314933, 6673.5662181958505, 6676.26561078281, 6680.766173183915, 6691.665416729144, 4573.382593349922, 4585.403897493305, 4591.51789062147, 4637.930431043537, 4644.396228490308, 6802.047713320139, 6919.238883722836, 6995.82510437238, 7001.579905205704, 7020.92979070213, 4571.062932098912, 4619.95380046202, 4624.653151013687, 4627.1439783640135, 4627.676062675648, 4611.5619016193405, 4664.416947881515, 4676.0647870426055, 4691.1555919934735, 4695.741734204583, 5474.206240095244, 5493.890122197534, 5519.0, 5545.861353466195, 5547.639403438763, 6687.665616719242, 6826.214985276657, 6827.556208846409, 6828.453723702092, 6853.760118395832, 1689.6451745133413, 1716.262007336857, 1743.2939659437948, 1743.4159556548698, 1748.7814023247095, 1121.9439028048564, 1127.7180704823795, 1135.3358285402967, 1140.6292954789726, 1146.3721515448083, 6510.44661203803, 6513.348665133543, 6518.674066296761, 6518.837029074311, 6554.082428460019, 6872.2819295176205, 6892.0, 6899.344562266577, 6902.861942761117, 6905.1713794345, 6408.455281301049, 6499.122618446449, 6499.675016249169, 6500.122483464766, 6533.085368048477, 3768.6231376862092, 3784.924301513954, 3807.485989391452, 3818.8090595470117, 3824.4454554089502, 7356.926430735624, 7396.704131834666, 7398.741044063432, 7426.220246874109, 7427.888581671279, 7064.0, 7153.856922861513, 7270.272972702687, 7276.235995220532, 7286.927130728731, 7315.451341149435, 7326.157491888394, 7354.080739907512, 7356.77929662111, 7370.152432470334, 6900.378965893094, 6915.031895534528, 6939.930600693929, 6967.8606427870145, 6970.059042029261, 6806.217285012089, 6931.09895713554, 6980.232174460703, 7013.368796808311, 7022.824429389306, 7377.8155546111775, 7387.519811212254, 7387.630618468947, 7406.18531961473, 7422.443316751157, 4679.953200467951, 4702.952970470252, 4708.4349878014855, 4716.268978308368, 4722.079194557028, 6833.555818871758, 6853.348931851466, 6990.825229369307, 7016.0, 7036.120484939383, 6703.497237707289, 6743.291954344723, 6770.796876093725, 6774.899781067885, 6781.694823732845, 6763.492738044568, 6790.117284752951, 6795.966020169867, 6806.42145417645, 6816.522843400914, 6503.739850405931, 6661.666916654245, 6679.899801503078, 6683.899741503784, 6684.364985326386, 6817.079694241214, 6817.943218801094, 6854.725810967506, 6855.931440685529, 6873.450123989969, 6651.33486651331, 6678.666066696548, 6696.19645642526, 6711.731530738716, 6726.461883049442], "yui.html": [781.3007358414219, 797.6968751874286, 835.4653022065879, 860.27736701171, 864.438115225104, 13730.10754300971, 14103.506377276797, 14112.647183820396, 14167.29163541824, 14176.519109155895, 13223.471061157567, 13304.800427993589, 13338.93330533346, 13438.798418023738, 13467.595972120827, 803.0203152154362, 815.4780940198278, 817.9713710020151, 819.8032472206687, 820.4134044158411, 808.5754978636204, 820.1142765812908, 821.6302663801314, 824.4476200945381, 827.2637352756052, 847.7244895408986, 852.995735021324, 854.2055888024136, 855.4867079752161, 857.9699710510133, 845.4546817302836, 847.1570787066846, 853.4495250563383, 855.2132038524572, 856.1609622569854, 620.7672122953892, 622.17561730707, 622.900335946251, 623.1462895832693, 623.7785586116954, 12813.551525696555, 12843.614691559269, 12893.935530322382, 12914.741705165938, 13009.804852927213, 10035.448050357227, 10405.323653962469, 10405.947970260177, 10422.166226701846, 10587.735306617396, 10180.796384072277, 10243.539040743184, 10286.32289338912, 10315.226358023177, 10358.792824143475, 3199.488081906907, 3256.6417694053634, 3258.5438038674606, 3304.7521435892163, 3383.2725963917874, 46534.30198547024, 46668.766656166845, 46717.532824671995, 46793.0, 47120.76439617814, 7799.398672316072, 7852.371810255166, 7926.801829954182, 7932.854478352379, 8052.919470805217, 12594.37028148589, 12617.369131543386, 12617.93691031539, 12632.178908370926, 12661.303628300348, 6332.303446620868, 6414.807555773335, 6572.11276477679, 6621.073049773036, 6660.56706314088, 4315.762633055149, 4347.5217726050105, 4364.258076127066, 4395.692301538862, 4418.690691651554, 2681.3832818451865, 2691.690455597631, 2694.676638803356, 2703.094463354759, 2709.444563864403, 428.57999160822567, 433.66174383979916, 437.89052736815796, 446.80117347779924, 446.84583818582536, 517.1286382445592, 534.4014703531991, 580.7473748919234, 589.7876764364826, 660.6282406192249, 8314.916850831536, 8720.694775682947, 9071.81856362869, 9599.664011759554, 9690.37012594179, 596.5406636889571, 644.1979735229576, 666.3037126203129, 699.6047233313263, 745.5750222373304, 4156.625903668684, 4372.803223854934, 4488.169688607618, 4529.592336689714, 4671.929921051187, 59603.40396596065, 60052.39685618877, 60627.393726063056, 61632.075518867256, 63104.68447657732, 50983.0, 51229.48770512322, 51524.227136592985, 52476.47523524716, 55311.44688553063, 49304.260436093486, 49823.25265121026, 49936.0, 50141.24788128108, 50208.246876296886, 9420.811583768424, 9424.95287523558, 9458.858117128111, 9459.0, 9464.479453629841, 33187.668123319425, 34067.14832129217, 34550.30899381948, 36336.63663363332, 37238.06904827401, 44784.328235075845, 44907.10185796331, 44975.10049799051, 45623.08753824971, 46523.0, 11019.83470247931, 11338.943305283421, 12331.876681233072, 12388.0, 12922.676933076747, 12849.357532123544, 12977.805332920203, 13176.0, 13454.663633409244, 13469.663258418617, 11851.70370740704, 12060.577879774166, 12075.456604452645, 12260.570880019157, 12743.10798244114, 11663.533458661559, 11919.1096903572, 12056.794320567873, 12070.517179312728, 12550.497980080694, 11650.184487085822, 12193.51225950952, 12238.571649992207, 12239.571614993432, 12559.497620095093, 10004.399736015863, 10073.0, 10198.541065652213, 10263.384196947909, 10666.946665266623, 9140.725778226664, 9266.305027123128, 9496.667616633385, 9883.998093119293, 10119.190464762949]}, "summary": {"lowerIsBetter": false, "suite": 6728.108717835, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6992.336082307724, "unit": "ms", "value": 6992.336082307724}, "dojo.html": {"lowerIsBetter": false, "filtered": 5456.628744014278, "unit": "ms", "value": 5456.628744014278}, "mootools.html": {"lowerIsBetter": false, "filtered": 4272.431007965438, "unit": "ms", "value": 4272.431007965438}, "ext.html": {"lowerIsBetter": false, "filtered": 18090.637543684883, "unit": "ms", "value": 18090.637543684883}, "prototype.html": {"lowerIsBetter": false, "filtered": 5067.157060443827, "unit": "ms", "value": 5067.157060443827}, "yui.html": {"lowerIsBetter": false, "filtered": 6207.007605506461, "unit": "ms", "value": 6207.007605506461}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-062.e"}, "testrun": {"date": 1447608272, "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": "20151115073848", "branch": "Mozilla-Inbound", "revision": "4922c78419fa8a7c6a81f0f504406b85c6cee763"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 163.0, 162.0, 162.0, 162.0, 170.0, 161.0, 165.0, 169.0, 163.0], "ai-astar": [111.0, 106.0, 111.0, 110.0, 111.0, 123.0, 111.0, 110.0, 109.0, 111.0], "imaging-gaussian-blur": [111.0, 110.0, 109.0, 111.0, 110.0, 111.0, 110.0, 110.0, 112.0, 111.0], "audio-beat-detection": [154.0, 131.0, 150.0, 161.0, 133.0, 148.0, 154.0, 129.0, 169.0, 133.0], "json-stringify-tinderbox": [68.0, 69.0, 68.0, 69.0, 70.0, 69.0, 74.0, 69.0, 70.0, 70.0], "stanford-crypto-pbkdf2": [151.0, 155.0, 143.0, 149.0, 152.0, 139.0, 164.0, 163.0, 151.0, 147.0], "json-parse-financial": [61.0, 62.0, 65.0, 67.0, 63.0, 62.0, 69.0, 63.0, 65.0, 60.0], "stanford-crypto-sha256-iterative": [69.0, 66.0, 68.0, 66.0, 68.0, 68.0, 69.0, 67.0, 69.0, 70.0], "audio-fft": [72.0, 74.0, 81.0, 72.0, 73.0, 74.0, 138.0, 74.0, 72.0, 72.0], "imaging-darkroom": [147.0, 147.0, 148.0, 147.0, 151.0, 146.0, 148.0, 147.0, 147.0, 145.0], "stanford-crypto-ccm": [118.0, 126.0, 119.0, 136.0, 124.0, 124.0, 130.0, 126.0, 128.0, 130.0], "audio-oscillator": [91.0, 91.0, 134.0, 91.0, 91.0, 92.0, 141.0, 91.0, 91.0, 133.0], "stanford-crypto-aes": [86.0, 83.0, 85.0, 86.0, 85.0, 86.0, 86.0, 87.0, 87.0, 87.0], "imaging-desaturate": [96.0, 98.0, 98.0, 96.0, 98.0, 97.0, 97.0, 97.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1525.4999999999998, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.2, "unit": "ms", "value": 80.2}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 151.4, "unit": "ms", "value": 151.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 146.2, "unit": "ms", "value": 146.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 126.1, "unit": "ms", "value": 126.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.3, "unit": "ms", "value": 147.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 63.7, "unit": "ms", "value": 63.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.6, "unit": "ms", "value": 104.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.3, "unit": "ms", "value": 111.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 163.9, "unit": "ms", "value": 163.9}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 68.0, "unit": "ms", "value": 68.0}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.6, "unit": "ms", "value": 69.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.5, "unit": "ms", "value": 110.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.8, "unit": "ms", "value": 85.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.9, "unit": "ms", "value": 96.9}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-062.e"}, "testrun": {"date": 1447608272, "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": "20151115073848", "branch": "Mozilla-Inbound", "revision": "4922c78419fa8a7c6a81f0f504406b85c6cee763"}}, {"talos_counters": {}, "results": {"DeltaBlue": [186.1850679575498], "Encrypt": [284.7380410022779], "NavierStokes": [4830.917874396136], "Decrypt": [5020.0], "Splay": [619.1358024691358], "Richards": [164.446637066272], "RegExp": [24829.268292682926], "Earley": [736.0294117647059], "Boyer": [12180.722891566265], "RayTrace": [1062.6992561105208]}, "summary": {"lowerIsBetter": false, "suite": 21396.075001911202, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 355.1197780000001, "unit": "score", "value": 355.1197780000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 934.8276720000003, "unit": "score", "value": 934.8276720000003}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 53.0241035856574, "unit": "score", "value": 53.0241035856574}, "Splay": {"lowerIsBetter": false, "filtered": 131.62055832502497, "unit": "score", "value": 131.62055832502497}, "RegExp": {"lowerIsBetter": false, "filtered": 36.68996561886052, "unit": "score", "value": 36.68996561886052}, "Richards": {"lowerIsBetter": false, "filtered": 214.67146200000008, "unit": "score", "value": 214.67146200000008}, "Earley": {"lowerIsBetter": false, "filtered": 905.4841958041958, "unit": "score", "value": 905.4841958041958}, "Boyer": {"lowerIsBetter": false, "filtered": 54.714568743818035, "unit": "score", "value": 54.714568743818035}, "RayTrace": {"lowerIsBetter": false, "filtered": 696.3296489999998, "unit": "score", "value": 696.3296489999998}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-062.e"}, "testrun": {"date": 1447608272, "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": "20151115073848", "branch": "Mozilla-Inbound", "revision": "4922c78419fa8a7c6a81f0f504406b85c6cee763"}}] 09:44:43 INFO - RETURN: dromaeo_css: 6728.11 09:44:43 INFO - RETURN: kraken: 1525.50 09:44:43 INFO - RETURN: v8_7: 21396.08 09:44:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21396.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1525.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6728.11"}}} 09:44:43 INFO - Return code: 0 09:44:43 INFO - # TBPL SUCCESS # 09:44:43 INFO - Running post-action listener: _resource_record_post_action 09:44:43 INFO - Running post-run listener: _resource_record_post_run 09:44:44 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 24576; Write bytes: 519393280; Read time: 192; Write time: 501056 09:44:44 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 181927936; Read time: 0; Write time: 193404 09:44:44 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 24576; Write bytes: 277815296; Read time: 192; Write time: 165480 09:44:44 INFO - Running post-run listener: _upload_blobber_files 09:44:44 INFO - Blob upload gear active. 09:44:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:44:44 INFO - Copying logs to upload dir... 09:44:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1253.790903 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2015-11-15 09:44:43.900494) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 09:44:43.904602) ========= 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=3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/41xWOCFTSZyx6Os0Im_03A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009852 build_url: 'https://queue.taskcluster.net/v1/task/41xWOCFTSZyx6Os0Im_03A/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-15 09:44:43.956156) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 09:44:43.956480) ========= 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=3c6a863b9a9413665da583f1000001cd-1447600897.692081-859546396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 09:44:44.006218) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 09:44:44.006578) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 09:44:44.006869) ========= ========= Total master_lag: 0.24 =========