builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1447862879.59 results: success (0) buildid: 20151118030232 builduid: 5d9fcb0e271c46358d1a5024fa3f382a revision: eb3016abd37db2e6a6d923265047e84b12c0af61 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 08:07:59.591902) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 08:07:59.592318) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 08:07:59.592604) ========= 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=801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006607 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 08:07:59.624649) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 08:07:59.624959) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 08:07:59.665251) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:07:59.665529) ========= 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=801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020185 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:07:59.714250) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 08:07:59.714517) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 08:07:59.714901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:07:59.715179) ========= 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=801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 08:07:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 77.1M=0s 2015-11-18 08:08:00 (77.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165061 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:07:59.898301) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:07:59.898600) ========= 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=801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.062187 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:07:59.971251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:07:59.971563) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev eb3016abd37db2e6a6d923265047e84b12c0af61 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev eb3016abd37db2e6a6d923265047e84b12c0af61 --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=801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 08:08:00,143 truncating revision to first 12 chars 2015-11-18 08:08:00,143 Setting DEBUG logging. 2015-11-18 08:08:00,143 attempt 1/10 2015-11-18 08:08:00,143 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/eb3016abd37d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 08:08:00,408 unpacking tar archive at: mozilla-central-eb3016abd37d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543512 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:08:00.527013) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 08:08:00.527299) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 08:08:00.534280) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 08:08:00.534532) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 08:08:00.534963) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-18 08:08:00.535261) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:08:00 INFO - MultiFileLogger online at 20151118 08:08:00 in /builds/slave/test-pgo 08:08:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:08:00 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:08:00 INFO - {'append_to_log': False, 08:08:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:08:00 INFO - 'blob_upload_branch': 'Firefox', 08:08:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:08:00 INFO - 'branch': 'Firefox', 08:08:00 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:00 INFO - 'config_files': ('talos/linux_config.py',), 08:08:00 INFO - 'default_actions': ('clobber', 08:08:00 INFO - 'read-buildbot-config', 08:08:00 INFO - 'download-and-extract', 08:08:00 INFO - 'populate-webroot', 08:08:00 INFO - 'create-virtualenv', 08:08:00 INFO - 'install', 08:08:00 INFO - 'run-tests'), 08:08:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:00 INFO - 'download_minidump_stackwalk': True, 08:08:00 INFO - 'download_symbols': 'ondemand', 08:08:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:00 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:00 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:00 INFO - 'installer_path': 'installer.exe', 08:08:00 INFO - 'log_level': 'info', 08:08:00 INFO - 'log_name': 'talos', 08:08:00 INFO - 'log_to_console': True, 08:08:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:08:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:08:00 INFO - 'opt_config_files': (), 08:08:00 INFO - 'pip_index': False, 08:08:00 INFO - 'sps_profile': False, 08:08:00 INFO - 'sps_profile_interval': 0, 08:08:00 INFO - 'suite': 'dromaeojs', 08:08:00 INFO - 'system_bits': '64', 08:08:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:00 INFO - 'title': 'talos-linux64-ix-006', 08:08:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:00 INFO - 'use_talos_json': True, 08:08:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:08:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:00 INFO - 'work_dir': 'build'} 08:08:00 INFO - ##### 08:08:00 INFO - ##### Running clobber step. 08:08:00 INFO - ##### 08:08:00 INFO - Running pre-action listener: _resource_record_pre_action 08:08:00 INFO - Running main action method: clobber 08:08:00 INFO - rmtree: /builds/slave/test-pgo/build 08:08:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:08:01 INFO - Running post-action listener: _resource_record_post_action 08:08:01 INFO - ##### 08:08:01 INFO - ##### Running read-buildbot-config step. 08:08:01 INFO - ##### 08:08:01 INFO - Running pre-action listener: _resource_record_pre_action 08:08:01 INFO - Running main action method: read_buildbot_config 08:08:01 INFO - Using buildbot properties: 08:08:01 INFO - { 08:08:01 INFO - "properties": { 08:08:01 INFO - "buildnumber": 116, 08:08:01 INFO - "product": "firefox", 08:08:01 INFO - "script_repo_revision": "production", 08:08:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:08:01 INFO - "repository": "", 08:08:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 08:08:01 INFO - "buildid": "20151118030232", 08:08:01 INFO - "slavename": "talos-linux64-ix-006", 08:08:01 INFO - "stage_platform": "linux64-pgo", 08:08:01 INFO - "basedir": "/builds/slave/test-pgo", 08:08:01 INFO - "nightly_build": "True", 08:08:01 INFO - "project": "", 08:08:01 INFO - "platform": "ubuntu64_hw", 08:08:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:08:01 INFO - "slavebuilddir": "test", 08:08:01 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 08:08:01 INFO - "branch": "mozilla-central", 08:08:01 INFO - "repo_path": "mozilla-central", 08:08:01 INFO - "pgo_build": "True", 08:08:01 INFO - "builduid": "5d9fcb0e271c46358d1a5024fa3f382a", 08:08:01 INFO - "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61" 08:08:01 INFO - }, 08:08:01 INFO - "sourcestamp": { 08:08:01 INFO - "repository": "", 08:08:01 INFO - "hasPatch": false, 08:08:01 INFO - "project": "", 08:08:01 INFO - "branch": "mozilla-central-linux64-pgo-talos", 08:08:01 INFO - "changes": [ 08:08:01 INFO - { 08:08:01 INFO - "category": null, 08:08:01 INFO - "files": [ 08:08:01 INFO - { 08:08:01 INFO - "url": null, 08:08:01 INFO - "name": "https://queue.taskcluster.net/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 08:08:01 INFO - } 08:08:01 INFO - ], 08:08:01 INFO - "repository": "", 08:08:01 INFO - "rev": "eb3016abd37db2e6a6d923265047e84b12c0af61", 08:08:01 INFO - "who": "sendchange", 08:08:01 INFO - "when": 1447862800, 08:08:01 INFO - "number": 6677426, 08:08:01 INFO - "comments": "", 08:08:01 INFO - "project": "", 08:08:01 INFO - "at": "Wed 18 Nov 2015 08:06:40", 08:08:01 INFO - "branch": "mozilla-central-linux64-pgo-talos", 08:08:01 INFO - "revlink": "", 08:08:01 INFO - "properties": [ 08:08:01 INFO - [ 08:08:01 INFO - "buildid", 08:08:01 INFO - "20151118030232", 08:08:01 INFO - "Change" 08:08:01 INFO - ], 08:08:01 INFO - [ 08:08:01 INFO - "builduid", 08:08:01 INFO - "5d9fcb0e271c46358d1a5024fa3f382a", 08:08:01 INFO - "Change" 08:08:01 INFO - ], 08:08:01 INFO - [ 08:08:01 INFO - "nightly_build", 08:08:01 INFO - "True", 08:08:01 INFO - "Change" 08:08:01 INFO - ], 08:08:01 INFO - [ 08:08:01 INFO - "pgo_build", 08:08:01 INFO - "True", 08:08:01 INFO - "Change" 08:08:01 INFO - ] 08:08:01 INFO - ], 08:08:01 INFO - "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61" 08:08:01 INFO - } 08:08:01 INFO - ], 08:08:01 INFO - "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61" 08:08:01 INFO - } 08:08:01 INFO - } 08:08:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 08:08:01 INFO - Running post-action listener: _resource_record_post_action 08:08:01 INFO - ##### 08:08:01 INFO - ##### Running download-and-extract step. 08:08:01 INFO - ##### 08:08:01 INFO - Running pre-action listener: _resource_record_pre_action 08:08:01 INFO - Running main action method: download_and_extract 08:08:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:01 INFO - https://queue.taskcluster.net/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:08:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/test_packages.json 08:08:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/test_packages.json 08:08:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:08:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:08:06 INFO - Downloaded 1302 bytes. 08:08:06 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:08:06 INFO - Using the following test package requirements: 08:08:06 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:06 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:08:06 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:06 INFO - u'jsshell-linux-x86_64.zip'], 08:08:06 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:08:06 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:06 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:08:06 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:08:06 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:08:06 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:06 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:08:06 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:06 INFO - https://queue.taskcluster.net/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:08:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:08:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/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 08:08:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/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 08:08:14 INFO - Downloaded 22461894 bytes. 08:08:14 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 08:08:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:08:14 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 08:08:15 INFO - Return code: 0 08:08:15 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 08:08:15 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')]} 08:08:16 INFO - https://queue.taskcluster.net/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:08:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:08:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/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 08:08:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/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 08:08:21 INFO - Downloaded 22461894 bytes. 08:08:21 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 08:08:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:08:21 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 08:08:22 INFO - Return code: 0 08:08:22 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')]} 08:08:22 INFO - https://queue.taskcluster.net/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:08:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/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 08:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/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 08:08:24 INFO - Downloaded 11131693 bytes. 08:08:24 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 08:08:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:24 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 08:08:24 INFO - Return code: 0 08:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:24 INFO - https://queue.taskcluster.net/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:08:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:08:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:08:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/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 08:08:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3O4cC8CaTUe-36pHW_03RQ/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 08:08:25 INFO - Downloaded 57188845 bytes. 08:08:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:08:25 INFO - mkdir: /builds/slave/test-pgo/properties 08:08:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:08:25 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:08:25 INFO - Contents: 08:08:25 INFO - build_url:https://queue.taskcluster.net/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:08:25 INFO - Running post-action listener: _resource_record_post_action 08:08:25 INFO - Running post-action listener: set_extra_try_arguments 08:08:25 INFO - ##### 08:08:25 INFO - ##### Running populate-webroot step. 08:08:25 INFO - ##### 08:08:25 INFO - Running pre-action listener: _resource_record_pre_action 08:08:25 INFO - Running main action method: populate_webroot 08:08:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:08:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:08:25 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:08:25 INFO - '../fennec_ids.txt'], 08:08:25 INFO - 'tests': ['tcheck2']}, 08:08:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:08:25 INFO - '--tppagecycles', 08:08:25 INFO - '7'], 08:08:25 INFO - 'tests': ['tsvgm']}}, 08:08:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:08:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:08:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:08:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:08:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:08:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:08:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:25 INFO - 'talos_options': ['--e10s'], 08:08:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:25 INFO - 'tests': ['damp', 'tps']}, 08:08:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:25 INFO - 'talos_options': ['--e10s'], 08:08:25 INFO - 'tests': ['damp', 'tps']}, 08:08:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:08:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:08:25 INFO - 'other': {'tests': ['a11yr', 08:08:25 INFO - 'ts_paint', 08:08:25 INFO - 'tpaint', 08:08:25 INFO - 'sessionrestore', 08:08:25 INFO - 'sessionrestore_no_auto_restore']}, 08:08:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:08:25 INFO - 'tests': ['a11yr', 08:08:25 INFO - 'ts_paint', 08:08:25 INFO - 'tpaint', 08:08:25 INFO - 'sessionrestore', 08:08:25 INFO - 'sessionrestore_no_auto_restore']}, 08:08:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:08:25 INFO - 'tests': ['a11yr', 08:08:25 INFO - 'ts_paint', 08:08:25 INFO - 'tpaint', 08:08:25 INFO - 'sessionrestore', 08:08:25 INFO - 'sessionrestore_no_auto_restore']}, 08:08:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:08:25 INFO - 'tests': ['a11yr', 08:08:25 INFO - 'ts_paint', 08:08:25 INFO - 'tpaint', 08:08:25 INFO - 'sessionrestore', 08:08:25 INFO - 'sessionrestore_no_auto_restore']}, 08:08:25 INFO - 'other_l64': {'tests': ['a11yr', 08:08:25 INFO - 'ts_paint', 08:08:25 INFO - 'tpaint', 08:08:25 INFO - 'sessionrestore', 08:08:25 INFO - 'sessionrestore_no_auto_restore']}, 08:08:25 INFO - 'other_nol64': {'tests': ['a11yr', 08:08:25 INFO - 'ts_paint', 08:08:25 INFO - 'tpaint', 08:08:25 INFO - 'sessionrestore', 08:08:25 INFO - 'sessionrestore_no_auto_restore']}, 08:08:25 INFO - 'svgr': {'tests': ['tsvgx', 08:08:25 INFO - 'tsvgr_opacity', 08:08:25 INFO - 'tart', 08:08:25 INFO - 'tscrollx', 08:08:25 INFO - 'cart']}, 08:08:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:08:25 INFO - 'tests': ['tsvgx', 08:08:25 INFO - 'tsvgr_opacity', 08:08:25 INFO - 'tart', 08:08:25 INFO - 'tscrollx', 08:08:25 INFO - 'cart']}, 08:08:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:25 INFO - 'tests': ['tp5o']}, 08:08:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:25 INFO - 'talos_options': ['--e10s'], 08:08:25 INFO - 'tests': ['tp5o']}, 08:08:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:25 INFO - 'talos_options': ['--xperf_path', 08:08:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:25 INFO - 'tests': ['tp5n']}, 08:08:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:25 INFO - 'talos_options': ['--e10s', 08:08:25 INFO - '--xperf_path', 08:08:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:25 INFO - 'tests': ['tp5n']}}, 08:08:25 INFO - 'talos.zip': {'path': '', 08:08:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:08:25 INFO - Running post-action listener: _resource_record_post_action 08:08:25 INFO - ##### 08:08:25 INFO - ##### Running create-virtualenv step. 08:08:25 INFO - ##### 08:08:25 INFO - Running pre-action listener: _resource_record_pre_action 08:08:25 INFO - Running main action method: create_virtualenv 08:08:25 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:08:25 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 08:08:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:08:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:08:25 INFO - Using real prefix '/usr' 08:08:25 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:08:26 INFO - Installing distribute.............................................................................................................................................................................................done. 08:08:28 INFO - Installing pip.................done. 08:08:28 INFO - Return code: 0 08:08:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:08:28 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')]} 08:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:28 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')]} 08:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:28 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 0x7fb06fef7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d448c0>, '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 0x1cf1420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf18b0>, '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': '801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717', '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 08:08:28 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 08:08:28 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 08:08:28 INFO - Using env: {'DISPLAY': ':0', 08:08:28 INFO - 'HOME': '/home/cltbld', 08:08:28 INFO - 'LANG': 'en_US.UTF-8', 08:08:28 INFO - 'LANGUAGE': 'en_US:en', 08:08:28 INFO - 'LOGNAME': 'cltbld', 08:08:28 INFO - 'MAIL': '/var/mail/cltbld', 08:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:28 INFO - 'MOZ_NO_REMOTE': '1', 08:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:28 INFO - 'NO_EM_RESTART': '1', 08:08:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:28 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:28 INFO - 'SHELL': '/bin/bash', 08:08:28 INFO - 'SHLVL': '1', 08:08:28 INFO - 'TERM': 'linux', 08:08:28 INFO - 'TMOUT': '86400', 08:08:28 INFO - 'USER': 'cltbld', 08:08:28 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717', 08:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:28 INFO - '_': '/tools/buildbot/bin/python'} 08:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:28 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 08:08:28 INFO - Cleaning up... 08:08:28 INFO - Return code: 0 08:08:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:08:28 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')]} 08:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:28 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')]} 08:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:28 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 0x7fb06fef7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d448c0>, '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 0x1cf1420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf18b0>, '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': '801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717', '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 08:08:28 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 08:08:28 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 08:08:28 INFO - Using env: {'DISPLAY': ':0', 08:08:28 INFO - 'HOME': '/home/cltbld', 08:08:28 INFO - 'LANG': 'en_US.UTF-8', 08:08:28 INFO - 'LANGUAGE': 'en_US:en', 08:08:28 INFO - 'LOGNAME': 'cltbld', 08:08:28 INFO - 'MAIL': '/var/mail/cltbld', 08:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:28 INFO - 'MOZ_NO_REMOTE': '1', 08:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:28 INFO - 'NO_EM_RESTART': '1', 08:08:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:28 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:28 INFO - 'SHELL': '/bin/bash', 08:08:28 INFO - 'SHLVL': '1', 08:08:28 INFO - 'TERM': 'linux', 08:08:28 INFO - 'TMOUT': '86400', 08:08:28 INFO - 'USER': 'cltbld', 08:08:28 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717', 08:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:28 INFO - '_': '/tools/buildbot/bin/python'} 08:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:28 INFO - Downloading/unpacking psutil>=0.7.1 08:08:28 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 08:08:28 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 08:08:28 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 08:08:28 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 08:08:28 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 08:08:28 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 08:08:30 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:08:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:08:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:08:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:30 INFO - Installing collected packages: psutil 08:08:30 INFO - Running setup.py install for psutil 08:08:30 INFO - building 'psutil._psutil_linux' extension 08:08:30 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 08:08:30 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 08:08:30 INFO - building 'psutil._psutil_posix' extension 08:08:30 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 08:08:31 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 08:08:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:31 INFO - Successfully installed psutil 08:08:31 INFO - Cleaning up... 08:08:31 INFO - Return code: 0 08:08:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:08:31 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')]} 08:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:31 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')]} 08:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:31 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 0x7fb06fef7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d448c0>, '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 0x1cf1420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf18b0>, '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': '801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717', '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 08:08:31 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 08:08:31 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 08:08:31 INFO - Using env: {'DISPLAY': ':0', 08:08:31 INFO - 'HOME': '/home/cltbld', 08:08:31 INFO - 'LANG': 'en_US.UTF-8', 08:08:31 INFO - 'LANGUAGE': 'en_US:en', 08:08:31 INFO - 'LOGNAME': 'cltbld', 08:08:31 INFO - 'MAIL': '/var/mail/cltbld', 08:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:31 INFO - 'MOZ_NO_REMOTE': '1', 08:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:31 INFO - 'NO_EM_RESTART': '1', 08:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:31 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:31 INFO - 'SHELL': '/bin/bash', 08:08:31 INFO - 'SHLVL': '1', 08:08:31 INFO - 'TERM': 'linux', 08:08:31 INFO - 'TMOUT': '86400', 08:08:31 INFO - 'USER': 'cltbld', 08:08:31 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717', 08:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:31 INFO - '_': '/tools/buildbot/bin/python'} 08:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:08:31 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 08:08:31 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 08:08:31 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 08:08:31 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 08:08:31 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 08:08:31 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 08:08:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:08:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:08:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:08:33 INFO - Installing collected packages: mozsystemmonitor 08:08:33 INFO - Running setup.py install for mozsystemmonitor 08:08:33 INFO - Successfully installed mozsystemmonitor 08:08:33 INFO - Cleaning up... 08:08:33 INFO - Return code: 0 08:08:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:08:33 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')]} 08:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:33 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')]} 08:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:33 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 0x7fb06fef7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d448c0>, '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 0x1cf1420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf18b0>, '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': '801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717', '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 08:08:33 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 08:08:33 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 08:08:33 INFO - Using env: {'DISPLAY': ':0', 08:08:33 INFO - 'HOME': '/home/cltbld', 08:08:33 INFO - 'LANG': 'en_US.UTF-8', 08:08:33 INFO - 'LANGUAGE': 'en_US:en', 08:08:33 INFO - 'LOGNAME': 'cltbld', 08:08:33 INFO - 'MAIL': '/var/mail/cltbld', 08:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:33 INFO - 'MOZ_NO_REMOTE': '1', 08:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:33 INFO - 'NO_EM_RESTART': '1', 08:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:33 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:33 INFO - 'SHELL': '/bin/bash', 08:08:33 INFO - 'SHLVL': '1', 08:08:33 INFO - 'TERM': 'linux', 08:08:33 INFO - 'TMOUT': '86400', 08:08:33 INFO - 'USER': 'cltbld', 08:08:33 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717', 08:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:33 INFO - '_': '/tools/buildbot/bin/python'} 08:08:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:33 INFO - Downloading/unpacking blobuploader==1.2.4 08:08:33 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 08:08:33 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 08:08:33 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 08:08:33 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 08:08:33 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 08:08:33 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 08:08:35 INFO - Downloading blobuploader-1.2.4.tar.gz 08:08:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:08:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:08:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:08:35 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 08:08:35 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 08:08:35 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 08:08:35 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 08:08:35 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 08:08:35 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 08:08:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:08:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:08:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:08:35 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 08:08:35 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 08:08:35 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 08:08:35 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 08:08:35 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 08:08:35 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 08:08:35 INFO - Downloading docopt-0.6.1.tar.gz 08:08:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:08:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:08:35 INFO - Installing collected packages: blobuploader, requests, docopt 08:08:35 INFO - Running setup.py install for blobuploader 08:08:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:08:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:08:35 INFO - Running setup.py install for requests 08:08:36 INFO - Running setup.py install for docopt 08:08:36 INFO - Successfully installed blobuploader requests docopt 08:08:36 INFO - Cleaning up... 08:08:36 INFO - Return code: 0 08:08:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:36 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 0x7fb06fef7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d448c0>, '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 0x1cf1420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf18b0>, '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': '801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717', '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 08:08:36 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 08:08:36 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 08:08:36 INFO - Using env: {'DISPLAY': ':0', 08:08:36 INFO - 'HOME': '/home/cltbld', 08:08:36 INFO - 'LANG': 'en_US.UTF-8', 08:08:36 INFO - 'LANGUAGE': 'en_US:en', 08:08:36 INFO - 'LOGNAME': 'cltbld', 08:08:36 INFO - 'MAIL': '/var/mail/cltbld', 08:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:36 INFO - 'MOZ_NO_REMOTE': '1', 08:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:36 INFO - 'NO_EM_RESTART': '1', 08:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:36 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:36 INFO - 'SHELL': '/bin/bash', 08:08:36 INFO - 'SHLVL': '1', 08:08:36 INFO - 'TERM': 'linux', 08:08:36 INFO - 'TMOUT': '86400', 08:08:36 INFO - 'USER': 'cltbld', 08:08:36 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717', 08:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:36 INFO - '_': '/tools/buildbot/bin/python'} 08:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:36 INFO - Running setup.py (path:/tmp/pip-FeLprM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:36 INFO - Running setup.py (path:/tmp/pip-oQFmXp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:36 INFO - Running setup.py (path:/tmp/pip-ldrJKz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:36 INFO - Running setup.py (path:/tmp/pip-5DTQnq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:36 INFO - Running setup.py (path:/tmp/pip-DL1yFz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:37 INFO - Running setup.py (path:/tmp/pip-Azz4bO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:37 INFO - Running setup.py (path:/tmp/pip-xvX6pE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:37 INFO - Running setup.py (path:/tmp/pip-WRHrnh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:37 INFO - Running setup.py (path:/tmp/pip-2KrV7i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:37 INFO - Running setup.py (path:/tmp/pip-1NpFUc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:37 INFO - Running setup.py (path:/tmp/pip-qTWWfb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:37 INFO - Running setup.py (path:/tmp/pip-mxO6Or-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:37 INFO - Running setup.py (path:/tmp/pip-xrAUOF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:37 INFO - Running setup.py (path:/tmp/pip-SWprKB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:37 INFO - Running setup.py (path:/tmp/pip-h4EIFy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:37 INFO - Running setup.py (path:/tmp/pip-UDzXJ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:37 INFO - Running setup.py (path:/tmp/pip-tmf4Ls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:08:37 INFO - Running setup.py install for manifestparser 08:08:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:08:37 INFO - Running setup.py install for mozcrash 08:08:38 INFO - Running setup.py install for mozdebug 08:08:38 INFO - Running setup.py install for mozdevice 08:08:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:08:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:08:38 INFO - Running setup.py install for mozfile 08:08:38 INFO - Running setup.py install for mozhttpd 08:08:38 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:08:38 INFO - Running setup.py install for mozinfo 08:08:38 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:08:38 INFO - Running setup.py install for mozInstall 08:08:38 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:08:38 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:08:38 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:08:38 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:08:38 INFO - Running setup.py install for mozleak 08:08:38 INFO - Running setup.py install for mozlog 08:08:38 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:08:38 INFO - Running setup.py install for moznetwork 08:08:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:08:38 INFO - Running setup.py install for mozprocess 08:08:39 INFO - Running setup.py install for mozprofile 08:08:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:08:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:08:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:08:39 INFO - Running setup.py install for mozrunner 08:08:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:08:39 INFO - Running setup.py install for mozscreenshot 08:08:39 INFO - Running setup.py install for moztest 08:08:39 INFO - Running setup.py install for mozversion 08:08:39 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:08:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:08:39 INFO - Cleaning up... 08:08:39 INFO - Return code: 0 08:08:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:39 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 0x7fb06fef7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d448c0>, '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 0x1cf1420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf18b0>, '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': '801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717', '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 08:08:39 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 08:08:39 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 08:08:39 INFO - Using env: {'DISPLAY': ':0', 08:08:39 INFO - 'HOME': '/home/cltbld', 08:08:39 INFO - 'LANG': 'en_US.UTF-8', 08:08:39 INFO - 'LANGUAGE': 'en_US:en', 08:08:39 INFO - 'LOGNAME': 'cltbld', 08:08:39 INFO - 'MAIL': '/var/mail/cltbld', 08:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:39 INFO - 'MOZ_NO_REMOTE': '1', 08:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:39 INFO - 'NO_EM_RESTART': '1', 08:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:39 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:39 INFO - 'SHELL': '/bin/bash', 08:08:39 INFO - 'SHLVL': '1', 08:08:39 INFO - 'TERM': 'linux', 08:08:39 INFO - 'TMOUT': '86400', 08:08:39 INFO - 'USER': 'cltbld', 08:08:39 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717', 08:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:39 INFO - '_': '/tools/buildbot/bin/python'} 08:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:39 INFO - Running setup.py (path:/tmp/pip-H4B3gZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:39 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)) 08:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:39 INFO - Running setup.py (path:/tmp/pip-dyYLl6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:40 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)) 08:08:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:40 INFO - Running setup.py (path:/tmp/pip-J5jEIr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:40 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)) 08:08:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:40 INFO - Running setup.py (path:/tmp/pip-GIAnGg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:40 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)) 08:08:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:40 INFO - Running setup.py (path:/tmp/pip-bkV3xb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:40 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)) 08:08:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:40 INFO - Running setup.py (path:/tmp/pip-9UzYxW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:40 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)) 08:08:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:40 INFO - Running setup.py (path:/tmp/pip-Q40bFR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:40 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)) 08:08:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:40 INFO - Running setup.py (path:/tmp/pip-0gYPuZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:40 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)) 08:08:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:40 INFO - Running setup.py (path:/tmp/pip-DbXYG_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:40 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)) 08:08:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:40 INFO - Running setup.py (path:/tmp/pip-t1lA0M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:40 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)) 08:08:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:40 INFO - Running setup.py (path:/tmp/pip-FsMlfw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:40 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)) 08:08:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:40 INFO - Running setup.py (path:/tmp/pip-Gd3P_t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:40 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)) 08:08:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:40 INFO - Running setup.py (path:/tmp/pip-kjZwvo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:40 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)) 08:08:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:40 INFO - Running setup.py (path:/tmp/pip-Oh3O0s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:40 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)) 08:08:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:40 INFO - Running setup.py (path:/tmp/pip-gnSoH9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:40 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)) 08:08:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:40 INFO - Running setup.py (path:/tmp/pip-IZbu_x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:41 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)) 08:08:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:41 INFO - Running setup.py (path:/tmp/pip-2o3Ubd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:41 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)) 08:08:41 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)) 08:08:41 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)) 08:08:41 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)) 08:08:41 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)) 08:08:41 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)) 08:08:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:08:41 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 08:08:41 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 08:08:41 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 08:08:41 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 08:08:41 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 08:08:41 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 08:08:42 INFO - Downloading blessings-1.5.1.tar.gz 08:08:42 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 08:08:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:08:42 INFO - Installing collected packages: blessings 08:08:42 INFO - Running setup.py install for blessings 08:08:42 INFO - Successfully installed blessings 08:08:42 INFO - Cleaning up... 08:08:43 INFO - Return code: 0 08:08:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:08:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:08:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:08:43 INFO - Reading from file tmpfile_stdout 08:08:43 INFO - Current package versions: 08:08:43 INFO - argparse == 1.2.1 08:08:43 INFO - blessings == 1.5.1 08:08:43 INFO - blobuploader == 1.2.4 08:08:43 INFO - docopt == 0.6.1 08:08:43 INFO - manifestparser == 1.1 08:08:43 INFO - mozInstall == 1.12 08:08:43 INFO - mozcrash == 0.16 08:08:43 INFO - mozdebug == 0.1 08:08:43 INFO - mozdevice == 0.47 08:08:43 INFO - mozfile == 1.2 08:08:43 INFO - mozhttpd == 0.7 08:08:43 INFO - mozinfo == 0.9 08:08:43 INFO - mozleak == 0.1 08:08:43 INFO - mozlog == 3.0 08:08:43 INFO - moznetwork == 0.27 08:08:43 INFO - mozprocess == 0.22 08:08:43 INFO - mozprofile == 0.27 08:08:43 INFO - mozrunner == 6.11 08:08:43 INFO - mozscreenshot == 0.1 08:08:43 INFO - mozsystemmonitor == 0.0 08:08:43 INFO - moztest == 0.7 08:08:43 INFO - mozversion == 1.4 08:08:43 INFO - psutil == 3.1.1 08:08:43 INFO - requests == 1.2.3 08:08:43 INFO - wsgiref == 0.1.2 08:08:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:43 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 0x7fb06fef7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d448c0>, '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 0x1cf1420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf18b0>, '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': '801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717', '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 08:08:43 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 08:08:43 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 08:08:43 INFO - Using env: {'DISPLAY': ':0', 08:08:43 INFO - 'HOME': '/home/cltbld', 08:08:43 INFO - 'LANG': 'en_US.UTF-8', 08:08:43 INFO - 'LANGUAGE': 'en_US:en', 08:08:43 INFO - 'LOGNAME': 'cltbld', 08:08:43 INFO - 'MAIL': '/var/mail/cltbld', 08:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:43 INFO - 'MOZ_NO_REMOTE': '1', 08:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:43 INFO - 'NO_EM_RESTART': '1', 08:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:43 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:43 INFO - 'SHELL': '/bin/bash', 08:08:43 INFO - 'SHLVL': '1', 08:08:43 INFO - 'TERM': 'linux', 08:08:43 INFO - 'TMOUT': '86400', 08:08:43 INFO - 'USER': 'cltbld', 08:08:43 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717', 08:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:43 INFO - '_': '/tools/buildbot/bin/python'} 08:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:43 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)) 08:08:43 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)) 08:08:43 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)) 08:08:43 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)) 08:08:43 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)) 08:08:43 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)) 08:08:43 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)) 08:08:43 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)) 08:08:43 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)) 08:08:43 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)) 08:08:43 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)) 08:08:43 INFO - Cleaning up... 08:08:43 INFO - Return code: 0 08:08:43 INFO - Running post-action listener: _resource_record_post_action 08:08:43 INFO - Running post-action listener: _start_resource_monitoring 08:08:43 INFO - Starting resource monitoring. 08:08:43 INFO - ##### 08:08:43 INFO - ##### Running install step. 08:08:43 INFO - ##### 08:08:43 INFO - Running pre-action listener: _resource_record_pre_action 08:08:43 INFO - Running main action method: install 08:08:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:08:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:08:43 INFO - Reading from file tmpfile_stdout 08:08:43 INFO - Detecting whether we're running mozinstall >=1.0... 08:08:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:08:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:08:43 INFO - Reading from file tmpfile_stdout 08:08:43 INFO - Output received: 08:08:43 INFO - Usage: mozinstall [options] installer 08:08:43 INFO - Options: 08:08:43 INFO - -h, --help show this help message and exit 08:08:43 INFO - -d DEST, --destination=DEST 08:08:43 INFO - Directory to install application into. [default: 08:08:43 INFO - "/builds/slave/test-pgo"] 08:08:43 INFO - --app=APP Application being installed. [default: firefox] 08:08:43 INFO - mkdir: /builds/slave/test-pgo/build/application 08:08:43 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'] 08:08:43 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 08:08:58 INFO - Reading from file tmpfile_stdout 08:08:58 INFO - Output received: 08:08:58 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:08:58 INFO - Running post-action listener: _resource_record_post_action 08:08:58 INFO - ##### 08:08:58 INFO - ##### Running run-tests step. 08:08:58 INFO - ##### 08:08:58 INFO - Running pre-action listener: _resource_record_pre_action 08:08:58 INFO - Running main action method: run_tests 08:08:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:08:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:08:58 INFO - Python 2.7.3 08:08:58 INFO - Return code: 0 08:08:58 INFO - grabbing minidump binary from tooltool 08:08: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')]} 08:08:58 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 0x1d448c0>, '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 0x1cf1420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf18b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:08:58 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 08:08:58 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 08:08:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:58 INFO - Return code: 0 08:08:58 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:08:58 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:08:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:08:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:08:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:08:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 08:08:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost 08:08:58 INFO - Using env: {'DISPLAY': ':0', 08:08:58 INFO - 'HOME': '/home/cltbld', 08:08:58 INFO - 'LANG': 'en_US.UTF-8', 08:08:58 INFO - 'LANGUAGE': 'en_US:en', 08:08:58 INFO - 'LOGNAME': 'cltbld', 08:08:58 INFO - 'MAIL': '/var/mail/cltbld', 08:08:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:08:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:58 INFO - 'MOZ_NO_REMOTE': '1', 08:08:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:58 INFO - 'NO_EM_RESTART': '1', 08:08:58 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:58 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:58 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:08:58 INFO - 'SHELL': '/bin/bash', 08:08:58 INFO - 'SHLVL': '1', 08:08:58 INFO - 'TERM': 'linux', 08:08:58 INFO - 'TMOUT': '86400', 08:08:58 INFO - 'USER': 'cltbld', 08:08:58 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717', 08:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:58 INFO - '_': '/tools/buildbot/bin/python'} 08:08:58 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost'] with output_timeout 3600 08:08:58 INFO - mozversion INFO | application_buildid: 20151118030232 08:08:58 INFO - mozversion INFO | application_changeset: eb3016abd37db2e6a6d923265047e84b12c0af61 08:08:58 INFO - mozversion INFO | application_display_name: Nightly 08:08:58 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:58 INFO - mozversion INFO | application_name: Firefox 08:08:58 INFO - mozversion INFO | application_remotingname: firefox 08:08:58 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 08:08:58 INFO - mozversion INFO | application_vendor: Mozilla 08:08:58 INFO - mozversion INFO | application_version: 45.0a1 08:08:58 INFO - mozversion INFO | platform_buildid: 20151118030232 08:08:58 INFO - mozversion INFO | platform_changeset: eb3016abd37db2e6a6d923265047e84b12c0af61 08:08:58 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 08:08:58 INFO - mozversion INFO | platform_version: 45.0a1 08:08:58 INFO - 2015-11-18 08:08:58,409 DEBUG : using testdate: 1447862938 08:08:58 INFO - 2015-11-18 08:08:58,409 DEBUG : actual date: 1447862938 08:08:58 INFO - 2015-11-18 08:08:58,420 INFO : starting webserver on 'localhost:40493' 08:08:58 INFO - 2015-11-18 08:08:58,421 INFO : Starting test suite talos-linux64-ix-006 08:08:58 INFO - 2015-11-18 08:08:58,421 INFO : Starting test dromaeo_css 08:08:58 INFO - 2015-11-18 08:08:58,421 DEBUG : operating with platform_type : linux_ 08:08:58 INFO - 2015-11-18 08:08:58,422 INFO : Initialising browser for dromaeo_css test... 08:08:58 INFO - 2015-11-18 08:08:58,438 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2qvbd9/profile http://localhost:40493/getInfo.html 08:09:02 INFO - 2015-11-18 08:09:02,075 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:09:02 INFO - 2015-11-18 08:09:02,075 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:09:02 INFO - 2015-11-18 08:09:02,076 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:09:02 INFO - 2015-11-18 08:09:02,076 DEBUG : BROWSER_OUTPUT: __metrics 08:09:02 INFO - 2015-11-18 08:09:02,152 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:09:03 INFO - 2015-11-18 08:09:03,445 INFO : Browser initialized. 08:09:03 INFO - 2015-11-18 08:09:03,446 INFO : Running cycle 1/1 for dromaeo_css test... 08:09:03 INFO - 2015-11-18 08:09:03,446 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2qvbd9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:09:15 INFO - 2015-11-18 08:09:15,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 141733888 08:09:15 INFO - 2015-11-18 08:09:15,207 DEBUG : BROWSER_OUTPUT: 08:10:06 INFO - 2015-11-18 08:10:06,854 DEBUG : BROWSER_OUTPUT: 1447863006854 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] 08:12:15 INFO - 2015-11-18 08:12:15,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40493/tests/dromaeo/cssquery-ext.html) 08:12:16 INFO - 2015-11-18 08:12:16,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 229642240 08:12:16 INFO - 2015-11-18 08:12:16,417 DEBUG : BROWSER_OUTPUT: 08:15:18 INFO - 2015-11-18 08:15:18,670 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/dromaeo/cssquery-ext.html (next: http://localhost:40493/tests/dromaeo/cssquery-jquery.html) 08:15:19 INFO - 2015-11-18 08:15:19,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 221757440 08:15:19 INFO - 2015-11-18 08:15:19,239 DEBUG : BROWSER_OUTPUT: 08:18:21 INFO - 2015-11-18 08:18:21,289 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40493/tests/dromaeo/cssquery-mootools.html) 08:18:21 INFO - 2015-11-18 08:18:21,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 212021248 08:18:21 INFO - 2015-11-18 08:18:21,863 DEBUG : BROWSER_OUTPUT: 08:21:23 INFO - 2015-11-18 08:21:23,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40493/tests/dromaeo/cssquery-prototype.html) 08:21:24 INFO - 2015-11-18 08:21:24,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 197730304 08:21:24 INFO - 2015-11-18 08:21:24,310 DEBUG : BROWSER_OUTPUT: 08:24:26 INFO - 2015-11-18 08:24:26,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40493/tests/dromaeo/cssquery-yui.html) 08:24:27 INFO - 2015-11-18 08:24:27,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 205017088 08:24:27 INFO - 2015-11-18 08:24:27,366 DEBUG : BROWSER_OUTPUT: 08:27:29 INFO - 2015-11-18 08:27:29,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/dromaeo/cssquery-yui.html (next: http://localhost:40493/tests/dromaeo/cssquery-dojo.html) 08:27:30 INFO - 2015-11-18 08:27:30,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 250056704 08:27:30 INFO - 2015-11-18 08:27:30,123 DEBUG : BROWSER_OUTPUT: 08:27:30 INFO - 2015-11-18 08:27:30,123 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:27:30 INFO - 2015-11-18 08:27:30,123 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:27:30 INFO - 2015-11-18 08:27:30,123 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:27:30 INFO - 2015-11-18 08:27:30,124 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:27:30 INFO - 2015-11-18 08:27:30,125 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3179.316446963903;3203.4233837909196;3237.2392487765387;3241.0924941016524;3259.690329418706;5242.239875218091;5274.709890955995;5291.391489978653;5335.306410166682;5377.542908852753;5390.245365648812;5425.538829199523;5454.181872719094;5480.862978425542;5495.725213739317;4991.725455099968;4996.300517927493;5004.249362595612;5020.347354843865;5053.722045287508;5069.594432445396;5115.155999260118;5127.33344665193;5139.357580302462;5142.640015198937;4813.446453657839;4932.383452068491;4941.110600091982;5043.293938848564;5112.233165025239;4857.34425852509;4895.216765317532;4921.557059864629;5019.247112933052;5044.2937988681615;4975.1293523633585;5007.123753343187;5011.774470148852;5031.094403007457;5054.090263752523;5121.308623335839;5229.869253268661;5289.814856480043;5332.3867755207875;5340.62615616907;5820.708964551798;5866.178734977107;5911.201987731644;5947.851303717398;5949.375315591844;5845.444682755132;5851.941480585182;5856.76572937082;5861.296644402656;5906.970465147647;5426;5446.8910621787345;5448.42791506894;5453.83638490842;5468.699221542814;5819.592628515963;5826.096954971986;5953.196318496947;5955.166276721176;5970.0746384310505;5886.264216972879;5888.322842873039;5891.086881533283;5892.587518873637;5901.262342207224;5808.970955145197;5927.525797936155;5976.581639285295;5983.730732117066;5994.07091900756;5718.656880587095;5778.595498315078;5781.306243250753;5795.710214489259;5832.533397328203;5841.2990441146485;5843.1235314703135;5849.5612829037145;5851.239338886003;5855.882882342329;4432.49026361966;4493.056458143761;4513.300438432048;4533.591976722111;4539.863804085882;4061.9796901015898;4096.078382364004;4097.85657501992;4113.074558224435;4114.897127571835;5343.6526625769975;5364.30264065669;5387.838364849061;5407.378151512627;5427.538659214011;5791.420857914175;5793;5793.768249270066;5794.304683438015;5819.098039803837;5447.428020057916;5483.561315094783;5487.835364939058;5489.368722596872;5497.257870187554;4985.376827896513;4991.001799640087;4997.125503036954;5061.316722242524;5079.949200508022;6025.548083893726;6066.908996365058;6077.453029227391;6083.513318934474;6088.756449741961;5896.321922978912;5918.437748413894;5951.047832346804;5956.13636022783;5958.344582096052;5996.700164991646;6004.099385092271;6007.729652165575;6022.36765139654;6069.33237343883;5825.533957283492;5831.329397119385;5848.824535263949;5849.268841394825;5856.267966504187;5769.59612827098;5961.195238642901;5963.165156878127;5964.493018093337;5972.372900845348;5698.430156984268;5846.532277417881;5871.7651293949475;5920.496757775637;5926.1999630049395;5843;5844.240248767633;5847.181394604674;5851;5856.765729370948;5490.176473529003;5602.635828671123;5737.311522617312;5737.512311453406;5739.598228123991;5634.690092044977;5715.199872018004;5753.884922301447;5757.309122905278;5764.193012978102;5573.972130139324;5664.971675141598;5706.8573285666525;5718.285214348207;5719.2279042328755 08:27:30 INFO - 2015-11-18 08:27:30,126 DEBUG : BROWSER_OUTPUT: |1;ext.html;570.9058005429105;594.1236675903046;613.6747523812378;614.7356636646243;668.9966550167252;31555.21111972202;31676;32129;32270.19324516888;40618.7969060155;42753.35869961953;43546.56453435465;43555.78222108893;43596;43629;8659.95670021649;8732.17044380786;8796.560171991407;8797.29621630268;8800.73597792064;7810.1408845027;7933.16701746317;8608.870866937;8707.390482666216;10050.346727462727;10081.647142350019;10167.847482287772;10186.083252507273;10190.286679932371;10198.388096714183;9981;10071.949640251752;10088.848667269996;10089.697309080739;10092.848607270897;7780.260875216845;7890.250426209501;7896.881546776803;7902.24928631779;10283.177345812317;41161.588384116076;41692.791536042125;41728.58271417277;41890.37164442536;41927.58072419298;3382.30662714143;3578.248567800765;3775.1505911170043;3850;3965.3457179565626;30422.69577304243;30963.845180774177;31051.534226986612;31078.689213107806;31222.53166202509;3472.618012018676;3516.665916737931;3527;3585.37255980205;3632.473291372736;288559;289808;290010.54994725104;290446;290766;61663;61805.69097154486;62108.06837897435;62177.68911155506;62274.37725622686;65509;65572;65615;65656;65793.7888695583;15018.924905375621;15207.619809504851;15233;15263.847361526465;15270.541883743506;12220.938895305644;12239.877601224052;12244.571439999558;12258.938705306417;12270.38648067593;20407.4898127548;20583.8970805145;20647.8967605161;20724;20878;7781.92218077812;7810.218978102258;7838.608069596497;7890.7632771015815;7934.484258523177;962.2061799015839;1003.6386900715737;1035.406307200473;1039.0025575447503;1066.2749330455365;28888.422231555673;29029.7097029027;29044.709552904624;29093.563596546068;29538.409231815243;1000.5497526113278;1017.3844823881593;1081.2269227502375;1160.3328086350382;1216.2459275249403;14105.647358815906;15582.45461408868;15790.289436975363;15921.681566368608;16204.351825926831;331922;338127;338252;338255;338541;55450.44549554533;55762;55789;55831.72084139553;55852;1345.9259740714158;1347.5418357758408;1349.5209200733796;1379.8413182484144;1385.2865774126333;24826.23631860632;26606.60090098611;28642.283942901595;29360.26599335034;29723.85138074296;50525.242121367475;51481.48518514767;51504.48495514997;51507;51528.22707659463;273905;277365;277704;278203;278321;28659.713402865706;28925.276868077624;32069;32704.67295327016;32735.508967365033;40434.79782601068;40492.1901561973;40512;40986.590134098275;41546;34115.65884341125;34368.48447273243;34369.65630343665;36159.45760813537;37322;36091.45862812112;36109.27781444304;36269.54921803098;37198.44202336913;37200.44199336958;35779.82110089537;36399.45400818937;36708.44937325889;36715.44926826046;36755.08112297214;30723.539146913263;32143.196420089684;33551;33562.66437335693;33631.4955275676;22492.876641361516;22854.657180141978;22859.657105143102;23079.538409232056;23130.768692313533 08:27:30 INFO - 2015-11-18 08:27:30,127 DEBUG : BROWSER_OUTPUT: |2;jquery.html;340.28709852858253;353.8637624514561;357.31752353005766;357.7102546936981;357.83897246239184;13461.999999999976;13783.93108034461;16536.58658533537;17019.57451063724;18119.275228990842;16686.66626667466;16827.915860420682;16910.66178676429;17534.82465175348;17541.82458175418;5310.548603368718;5440.129579267318;5445.047116754572;5445.782168713266;5447.373552041527;4055.229506393776;4171.1866186093575;5392.56859451245;5821.796237131702;6009.33897271302;5905.704714764266;5929.970350148244;5931.555133364994;5944.554158438113;5968.97015514924;5774.8267551973295;5874.765009399619;5894.204282421904;5899.32157801854;5901.498372638288;5174;5180.430152683201;5182.481751824787;5199.298094757197;5203.765830537635;12992.545260915822;13137.540186093536;13324.734795084762;13334.19994800315;13399.933000335033;1942.7474428324228;1991.8008199179967;2005.9498512537157;2015.8084981926693;2113.9788602113936;9578.808423831484;9801.068898454636;9900.801983960353;9923.90076099237;10052.14556762676;1663.6672665466956;1713.6230029393514;1734.5576877896183;1750.4048623468082;1751.6846967545837;61125;62603;63291.36708632947;63308.68345658288;64032;6966.512344135862;7024.051753013277;7025.192102908129;7032.437405007587;7033.261507541634;8405;8410.074891761902;8412.158784121539;8417.957910210409;8424.410291279552;5676.432356764373;5691.886162276731;5720.8283751487525;5765.250517432707;5768.682722450306;5974.4324289192455;5998.730057147439;6017.518598512196;6024.518038556905;6025.66858822769;3253.8047717137047;3284.901452956415;3285.91785205367;3310.784798988058;3311.93376132476;1131.1516362727955;1143.7255058785997;1157.242006485753;1168.2406435816617;1200.8085244428953;332.43856088835463;492.4976523945627;493.9654224204343;501.32571691075447;512.8897287083221;11667.774883637265;11944.283342999273;12253.69365765863;12330.568430104904;12454.377281135907;502.54017573920186;505.2396143803552;516.40097486915;518.1036806325079;520.731823111098;6603.933960660428;6703.664816759143;6716.294789047178;6780.93219067803;6785.898211526831;571206;590510;604332;609951;618232;76084.61957690176;78220.21779782244;78523.60738196272;79489;79830;508.5778803593009;519.5194445138231;519.9142141546678;523.3013926408288;523.8166641675383;11207.887921120684;11326.546938122383;11496.655100347003;11527.250728702607;11560.190786644855;35757.28485430329;35770.28459430849;36206.63793362138;36721;36765.99999999893;47982.520174797806;49756;50316;50421.495785043146;50454.495455046446;6563.507736919654;6600.834979125369;6894.345037221456;6912.55068420551;6914.827129321807;12235.449404776984;12304.692382690504;12329.383530823603;12387.938060310002;12400.13199076056;9199.540022998957;9603.711888643353;9764.170045546209;10754.40850753216;11076.723081923017;10492.580296788348;10615;10654;10737.570497180337;10764.461776910966;10810.945945270538;10812.729681758019;11040.392778397265;11043.392613406018;11187.72030699239;6224.688765561613;6335.176427064452;6684.966575167093;6877.65611719402;6879.346462086094;10479.94760026195;10506.159507239556;11040;11060.889391105986;11080.944595277295 08:27:30 INFO - 2015-11-18 08:27:30,131 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1308.6270412932315;1458.56972193203;1463.3195564062712;1598.073117591796;1754.8947063176217;6716.529842910998;7309.34215920567;7447.404207663394;7455.217202193773;7477.289657482531;7353.1911489736085;7499.962500187491;7501;7509.324160825525;7516.586587737672;2000.6998950157447;2030.4517780199337;2246.1913711064003;2306.2850516339904;2325.3140323604575;2291.232437133562;2295.598270302699;2299.7125359330084;2301.056566807609;2302;2230.9107635694554;2297.3452566018686;2301.148575027234;2302.5164715409783;2303.8617682938993;2010.4571765623273;2048.58004109158;2243.0354947372703;2295.024614538814;2296.5636529059425;2282.6233671444193;2302.6315789473606;2323.8954247058923;2326.3137374474572;2327.650852372141;7532.17146113927;7580.810479738051;7591.354734847545;7598.240175982412;7610.657520411595;4517.480489743656;4538.115067561826;4546.659000574937;4589.196890544142;4613.423322084739;2996.3857409231273;3028.9545656814944;3030.8787648494035;3037.893673721409;3167.0657156138764;1063.1919740996898;1087.9673609791719;1095.1054675411503;1096.2874131814306;1124.3085502416036;10278.897211027868;10285.79428411435;10293.794124117476;10321.071103600712;10330.12193963514;4362.8036738346855;4373.497047839475;4464.486584042812;4504.2793153095345;4510.503844577094;8459.450135741157;8558.61486233121;8567.700130495403;8571.485710857369;8574;4614.630829533629;4647.6281897448125;4656.115338085753;4661.254199328091;4663.067386522709;4250.171216612731;4262.232798096373;4266.0827921996915;4298.032942587893;4306.935395969063;3450.6894379505966;3462.6364231755806;3477.5826900772067;3480.547528821288;3513.350030244413;1050.3802756373775;1069.315637991686;1074.8065348237235;1076.6500887211687;1083.978320433587;896.9596368163449;990.9851352229722;1003.2826529031777;1008.2035192198082;1172.407933993328;6854.760083397057;7109.502334836615;7122.821929451805;7163.534370265916;7166.820829479305;711.4557363616838;713.7038129176334;715.2382712411265;719.9388052015637;834.0866750907746;5482.616216864861;5582.469665381782;5586.608937374426;5588.552915766729;5591.804286849941;8637.179467950535;8939.329550283755;8947.32895032875;9130.680426185052;9195.356325057182;9067.319951003701;9080.500572468578;9117.042710515432;9117.726468205965;9119.908800912039;7001.089858318386;7053.92946070543;7072.328128827753;7132.179799323144;7176.641167941582;6693.598384096969;6697.564658297195;6705.430038446591;6714.865702686016;6720.428763555153;7840.72557460509;7990.280874721303;8034.558099304594;8128.512289262663;8141.959290203511;7938.126806051445;7960.601969901366;8028.197180281925;8034.276915077671;8331.458455200393;6709.664516774044;6738.49461290415;6782.559133656297;6841;6863.450923926173;7432.665530051268;7467.066616672916;7478.214787447239;7485.214052524407;7490.737824176128;6690.89036959299;6841.076454678754;6881.483888708467;6922.8615427692175;6985.476089293425;6815.216250131299;6860.794176174722;6879.58722476653;6946.617936013366;6988.196357418758;6139.662318572521;6293.968530157503;6433.453156481752;6601.834954126185;6638.402543771083;6384.425401713868;6412.166418365583;6414.326495718069;6423.96788016057;6426.678666066771;6201.906971395523;6407.10300557913;6407.10300557913;6420.935790642221;6451.322611125952 08:27:30 INFO - 2015-11-18 08:27:30,131 DEBUG : BROWSER_OUTPUT: |4;prototype.html;330.63795144316964;331.19684764446214;335.5537135609639;340.4144870822185;346.6377635371038;6059.424354686304;6084.178635884155;6086.847828804277;6106.938930610692;6126.877462450749;5975.372585878486;5977.073553599199;5977.282726072877;5995.220621319233;5995.430434108764;4613.492515823274;4628.143793398215;4632.74519901407;4634.1195172917205;4640.466346370168;4390.67069969752;4577.267637178053;4581.5647513486165;4584.564466375706;4657.254839225725;4518.028623845872;4518.502964673883;4528.569785870337;4528.864134075983;4533.0480599074235;4420.138073075752;4516.14193303273;4527.230370836965;4541.250693635546;4547.909041819178;3950.743201691881;3951.7826519541413;3955.3473676843287;4039.111395492987;4053.351463765783;5688.744006519716;5694.402087780806;5704.515116215085;5713.942860571424;5720.141978703186;5071.594272458195;5351.143816989302;5351.224072509464;5359.464053594648;5365.678059316415;6193.256809182882;6206.813795586139;6376.968115159394;6384.648844313561;6386.744530218785;4376.496702879178;4386.583274588909;4388.232059389594;4389.626881715026;4390.934135987963;6411.711472983727;6460.612363258267;6468.191476065492;6471.158749362553;6474.287828338879;4429.402030725811;4433.135538570013;4564.452265728134;4568.657350698711;4583.083383323348;4615.723056616614;4622.653301002439;4629.102068152041;4629.930551041737;4633;5346.064438723208;5350.8127215547265;5351.224072509464;5353.4646535346155;5353.7590808413715;6313.842153946188;6434.581752186093;6437.967810160919;6447.9355206447335;6448.161738973997;1611.4521062838692;1613.435297645838;1614.144503413193;1615.2489092572011;1615.3780794394243;1080.330195278932;1091.2743025887696;1101.614434947778;1112.0214211493994;1115.7154925493946;6167.982282923357;6172.22847144107;6173.382661733791;6179.69101544921;6183.227096612924;6609;6620.933790662032;6630.171228596426;6630.83422914431;6632.8673426531195;6010.759569617254;6144.293406258248;6165.753369865155;6167.722452489649;6171.166892469549;3544.556930383702;3570.1967057411875;3602.6397360263763;3604.675579197885;3606.855725770992;6851.040854280404;6851.760188393482;6854.246032936373;6860.279670634612;6861.931380686229;6647.335266473314;6763.966180169067;6772.762953296611;6783.864322713617;6786.76246331376;6606.174228221473;6717;6723.327667233335;6826.385625293748;6876;6637.103990961158;6641.867162656817;6668.43318317929;6672.633005184762;6684.331566843277;6522.836929076621;6531.281559028408;6536.346365363425;6538.117354157318;6542.771003014872;6663.766768163091;6829.6243706596615;6831.146106736658;6844.897326540006;6908.723651053901;4539.546045395434;4576.633869290382;4578.267477203764;4582.289745089516;4585.9312110317705;6656.966715166393;6664.83337916556;6667.799966001027;6669.46644268467;6680.599164049978;6251.374862513712;6415.807525774234;6425.5823371482575;6432.839179020562;6456.903146452901;6479.773207937699;6499.610023398611;6503.414692677682;6506.186726659168;6510.576812507172;6352.110704501466;6360.141380913517;6362.172917520693;6369.90445143314;6371.7132729028235;6379.106925030406;6527.706253218522;6530.8367290818105;6537.542372033912;6547.901781473377;6349.587276826992;6359.109724638462;6361.01404282337;6361.904571431525;6365.490760739222 08:27:30 INFO - 2015-11-18 08:27:30,131 DEBUG : BROWSER_OUTPUT: |5;yui.html;766.7163149634636;778.4618907067378;827.4910929778187;839.5298632765656;852.1010334097529;14079;14456.132632042072;14559.708805823877;14566.344514496846;14590.41638334468;13554.254516001616;13555.11891727037;13587;13594.388252528635;13597.660058498543;669.7923643670454;674.43684523423;805.5408417202198;810.048193372789;820.233082068265;816.9795755106111;822.9012518497789;832.3341326938425;833.4957350802767;836.1429534726923;864.2222000199807;876.4390789894472;877.0352612126674;878.1789027259533;879.3448880583974;715.706560310273;723.7720118162762;851.5188918261163;859.6389516403126;868.68727258187;628.1896353703717;631.5957787016313;631.7599312261357;632.1308201223318;634.0204384226381;14095.78856317156;14269.357878895475;14272.785908211385;14304.642383940381;14318.713625727427;11507.309561426342;12258.75482490354;12328.753424931541;12554.623361299176;12927.353632318347;10478.161747060218;10553.577856885715;10699.78600427995;10921.781564368748;10980.780384392347;3702.4631428442726;3742.7941463219513;3780.6219378061974;3854.807259637007;3855.1325951660933;49993.750031249976;50349.74825125851;50451.495485045045;50542;50686.746566266935;10500.579976800842;10567.841482377771;10831.187660925461;11064.889351106547;11199.888001119885;19504.707429388287;19505.122269497908;19531.902340488206;19537.316193933144;19563.315283964992;7696.4227682924;7911.248431399008;7968.840623187504;8155.266026057683;8233.135520770233;4222.7888605570215;4233.153369326147;4311.827526898889;4365;4398.406215160976;3168.7940283881476;3183.840807959593;3198.984005080006;3200.199950012497;3205.166656669283;490.6786055133893;512.3211744438634;515.9613029022838;516.6641682906065;517.3868965276159;557.5873853348493;600.2646757721843;633.8352028472631;649.5940037476577;724.9855002899913;8782;8805.779855503664;8954.686585969459;9006.459612423276;9115.498647574446;554.2174657959443;635.7234602947733;638.1544453599;642.9935700643027;656.6847913001691;4089.6523795477124;4104.589541045932;4208.537060923296;4233.640140588023;4245.97877010613;58861.41138588645;60071.39928600746;60751.69624151939;60973.69513152406;61017.694911525155;51586;52453.73773131186;52654.21018684723;52659;52799.73600131975;46658.76670616625;46799;46938.5306146941;47855;48227.007083972625;8530.872036919327;8645.438046526955;8714.782130446789;8754.638681616834;8976.371653984159;33249.335013300086;33295.83352083224;33851.4922276171;34210.48684269788;34378.312433751686;44252.11495770131;45209.77395113135;45514.77242613766;45534.54465455435;45743.313850292936;8318.126596707258;8415.621297041771;8506.29874025185;8557.61490732906;8559.144085591392;12635.1787133836;12883.677908052;12952.935235323763;12989.480420783062;12997.15518491295;11314.547418103184;11394.202405831513;11727.706807329885;11821.468033938321;12139.635810925687;11255.7748845021;12019.158658893793;12154.088443366605;12321;12414.813777793159;11753.118516111155;11872.703182420508;11875.109366797353;12087.214331068453;12182.573609923611;9566.61733530651;9719.46542940145;9804.558794854105;9977.950110249401;10232.744181395525;8686.869696954676;9093.454392736458;9281;9333.439993600407;9656.613735450503 08:27:30 INFO - 2015-11-18 08:27:30,131 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:27:30 INFO - 2015-11-18 08:27:30,131 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:27:30 INFO - 2015-11-18 08:27:30,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,750 08:27:30 INFO - 2015-11-18 08:27:30,131 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:27:30 INFO - 2015-11-18 08:27:30,132 DEBUG : BROWSER_OUTPUT: __startTimestamp1447864050122__endTimestamp 08:27:30 INFO - 2015-11-18 08:27:30,132 DEBUG : BROWSER_OUTPUT: 08:27:30 INFO - 2015-11-18 08:27:30,132 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:27:30 INFO - 2015-11-18 08:27:30,132 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:27:30 INFO - 2015-11-18 08:27:30,132 DEBUG : BROWSER_OUTPUT: 08:27:30 INFO - 2015-11-18 08:27:30,132 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5446.25 Median:5715.20 stddev:609.83 (10.7%) stddev-sans-first:585.19 08:27:30 INFO - 2015-11-18 08:27:30,133 DEBUG : BROWSER_OUTPUT: Values: 3179.3 3203.4 3237.2 3241.1 3259.7 5242.2 5274.7 5291.4 5335.3 5377.5 5390.2 5425.5 5454.2 5480.9 5495.7 4991.7 4996.3 5004.2 5020.3 5053.7 5069.6 5115.2 5127.3 5139.4 5142.6 4813.4 4932.4 4941.1 5043.3 5112.2 4857.3 4895.2 4921.6 5019.2 5044.3 4975.1 5007.1 5011.8 5031.1 5054.1 5121.3 5229.9 5289.8 5332.4 5340.6 5820.7 5866.2 5911.2 5947.9 5949.4 5845.4 5851.9 5856.8 5861.3 5907.0 5426.0 5446.9 5448.4 5453.8 5468.7 5819.6 5826.1 5953.2 5955.2 5970.1 5886.3 5888.3 5891.1 5892.6 5901.3 5809.0 5927.5 5976.6 5983.7 5994.1 5718.7 5778.6 5781.3 5795.7 5832.5 5841.3 5843.1 5849.6 5851.2 5855.9 4432.5 4493.1 4513.3 4533.6 4539.9 4062.0 4096.1 4097.9 4113.1 4114.9 5343.7 5364.3 5387.8 5407.4 5427.5 5791.4 5793.0 5793.8 5794.3 5819.1 5447.4 5483.6 5487.8 5489.4 5497.3 4985.4 4991.0 4997.1 5061.3 5079.9 6025.5 6066.9 6077.5 6083.5 6088.8 5896.3 5918.4 5951.0 5956.1 5958.3 5996.7 6004.1 6007.7 6022.4 6069.3 5825.5 5831.3 5848.8 5849.3 5856.3 5769.6 5961.2 5963.2 5964.5 5972.4 5698.4 5846.5 5871.8 5920.5 5926.2 5843.0 5844.2 5847.2 5851.0 5856.8 5490.2 5602.6 5737.3 5737.5 5739.6 5634.7 5715.2 5753.9 5757.3 5764.2 5574.0 5665.0 5706.9 5718.3 5719.2 08:27:30 INFO - 2015-11-18 08:27:30,134 DEBUG : BROWSER_OUTPUT: 08:27:30 INFO - 2015-11-18 08:27:30,134 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47496.33 Median:170754.65 stddev:79130.34 (46.3%) stddev-sans-first:79273.88 08:27:30 INFO - 2015-11-18 08:27:30,134 DEBUG : BROWSER_OUTPUT: Values: 570.9 594.1 613.7 614.7 669.0 31555.2 31676.0 32129.0 32270.2 40618.8 42753.4 43546.6 43555.8 43596.0 43629.0 8660.0 8732.2 8796.6 8797.3 8800.7 7810.1 7933.2 8608.9 8707.4 10050.3 10081.6 10167.8 10186.1 10190.3 10198.4 9981.0 10071.9 10088.8 10089.7 10092.8 7780.3 7890.3 7896.9 7902.2 10283.2 41161.6 41692.8 41728.6 41890.4 41927.6 3382.3 3578.2 3775.2 3850.0 3965.3 30422.7 30963.8 31051.5 31078.7 31222.5 3472.6 3516.7 3527.0 3585.4 3632.5 288559.0 289808.0 290010.5 290446.0 290766.0 61663.0 61805.7 62108.1 62177.7 62274.4 65509.0 65572.0 65615.0 65656.0 65793.8 15018.9 15207.6 15233.0 15263.8 15270.5 12220.9 12239.9 12244.6 12258.9 12270.4 20407.5 20583.9 20647.9 20724.0 20878.0 7781.9 7810.2 7838.6 7890.8 7934.5 962.2 1003.6 1035.4 1039.0 1066.3 28888.4 29029.7 29044.7 29093.6 29538.4 1000.5 1017.4 1081.2 1160.3 1216.2 14105.6 15582.5 15790.3 15921.7 16204.4 331922.0 338127.0 338252.0 338255.0 338541.0 55450.4 55762.0 55789.0 55831.7 55852.0 1345.9 1347.5 1349.5 1379.8 1385.3 24826.2 26606.6 28642.3 29360.3 29723.9 50525.2 51481.5 51504.5 51507.0 51528.2 273905.0 277365.0 277704.0 278203.0 278321.0 28659.7 28925.3 32069.0 32704.7 32735.5 40434.8 40492.2 40512.0 40986.6 41546.0 34115.7 34368.5 34369.7 36159.5 37322.0 36091.5 36109.3 36269.5 37198.4 37200.4 35779.8 36399.5 36708.4 36715.4 36755.1 30723.5 32143.2 33551.0 33562.7 33631.5 22492.9 22854.7 22859.7 23079.5 23130.8 08:27:30 INFO - 2015-11-18 08:27:30,134 DEBUG : BROWSER_OUTPUT: 08:27:30 INFO - 2015-11-18 08:27:30,134 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29038.33 Median:506.91 stddev:98114.98 (19355.6%) stddev-sans-first:98366.55 08:27:30 INFO - 2015-11-18 08:27:30,135 DEBUG : BROWSER_OUTPUT: Values: 340.3 353.9 357.3 357.7 357.8 13462.0 13783.9 16536.6 17019.6 18119.3 16686.7 16827.9 16910.7 17534.8 17541.8 5310.5 5440.1 5445.0 5445.8 5447.4 4055.2 4171.2 5392.6 5821.8 6009.3 5905.7 5930.0 5931.6 5944.6 5969.0 5774.8 5874.8 5894.2 5899.3 5901.5 5174.0 5180.4 5182.5 5199.3 5203.8 12992.5 13137.5 13324.7 13334.2 13399.9 1942.7 1991.8 2005.9 2015.8 2114.0 9578.8 9801.1 9900.8 9923.9 10052.1 1663.7 1713.6 1734.6 1750.4 1751.7 61125.0 62603.0 63291.4 63308.7 64032.0 6966.5 7024.1 7025.2 7032.4 7033.3 8405.0 8410.1 8412.2 8418.0 8424.4 5676.4 5691.9 5720.8 5765.3 5768.7 5974.4 5998.7 6017.5 6024.5 6025.7 3253.8 3284.9 3285.9 3310.8 3311.9 1131.2 1143.7 1157.2 1168.2 1200.8 332.4 492.5 494.0 501.3 512.9 11667.8 11944.3 12253.7 12330.6 12454.4 502.5 505.2 516.4 518.1 520.7 6603.9 6703.7 6716.3 6780.9 6785.9 571206.0 590510.0 604332.0 609951.0 618232.0 76084.6 78220.2 78523.6 79489.0 79830.0 508.6 519.5 519.9 523.3 523.8 11207.9 11326.5 11496.7 11527.3 11560.2 35757.3 35770.3 36206.6 36721.0 36766.0 47982.5 49756.0 50316.0 50421.5 50454.5 6563.5 6600.8 6894.3 6912.6 6914.8 12235.4 12304.7 12329.4 12387.9 12400.1 9199.5 9603.7 9764.2 10754.4 11076.7 10492.6 10615.0 10654.0 10737.6 10764.5 10810.9 10812.7 11040.4 11043.4 11187.7 6224.7 6335.2 6685.0 6877.7 6879.3 10479.9 10506.2 11040.0 11060.9 11080.9 08:27:30 INFO - 2015-11-18 08:27:30,135 DEBUG : BROWSER_OUTPUT: 08:27:30 INFO - 2015-11-18 08:27:30,135 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5282.51 Median:6417.63 stddev:2712.33 (42.3%) stddev-sans-first:2703.49 08:27:30 INFO - 2015-11-18 08:27:30,136 DEBUG : BROWSER_OUTPUT: Values: 1308.6 1458.6 1463.3 1598.1 1754.9 6716.5 7309.3 7447.4 7455.2 7477.3 7353.2 7500.0 7501.0 7509.3 7516.6 2000.7 2030.5 2246.2 2306.3 2325.3 2291.2 2295.6 2299.7 2301.1 2302.0 2230.9 2297.3 2301.1 2302.5 2303.9 2010.5 2048.6 2243.0 2295.0 2296.6 2282.6 2302.6 2323.9 2326.3 2327.7 7532.2 7580.8 7591.4 7598.2 7610.7 4517.5 4538.1 4546.7 4589.2 4613.4 2996.4 3029.0 3030.9 3037.9 3167.1 1063.2 1088.0 1095.1 1096.3 1124.3 10278.9 10285.8 10293.8 10321.1 10330.1 4362.8 4373.5 4464.5 4504.3 4510.5 8459.5 8558.6 8567.7 8571.5 8574.0 4614.6 4647.6 4656.1 4661.3 4663.1 4250.2 4262.2 4266.1 4298.0 4306.9 3450.7 3462.6 3477.6 3480.5 3513.4 1050.4 1069.3 1074.8 1076.7 1084.0 897.0 991.0 1003.3 1008.2 1172.4 6854.8 7109.5 7122.8 7163.5 7166.8 711.5 713.7 715.2 719.9 834.1 5482.6 5582.5 5586.6 5588.6 5591.8 8637.2 8939.3 8947.3 9130.7 9195.4 9067.3 9080.5 9117.0 9117.7 9119.9 7001.1 7053.9 7072.3 7132.2 7176.6 6693.6 6697.6 6705.4 6714.9 6720.4 7840.7 7990.3 8034.6 8128.5 8142.0 7938.1 7960.6 8028.2 8034.3 8331.5 6709.7 6738.5 6782.6 6841.0 6863.5 7432.7 7467.1 7478.2 7485.2 7490.7 6690.9 6841.1 6881.5 6922.9 6985.5 6815.2 6860.8 6879.6 6946.6 6988.2 6139.7 6294.0 6433.5 6601.8 6638.4 6384.4 6412.2 6414.3 6424.0 6426.7 6201.9 6407.1 6407.1 6420.9 6451.3 08:27:30 INFO - 2015-11-18 08:27:30,136 DEBUG : BROWSER_OUTPUT: 08:27:30 INFO - 2015-11-18 08:27:30,136 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5351.61 Median:6135.59 stddev:1618.21 (26.4%) stddev-sans-first:1578.26 08:27:30 INFO - 2015-11-18 08:27:30,136 DEBUG : BROWSER_OUTPUT: Values: 330.6 331.2 335.6 340.4 346.6 6059.4 6084.2 6086.8 6106.9 6126.9 5975.4 5977.1 5977.3 5995.2 5995.4 4613.5 4628.1 4632.7 4634.1 4640.5 4390.7 4577.3 4581.6 4584.6 4657.3 4518.0 4518.5 4528.6 4528.9 4533.0 4420.1 4516.1 4527.2 4541.3 4547.9 3950.7 3951.8 3955.3 4039.1 4053.4 5688.7 5694.4 5704.5 5713.9 5720.1 5071.6 5351.1 5351.2 5359.5 5365.7 6193.3 6206.8 6377.0 6384.6 6386.7 4376.5 4386.6 4388.2 4389.6 4390.9 6411.7 6460.6 6468.2 6471.2 6474.3 4429.4 4433.1 4564.5 4568.7 4583.1 4615.7 4622.7 4629.1 4629.9 4633.0 5346.1 5350.8 5351.2 5353.5 5353.8 6313.8 6434.6 6438.0 6447.9 6448.2 1611.5 1613.4 1614.1 1615.2 1615.4 1080.3 1091.3 1101.6 1112.0 1115.7 6168.0 6172.2 6173.4 6179.7 6183.2 6609.0 6620.9 6630.2 6630.8 6632.9 6010.8 6144.3 6165.8 6167.7 6171.2 3544.6 3570.2 3602.6 3604.7 3606.9 6851.0 6851.8 6854.2 6860.3 6861.9 6647.3 6764.0 6772.8 6783.9 6786.8 6606.2 6717.0 6723.3 6826.4 6876.0 6637.1 6641.9 6668.4 6672.6 6684.3 6522.8 6531.3 6536.3 6538.1 6542.8 6663.8 6829.6 6831.1 6844.9 6908.7 4539.5 4576.6 4578.3 4582.3 4585.9 6657.0 6664.8 6667.8 6669.5 6680.6 6251.4 6415.8 6425.6 6432.8 6456.9 6479.8 6499.6 6503.4 6506.2 6510.6 6352.1 6360.1 6362.2 6369.9 6371.7 6379.1 6527.7 6530.8 6537.5 6547.9 6349.6 6359.1 6361.0 6361.9 6365.5 08:27:30 INFO - 2015-11-18 08:27:30,137 DEBUG : BROWSER_OUTPUT: 08:27:30 INFO - 2015-11-18 08:27:30,137 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14135.74 Median:24358.84 stddev:16423.93 (67.4%) stddev-sans-first:16439.32 08:27:30 INFO - 2015-11-18 08:27:30,137 DEBUG : BROWSER_OUTPUT: Values: 766.7 778.5 827.5 839.5 852.1 14079.0 14456.1 14559.7 14566.3 14590.4 13554.3 13555.1 13587.0 13594.4 13597.7 669.8 674.4 805.5 810.0 820.2 817.0 822.9 832.3 833.5 836.1 864.2 876.4 877.0 878.2 879.3 715.7 723.8 851.5 859.6 868.7 628.2 631.6 631.8 632.1 634.0 14095.8 14269.4 14272.8 14304.6 14318.7 11507.3 12258.8 12328.8 12554.6 12927.4 10478.2 10553.6 10699.8 10921.8 10980.8 3702.5 3742.8 3780.6 3854.8 3855.1 49993.8 50349.7 50451.5 50542.0 50686.7 10500.6 10567.8 10831.2 11064.9 11199.9 19504.7 19505.1 19531.9 19537.3 19563.3 7696.4 7911.2 7968.8 8155.3 8233.1 4222.8 4233.2 4311.8 4365.0 4398.4 3168.8 3183.8 3199.0 3200.2 3205.2 490.7 512.3 516.0 516.7 517.4 557.6 600.3 633.8 649.6 725.0 8782.0 8805.8 8954.7 9006.5 9115.5 554.2 635.7 638.2 643.0 656.7 4089.7 4104.6 4208.5 4233.6 4246.0 58861.4 60071.4 60751.7 60973.7 61017.7 51586.0 52453.7 52654.2 52659.0 52799.7 46658.8 46799.0 46938.5 47855.0 48227.0 8530.9 8645.4 8714.8 8754.6 8976.4 33249.3 33295.8 33851.5 34210.5 34378.3 44252.1 45209.8 45514.8 45534.5 45743.3 8318.1 8415.6 8506.3 8557.6 8559.1 12635.2 12883.7 12952.9 12989.5 12997.2 11314.5 11394.2 11727.7 11821.5 12139.6 11255.8 12019.2 12154.1 12321.0 12414.8 11753.1 11872.7 11875.1 12087.2 12182.6 9566.6 9719.5 9804.6 9978.0 10232.7 8686.9 9093.5 9281.0 9333.4 9656.6 08:27:30 INFO - 2015-11-18 08:27:30,137 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:27:30 INFO - 2015-11-18 08:27:30,137 DEBUG : BROWSER_OUTPUT: 08:27:30 INFO - 2015-11-18 08:27:30,858 INFO : Browser exited with error code: 0 08:27:30 INFO - 2015-11-18 08:27:30,879 INFO : Completed test dromaeo_css (00:18:32) 08:27:30 INFO - 2015-11-18 08:27:30,879 INFO : Starting test kraken 08:27:30 INFO - 2015-11-18 08:27:30,879 DEBUG : operating with platform_type : linux_ 08:27:30 INFO - 2015-11-18 08:27:30,879 INFO : Initialising browser for kraken test... 08:27:30 INFO - 2015-11-18 08:27:30,885 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmotAqM/profile http://localhost:40493/getInfo.html 08:27:34 INFO - 2015-11-18 08:27:34,537 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:27:34 INFO - 2015-11-18 08:27:34,537 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:27:34 INFO - 2015-11-18 08:27:34,537 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:27:34 INFO - 2015-11-18 08:27:34,537 DEBUG : BROWSER_OUTPUT: __metrics 08:27:34 INFO - 2015-11-18 08:27:34,678 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:27:35 INFO - 2015-11-18 08:27:35,855 INFO : Browser initialized. 08:27:35 INFO - 2015-11-18 08:27:35,856 INFO : Running cycle 1/1 for kraken test... 08:27:35 INFO - 2015-11-18 08:27:35,856 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmotAqM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:27:47 INFO - 2015-11-18 08:27:47,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 141545472 08:27:47 INFO - 2015-11-18 08:27:47,659 DEBUG : BROWSER_OUTPUT: 08:27:50 INFO - 2015-11-18 08:27:50,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40493/tests/kraken/driver.html?testName=audio-beat-detection) 08:27:50 INFO - 2015-11-18 08:27:50,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 180678656 08:27:50 INFO - 2015-11-18 08:27:50,734 DEBUG : BROWSER_OUTPUT: 08:27:53 INFO - 2015-11-18 08:27:53,322 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40493/tests/kraken/driver.html?testName=audio-dft) 08:27:53 INFO - 2015-11-18 08:27:53,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 170246144 08:27:53 INFO - 2015-11-18 08:27:53,897 DEBUG : BROWSER_OUTPUT: 08:27:56 INFO - 2015-11-18 08:27:56,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40493/tests/kraken/driver.html?testName=audio-fft) 08:27:57 INFO - 2015-11-18 08:27:57,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 151572480 08:27:57 INFO - 2015-11-18 08:27:57,395 DEBUG : BROWSER_OUTPUT: 08:27:59 INFO - 2015-11-18 08:27:59,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40493/tests/kraken/driver.html?testName=audio-oscillator) 08:27:59 INFO - 2015-11-18 08:27:59,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 152633344 08:27:59 INFO - 2015-11-18 08:27:59,959 DEBUG : BROWSER_OUTPUT: 08:28:02 INFO - 2015-11-18 08:28:02,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40493/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:28:02 INFO - 2015-11-18 08:28:02,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 156209152 08:28:02 INFO - 2015-11-18 08:28:02,685 DEBUG : BROWSER_OUTPUT: 08:28:05 INFO - 2015-11-18 08:28:05,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40493/tests/kraken/driver.html?testName=imaging-darkroom) 08:28:06 INFO - 2015-11-18 08:28:06,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 156258304 08:28:06 INFO - 2015-11-18 08:28:06,173 DEBUG : BROWSER_OUTPUT: 08:28:09 INFO - 2015-11-18 08:28:09,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40493/tests/kraken/driver.html?testName=imaging-desaturate) 08:28:10 INFO - 2015-11-18 08:28:10,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 156909568 08:28:10 INFO - 2015-11-18 08:28:10,159 DEBUG : BROWSER_OUTPUT: 08:28:12 INFO - 2015-11-18 08:28:12,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40493/tests/kraken/driver.html?testName=json-parse-financial) 08:28:13 INFO - 2015-11-18 08:28:13,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 157052928 08:28:13 INFO - 2015-11-18 08:28:13,538 DEBUG : BROWSER_OUTPUT: 08:28:15 INFO - 2015-11-18 08:28:15,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40493/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:28:15 INFO - 2015-11-18 08:28:15,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 166346752 08:28:15 INFO - 2015-11-18 08:28:15,671 DEBUG : BROWSER_OUTPUT: 08:28:17 INFO - 2015-11-18 08:28:17,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40493/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:28:18 INFO - 2015-11-18 08:28:18,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 164388864 08:28:18 INFO - 2015-11-18 08:28:18,078 DEBUG : BROWSER_OUTPUT: 08:28:20 INFO - 2015-11-18 08:28:20,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40493/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:28:20 INFO - 2015-11-18 08:28:20,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 175493120 08:28:20 INFO - 2015-11-18 08:28:20,703 DEBUG : BROWSER_OUTPUT: 08:28:23 INFO - 2015-11-18 08:28:23,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40493/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:28:23 INFO - 2015-11-18 08:28:23,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 183279616 08:28:23 INFO - 2015-11-18 08:28:23,690 DEBUG : BROWSER_OUTPUT: 08:28:26 INFO - 2015-11-18 08:28:26,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40493/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:28:26 INFO - 2015-11-18 08:28:26,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 181530624 08:28:26 INFO - 2015-11-18 08:28:26,826 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40493/tests/kraken/driver.html?testName=ai-astar) 08:28:28 INFO - 2015-11-18 08:28:28,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 240394240 08:28:28 INFO - 2015-11-18 08:28:28,698 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,698 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:28:28 INFO - 2015-11-18 08:28:28,700 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:28:28 INFO - 2015-11-18 08:28:28,700 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:28:28 INFO - 2015-11-18 08:28:28,700 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:28:28 INFO - 2015-11-18 08:28:28,700 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;105;111;109;110;98;108;109;109 08:28:28 INFO - 2015-11-18 08:28:28,700 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;123;151;161;124;162;157;123;165;124 08:28:28 INFO - 2015-11-18 08:28:28,701 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;159;160;162;159;163;160;167;161;161 08:28:28 INFO - 2015-11-18 08:28:28,701 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;73;97;71;72;74;101;89;71 08:28:28 INFO - 2015-11-18 08:28:28,701 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;132;90;90;89;133;90;90;130 08:28:28 INFO - 2015-11-18 08:28:28,701 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;109;109;109;109;110 08:28:28 INFO - 2015-11-18 08:28:28,701 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;146;145;145;145;145;145 08:28:28 INFO - 2015-11-18 08:28:28,701 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;96;95;96;95;95 08:28:28 INFO - 2015-11-18 08:28:28,701 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;65;60;57;56;56;59;65;54;55 08:28:28 INFO - 2015-11-18 08:28:28,702 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;68;68;69;69;71;69;68 08:28:28 INFO - 2015-11-18 08:28:28,702 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;85;84;90;84;93;83;86;84 08:28:28 INFO - 2015-11-18 08:28:28,702 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;122;121;119;117;119;123;120;115;122 08:28:28 INFO - 2015-11-18 08:28:28,702 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;151;142;146;149;139;160;151;146;138 08:28:28 INFO - 2015-11-18 08:28:28,702 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;66;67;65;66;64;64;70;64;65 08:28:28 INFO - 2015-11-18 08:28:28,702 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:28:28 INFO - 2015-11-18 08:28:28,702 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:28:28 INFO - 2015-11-18 08:28:28,702 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,961 08:28:28 INFO - 2015-11-18 08:28:28,702 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:28:28 INFO - 2015-11-18 08:28:28,702 DEBUG : BROWSER_OUTPUT: __startTimestamp1447864108698__endTimestamp 08:28:28 INFO - 2015-11-18 08:28:28,702 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,703 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:28:28 INFO - 2015-11-18 08:28:28,703 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:28:28 INFO - 2015-11-18 08:28:28,704 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,704 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.80 Median:109.50 stddev:3.79 (3.5%) stddev-sans-first:4.00 08:28:28 INFO - 2015-11-18 08:28:28,704 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 105.0 111.0 109.0 110.0 98.0 108.0 109.0 109.0 08:28:28 INFO - 2015-11-18 08:28:28,704 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,704 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.10 Median:154.00 stddev:18.27 (11.9%) stddev-sans-first:19.20 08:28:28 INFO - 2015-11-18 08:28:28,704 DEBUG : BROWSER_OUTPUT: Values: 151.0 123.0 151.0 161.0 124.0 162.0 157.0 123.0 165.0 124.0 08:28:28 INFO - 2015-11-18 08:28:28,704 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,704 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:2.37 (1.5%) stddev-sans-first:2.50 08:28:28 INFO - 2015-11-18 08:28:28,704 DEBUG : BROWSER_OUTPUT: Values: 162.0 159.0 160.0 162.0 159.0 163.0 160.0 167.0 161.0 161.0 08:28:28 INFO - 2015-11-18 08:28:28,705 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,705 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.20 Median:72.50 stddev:11.75 (16.2%) stddev-sans-first:12.18 08:28:28 INFO - 2015-11-18 08:28:28,705 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 97.0 71.0 72.0 74.0 101.0 89.0 71.0 08:28:28 INFO - 2015-11-18 08:28:28,705 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,705 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.40 Median:90.00 stddev:20.21 (22.5%) stddev-sans-first:20.93 08:28:28 INFO - 2015-11-18 08:28:28,705 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 132.0 90.0 90.0 89.0 133.0 90.0 90.0 130.0 08:28:28 INFO - 2015-11-18 08:28:28,705 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,705 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:28:28 INFO - 2015-11-18 08:28:28,705 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 08:28:28 INFO - 2015-11-18 08:28:28,705 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,705 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:28:28 INFO - 2015-11-18 08:28:28,706 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 08:28:28 INFO - 2015-11-18 08:28:28,707 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,707 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 08:28:28 INFO - 2015-11-18 08:28:28,707 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 08:28:28 INFO - 2015-11-18 08:28:28,707 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,707 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.50 stddev:3.87 (6.6%) stddev-sans-first:4.10 08:28:28 INFO - 2015-11-18 08:28:28,708 DEBUG : BROWSER_OUTPUT: Values: 58.0 65.0 60.0 57.0 56.0 56.0 59.0 65.0 54.0 55.0 08:28:28 INFO - 2015-11-18 08:28:28,708 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,708 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.97 08:28:28 INFO - 2015-11-18 08:28:28,708 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 68.0 68.0 69.0 69.0 71.0 69.0 68.0 08:28:28 INFO - 2015-11-18 08:28:28,708 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,708 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:3.27 (3.8%) stddev-sans-first:3.32 08:28:28 INFO - 2015-11-18 08:28:28,708 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 85.0 84.0 90.0 84.0 93.0 83.0 86.0 84.0 08:28:28 INFO - 2015-11-18 08:28:28,708 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,708 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:120.50 stddev:2.59 (2.2%) stddev-sans-first:2.59 08:28:28 INFO - 2015-11-18 08:28:28,708 DEBUG : BROWSER_OUTPUT: Values: 117.0 122.0 121.0 119.0 117.0 119.0 123.0 120.0 115.0 122.0 08:28:28 INFO - 2015-11-18 08:28:28,708 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,708 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:147.50 stddev:6.65 (4.5%) stddev-sans-first:6.86 08:28:28 INFO - 2015-11-18 08:28:28,708 DEBUG : BROWSER_OUTPUT: Values: 142.0 151.0 142.0 146.0 149.0 139.0 160.0 151.0 146.0 138.0 08:28:28 INFO - 2015-11-18 08:28:28,708 DEBUG : BROWSER_OUTPUT: 08:28:28 INFO - 2015-11-18 08:28:28,708 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:1.84 (2.8%) stddev-sans-first:1.94 08:28:28 INFO - 2015-11-18 08:28:28,709 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 67.0 65.0 66.0 64.0 64.0 70.0 64.0 65.0 08:28:28 INFO - 2015-11-18 08:28:28,709 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:28:28 INFO - 2015-11-18 08:28:28,709 DEBUG : BROWSER_OUTPUT: 08:28:29 INFO - 2015-11-18 08:28:29,558 INFO : Browser exited with error code: 0 08:28:29 INFO - 2015-11-18 08:28:29,606 INFO : Completed test kraken (00:00:58) 08:28:29 INFO - 2015-11-18 08:28:29,606 INFO : Starting test v8_7 08:28:29 INFO - 2015-11-18 08:28:29,606 DEBUG : operating with platform_type : linux_ 08:28:29 INFO - 2015-11-18 08:28:29,606 INFO : Initialising browser for v8_7 test... 08:28:29 INFO - 2015-11-18 08:28:29,612 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXQ7ri0/profile http://localhost:40493/getInfo.html 08:28:33 INFO - 2015-11-18 08:28:33,301 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:28:33 INFO - 2015-11-18 08:28:33,301 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:28:33 INFO - 2015-11-18 08:28:33,301 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:28:33 INFO - 2015-11-18 08:28:33,302 DEBUG : BROWSER_OUTPUT: __metrics 08:28:33 INFO - 2015-11-18 08:28:33,450 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:28:34 INFO - 2015-11-18 08:28:34,532 INFO : Browser initialized. 08:28:34 INFO - 2015-11-18 08:28:34,533 INFO : Running cycle 1/1 for v8_7 test... 08:28:34 INFO - 2015-11-18 08:28:34,533 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXQ7ri0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:28:46 INFO - 2015-11-18 08:28:46,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 141799424 08:28:46 INFO - 2015-11-18 08:28:46,352 DEBUG : BROWSER_OUTPUT: 08:29:07 INFO - 2015-11-18 08:29:07,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40493/tests/v8_7/run.html (next: http://localhost:40493/tests/v8_7/run.html) 08:29:08 INFO - 2015-11-18 08:29:08,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 611418112 08:29:08 INFO - 2015-11-18 08:29:08,005 DEBUG : BROWSER_OUTPUT: 08:29:08 INFO - 2015-11-18 08:29:08,005 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:29:08 INFO - 2015-11-18 08:29:08,005 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:29:08 INFO - 2015-11-18 08:29:08,005 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:29:08 INFO - 2015-11-18 08:29:08,005 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:29:08 INFO - 2015-11-18 08:29:08,005 DEBUG : BROWSER_OUTPUT: |0;Richards;163.71971185330713 08:29:08 INFO - 2015-11-18 08:29:08,005 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.46101760495262 08:29:08 INFO - 2015-11-18 08:29:08,005 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.7142857142857 08:29:08 INFO - 2015-11-18 08:29:08,005 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 08:29:08 INFO - 2015-11-18 08:29:08,006 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2016.1290322580646 08:29:08 INFO - 2015-11-18 08:29:08,006 DEBUG : BROWSER_OUTPUT: |5;Earley;783.0853563038371 08:29:08 INFO - 2015-11-18 08:29:08,006 DEBUG : BROWSER_OUTPUT: |6;Boyer;11964.285714285714 08:29:08 INFO - 2015-11-18 08:29:08,006 DEBUG : BROWSER_OUTPUT: |7;RegExp;25200 08:29:08 INFO - 2015-11-18 08:29:08,006 DEBUG : BROWSER_OUTPUT: |8;Splay;619.1950464396285 08:29:08 INFO - 2015-11-18 08:29:08,006 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 08:29:08 INFO - 2015-11-18 08:29:08,006 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:29:08 INFO - 2015-11-18 08:29:08,006 DEBUG : BROWSER_OUTPUT: __startTimestamp1447864147998__endTimestamp 08:29:08 INFO - 2015-11-18 08:29:08,006 DEBUG : BROWSER_OUTPUT: 08:29:08 INFO - 2015-11-18 08:29:08,006 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:29:08 INFO - 2015-11-18 08:29:08,006 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:29:08 INFO - 2015-11-18 08:29:08,006 DEBUG : BROWSER_OUTPUT: 08:29:08 INFO - 2015-11-18 08:29:08,006 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.72 Median:163.72 stddev:0.00 (0.0%) 08:29:08 INFO - 2015-11-18 08:29:08,007 DEBUG : BROWSER_OUTPUT: Values: 163.7 08:29:08 INFO - 2015-11-18 08:29:08,007 DEBUG : BROWSER_OUTPUT: 08:29:08 INFO - 2015-11-18 08:29:08,007 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.46 Median:193.46 stddev:0.00 (0.0%) 08:29:08 INFO - 2015-11-18 08:29:08,007 DEBUG : BROWSER_OUTPUT: Values: 193.5 08:29:08 INFO - 2015-11-18 08:29:08,007 DEBUG : BROWSER_OUTPUT: 08:29:08 INFO - 2015-11-18 08:29:08,007 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.71 Median:285.71 stddev:0.00 (0.0%) 08:29:08 INFO - 2015-11-18 08:29:08,007 DEBUG : BROWSER_OUTPUT: Values: 285.7 08:29:08 INFO - 2015-11-18 08:29:08,007 DEBUG : BROWSER_OUTPUT: 08:29:08 INFO - 2015-11-18 08:29:08,007 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 08:29:08 INFO - 2015-11-18 08:29:08,007 DEBUG : BROWSER_OUTPUT: Values: 5050.5 08:29:08 INFO - 2015-11-18 08:29:08,007 DEBUG : BROWSER_OUTPUT: 08:29:08 INFO - 2015-11-18 08:29:08,007 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2016.13 Median:2016.13 stddev:0.00 (0.0%) 08:29:08 INFO - 2015-11-18 08:29:08,007 DEBUG : BROWSER_OUTPUT: Values: 2016.1 08:29:08 INFO - 2015-11-18 08:29:08,007 DEBUG : BROWSER_OUTPUT: 08:29:08 INFO - 2015-11-18 08:29:08,007 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.09 Median:783.09 stddev:0.00 (0.0%) 08:29:08 INFO - 2015-11-18 08:29:08,007 DEBUG : BROWSER_OUTPUT: Values: 783.1 08:29:08 INFO - 2015-11-18 08:29:08,008 DEBUG : BROWSER_OUTPUT: 08:29:08 INFO - 2015-11-18 08:29:08,008 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11964.29 Median:11964.29 stddev:0.00 (0.0%) 08:29:08 INFO - 2015-11-18 08:29:08,008 DEBUG : BROWSER_OUTPUT: Values: 11964.3 08:29:08 INFO - 2015-11-18 08:29:08,008 DEBUG : BROWSER_OUTPUT: 08:29:08 INFO - 2015-11-18 08:29:08,008 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25200.00 Median:25200.00 stddev:0.00 (0.0%) 08:29:08 INFO - 2015-11-18 08:29:08,008 DEBUG : BROWSER_OUTPUT: Values: 25200.0 08:29:08 INFO - 2015-11-18 08:29:08,008 DEBUG : BROWSER_OUTPUT: 08:29:08 INFO - 2015-11-18 08:29:08,008 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:619.20 Median:619.20 stddev:0.00 (0.0%) 08:29:08 INFO - 2015-11-18 08:29:08,008 DEBUG : BROWSER_OUTPUT: Values: 619.2 08:29:08 INFO - 2015-11-18 08:29:08,008 DEBUG : BROWSER_OUTPUT: 08:29:08 INFO - 2015-11-18 08:29:08,008 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 08:29:08 INFO - 2015-11-18 08:29:08,008 DEBUG : BROWSER_OUTPUT: Values: 4826.9 08:29:08 INFO - 2015-11-18 08:29:08,008 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:29:08 INFO - 2015-11-18 08:29:08,008 DEBUG : BROWSER_OUTPUT: 08:29:08 INFO - 2015-11-18 08:29:08,774 INFO : Browser exited with error code: 0 08:29:08 INFO - 2015-11-18 08:29:08,792 INFO : Completed test v8_7 (00:00:39) 08:29:09 INFO - 2015-11-18 08:29:09,007 INFO : Completed test suite (00:20:10) 08:29:09 INFO - 2015-11-18 08:29:09,007 DEBUG : Working with test: dromaeo_css 08:29:09 INFO - 2015-11-18 08:29:09,008 DEBUG : Generating results file: dromaeo_css 08:29:09 INFO - 2015-11-18 08:29:09,009 DEBUG : Working with test: kraken 08:29:09 INFO - 2015-11-18 08:29:09,009 DEBUG : Generating results file: kraken 08:29:09 INFO - 2015-11-18 08:29:09,009 INFO : javascript benchmark 08:29:09 INFO - 2015-11-18 08:29:09,009 DEBUG : Working with test: v8_7 08:29:09 INFO - 2015-11-18 08:29:09,009 DEBUG : Generating results file: v8_7 08:29:09 INFO - 2015-11-18 08:29:09,010 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:09 INFO - 2015-11-18 08:29:09,061 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 08:29:09 INFO - 2015-11-18 08:29:09,061 DEBUG : process_Request line: dromaeo_css 6784.34 graph.html#tests=[[72,1,35]] 08:29:09 INFO - 2015-11-18 08:29:09,062 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:09 INFO - 2015-11-18 08:29:09,096 DEBUG : process_Request line: kraken 1489.00 graph.html#tests=[[232,1,35]] 08:29:09 INFO - 2015-11-18 08:29:09,096 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:09 INFO - 2015-11-18 08:29:09,135 DEBUG : process_Request line: v8_7 19862.30 graph.html#tests=[[230,1,35]] 08:29:09 INFO - 2015-11-18 08:29:09,136 INFO : javascript benchmark 08:29:09 INFO - 2015-11-18 08:29:09,140 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [340.28709852858253, 353.8637624514561, 357.31752353005766, 357.7102546936981, 357.83897246239184, 13461.999999999976, 13783.93108034461, 16536.58658533537, 17019.57451063724, 18119.275228990842, 16686.66626667466, 16827.915860420682, 16910.66178676429, 17534.82465175348, 17541.82458175418, 5310.548603368718, 5440.129579267318, 5445.047116754572, 5445.782168713266, 5447.373552041527, 4055.229506393776, 4171.1866186093575, 5392.56859451245, 5821.796237131702, 6009.33897271302, 5905.704714764266, 5929.970350148244, 5931.555133364994, 5944.554158438113, 5968.97015514924, 5774.8267551973295, 5874.765009399619, 5894.204282421904, 5899.32157801854, 5901.498372638288, 5174.0, 5180.430152683201, 5182.481751824787, 5199.298094757197, 5203.765830537635, 12992.545260915822, 13137.540186093536, 13324.734795084762, 13334.19994800315, 13399.933000335033, 1942.7474428324228, 1991.8008199179967, 2005.9498512537157, 2015.8084981926693, 2113.9788602113936, 9578.808423831484, 9801.068898454636, 9900.801983960353, 9923.90076099237, 10052.14556762676, 1663.6672665466956, 1713.6230029393514, 1734.5576877896183, 1750.4048623468082, 1751.6846967545837, 61125.0, 62603.0, 63291.36708632947, 63308.68345658288, 64032.0, 6966.512344135862, 7024.051753013277, 7025.192102908129, 7032.437405007587, 7033.261507541634, 8405.0, 8410.074891761902, 8412.158784121539, 8417.957910210409, 8424.410291279552, 5676.432356764373, 5691.886162276731, 5720.8283751487525, 5765.250517432707, 5768.682722450306, 5974.4324289192455, 5998.730057147439, 6017.518598512196, 6024.518038556905, 6025.66858822769, 3253.8047717137047, 3284.901452956415, 3285.91785205367, 3310.784798988058, 3311.93376132476, 1131.1516362727955, 1143.7255058785997, 1157.242006485753, 1168.2406435816617, 1200.8085244428953, 332.43856088835463, 492.4976523945627, 493.9654224204343, 501.32571691075447, 512.8897287083221, 11667.774883637265, 11944.283342999273, 12253.69365765863, 12330.568430104904, 12454.377281135907, 502.54017573920186, 505.2396143803552, 516.40097486915, 518.1036806325079, 520.731823111098, 6603.933960660428, 6703.664816759143, 6716.294789047178, 6780.93219067803, 6785.898211526831, 571206.0, 590510.0, 604332.0, 609951.0, 618232.0, 76084.61957690176, 78220.21779782244, 78523.60738196272, 79489.0, 79830.0, 508.5778803593009, 519.5194445138231, 519.9142141546678, 523.3013926408288, 523.8166641675383, 11207.887921120684, 11326.546938122383, 11496.655100347003, 11527.250728702607, 11560.190786644855, 35757.28485430329, 35770.28459430849, 36206.63793362138, 36721.0, 36765.99999999893, 47982.520174797806, 49756.0, 50316.0, 50421.495785043146, 50454.495455046446, 6563.507736919654, 6600.834979125369, 6894.345037221456, 6912.55068420551, 6914.827129321807, 12235.449404776984, 12304.692382690504, 12329.383530823603, 12387.938060310002, 12400.13199076056, 9199.540022998957, 9603.711888643353, 9764.170045546209, 10754.40850753216, 11076.723081923017, 10492.580296788348, 10615.0, 10654.0, 10737.570497180337, 10764.461776910966, 10810.945945270538, 10812.729681758019, 11040.392778397265, 11043.392613406018, 11187.72030699239, 6224.688765561613, 6335.176427064452, 6684.966575167093, 6877.65611719402, 6879.346462086094, 10479.94760026195, 10506.159507239556, 11040.0, 11060.889391105986, 11080.944595277295], "dojo.html": [3179.316446963903, 3203.4233837909196, 3237.2392487765387, 3241.0924941016524, 3259.690329418706, 5242.239875218091, 5274.709890955995, 5291.391489978653, 5335.306410166682, 5377.542908852753, 5390.245365648812, 5425.538829199523, 5454.181872719094, 5480.862978425542, 5495.725213739317, 4991.725455099968, 4996.300517927493, 5004.249362595612, 5020.347354843865, 5053.722045287508, 5069.594432445396, 5115.155999260118, 5127.33344665193, 5139.357580302462, 5142.640015198937, 4813.446453657839, 4932.383452068491, 4941.110600091982, 5043.293938848564, 5112.233165025239, 4857.34425852509, 4895.216765317532, 4921.557059864629, 5019.247112933052, 5044.2937988681615, 4975.1293523633585, 5007.123753343187, 5011.774470148852, 5031.094403007457, 5054.090263752523, 5121.308623335839, 5229.869253268661, 5289.814856480043, 5332.3867755207875, 5340.62615616907, 5820.708964551798, 5866.178734977107, 5911.201987731644, 5947.851303717398, 5949.375315591844, 5845.444682755132, 5851.941480585182, 5856.76572937082, 5861.296644402656, 5906.970465147647, 5426.0, 5446.8910621787345, 5448.42791506894, 5453.83638490842, 5468.699221542814, 5819.592628515963, 5826.096954971986, 5953.196318496947, 5955.166276721176, 5970.0746384310505, 5886.264216972879, 5888.322842873039, 5891.086881533283, 5892.587518873637, 5901.262342207224, 5808.970955145197, 5927.525797936155, 5976.581639285295, 5983.730732117066, 5994.07091900756, 5718.656880587095, 5778.595498315078, 5781.306243250753, 5795.710214489259, 5832.533397328203, 5841.2990441146485, 5843.1235314703135, 5849.5612829037145, 5851.239338886003, 5855.882882342329, 4432.49026361966, 4493.056458143761, 4513.300438432048, 4533.591976722111, 4539.863804085882, 4061.9796901015898, 4096.078382364004, 4097.85657501992, 4113.074558224435, 4114.897127571835, 5343.6526625769975, 5364.30264065669, 5387.838364849061, 5407.378151512627, 5427.538659214011, 5791.420857914175, 5793.0, 5793.768249270066, 5794.304683438015, 5819.098039803837, 5447.428020057916, 5483.561315094783, 5487.835364939058, 5489.368722596872, 5497.257870187554, 4985.376827896513, 4991.001799640087, 4997.125503036954, 5061.316722242524, 5079.949200508022, 6025.548083893726, 6066.908996365058, 6077.453029227391, 6083.513318934474, 6088.756449741961, 5896.321922978912, 5918.437748413894, 5951.047832346804, 5956.13636022783, 5958.344582096052, 5996.700164991646, 6004.099385092271, 6007.729652165575, 6022.36765139654, 6069.33237343883, 5825.533957283492, 5831.329397119385, 5848.824535263949, 5849.268841394825, 5856.267966504187, 5769.59612827098, 5961.195238642901, 5963.165156878127, 5964.493018093337, 5972.372900845348, 5698.430156984268, 5846.532277417881, 5871.7651293949475, 5920.496757775637, 5926.1999630049395, 5843.0, 5844.240248767633, 5847.181394604674, 5851.0, 5856.765729370948, 5490.176473529003, 5602.635828671123, 5737.311522617312, 5737.512311453406, 5739.598228123991, 5634.690092044977, 5715.199872018004, 5753.884922301447, 5757.309122905278, 5764.193012978102, 5573.972130139324, 5664.971675141598, 5706.8573285666525, 5718.285214348207, 5719.2279042328755], "mootools.html": [1308.6270412932315, 1458.56972193203, 1463.3195564062712, 1598.073117591796, 1754.8947063176217, 6716.529842910998, 7309.34215920567, 7447.404207663394, 7455.217202193773, 7477.289657482531, 7353.1911489736085, 7499.962500187491, 7501.0, 7509.324160825525, 7516.586587737672, 2000.6998950157447, 2030.4517780199337, 2246.1913711064003, 2306.2850516339904, 2325.3140323604575, 2291.232437133562, 2295.598270302699, 2299.7125359330084, 2301.056566807609, 2302.0, 2230.9107635694554, 2297.3452566018686, 2301.148575027234, 2302.5164715409783, 2303.8617682938993, 2010.4571765623273, 2048.58004109158, 2243.0354947372703, 2295.024614538814, 2296.5636529059425, 2282.6233671444193, 2302.6315789473606, 2323.8954247058923, 2326.3137374474572, 2327.650852372141, 7532.17146113927, 7580.810479738051, 7591.354734847545, 7598.240175982412, 7610.657520411595, 4517.480489743656, 4538.115067561826, 4546.659000574937, 4589.196890544142, 4613.423322084739, 2996.3857409231273, 3028.9545656814944, 3030.8787648494035, 3037.893673721409, 3167.0657156138764, 1063.1919740996898, 1087.9673609791719, 1095.1054675411503, 1096.2874131814306, 1124.3085502416036, 10278.897211027868, 10285.79428411435, 10293.794124117476, 10321.071103600712, 10330.12193963514, 4362.8036738346855, 4373.497047839475, 4464.486584042812, 4504.2793153095345, 4510.503844577094, 8459.450135741157, 8558.61486233121, 8567.700130495403, 8571.485710857369, 8574.0, 4614.630829533629, 4647.6281897448125, 4656.115338085753, 4661.254199328091, 4663.067386522709, 4250.171216612731, 4262.232798096373, 4266.0827921996915, 4298.032942587893, 4306.935395969063, 3450.6894379505966, 3462.6364231755806, 3477.5826900772067, 3480.547528821288, 3513.350030244413, 1050.3802756373775, 1069.315637991686, 1074.8065348237235, 1076.6500887211687, 1083.978320433587, 896.9596368163449, 990.9851352229722, 1003.2826529031777, 1008.2035192198082, 1172.407933993328, 6854.760083397057, 7109.502334836615, 7122.821929451805, 7163.534370265916, 7166.820829479305, 711.4557363616838, 713.7038129176334, 715.2382712411265, 719.9388052015637, 834.0866750907746, 5482.616216864861, 5582.469665381782, 5586.608937374426, 5588.552915766729, 5591.804286849941, 8637.179467950535, 8939.329550283755, 8947.32895032875, 9130.680426185052, 9195.356325057182, 9067.319951003701, 9080.500572468578, 9117.042710515432, 9117.726468205965, 9119.908800912039, 7001.089858318386, 7053.92946070543, 7072.328128827753, 7132.179799323144, 7176.641167941582, 6693.598384096969, 6697.564658297195, 6705.430038446591, 6714.865702686016, 6720.428763555153, 7840.72557460509, 7990.280874721303, 8034.558099304594, 8128.512289262663, 8141.959290203511, 7938.126806051445, 7960.601969901366, 8028.197180281925, 8034.276915077671, 8331.458455200393, 6709.664516774044, 6738.49461290415, 6782.559133656297, 6841.0, 6863.450923926173, 7432.665530051268, 7467.066616672916, 7478.214787447239, 7485.214052524407, 7490.737824176128, 6690.89036959299, 6841.076454678754, 6881.483888708467, 6922.8615427692175, 6985.476089293425, 6815.216250131299, 6860.794176174722, 6879.58722476653, 6946.617936013366, 6988.196357418758, 6139.662318572521, 6293.968530157503, 6433.453156481752, 6601.834954126185, 6638.402543771083, 6384.425401713868, 6412.166418365583, 6414.326495718069, 6423.96788016057, 6426.678666066771, 6201.906971395523, 6407.10300557913, 6407.10300557913, 6420.935790642221, 6451.322611125952], "ext.html": [570.9058005429105, 594.1236675903046, 613.6747523812378, 614.7356636646243, 668.9966550167252, 31555.21111972202, 31676.0, 32129.0, 32270.19324516888, 40618.7969060155, 42753.35869961953, 43546.56453435465, 43555.78222108893, 43596.0, 43629.0, 8659.95670021649, 8732.17044380786, 8796.560171991407, 8797.29621630268, 8800.73597792064, 7810.1408845027, 7933.16701746317, 8608.870866937, 8707.390482666216, 10050.346727462727, 10081.647142350019, 10167.847482287772, 10186.083252507273, 10190.286679932371, 10198.388096714183, 9981.0, 10071.949640251752, 10088.848667269996, 10089.697309080739, 10092.848607270897, 7780.260875216845, 7890.250426209501, 7896.881546776803, 7902.24928631779, 10283.177345812317, 41161.588384116076, 41692.791536042125, 41728.58271417277, 41890.37164442536, 41927.58072419298, 3382.30662714143, 3578.248567800765, 3775.1505911170043, 3850.0, 3965.3457179565626, 30422.69577304243, 30963.845180774177, 31051.534226986612, 31078.689213107806, 31222.53166202509, 3472.618012018676, 3516.665916737931, 3527.0, 3585.37255980205, 3632.473291372736, 288559.0, 289808.0, 290010.54994725104, 290446.0, 290766.0, 61663.0, 61805.69097154486, 62108.06837897435, 62177.68911155506, 62274.37725622686, 65509.0, 65572.0, 65615.0, 65656.0, 65793.7888695583, 15018.924905375621, 15207.619809504851, 15233.0, 15263.847361526465, 15270.541883743506, 12220.938895305644, 12239.877601224052, 12244.571439999558, 12258.938705306417, 12270.38648067593, 20407.4898127548, 20583.8970805145, 20647.8967605161, 20724.0, 20878.0, 7781.92218077812, 7810.218978102258, 7838.608069596497, 7890.7632771015815, 7934.484258523177, 962.2061799015839, 1003.6386900715737, 1035.406307200473, 1039.0025575447503, 1066.2749330455365, 28888.422231555673, 29029.7097029027, 29044.709552904624, 29093.563596546068, 29538.409231815243, 1000.5497526113278, 1017.3844823881593, 1081.2269227502375, 1160.3328086350382, 1216.2459275249403, 14105.647358815906, 15582.45461408868, 15790.289436975363, 15921.681566368608, 16204.351825926831, 331922.0, 338127.0, 338252.0, 338255.0, 338541.0, 55450.44549554533, 55762.0, 55789.0, 55831.72084139553, 55852.0, 1345.9259740714158, 1347.5418357758408, 1349.5209200733796, 1379.8413182484144, 1385.2865774126333, 24826.23631860632, 26606.60090098611, 28642.283942901595, 29360.26599335034, 29723.85138074296, 50525.242121367475, 51481.48518514767, 51504.48495514997, 51507.0, 51528.22707659463, 273905.0, 277365.0, 277704.0, 278203.0, 278321.0, 28659.713402865706, 28925.276868077624, 32069.0, 32704.67295327016, 32735.508967365033, 40434.79782601068, 40492.1901561973, 40512.0, 40986.590134098275, 41546.0, 34115.65884341125, 34368.48447273243, 34369.65630343665, 36159.45760813537, 37322.0, 36091.45862812112, 36109.27781444304, 36269.54921803098, 37198.44202336913, 37200.44199336958, 35779.82110089537, 36399.45400818937, 36708.44937325889, 36715.44926826046, 36755.08112297214, 30723.539146913263, 32143.196420089684, 33551.0, 33562.66437335693, 33631.4955275676, 22492.876641361516, 22854.657180141978, 22859.657105143102, 23079.538409232056, 23130.768692313533], "prototype.html": [330.63795144316964, 331.19684764446214, 335.5537135609639, 340.4144870822185, 346.6377635371038, 6059.424354686304, 6084.178635884155, 6086.847828804277, 6106.938930610692, 6126.877462450749, 5975.372585878486, 5977.073553599199, 5977.282726072877, 5995.220621319233, 5995.430434108764, 4613.492515823274, 4628.143793398215, 4632.74519901407, 4634.1195172917205, 4640.466346370168, 4390.67069969752, 4577.267637178053, 4581.5647513486165, 4584.564466375706, 4657.254839225725, 4518.028623845872, 4518.502964673883, 4528.569785870337, 4528.864134075983, 4533.0480599074235, 4420.138073075752, 4516.14193303273, 4527.230370836965, 4541.250693635546, 4547.909041819178, 3950.743201691881, 3951.7826519541413, 3955.3473676843287, 4039.111395492987, 4053.351463765783, 5688.744006519716, 5694.402087780806, 5704.515116215085, 5713.942860571424, 5720.141978703186, 5071.594272458195, 5351.143816989302, 5351.224072509464, 5359.464053594648, 5365.678059316415, 6193.256809182882, 6206.813795586139, 6376.968115159394, 6384.648844313561, 6386.744530218785, 4376.496702879178, 4386.583274588909, 4388.232059389594, 4389.626881715026, 4390.934135987963, 6411.711472983727, 6460.612363258267, 6468.191476065492, 6471.158749362553, 6474.287828338879, 4429.402030725811, 4433.135538570013, 4564.452265728134, 4568.657350698711, 4583.083383323348, 4615.723056616614, 4622.653301002439, 4629.102068152041, 4629.930551041737, 4633.0, 5346.064438723208, 5350.8127215547265, 5351.224072509464, 5353.4646535346155, 5353.7590808413715, 6313.842153946188, 6434.581752186093, 6437.967810160919, 6447.9355206447335, 6448.161738973997, 1611.4521062838692, 1613.435297645838, 1614.144503413193, 1615.2489092572011, 1615.3780794394243, 1080.330195278932, 1091.2743025887696, 1101.614434947778, 1112.0214211493994, 1115.7154925493946, 6167.982282923357, 6172.22847144107, 6173.382661733791, 6179.69101544921, 6183.227096612924, 6609.0, 6620.933790662032, 6630.171228596426, 6630.83422914431, 6632.8673426531195, 6010.759569617254, 6144.293406258248, 6165.753369865155, 6167.722452489649, 6171.166892469549, 3544.556930383702, 3570.1967057411875, 3602.6397360263763, 3604.675579197885, 3606.855725770992, 6851.040854280404, 6851.760188393482, 6854.246032936373, 6860.279670634612, 6861.931380686229, 6647.335266473314, 6763.966180169067, 6772.762953296611, 6783.864322713617, 6786.76246331376, 6606.174228221473, 6717.0, 6723.327667233335, 6826.385625293748, 6876.0, 6637.103990961158, 6641.867162656817, 6668.43318317929, 6672.633005184762, 6684.331566843277, 6522.836929076621, 6531.281559028408, 6536.346365363425, 6538.117354157318, 6542.771003014872, 6663.766768163091, 6829.6243706596615, 6831.146106736658, 6844.897326540006, 6908.723651053901, 4539.546045395434, 4576.633869290382, 4578.267477203764, 4582.289745089516, 4585.9312110317705, 6656.966715166393, 6664.83337916556, 6667.799966001027, 6669.46644268467, 6680.599164049978, 6251.374862513712, 6415.807525774234, 6425.5823371482575, 6432.839179020562, 6456.903146452901, 6479.773207937699, 6499.610023398611, 6503.414692677682, 6506.186726659168, 6510.576812507172, 6352.110704501466, 6360.141380913517, 6362.172917520693, 6369.90445143314, 6371.7132729028235, 6379.106925030406, 6527.706253218522, 6530.8367290818105, 6537.542372033912, 6547.901781473377, 6349.587276826992, 6359.109724638462, 6361.01404282337, 6361.904571431525, 6365.490760739222], "yui.html": [766.7163149634636, 778.4618907067378, 827.4910929778187, 839.5298632765656, 852.1010334097529, 14079.0, 14456.132632042072, 14559.708805823877, 14566.344514496846, 14590.41638334468, 13554.254516001616, 13555.11891727037, 13587.0, 13594.388252528635, 13597.660058498543, 669.7923643670454, 674.43684523423, 805.5408417202198, 810.048193372789, 820.233082068265, 816.9795755106111, 822.9012518497789, 832.3341326938425, 833.4957350802767, 836.1429534726923, 864.2222000199807, 876.4390789894472, 877.0352612126674, 878.1789027259533, 879.3448880583974, 715.706560310273, 723.7720118162762, 851.5188918261163, 859.6389516403126, 868.68727258187, 628.1896353703717, 631.5957787016313, 631.7599312261357, 632.1308201223318, 634.0204384226381, 14095.78856317156, 14269.357878895475, 14272.785908211385, 14304.642383940381, 14318.713625727427, 11507.309561426342, 12258.75482490354, 12328.753424931541, 12554.623361299176, 12927.353632318347, 10478.161747060218, 10553.577856885715, 10699.78600427995, 10921.781564368748, 10980.780384392347, 3702.4631428442726, 3742.7941463219513, 3780.6219378061974, 3854.807259637007, 3855.1325951660933, 49993.750031249976, 50349.74825125851, 50451.495485045045, 50542.0, 50686.746566266935, 10500.579976800842, 10567.841482377771, 10831.187660925461, 11064.889351106547, 11199.888001119885, 19504.707429388287, 19505.122269497908, 19531.902340488206, 19537.316193933144, 19563.315283964992, 7696.4227682924, 7911.248431399008, 7968.840623187504, 8155.266026057683, 8233.135520770233, 4222.7888605570215, 4233.153369326147, 4311.827526898889, 4365.0, 4398.406215160976, 3168.7940283881476, 3183.840807959593, 3198.984005080006, 3200.199950012497, 3205.166656669283, 490.6786055133893, 512.3211744438634, 515.9613029022838, 516.6641682906065, 517.3868965276159, 557.5873853348493, 600.2646757721843, 633.8352028472631, 649.5940037476577, 724.9855002899913, 8782.0, 8805.779855503664, 8954.686585969459, 9006.459612423276, 9115.498647574446, 554.2174657959443, 635.7234602947733, 638.1544453599, 642.9935700643027, 656.6847913001691, 4089.6523795477124, 4104.589541045932, 4208.537060923296, 4233.640140588023, 4245.97877010613, 58861.41138588645, 60071.39928600746, 60751.69624151939, 60973.69513152406, 61017.694911525155, 51586.0, 52453.73773131186, 52654.21018684723, 52659.0, 52799.73600131975, 46658.76670616625, 46799.0, 46938.5306146941, 47855.0, 48227.007083972625, 8530.872036919327, 8645.438046526955, 8714.782130446789, 8754.638681616834, 8976.371653984159, 33249.335013300086, 33295.83352083224, 33851.4922276171, 34210.48684269788, 34378.312433751686, 44252.11495770131, 45209.77395113135, 45514.77242613766, 45534.54465455435, 45743.313850292936, 8318.126596707258, 8415.621297041771, 8506.29874025185, 8557.61490732906, 8559.144085591392, 12635.1787133836, 12883.677908052, 12952.935235323763, 12989.480420783062, 12997.15518491295, 11314.547418103184, 11394.202405831513, 11727.706807329885, 11821.468033938321, 12139.635810925687, 11255.7748845021, 12019.158658893793, 12154.088443366605, 12321.0, 12414.813777793159, 11753.118516111155, 11872.703182420508, 11875.109366797353, 12087.214331068453, 12182.573609923611, 9566.61733530651, 9719.46542940145, 9804.558794854105, 9977.950110249401, 10232.744181395525, 8686.869696954676, 9093.454392736458, 9281.0, 9333.439993600407, 9656.613735450503]}, "summary": {"lowerIsBetter": false, "suite": 6784.3375009066085, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7199.670846701912, "unit": "ms", "value": 7199.670846701912}, "dojo.html": {"lowerIsBetter": false, "filtered": 5406.174333563223, "unit": "ms", "value": 5406.174333563223}, "mootools.html": {"lowerIsBetter": false, "filtered": 4319.003226176588, "unit": "ms", "value": 4319.003226176588}, "ext.html": {"lowerIsBetter": false, "filtered": 18839.50571780008, "unit": "ms", "value": 18839.50571780008}, "prototype.html": {"lowerIsBetter": false, "filtered": 4825.570885195755, "unit": "ms", "value": 4825.570885195755}, "yui.html": {"lowerIsBetter": false, "filtered": 6379.72574598537, "unit": "ms", "value": 6379.72574598537}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-006"}, "testrun": {"date": 1447862938, "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": "20151118030232", "branch": "Firefox", "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 159.0, 160.0, 162.0, 159.0, 163.0, 160.0, 167.0, 161.0, 161.0], "ai-astar": [109.0, 110.0, 105.0, 111.0, 109.0, 110.0, 98.0, 108.0, 109.0, 109.0], "imaging-gaussian-blur": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0], "audio-beat-detection": [151.0, 123.0, 151.0, 161.0, 124.0, 162.0, 157.0, 123.0, 165.0, 124.0], "json-stringify-tinderbox": [69.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 71.0, 69.0, 68.0], "stanford-crypto-pbkdf2": [142.0, 151.0, 142.0, 146.0, 149.0, 139.0, 160.0, 151.0, 146.0, 138.0], "json-parse-financial": [58.0, 65.0, 60.0, 57.0, 56.0, 56.0, 59.0, 65.0, 54.0, 55.0], "stanford-crypto-sha256-iterative": [65.0, 66.0, 67.0, 65.0, 66.0, 64.0, 64.0, 70.0, 64.0, 65.0], "audio-fft": [72.0, 72.0, 73.0, 97.0, 71.0, 72.0, 74.0, 101.0, 89.0, 71.0], "imaging-darkroom": [145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "stanford-crypto-ccm": [117.0, 122.0, 121.0, 119.0, 117.0, 119.0, 123.0, 120.0, 115.0, 122.0], "audio-oscillator": [90.0, 90.0, 132.0, 90.0, 90.0, 89.0, 133.0, 90.0, 90.0, 130.0], "stanford-crypto-aes": [83.0, 85.0, 85.0, 84.0, 90.0, 84.0, 93.0, 83.0, 86.0, 84.0], "imaging-desaturate": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1489.0, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.2, "unit": "ms", "value": 79.2}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 146.4, "unit": "ms", "value": 146.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.1, "unit": "ms", "value": 144.1}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 119.5, "unit": "ms", "value": 119.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.1, "unit": "ms", "value": 145.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 58.5, "unit": "ms", "value": 58.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.4, "unit": "ms", "value": 102.4}, "ai-astar": {"lowerIsBetter": true, "filtered": 107.8, "unit": "ms", "value": 107.8}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.4, "unit": "ms", "value": 161.4}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 65.6, "unit": "ms", "value": 65.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.8, "unit": "ms", "value": 68.8}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.2, "unit": "ms", "value": 109.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.7, "unit": "ms", "value": 85.7}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.3, "unit": "ms", "value": 95.3}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-006"}, "testrun": {"date": 1447862938, "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": "20151118030232", "branch": "Firefox", "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.46101760495262], "Encrypt": [285.7142857142857], "NavierStokes": [4826.923076923077], "Decrypt": [5050.50505050505], "Splay": [619.1950464396285], "Richards": [163.71971185330713], "RegExp": [25200.0], "Earley": [783.0853563038371], "Boyer": [11964.285714285714], "RayTrace": [2016.1290322580646]}, "summary": {"lowerIsBetter": false, "suite": 19862.30055193769, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 341.7639419999998, "unit": "score", "value": 341.7639419999998}, "Encrypt": {"lowerIsBetter": false, "filtered": 931.6335000000004, "unit": "score", "value": 931.6335000000004}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.4422310756973, "unit": "score", "value": 307.4422310756973}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.70383799999996, "unit": "score", "value": 52.70383799999996}, "Splay": {"lowerIsBetter": false, "filtered": 131.60796499999995, "unit": "score", "value": 131.60796499999995}, "RegExp": {"lowerIsBetter": false, "filtered": 36.150198412698415, "unit": "score", "value": 36.150198412698415}, "Richards": {"lowerIsBetter": false, "filtered": 215.62461599999997, "unit": "score", "value": 215.62461599999997}, "Earley": {"lowerIsBetter": false, "filtered": 851.0732510000003, "unit": "score", "value": 851.0732510000003}, "Boyer": {"lowerIsBetter": false, "filtered": 55.704370149253705, "unit": "score", "value": 55.704370149253705}, "RayTrace": {"lowerIsBetter": false, "filtered": 367.03454399999987, "unit": "score", "value": 367.03454399999987}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-006"}, "testrun": {"date": 1447862938, "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": "20151118030232", "branch": "Firefox", "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61"}}] 08:29:09 INFO - RETURN: dromaeo_css: 6784.34 08:29:09 INFO - RETURN: kraken: 1489.00 08:29:09 INFO - RETURN: v8_7: 19862.30 08:29:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19862.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1489.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6784.34"}}} 08:29:09 INFO - Return code: 0 08:29:09 INFO - # TBPL SUCCESS # 08:29:09 INFO - Running post-action listener: _resource_record_post_action 08:29:09 INFO - Running post-run listener: _resource_record_post_run 08:29:10 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 20480; Write bytes: 496214016; Read time: 120; Write time: 364920 08:29:10 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 221290496; Read time: 0; Write time: 214012 08:29:10 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 20480; Write bytes: 274923520; Read time: 120; Write time: 150908 08:29:10 INFO - Running post-run listener: _upload_blobber_files 08:29:10 INFO - Blob upload gear active. 08:29:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:29:10 INFO - Copying logs to upload dir... 08:29:10 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.647854 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-18 08:29:10.198109) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 08:29:10.201165) ========= 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=801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/3O4cC8CaTUe-36pHW_03RQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010080 build_url: 'https://queue.taskcluster.net/v1/task/3O4cC8CaTUe-36pHW_03RQ/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-18 08:29:10.251382) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:29:10.251733) ========= 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=801756c90a5e5cfe63934219000001c7-1447860572.697533-1216727717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:29:10.301317) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 08:29:10.301611) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 08:29:10.301896) ========= ========= Total master_lag: 0.19 =========