builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1448011968.93 results: success (0) buildid: 20151119233015 builduid: 37107d1fb2074cd49e59431bb444ffd8 revision: 1b2e15608f34fef0f23369731c80138f55f00cf2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:48.928036) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:48.928509) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:48.928965) ========= 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=5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006714 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:48.952278) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:48.952686) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:48.990508) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:48.990805) ========= 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=5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018100 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:49.043384) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:49.043702) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:49.044109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:49.044403) ========= 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=5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 01:32:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2015-11-20 01:32:49 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108869 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:49.166188) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:49.166546) ========= 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=5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.094609 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:49.272753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:49.273127) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1b2e15608f34fef0f23369731c80138f55f00cf2 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1b2e15608f34fef0f23369731c80138f55f00cf2 --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=5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 01:32:49,583 truncating revision to first 12 chars 2015-11-20 01:32:49,583 Setting DEBUG logging. 2015-11-20 01:32:49,583 attempt 1/10 2015-11-20 01:32:49,584 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1b2e15608f34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 01:32:49,842 unpacking tar archive at: fx-team-1b2e15608f34/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545951 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:49.830846) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:49.831271) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:49.839753) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:49.840152) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 01:32:49.840611) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-20 01:32:49.840988) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:32:50 INFO - MultiFileLogger online at 20151120 01:32:50 in /builds/slave/test-pgo 01:32:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:32:50 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:32:50 INFO - {'append_to_log': False, 01:32:50 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:32:50 INFO - 'blob_upload_branch': 'Fx-Team', 01:32:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:32:50 INFO - 'branch': 'Fx-Team', 01:32:50 INFO - 'buildbot_json_path': 'buildprops.json', 01:32:50 INFO - 'config_files': ('talos/linux_config.py',), 01:32:50 INFO - 'default_actions': ('clobber', 01:32:50 INFO - 'read-buildbot-config', 01:32:50 INFO - 'download-and-extract', 01:32:50 INFO - 'populate-webroot', 01:32:50 INFO - 'create-virtualenv', 01:32:50 INFO - 'install', 01:32:50 INFO - 'run-tests'), 01:32:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:32:50 INFO - 'download_minidump_stackwalk': True, 01:32:50 INFO - 'download_symbols': 'ondemand', 01:32:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:32:50 INFO - 'tooltool.py': '/tools/tooltool.py', 01:32:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:32:50 INFO - '/tools/misc-python/virtualenv.py')}, 01:32:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:32:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:32:50 INFO - 'installer_path': 'installer.exe', 01:32:50 INFO - 'log_level': 'info', 01:32:50 INFO - 'log_name': 'talos', 01:32:50 INFO - 'log_to_console': True, 01:32:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:32:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:32:50 INFO - 'opt_config_files': (), 01:32:50 INFO - 'pip_index': False, 01:32:50 INFO - 'sps_profile': False, 01:32:50 INFO - 'sps_profile_interval': 0, 01:32:50 INFO - 'suite': 'dromaeojs-e10s', 01:32:50 INFO - 'system_bits': '64', 01:32:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:32:50 INFO - 'title': 'talos-linux64-ix-061', 01:32:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:32:50 INFO - 'use_talos_json': True, 01:32:50 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:32:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:32:50 INFO - 'work_dir': 'build'} 01:32:50 INFO - ##### 01:32:50 INFO - ##### Running clobber step. 01:32:50 INFO - ##### 01:32:50 INFO - Running pre-action listener: _resource_record_pre_action 01:32:50 INFO - Running main action method: clobber 01:32:50 INFO - rmtree: /builds/slave/test-pgo/build 01:32:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:32:51 INFO - Running post-action listener: _resource_record_post_action 01:32:51 INFO - ##### 01:32:51 INFO - ##### Running read-buildbot-config step. 01:32:51 INFO - ##### 01:32:51 INFO - Running pre-action listener: _resource_record_pre_action 01:32:51 INFO - Running main action method: read_buildbot_config 01:32:51 INFO - Using buildbot properties: 01:32:51 INFO - { 01:32:51 INFO - "properties": { 01:32:51 INFO - "buildnumber": 64, 01:32:51 INFO - "product": "firefox", 01:32:51 INFO - "script_repo_revision": "production", 01:32:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:32:51 INFO - "repository": "", 01:32:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 01:32:51 INFO - "buildid": "20151119233015", 01:32:51 INFO - "slavename": "talos-linux64-ix-061", 01:32:51 INFO - "pgo_build": "True", 01:32:51 INFO - "basedir": "/builds/slave/test-pgo", 01:32:51 INFO - "project": "", 01:32:51 INFO - "platform": "ubuntu64_hw", 01:32:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:32:51 INFO - "slavebuilddir": "test", 01:32:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:32:51 INFO - "branch": "fx-team", 01:32:51 INFO - "repo_path": "integration/fx-team", 01:32:51 INFO - "stage_platform": "linux64-pgo", 01:32:51 INFO - "builduid": "37107d1fb2074cd49e59431bb444ffd8", 01:32:51 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 01:32:51 INFO - }, 01:32:51 INFO - "sourcestamp": { 01:32:51 INFO - "repository": "", 01:32:51 INFO - "hasPatch": false, 01:32:51 INFO - "project": "", 01:32:51 INFO - "branch": "fx-team-linux64-pgo-talos", 01:32:51 INFO - "changes": [ 01:32:51 INFO - { 01:32:51 INFO - "category": null, 01:32:51 INFO - "files": [ 01:32:51 INFO - { 01:32:51 INFO - "url": null, 01:32:51 INFO - "name": "https://queue.taskcluster.net/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 01:32:51 INFO - } 01:32:51 INFO - ], 01:32:51 INFO - "repository": "", 01:32:51 INFO - "rev": "1b2e15608f34fef0f23369731c80138f55f00cf2", 01:32:51 INFO - "who": "sendchange", 01:32:51 INFO - "when": 1448011885, 01:32:51 INFO - "number": 6687652, 01:32:51 INFO - "comments": "", 01:32:51 INFO - "project": "", 01:32:51 INFO - "at": "Fri 20 Nov 2015 01:31:25", 01:32:51 INFO - "branch": "fx-team-linux64-pgo-talos", 01:32:51 INFO - "revlink": "", 01:32:51 INFO - "properties": [ 01:32:51 INFO - [ 01:32:51 INFO - "buildid", 01:32:51 INFO - "20151119233015", 01:32:51 INFO - "Change" 01:32:51 INFO - ], 01:32:51 INFO - [ 01:32:51 INFO - "builduid", 01:32:51 INFO - "37107d1fb2074cd49e59431bb444ffd8", 01:32:51 INFO - "Change" 01:32:51 INFO - ], 01:32:51 INFO - [ 01:32:51 INFO - "pgo_build", 01:32:51 INFO - "True", 01:32:51 INFO - "Change" 01:32:51 INFO - ] 01:32:51 INFO - ], 01:32:51 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 01:32:51 INFO - } 01:32:51 INFO - ], 01:32:51 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 01:32:51 INFO - } 01:32:51 INFO - } 01:32:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 01:32:51 INFO - Running post-action listener: _resource_record_post_action 01:32:51 INFO - ##### 01:32:51 INFO - ##### Running download-and-extract step. 01:32:51 INFO - ##### 01:32:51 INFO - Running pre-action listener: _resource_record_pre_action 01:32:51 INFO - Running main action method: download_and_extract 01:32:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:51 INFO - https://queue.taskcluster.net/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:32:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/test_packages.json 01:32:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/test_packages.json 01:32:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:32:58 INFO - Downloaded 1302 bytes. 01:32:58 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:32:58 INFO - Using the following test package requirements: 01:32:58 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:32:58 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:32:58 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:58 INFO - u'jsshell-linux-x86_64.zip'], 01:32:58 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:32:58 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:32:58 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:32:58 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:32:58 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:32:58 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:32:58 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:32:58 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:32: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')]} 01:32:58 INFO - https://queue.taskcluster.net/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:32:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:32:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:32:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:32:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:32:59 INFO - Downloaded 22525346 bytes. 01:32:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:32:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:32:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:33:01 INFO - Return code: 0 01:33:01 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:33: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')]} 01:33:01 INFO - https://queue.taskcluster.net/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:33:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:33:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:33:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:33:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:33:04 INFO - Downloaded 22525346 bytes. 01:33:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:33:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:33:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:33:05 INFO - Return code: 0 01:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:05 INFO - https://queue.taskcluster.net/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:33:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:33:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:33:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:33:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:33:11 INFO - Downloaded 11130997 bytes. 01:33:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 01:33:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:33:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 01:33:11 INFO - Return code: 0 01:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:11 INFO - https://queue.taskcluster.net/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:33:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:33:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:33:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:33:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:33:12 INFO - Downloaded 57347992 bytes. 01:33:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:33:12 INFO - mkdir: /builds/slave/test-pgo/properties 01:33:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:33:12 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:33:12 INFO - Contents: 01:33:12 INFO - build_url:https://queue.taskcluster.net/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:33:12 INFO - Running post-action listener: _resource_record_post_action 01:33:12 INFO - Running post-action listener: set_extra_try_arguments 01:33:12 INFO - ##### 01:33:12 INFO - ##### Running populate-webroot step. 01:33:12 INFO - ##### 01:33:12 INFO - Running pre-action listener: _resource_record_pre_action 01:33:12 INFO - Running main action method: populate_webroot 01:33:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:33:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:33:12 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:33:12 INFO - '../fennec_ids.txt'], 01:33:12 INFO - 'tests': ['tcheck2']}, 01:33:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:33:12 INFO - '--tppagecycles', 01:33:12 INFO - '7'], 01:33:12 INFO - 'tests': ['tsvgm']}}, 01:33:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:33:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:33:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:33:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:33:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:33:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:33:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:33:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:12 INFO - 'talos_options': ['--e10s'], 01:33:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:33:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:12 INFO - 'tests': ['damp', 'tps']}, 01:33:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:12 INFO - 'talos_options': ['--e10s'], 01:33:12 INFO - 'tests': ['damp', 'tps']}, 01:33:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:33:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:33:12 INFO - 'other': {'tests': ['a11yr', 01:33:12 INFO - 'ts_paint', 01:33:12 INFO - 'tpaint', 01:33:12 INFO - 'sessionrestore', 01:33:12 INFO - 'sessionrestore_no_auto_restore']}, 01:33:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:33:12 INFO - 'tests': ['a11yr', 01:33:12 INFO - 'ts_paint', 01:33:12 INFO - 'tpaint', 01:33:12 INFO - 'sessionrestore', 01:33:12 INFO - 'sessionrestore_no_auto_restore']}, 01:33:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:33:12 INFO - 'tests': ['a11yr', 01:33:12 INFO - 'ts_paint', 01:33:12 INFO - 'tpaint', 01:33:12 INFO - 'sessionrestore', 01:33:12 INFO - 'sessionrestore_no_auto_restore']}, 01:33:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:33:12 INFO - 'tests': ['a11yr', 01:33:12 INFO - 'ts_paint', 01:33:12 INFO - 'tpaint', 01:33:12 INFO - 'sessionrestore', 01:33:12 INFO - 'sessionrestore_no_auto_restore']}, 01:33:12 INFO - 'other_l64': {'tests': ['a11yr', 01:33:12 INFO - 'ts_paint', 01:33:12 INFO - 'tpaint', 01:33:12 INFO - 'sessionrestore', 01:33:12 INFO - 'sessionrestore_no_auto_restore']}, 01:33:12 INFO - 'other_nol64': {'tests': ['a11yr', 01:33:12 INFO - 'ts_paint', 01:33:12 INFO - 'tpaint', 01:33:12 INFO - 'sessionrestore', 01:33:12 INFO - 'sessionrestore_no_auto_restore']}, 01:33:12 INFO - 'svgr': {'tests': ['tsvgx', 01:33:12 INFO - 'tsvgr_opacity', 01:33:12 INFO - 'tart', 01:33:12 INFO - 'tscrollx', 01:33:12 INFO - 'cart']}, 01:33:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:33:12 INFO - 'tests': ['tsvgx', 01:33:12 INFO - 'tsvgr_opacity', 01:33:12 INFO - 'tart', 01:33:12 INFO - 'tscrollx', 01:33:12 INFO - 'cart']}, 01:33:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:12 INFO - 'tests': ['tp5o']}, 01:33:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:12 INFO - 'talos_options': ['--e10s'], 01:33:12 INFO - 'tests': ['tp5o']}, 01:33:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:12 INFO - 'talos_options': ['--xperf_path', 01:33:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:33:12 INFO - 'tests': ['tp5n']}, 01:33:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:12 INFO - 'talos_options': ['--e10s', 01:33:12 INFO - '--xperf_path', 01:33:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:33:12 INFO - 'tests': ['tp5n']}}, 01:33:12 INFO - 'talos.zip': {'path': '', 01:33:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:33:12 INFO - Running post-action listener: _resource_record_post_action 01:33:12 INFO - ##### 01:33:12 INFO - ##### Running create-virtualenv step. 01:33:12 INFO - ##### 01:33:12 INFO - Running pre-action listener: _resource_record_pre_action 01:33:12 INFO - Running main action method: create_virtualenv 01:33:12 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:33:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 01:33:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:33:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:33:12 INFO - Using real prefix '/usr' 01:33:12 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:33:13 INFO - Installing distribute.............................................................................................................................................................................................done. 01:33:15 INFO - Installing pip.................done. 01:33:15 INFO - Return code: 0 01:33:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:33: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')]} 01:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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')]} 01:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:15 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 0x7fd52d89bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19066c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c76e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fda90>, '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 0x1a4ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a502e0>, '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': '5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 01:33:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:33:15 INFO - Using env: {'DISPLAY': ':0', 01:33:15 INFO - 'HOME': '/home/cltbld', 01:33:15 INFO - 'LANG': 'en_US.UTF-8', 01:33:15 INFO - 'LANGUAGE': 'en_US:en', 01:33:15 INFO - 'LOGNAME': 'cltbld', 01:33:15 INFO - 'MAIL': '/var/mail/cltbld', 01:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:15 INFO - 'MOZ_NO_REMOTE': '1', 01:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:15 INFO - 'NO_EM_RESTART': '1', 01:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:33:15 INFO - 'PWD': '/builds/slave/test-pgo', 01:33:15 INFO - 'SHELL': '/bin/bash', 01:33:15 INFO - 'SHLVL': '1', 01:33:15 INFO - 'TERM': 'linux', 01:33:15 INFO - 'TMOUT': '86400', 01:33:15 INFO - 'USER': 'cltbld', 01:33:15 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167', 01:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:15 INFO - '_': '/tools/buildbot/bin/python'} 01:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:33:15 INFO - Cleaning up... 01:33:15 INFO - Return code: 0 01:33:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:33: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')]} 01:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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')]} 01:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:15 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 0x7fd52d89bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19066c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c76e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fda90>, '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 0x1a4ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a502e0>, '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': '5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 01:33:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:33:15 INFO - Using env: {'DISPLAY': ':0', 01:33:15 INFO - 'HOME': '/home/cltbld', 01:33:15 INFO - 'LANG': 'en_US.UTF-8', 01:33:15 INFO - 'LANGUAGE': 'en_US:en', 01:33:15 INFO - 'LOGNAME': 'cltbld', 01:33:15 INFO - 'MAIL': '/var/mail/cltbld', 01:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:15 INFO - 'MOZ_NO_REMOTE': '1', 01:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:15 INFO - 'NO_EM_RESTART': '1', 01:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:33:15 INFO - 'PWD': '/builds/slave/test-pgo', 01:33:15 INFO - 'SHELL': '/bin/bash', 01:33:15 INFO - 'SHLVL': '1', 01:33:15 INFO - 'TERM': 'linux', 01:33:15 INFO - 'TMOUT': '86400', 01:33:15 INFO - 'USER': 'cltbld', 01:33:15 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167', 01:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:15 INFO - '_': '/tools/buildbot/bin/python'} 01:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:15 INFO - Downloading/unpacking psutil>=0.7.1 01:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:17 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:33:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:33:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:33:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:33:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:33:17 INFO - Installing collected packages: psutil 01:33:17 INFO - Running setup.py install for psutil 01:33:17 INFO - building 'psutil._psutil_linux' extension 01:33:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:33:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:33:18 INFO - building 'psutil._psutil_posix' extension 01:33:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:33:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:33:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:33:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:33:18 INFO - Successfully installed psutil 01:33:18 INFO - Cleaning up... 01:33:18 INFO - Return code: 0 01:33:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd52d89bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19066c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c76e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fda90>, '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 0x1a4ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a502e0>, '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': '5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:33:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:33:18 INFO - Using env: {'DISPLAY': ':0', 01:33:18 INFO - 'HOME': '/home/cltbld', 01:33:18 INFO - 'LANG': 'en_US.UTF-8', 01:33:18 INFO - 'LANGUAGE': 'en_US:en', 01:33:18 INFO - 'LOGNAME': 'cltbld', 01:33:18 INFO - 'MAIL': '/var/mail/cltbld', 01:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:18 INFO - 'MOZ_NO_REMOTE': '1', 01:33:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:18 INFO - 'NO_EM_RESTART': '1', 01:33:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:33:18 INFO - 'PWD': '/builds/slave/test-pgo', 01:33:18 INFO - 'SHELL': '/bin/bash', 01:33:18 INFO - 'SHLVL': '1', 01:33:18 INFO - 'TERM': 'linux', 01:33:18 INFO - 'TMOUT': '86400', 01:33:18 INFO - 'USER': 'cltbld', 01:33:18 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167', 01:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:18 INFO - '_': '/tools/buildbot/bin/python'} 01:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:33:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:33:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:33:20 INFO - Installing collected packages: mozsystemmonitor 01:33:20 INFO - Running setup.py install for mozsystemmonitor 01:33:20 INFO - Successfully installed mozsystemmonitor 01:33:20 INFO - Cleaning up... 01:33:20 INFO - Return code: 0 01:33:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:20 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 0x7fd52d89bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19066c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c76e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fda90>, '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 0x1a4ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a502e0>, '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': '5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 01:33:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:33:20 INFO - Using env: {'DISPLAY': ':0', 01:33:20 INFO - 'HOME': '/home/cltbld', 01:33:20 INFO - 'LANG': 'en_US.UTF-8', 01:33:20 INFO - 'LANGUAGE': 'en_US:en', 01:33:20 INFO - 'LOGNAME': 'cltbld', 01:33:20 INFO - 'MAIL': '/var/mail/cltbld', 01:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:20 INFO - 'MOZ_NO_REMOTE': '1', 01:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:20 INFO - 'NO_EM_RESTART': '1', 01:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:33:20 INFO - 'PWD': '/builds/slave/test-pgo', 01:33:20 INFO - 'SHELL': '/bin/bash', 01:33:20 INFO - 'SHLVL': '1', 01:33:20 INFO - 'TERM': 'linux', 01:33:20 INFO - 'TMOUT': '86400', 01:33:20 INFO - 'USER': 'cltbld', 01:33:20 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167', 01:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:20 INFO - '_': '/tools/buildbot/bin/python'} 01:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:20 INFO - Downloading/unpacking blobuploader==1.2.4 01:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:22 INFO - Downloading blobuploader-1.2.4.tar.gz 01:33:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:33:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:33:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:33:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:33:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:22 INFO - Downloading docopt-0.6.1.tar.gz 01:33:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:33:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:33:22 INFO - Installing collected packages: blobuploader, requests, docopt 01:33:22 INFO - Running setup.py install for blobuploader 01:33:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:33:23 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:33:23 INFO - Running setup.py install for requests 01:33:23 INFO - Running setup.py install for docopt 01:33:23 INFO - Successfully installed blobuploader requests docopt 01:33:23 INFO - Cleaning up... 01:33:23 INFO - Return code: 0 01:33:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:23 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 0x7fd52d89bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19066c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c76e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fda90>, '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 0x1a4ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a502e0>, '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': '5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 01:33:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:33:23 INFO - Using env: {'DISPLAY': ':0', 01:33:23 INFO - 'HOME': '/home/cltbld', 01:33:23 INFO - 'LANG': 'en_US.UTF-8', 01:33:23 INFO - 'LANGUAGE': 'en_US:en', 01:33:23 INFO - 'LOGNAME': 'cltbld', 01:33:23 INFO - 'MAIL': '/var/mail/cltbld', 01:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:23 INFO - 'MOZ_NO_REMOTE': '1', 01:33:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:23 INFO - 'NO_EM_RESTART': '1', 01:33:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:33:23 INFO - 'PWD': '/builds/slave/test-pgo', 01:33:23 INFO - 'SHELL': '/bin/bash', 01:33:23 INFO - 'SHLVL': '1', 01:33:23 INFO - 'TERM': 'linux', 01:33:23 INFO - 'TMOUT': '86400', 01:33:23 INFO - 'USER': 'cltbld', 01:33:23 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167', 01:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:23 INFO - '_': '/tools/buildbot/bin/python'} 01:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:33:23 INFO - Running setup.py (path:/tmp/pip-P8GAKK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:33:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:33:23 INFO - Running setup.py (path:/tmp/pip-fxVY3F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:33:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:33:23 INFO - Running setup.py (path:/tmp/pip-yR35nt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:33:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:33:24 INFO - Running setup.py (path:/tmp/pip-D0SKFP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:33:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:33:24 INFO - Running setup.py (path:/tmp/pip-uYTPly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:33:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:33:24 INFO - Running setup.py (path:/tmp/pip-983sfY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:33:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:33:24 INFO - Running setup.py (path:/tmp/pip-BsMZXb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:33:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:33:24 INFO - Running setup.py (path:/tmp/pip-MvhQvD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:33:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:33:24 INFO - Running setup.py (path:/tmp/pip-9ZxXH7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:33:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:33:24 INFO - Running setup.py (path:/tmp/pip-5vdTdZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:33:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:33:24 INFO - Running setup.py (path:/tmp/pip-IjDDDX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:33:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:33:24 INFO - Running setup.py (path:/tmp/pip-WXp05W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:33:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:33:24 INFO - Running setup.py (path:/tmp/pip-odtfaY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:33:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:33:24 INFO - Running setup.py (path:/tmp/pip-gdfE44-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:33:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:33:24 INFO - Running setup.py (path:/tmp/pip-7LZwvw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:33:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:33:24 INFO - Running setup.py (path:/tmp/pip-Pm8PUg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:33:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:33:24 INFO - Running setup.py (path:/tmp/pip-s0YteZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:33:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:33:25 INFO - Running setup.py install for manifestparser 01:33:25 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:33:25 INFO - Running setup.py install for mozcrash 01:33:25 INFO - Running setup.py install for mozdebug 01:33:25 INFO - Running setup.py install for mozdevice 01:33:25 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:33:25 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:33:25 INFO - Running setup.py install for mozfile 01:33:25 INFO - Running setup.py install for mozhttpd 01:33:25 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:33:25 INFO - Running setup.py install for mozinfo 01:33:25 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:33:25 INFO - Running setup.py install for mozInstall 01:33:25 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:33:25 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:33:25 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:33:25 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:33:25 INFO - Running setup.py install for mozleak 01:33:25 INFO - Running setup.py install for mozlog 01:33:26 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:33:26 INFO - Running setup.py install for moznetwork 01:33:26 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:33:26 INFO - Running setup.py install for mozprocess 01:33:26 INFO - Running setup.py install for mozprofile 01:33:26 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:33:26 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:33:26 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:33:26 INFO - Running setup.py install for mozrunner 01:33:26 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:33:26 INFO - Running setup.py install for mozscreenshot 01:33:26 INFO - Running setup.py install for moztest 01:33:26 INFO - Running setup.py install for mozversion 01:33:26 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:33:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:33:26 INFO - Cleaning up... 01:33:26 INFO - Return code: 0 01:33:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:26 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 0x7fd52d89bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19066c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c76e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fda90>, '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 0x1a4ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a502e0>, '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': '5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 01:33:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:33:26 INFO - Using env: {'DISPLAY': ':0', 01:33:26 INFO - 'HOME': '/home/cltbld', 01:33:26 INFO - 'LANG': 'en_US.UTF-8', 01:33:26 INFO - 'LANGUAGE': 'en_US:en', 01:33:26 INFO - 'LOGNAME': 'cltbld', 01:33:26 INFO - 'MAIL': '/var/mail/cltbld', 01:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:26 INFO - 'MOZ_NO_REMOTE': '1', 01:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:26 INFO - 'NO_EM_RESTART': '1', 01:33:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:33:26 INFO - 'PWD': '/builds/slave/test-pgo', 01:33:26 INFO - 'SHELL': '/bin/bash', 01:33:26 INFO - 'SHLVL': '1', 01:33:26 INFO - 'TERM': 'linux', 01:33:26 INFO - 'TMOUT': '86400', 01:33:26 INFO - 'USER': 'cltbld', 01:33:26 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167', 01:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:26 INFO - '_': '/tools/buildbot/bin/python'} 01:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:33:26 INFO - Running setup.py (path:/tmp/pip-vdPilO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 01:33:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:33:27 INFO - Running setup.py (path:/tmp/pip-t0kg0Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:33:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:33:27 INFO - Running setup.py (path:/tmp/pip-Yc5QtJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 01:33:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:33:27 INFO - Running setup.py (path:/tmp/pip-TLkUO0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:33:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:33:27 INFO - Running setup.py (path:/tmp/pip-Kc6gcC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 01:33:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:33:27 INFO - Running setup.py (path:/tmp/pip-d9D3dN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 01:33:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:33:27 INFO - Running setup.py (path:/tmp/pip-RVzS3I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 01:33:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:33:27 INFO - Running setup.py (path:/tmp/pip-fyvCxg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 01:33:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:33:27 INFO - Running setup.py (path:/tmp/pip-Y1bhnw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 01:33:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:33:27 INFO - Running setup.py (path:/tmp/pip-I7xX6d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:33:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:33:27 INFO - Running setup.py (path:/tmp/pip-FcM6EK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 01:33:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:33:27 INFO - Running setup.py (path:/tmp/pip-I6gO2T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 01:33:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:33:27 INFO - Running setup.py (path:/tmp/pip-IB9xC4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 01:33:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:33:27 INFO - Running setup.py (path:/tmp/pip-JI3DBZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 01:33:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:33:27 INFO - Running setup.py (path:/tmp/pip-J6c3Eb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 01:33:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:33:28 INFO - Running setup.py (path:/tmp/pip-3MWiaT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 01:33:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:33:28 INFO - Running setup.py (path:/tmp/pip-AouVKd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 01:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 01:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:33:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:33: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 01:33: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 01:33: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 01:33: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 01:33: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 01:33: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 01:33:29 INFO - Downloading blessings-1.5.1.tar.gz 01:33:29 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 01:33:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:33:29 INFO - Installing collected packages: blessings 01:33:29 INFO - Running setup.py install for blessings 01:33:30 INFO - Successfully installed blessings 01:33:30 INFO - Cleaning up... 01:33:30 INFO - Return code: 0 01:33:30 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:33:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:33:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:33:30 INFO - Reading from file tmpfile_stdout 01:33:30 INFO - Current package versions: 01:33:30 INFO - argparse == 1.2.1 01:33:30 INFO - blessings == 1.5.1 01:33:30 INFO - blobuploader == 1.2.4 01:33:30 INFO - docopt == 0.6.1 01:33:30 INFO - manifestparser == 1.1 01:33:30 INFO - mozInstall == 1.12 01:33:30 INFO - mozcrash == 0.16 01:33:30 INFO - mozdebug == 0.1 01:33:30 INFO - mozdevice == 0.47 01:33:30 INFO - mozfile == 1.2 01:33:30 INFO - mozhttpd == 0.7 01:33:30 INFO - mozinfo == 0.9 01:33:30 INFO - mozleak == 0.1 01:33:30 INFO - mozlog == 3.0 01:33:30 INFO - moznetwork == 0.27 01:33:30 INFO - mozprocess == 0.22 01:33:30 INFO - mozprofile == 0.27 01:33:30 INFO - mozrunner == 6.11 01:33:30 INFO - mozscreenshot == 0.1 01:33:30 INFO - mozsystemmonitor == 0.0 01:33:30 INFO - moztest == 0.7 01:33:30 INFO - mozversion == 1.4 01:33:30 INFO - psutil == 3.1.1 01:33:30 INFO - requests == 1.2.3 01:33:30 INFO - wsgiref == 0.1.2 01:33:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:30 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 0x7fd52d89bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19066c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c76e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fda90>, '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 0x1a4ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a502e0>, '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': '5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 01:33:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:33:30 INFO - Using env: {'DISPLAY': ':0', 01:33:30 INFO - 'HOME': '/home/cltbld', 01:33:30 INFO - 'LANG': 'en_US.UTF-8', 01:33:30 INFO - 'LANGUAGE': 'en_US:en', 01:33:30 INFO - 'LOGNAME': 'cltbld', 01:33:30 INFO - 'MAIL': '/var/mail/cltbld', 01:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:30 INFO - 'MOZ_NO_REMOTE': '1', 01:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:30 INFO - 'NO_EM_RESTART': '1', 01:33:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:33:30 INFO - 'PWD': '/builds/slave/test-pgo', 01:33:30 INFO - 'SHELL': '/bin/bash', 01:33:30 INFO - 'SHLVL': '1', 01:33:30 INFO - 'TERM': 'linux', 01:33:30 INFO - 'TMOUT': '86400', 01:33:30 INFO - 'USER': 'cltbld', 01:33:30 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167', 01:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:30 INFO - '_': '/tools/buildbot/bin/python'} 01:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 01:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 01:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 01:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 01:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 01:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 01:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 01:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 01:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 01:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 01:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 01:33:30 INFO - Cleaning up... 01:33:30 INFO - Return code: 0 01:33:30 INFO - Running post-action listener: _resource_record_post_action 01:33:30 INFO - Running post-action listener: _start_resource_monitoring 01:33:30 INFO - Starting resource monitoring. 01:33:30 INFO - ##### 01:33:30 INFO - ##### Running install step. 01:33:30 INFO - ##### 01:33:30 INFO - Running pre-action listener: _resource_record_pre_action 01:33:30 INFO - Running main action method: install 01:33:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:33:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:33:30 INFO - Reading from file tmpfile_stdout 01:33:30 INFO - Detecting whether we're running mozinstall >=1.0... 01:33:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:33:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:33:30 INFO - Reading from file tmpfile_stdout 01:33:30 INFO - Output received: 01:33:30 INFO - Usage: mozinstall [options] installer 01:33:30 INFO - Options: 01:33:30 INFO - -h, --help show this help message and exit 01:33:30 INFO - -d DEST, --destination=DEST 01:33:30 INFO - Directory to install application into. [default: 01:33:30 INFO - "/builds/slave/test-pgo"] 01:33:30 INFO - --app=APP Application being installed. [default: firefox] 01:33:30 INFO - mkdir: /builds/slave/test-pgo/build/application 01:33:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 01:33:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 01:33:45 INFO - Reading from file tmpfile_stdout 01:33:45 INFO - Output received: 01:33:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:33:45 INFO - Running post-action listener: _resource_record_post_action 01:33:45 INFO - ##### 01:33:45 INFO - ##### Running run-tests step. 01:33:45 INFO - ##### 01:33:45 INFO - Running pre-action listener: _resource_record_pre_action 01:33:45 INFO - Running main action method: run_tests 01:33:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:33:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:33:45 INFO - Python 2.7.3 01:33:45 INFO - Return code: 0 01:33:45 INFO - grabbing minidump binary from tooltool 01:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:45 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 0x19fda90>, '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 0x1a4ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a502e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:33:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 01:33:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:33:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:33:45 INFO - Return code: 0 01:33:45 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:33:45 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:33:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:33:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:33:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:33:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 01:33:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost 01:33:45 INFO - Using env: {'DISPLAY': ':0', 01:33:45 INFO - 'HOME': '/home/cltbld', 01:33:45 INFO - 'LANG': 'en_US.UTF-8', 01:33:45 INFO - 'LANGUAGE': 'en_US:en', 01:33:45 INFO - 'LOGNAME': 'cltbld', 01:33:45 INFO - 'MAIL': '/var/mail/cltbld', 01:33:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:33:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:45 INFO - 'MOZ_NO_REMOTE': '1', 01:33:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:33:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:45 INFO - 'NO_EM_RESTART': '1', 01:33:45 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:33:45 INFO - 'PWD': '/builds/slave/test-pgo', 01:33:45 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:33:45 INFO - 'SHELL': '/bin/bash', 01:33:45 INFO - 'SHLVL': '1', 01:33:45 INFO - 'TERM': 'linux', 01:33:45 INFO - 'TMOUT': '86400', 01:33:45 INFO - 'USER': 'cltbld', 01:33:45 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167', 01:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:45 INFO - '_': '/tools/buildbot/bin/python'} 01:33:45 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] with output_timeout 3600 01:33:45 INFO - mozversion INFO | application_buildid: 20151119233015 01:33:45 INFO - mozversion INFO | application_changeset: 1b2e15608f34fef0f23369731c80138f55f00cf2 01:33:45 INFO - mozversion INFO | application_display_name: Nightly 01:33:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:33:45 INFO - mozversion INFO | application_name: Firefox 01:33:45 INFO - mozversion INFO | application_remotingname: firefox 01:33:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 01:33:45 INFO - mozversion INFO | application_vendor: Mozilla 01:33:45 INFO - mozversion INFO | application_version: 45.0a1 01:33:45 INFO - mozversion INFO | platform_buildid: 20151119233015 01:33:45 INFO - mozversion INFO | platform_changeset: 1b2e15608f34fef0f23369731c80138f55f00cf2 01:33:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 01:33:45 INFO - mozversion INFO | platform_version: 45.0a1 01:33:45 INFO - 2015-11-20 01:33:45,534 DEBUG : using testdate: 1448012025 01:33:45 INFO - 2015-11-20 01:33:45,535 DEBUG : actual date: 1448012025 01:33:45 INFO - 2015-11-20 01:33:45,543 INFO : starting webserver on 'localhost:59301' 01:33:45 INFO - 2015-11-20 01:33:45,544 INFO : Starting test suite talos-linux64-ix-061.e 01:33:45 INFO - 2015-11-20 01:33:45,544 INFO : Starting test dromaeo_css 01:33:45 INFO - 2015-11-20 01:33:45,544 DEBUG : operating with platform_type : linux_ 01:33:45 INFO - 2015-11-20 01:33:45,545 INFO : Initialising browser for dromaeo_css test... 01:33:45 INFO - 2015-11-20 01:33:45,556 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBMPc95/profile http://localhost:59301/getInfo.html 01:33:49 INFO - 2015-11-20 01:33:49,758 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:33:49 INFO - 2015-11-20 01:33:49,758 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:33:49 INFO - 2015-11-20 01:33:49,758 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:33:49 INFO - 2015-11-20 01:33:49,758 DEBUG : BROWSER_OUTPUT: __metrics 01:33:50 INFO - 2015-11-20 01:33:50,769 INFO : Browser initialized. 01:33:50 INFO - 2015-11-20 01:33:50,769 INFO : Running cycle 1/1 for dromaeo_css test... 01:33:50 INFO - 2015-11-20 01:33:50,770 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBMPc95/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:34:02 INFO - 2015-11-20 01:34:02,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 141549568 01:34:02 INFO - 2015-11-20 01:34:02,572 DEBUG : BROWSER_OUTPUT: 01:34:52 INFO - 2015-11-20 01:34:52,199 DEBUG : BROWSER_OUTPUT: 1448012092196 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:37:01 INFO - 2015-11-20 01:37:01,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59301/tests/dromaeo/cssquery-ext.html) 01:37:02 INFO - 2015-11-20 01:37:02,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 146432000 01:37:02 INFO - 2015-11-20 01:37:02,248 DEBUG : BROWSER_OUTPUT: 01:40:04 INFO - 2015-11-20 01:40:04,189 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/dromaeo/cssquery-ext.html (next: http://localhost:59301/tests/dromaeo/cssquery-jquery.html) 01:40:04 INFO - 2015-11-20 01:40:04,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 140832768 01:40:04 INFO - 2015-11-20 01:40:04,770 DEBUG : BROWSER_OUTPUT: 01:43:06 INFO - 2015-11-20 01:43:06,439 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59301/tests/dromaeo/cssquery-mootools.html) 01:43:07 INFO - 2015-11-20 01:43:07,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 142184448 01:43:07 INFO - 2015-11-20 01:43:07,040 DEBUG : BROWSER_OUTPUT: 01:46:08 INFO - 2015-11-20 01:46:08,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59301/tests/dromaeo/cssquery-prototype.html) 01:46:09 INFO - 2015-11-20 01:46:09,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 141135872 01:46:09 INFO - 2015-11-20 01:46:09,276 DEBUG : BROWSER_OUTPUT: 01:49:11 INFO - 2015-11-20 01:49:11,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59301/tests/dromaeo/cssquery-yui.html) 01:49:12 INFO - 2015-11-20 01:49:12,171 DEBUG : BROWSER_OUTPUT: RSS: Main: 141803520 01:49:12 INFO - 2015-11-20 01:49:12,171 DEBUG : BROWSER_OUTPUT: 01:52:14 INFO - 2015-11-20 01:52:14,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/dromaeo/cssquery-yui.html (next: http://localhost:59301/tests/dromaeo/cssquery-dojo.html) 01:52:14 INFO - 2015-11-20 01:52:14,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 143937536 01:52:14 INFO - 2015-11-20 01:52:14,623 DEBUG : BROWSER_OUTPUT: 01:52:14 INFO - 2015-11-20 01:52:14,625 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:52:14 INFO - 2015-11-20 01:52:14,625 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:52:14 INFO - 2015-11-20 01:52:14,625 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:52:14 INFO - 2015-11-20 01:52:14,625 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:52:14 INFO - 2015-11-20 01:52:14,629 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3255.739540836733;3330.7668463207583;3351.631320554737;3375.9493607595873;3389.559357283554;5268.341457317835;5497.862553436166;5511.283533140691;5518.91721624176;5524.64089834161;5440.510354068133;5454.645448045874;5457.536109430703;5510.972445137769;5533.47431993961;4640.303954406849;4952.331435256248;5074.416442109149;5079.136546787036;5106.131957567204;4942.18453955097;5052.772625231855;5096.311997880276;5121.3342265505435;5149;5012.147934851102;5045.091883460976;5072.568831649277;5091.1854103343285;5130;5049.495050494921;5060.873478163038;5066.290719299301;5076.568491678212;5108.131617624976;4966.106100901836;5023.171176755831;5029.119904016819;5032.547070763649;5062.620303477254;5166.819161329373;5172.069027575035;5203.427622961472;5228.607854410896;5283.894322113536;5899.174115623816;5899.292084949833;5899.793507227227;5911.142884281755;5914.556408269397;5848.239728835267;5927.851803704942;5949.286085669704;5996.700164991733;6052.697365131769;5566.777328906839;5596.412376700469;5601.383847776741;5605.859853503654;5627.6904770237625;6007.459328660441;6024;6053.818385448443;6057.969710151421;6090.786822461193;5761.53907687384;5826.533877289891;5874.795666888278;5888.440598143169;5943.227380440515;5904.114382842522;5905.40945905406;5934.584579079423;5948.762049517971;5951.196588460589;5883.14694369314;5915.201447804578;5933.228680271537;5934.43622855828;5938.376470470625;5720.856978575569;5785.1322301654245;5819.854503637443;5890.970545147246;5932.228810254639;4556.17988762026;4559.817607295738;4571.994161284512;4595.862124136282;4611.5619016193405;3989.0027493126718;4057.2899742544937;4072.511298644182;4077.2660921033907;4100.6924480664065;5520.171974203821;5548.77804887808;5560.916586251209;5618.775248989995;5627.943720562824;6011.759529618854;6035.547333949971;6037.78867739627;6038.698065096728;6048.395160484004;5461.590380721462;5548.722563871871;5639.097744360883;5672.290963629546;5699.629524080921;5068.493150684902;5114.590832733373;5136.845894623168;5145.845624631267;5180.948190518122;6060.696965151725;6080.270367555921;6086.117512960596;6135.9079613805825;6188.659623720739;5759.193712880284;5850.531957443309;5851.239338886088;5977.760889564369;5987.34139244674;6060.272822245639;6116.149912098478;6168.25980882297;6182;6193.81418557444;5832.445917637818;5891.23413956183;5902.970485147547;5908.822735317947;5917.733701983335;5775.768969241351;5872.882542349214;5907.9704601476715;5976.462118409364;5998.70006499682;5813.94186058134;5822.155787410887;5823.272090988627;5831.096180092092;5881.970590147193;5769.019266724583;5769.07694768835;5773.364929857628;5773.797917072882;5808.738606762621;5467.617266791286;5514.255575497417;5542.251796007487;5636.0418728815375;5642.210090587403;5727.942720572908;5761.971190144022;5762.510186634183;5770.451807078321;5818.796342128006;5664.122061080539;5706.914396284142;5721.313442386941;5724.026915424304;5741.45456181662 01:52:14 INFO - 2015-11-20 01:52:14,629 DEBUG : BROWSER_OUTPUT: |1;ext.html;526.3999041093155;557.0863783395232;564.5511818104608;570.7089384413947;600.3336296710653;30895;31861.36277274453;39188.60811391885;39593.20813583727;39718;42156;42557.57442425575;42577.78711106448;42680;42752.35871461923;8723.520206388646;8886.73339799807;8897.866532002025;8916.821663566725;8926.46441213526;8627.79210910473;8630.223279904807;8695.087015863339;8727.781805454852;8737.7815554611;8686.348523860705;8787.604557794883;8787.78030549235;8789.340799440035;8812.074732153127;8701.825963480727;8733.34499912509;8788.16512431318;8790.472571645658;8818.382713210078;8585.656573737044;8628.266597339234;8685.044645089036;8716.869246961302;8736.388452808305;39247;39578.80210598958;39669.60330396688;39681;39741.80129099365;3290.654481279455;3321.110216736723;3360;3430.1939044324563;3544.149404143013;29471.705282947325;29892.8235100674;30139.09582712522;30193.245168870733;30688.693113068806;3864.7487913285545;3962.5046869141356;3969.166475040245;3970.4838371011874;3980.920381592352;258831;261103.9448027591;261353;262188;262893.685531573;41230.79384603058;42190;42451;57361;57735.42264577385;41215.587844121175;41366.37950430746;41397.37903931444;41605.583944160775;41747;14824.258787060604;14994.425585313604;15038.172900490577;15041.849581504264;15042.097474151367;11691.824622630667;11772.411379430994;11773.704892461994;11781.469833857496;11785;14070.085444446078;14217.36021879018;14294.428222871176;14351.210683412513;14372.191369287148;5784.768609255667;5819.709014549256;5826.271716035496;5864.706764661835;5910.143029260819;969.4474149734724;978.3542861711236;1026.6868605075374;1043.8695163104612;1078.1051727066515;28358.149255522367;28883.56674649882;28931;28984.710152898624;29245.707542924723;1012.792377562598;1063.5798859450474;1070.9946450267698;1111.4942701070993;1142.845715828369;14245.287735613178;14589.270536473134;14745.11529308245;14787.186704731343;16610.833891661172;362556;363679;364983;367662;369438;54368.18447723287;54690;54866.451335486934;54995.72502137464;55050.724746376014;1367.2138520350838;1387.4450219912117;1404.908680935736;1405.4588983241322;1409.9224542650047;29119.85440072786;29980.400391991603;30025.249368765955;30410;32393;49712;50055.74972125116;50121.74939125281;50545.74727126341;50688.23967640415;292457;292556;294665;295134;295776;42042.57957420387;45835.54164458313;45880.541194588965;45934.31098533458;47110;43269.350959735;43587.12825743531;43974.78012610044;44267.77866110649;44387.77806111078;37136.07159821026;37515.43726844045;40777;42763.14473710571;42805.35791963185;36881.44677829889;37416.43875341817;37689.43465848069;37722.81138594289;38027.61972380241;36538.8173059133;36819.81590092139;36834.71078512239;37208.44187337246;37232.81383593065;32891.17772055622;33018.12607626673;33184;33220.66779332176;33437.49843752297;26323.605145922444;26645.733542664326;27212.31969200786;28465.43069138564;28734.281642958256 01:52:14 INFO - 2015-11-20 01:52:14,630 DEBUG : BROWSER_OUTPUT: |2;jquery.html;346.21063974138974;346.74860725973673;349.6101846441217;352.6808238544117;356.568552052017;16320.755188672165;16922.323107075717;17538.912305438487;17980.999999999985;18252;10382;10945.616903408381;16081.517554473356;16095.436659716912;16188.514344569681;4688.85933421997;4996.575291100261;5115.411727651331;5123.769430375623;5131.2303154526935;5075.289459475676;5130.410002849664;5163.328767260251;5909.025010873201;6082.482988945945;5155.587552995751;5314.388845282803;5973.850653733648;6019.036954087347;6022.156898034279;5255.579553635719;5284.894302113975;5288.153895376721;5293.179557168645;5321.4412486688725;4963.45402005779;5113.846584602468;5115.846524604268;5128.282040514331;5141.742912854343;11750.588729394516;11803.468843902045;12968.80546791799;20265.290714825056;20269.898650506802;1990.2238127130286;2024.9493762655904;2032.8373730101705;2033.4712974626705;2098.464891452685;9041.773955651095;9305.627774888997;9327.906720932771;10433.32183408076;13548.93225533876;1807.430659342303;1815.7035975803967;1885.538043179416;1890.5179179309189;1898.2027548429692;58658.41341586615;59740.402595973916;61037.08444373338;62387.6880615594;62465.37534624641;10104.74738131538;10196.3372380795;10327.741806454898;10338.638147664795;10361.4301213434;13473.797893031613;13516.391762370717;13554.661133471545;13581.456741730417;13615.931920340336;7602.771916842504;7618.200088990687;7631.771046868603;7649.655765490566;7731.226877312336;7384.2246564111065;7440.367568756608;7475.5888426136;7482.8877566836545;7495.400367970549;4009.518857737032;4113.300738874398;4393.406890069799;4428.2914733642465;4443.244648409778;1820.6995845685578;1841.1254654039492;1843.1613615805045;1849.2695385322722;1856.201833211705;422.86679695895697;438.5789641943706;454.9545045495424;458.429255576809;467.8011844965876;9755.902440975642;10509.579616815394;10564.207684423698;10827.079698225582;10833.241673082808;444.4555419611015;449.4808496186909;465.5949324088065;475.372508289062;480.34672844930867;5674.77300907959;5751;5778.913316300259;5784.71076446176;5821.970890145607;552056;557800;560296;565846;574323;71020.2897971024;86502.56748716343;86566;87137.56431217803;88585.11414885768;485.82995951416723;495.0396231311245;497.56711660855285;499.5129748495261;500.2521230760037;10561.207909406672;10682.465876705977;10716.142708583451;10792.892071079503;14601.342939567958;33496.49755253722;33740.32519349649;35513.64486355103;35848.103797404234;36028;44567.77716111398;44819.77590112029;45758;47187.528124718316;49473.75263123661;9143.13140251675;9582;10147.985201479793;10163.89836101659;10165.796684066425;17825;17885.73171402456;17891.910540447214;18007.189676464328;18255.817441825944;14032.438702451787;14467.49363772305;14770.63073423173;14786.48247311382;14941.252937353307;14729.410823567367;14989.100653960797;15017.924910375816;15308.31112599958;15348.693026139637;15172.165530895907;15333.76999345033;15468.84531154674;15931;15953.122578258308;9012.86480702803;9132.954335228282;9181.311401644769;9720.513974301115;10099.848502272325;14190.645233868823;14647.487337943121;14697.596355571386;14857.925710371379;15127.697446051237 01:52:14 INFO - 2015-11-20 01:52:14,631 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1479.4304192885736;1698.6602679464106;1738.7044202485577;1753.8775183882317;1768.080598088993;7218.8917166242545;7363.374113200378;7396.593187374692;7708.614569271528;7722.884156737647;7639.236076392358;7696.884546731803;7767.262110099546;7776.261255180763;7780.688772449095;2234.2626933112033;2241.9663705044436;2261.728592568894;2261.8642881427168;2279.282026161754;2239.7200349956256;2266.8526545774553;2276.8747718875456;2277.9658305125436;2278.6582012698063;2157.9892100539555;2194.1771835561663;2221.1559607349186;2225.2434172381386;2226.421130506064;2205.6801763744247;2258.5934531784274;2280.04238219948;2283.5889539882814;2286.211257116292;2203.8567493112896;2252.68462415262;2265.8187345012525;2267.807236384909;2267.977320226793;7419.183889772121;7487.1764105948305;7493.025906632158;7496.700131994714;7506.3244308012;4657.4411070671395;4670.065986802653;4684.718916864999;4719.598834099105;4728.976355118237;3091.5517249998848;3118.8304385855304;3164.5886034815558;3166.778325517215;3184.1243657994005;1010.600812678995;1029.0995379043336;1961.3625571689258;1964.312490628283;1972.5167334003118;9836.90163098367;9858.457784821832;9867.90132098677;9908.108270255712;9923.652672156511;4100.507939047334;4108.589141085928;4122.525909520444;4198.685098617616;4274.572542745763;8361.205685459872;8364.707235246737;8380.748577542683;8388.748337549883;8391.664333426594;4577.931331030038;4616.422947131608;4619.099275641218;4631.698939568917;4642.744649044335;4227.323628219531;4239.576042395735;4257.936130958038;4261.765602891871;4273.957260427356;3372.5278461015478;3376.983115084458;3407.3185362927516;3411.9658803412144;3428.3314753623304;1060.6552870317023;1065.195777188218;1066.5467176449977;1072.4905669806778;1076.1390887290136;1078.0513148429332;1089.0851684584986;1092.0662833277593;1258.5972488803495;1363.8431580368185;6794.8448763710285;6933.826654333581;6947.513674042769;6948.5483443576;7080.398166155935;1164.0861923390098;1165.7610189911047;1166.5100657723776;1170.5025364220173;1175.9353235572125;5672.716364181774;5675.091985282417;5688.658680479184;5692.658440493584;5711.914321285184;8827.911720882708;8852.38033337673;9006.459612423276;9130.954345228363;9158.90841091594;8890.511021893857;8993.460392376479;9033.412828166149;9056.547172641342;9058.230050445785;6804.965975170093;6855.588664680035;7052.92947070533;7074.3633073023675;7103;7105.82235444118;7116.039334689751;7145;7165.856682866418;7171.533850299714;7795.961020194863;8132.105468398589;8138.87791683137;8226.095129535626;8248.54632995191;8227;8275.668973241243;8348;8367;8413.411061225655;6675.899861502178;6691;6830;6832.931670683429;6854.246032936473;7368.263173682589;7392.704291828267;7407.851842963003;7413.592252425952;7414.962925185339;6677.131972843499;6777.796666100025;6892.241853396022;7022.754203603054;7092.148942126978;6672.099266599141;6839;6912.27421120775;6970.721171153097;6994.965025174842;6831.282715315019;6978.197507286524;6984.371406573433;6994.405475534433;6995.370416662525;6292.842678933063;6333.524985626004;6334.828056809505;6348.492120630246;6377.394147555975;6346.555741098079;6357.650329231937;6371.139896113966;6403.391677790602;6423.454006409321 01:52:14 INFO - 2015-11-20 01:52:14,633 DEBUG : BROWSER_OUTPUT: |4;prototype.html;327.5414419812262;327.91310302769756;334.2929703676721;336.81811821616327;348.4164025257693;6209.9068513972325;6212.378762123785;6289.874202515953;6296.212973378328;6330.936690633092;6134.938650613492;6224.875502489947;6275.497960163188;6276.717547710353;6290.811275661726;4763.642726795496;4766.976165119169;4786.521347865203;4792.353032340642;4793.376861008064;4765.094632019923;4791.3531673224015;4796.3045358423005;4814.277858321262;4826.589739872115;4678.5789278964885;4773.06925149596;4775.570198682118;4777.641676874231;4780.139574876521;4730.006698593316;4751.453582837983;4752.691075080109;4771.9761401192945;4774.952250477486;4111.342185250375;4121.175764847043;4136.420901073852;4140.15126898985;4140.399642051916;5933.3473317934995;5962.940370596325;5972.820815375546;5980.820575382745;5986.132010858445;5428.891422171574;5554.527865131468;5556.9719601873785;5560.582956278296;5562.415946325658;6667.366600172976;6673.132492775908;6691.063251144844;6692.230393504712;6695.430888374494;4580.450345958473;4581.63346932248;4584.060267645124;4599.747013914233;4607.9078418431445;6834.521583489158;6986.266442023565;7000.054992575988;7008.719651213996;7014.684339204697;4711.858644240679;4712.434507859079;4716.6698331116495;4717.481077081518;4719.126961512063;4766.928496072562;4772.451168115642;4772.976135119302;4773.284007398918;4783.210770222874;5562.054450743383;5567.66594004361;5570.832875013756;5572.414896435897;5574.86062848432;6608.801735947929;6764.797056088325;6775.830604234933;6780.050792888999;6788.049673045777;1615.781869447633;1647.9176041197893;1649.150687395992;1655.3213182595077;1680.9411670591714;1064.3188359449803;1071.8070747265567;1075.704181350135;1084.2356138922041;1092.2900114925362;6375.768481031602;6384.936150638434;6420.903686444707;6450.870982580323;6477.352264773485;6895.207051189077;6915.965420172967;6924.965375173092;6932.826679333057;6937.340952609494;6418.550701450854;6449.193850768654;6461.095446637474;6462.48300135988;6463.9980802975615;3791.052236940765;3796.0699628591174;3803.9919421353366;3830.578636349999;3839.7120215983914;7390.926090739132;7404.2595740426605;7425.294597013275;7426.517276377018;7432.7770166894;7055.929440705528;7150.892736608955;7239.348458638642;7294.598797066213;7296.562206267535;7272.418206543463;7357.006804081488;7380.483366164317;7387;7430.219826918095;7032.824179395556;7095.290470952863;7101;7104.57908418308;7114.14630244374;6792.490563207681;6893.276205998499;6912.861742765016;6950.54821436605;6993.370596646327;7324.974503569611;7365.263473652806;7391.113066432063;7392.297731715478;7407.518511296748;4724.48030716614;4769.260764581495;4772.188727916332;4774.880627984189;4775.689580177277;6847.657617119224;6885.173779146535;6983.127109111361;7003.369696727319;7006.894896576454;6743.763968261087;6754.18949726036;6758.898616520658;6792;6803.693833777591;6777.220619628806;6790.45676345901;6812.591244525344;6820.04519367279;6845.418139458202;6474.1907261592305;6605.834854128685;6634.502412318999;6636.2700102987665;6636.867262654817;6835.14560679915;6851.075104860979;6852.246252912076;6865.519413641197;6891.896621550581;6688.230853451915;6713.530052896251;6713.697883595348;6721.395074443323;6724.697388617622 01:52:14 INFO - 2015-11-20 01:52:14,633 DEBUG : BROWSER_OUTPUT: |5;yui.html;719.3202423709595;813.7680760983121;818.7748369198473;827.9006519217695;828.5277391886625;11590.710232244199;11651.708707282321;12110.394480275983;12319;12337.383130843456;12421.378931053434;12472.314022728746;12502.49990000399;12553.309567973758;12649.241045537274;809.2878267124922;810.5703976892227;821.40858581821;825.3933358981144;826.0665448043702;808.7169490678245;813.7314686153585;814.2712272516095;820.4789958376414;823.6211342782327;848.2535368875411;859.0550394565959;860.4493124400389;863.3913091270639;863.6847550644032;856.6273670953124;856.7943693513512;857.2627540315324;857.391252210931;858.3476557816074;626.2922897126264;630.6216270237867;631.343402861024;631.3907079668143;632.4845251120322;11987.10096742739;12389.194702344408;12399.814002789966;12417.379131043412;12423;12299.815502767466;12313.876861231363;12379.75240495194;12388.194767340094;12816.423260953186;9981;9986.850197247048;10142.833574138995;10183.694489165337;10439.582416703322;3611.981940090283;3622.094476380905;3643.617420170897;3645.7265705072227;3761.887143385703;45057.54942450566;45389.773051134536;45699;45729;45831.54168458306;9746.853797193047;9751.512424378752;9809.117179453884;9885.654002109892;9980.550875210633;17867.642647146986;17999.820001800075;18277.90861045713;18303.633927321378;18316.816831831777;7385.66764495599;7387.261273872569;7419.406447484188;7648.158702542716;7710.4217183710325;4230.344296634026;4314.417553630283;4349.064951035542;4356.215881141425;4370.169667763115;3099.0857696979447;3118.438681037435;3121.9219519512194;3127.6559578446354;3127.8436078196455;561.0574235284761;568.3066658676408;568.5451638689033;575.8963386590453;582.4292193650247;635.4090695653088;640.9455196308367;644.7807745366504;654.7184710574498;716.6667499612705;8300.128486508951;8646.524441155796;8669.393142479967;8924.955375223211;8980;508.1640701046831;613.828128124126;637.6811594202899;643.3598569423453;645.3320812958565;3826.100866296418;3882.378819388884;3914.3345631242755;4119.608637179464;4152.211079894811;53091.46908530942;54313;54881.176782348295;55887.44112558904;56586.71706641441;48786.02427951421;49054.50945490571;49186.754066230154;49526;49545;45981.540184598394;46869.29696054562;47268;47381.763091185014;47480.76259618749;8270.131636178356;8429.283510901396;8450.957745211235;8559.914400856162;8691.869621955802;34234.48648270228;34680.30639387148;35392.823035884656;35420.82289588536;35691.10772230715;45721;45771.542284576724;45887;46184.30723539217;46365.53634463747;10827.350358978172;10920.726981825517;10991.560337586407;11097.500612472297;11105.666829995112;12435.44040518197;12456.833370599561;12501.624951251477;12527;13143.685631437162;11188.83216751733;11309.604163854226;11435.313881167156;11559.248648837798;11630.53477860876;11358.659240222807;11666.650000499998;11704.356260405759;11731.88268117308;11915.106367022681;10762;11109.83335249988;11248.325100493996;11494.597689080842;11574.189806713786;9823.214142868695;9881.160101391175;9910.454924979196;9982.950085249528;10107.19142468586;8461.661533538589;8502;8730.956345218234;9413.294002949942;9464.668736594185 01:52:14 INFO - 2015-11-20 01:52:14,633 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:52:14 INFO - 2015-11-20 01:52:14,633 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:52:14 INFO - 2015-11-20 01:52:14,633 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,282 01:52:14 INFO - 2015-11-20 01:52:14,633 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:52:14 INFO - 2015-11-20 01:52:14,633 DEBUG : BROWSER_OUTPUT: __startTimestamp1448013134624__endTimestamp 01:52:14 INFO - 2015-11-20 01:52:14,633 DEBUG : BROWSER_OUTPUT: 01:52:14 INFO - 2015-11-20 01:52:14,633 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:52:14 INFO - 2015-11-20 01:52:14,633 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:52:14 INFO - 2015-11-20 01:52:14,633 DEBUG : BROWSER_OUTPUT: 01:52:14 INFO - 2015-11-20 01:52:14,633 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5494.55 Median:5720.86 stddev:607.85 (10.6%) stddev-sans-first:583.79 01:52:14 INFO - 2015-11-20 01:52:14,635 DEBUG : BROWSER_OUTPUT: Values: 3255.7 3330.8 3351.6 3375.9 3389.6 5268.3 5497.9 5511.3 5518.9 5524.6 5440.5 5454.6 5457.5 5511.0 5533.5 4640.3 4952.3 5074.4 5079.1 5106.1 4942.2 5052.8 5096.3 5121.3 5149.0 5012.1 5045.1 5072.6 5091.2 5130.0 5049.5 5060.9 5066.3 5076.6 5108.1 4966.1 5023.2 5029.1 5032.5 5062.6 5166.8 5172.1 5203.4 5228.6 5283.9 5899.2 5899.3 5899.8 5911.1 5914.6 5848.2 5927.9 5949.3 5996.7 6052.7 5566.8 5596.4 5601.4 5605.9 5627.7 6007.5 6024.0 6053.8 6058.0 6090.8 5761.5 5826.5 5874.8 5888.4 5943.2 5904.1 5905.4 5934.6 5948.8 5951.2 5883.1 5915.2 5933.2 5934.4 5938.4 5720.9 5785.1 5819.9 5891.0 5932.2 4556.2 4559.8 4572.0 4595.9 4611.6 3989.0 4057.3 4072.5 4077.3 4100.7 5520.2 5548.8 5560.9 5618.8 5627.9 6011.8 6035.5 6037.8 6038.7 6048.4 5461.6 5548.7 5639.1 5672.3 5699.6 5068.5 5114.6 5136.8 5145.8 5180.9 6060.7 6080.3 6086.1 6135.9 6188.7 5759.2 5850.5 5851.2 5977.8 5987.3 6060.3 6116.1 6168.3 6182.0 6193.8 5832.4 5891.2 5903.0 5908.8 5917.7 5775.8 5872.9 5908.0 5976.5 5998.7 5813.9 5822.2 5823.3 5831.1 5882.0 5769.0 5769.1 5773.4 5773.8 5808.7 5467.6 5514.3 5542.3 5636.0 5642.2 5727.9 5762.0 5762.5 5770.5 5818.8 5664.1 5706.9 5721.3 5724.0 5741.5 01:52:14 INFO - 2015-11-20 01:52:14,635 DEBUG : BROWSER_OUTPUT: 01:52:14 INFO - 2015-11-20 01:52:14,635 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47361.75 Median:37875.22 stddev:81228.64 (214.5%) stddev-sans-first:81380.39 01:52:14 INFO - 2015-11-20 01:52:14,635 DEBUG : BROWSER_OUTPUT: Values: 526.4 557.1 564.6 570.7 600.3 30895.0 31861.4 39188.6 39593.2 39718.0 42156.0 42557.6 42577.8 42680.0 42752.4 8723.5 8886.7 8897.9 8916.8 8926.5 8627.8 8630.2 8695.1 8727.8 8737.8 8686.3 8787.6 8787.8 8789.3 8812.1 8701.8 8733.3 8788.2 8790.5 8818.4 8585.7 8628.3 8685.0 8716.9 8736.4 39247.0 39578.8 39669.6 39681.0 39741.8 3290.7 3321.1 3360.0 3430.2 3544.1 29471.7 29892.8 30139.1 30193.2 30688.7 3864.7 3962.5 3969.2 3970.5 3980.9 258831.0 261103.9 261353.0 262188.0 262893.7 41230.8 42190.0 42451.0 57361.0 57735.4 41215.6 41366.4 41397.4 41605.6 41747.0 14824.3 14994.4 15038.2 15041.8 15042.1 11691.8 11772.4 11773.7 11781.5 11785.0 14070.1 14217.4 14294.4 14351.2 14372.2 5784.8 5819.7 5826.3 5864.7 5910.1 969.4 978.4 1026.7 1043.9 1078.1 28358.1 28883.6 28931.0 28984.7 29245.7 1012.8 1063.6 1071.0 1111.5 1142.8 14245.3 14589.3 14745.1 14787.2 16610.8 362556.0 363679.0 364983.0 367662.0 369438.0 54368.2 54690.0 54866.5 54995.7 55050.7 1367.2 1387.4 1404.9 1405.5 1409.9 29119.9 29980.4 30025.2 30410.0 32393.0 49712.0 50055.7 50121.7 50545.7 50688.2 292457.0 292556.0 294665.0 295134.0 295776.0 42042.6 45835.5 45880.5 45934.3 47110.0 43269.4 43587.1 43974.8 44267.8 44387.8 37136.1 37515.4 40777.0 42763.1 42805.4 36881.4 37416.4 37689.4 37722.8 38027.6 36538.8 36819.8 36834.7 37208.4 37232.8 32891.2 33018.1 33184.0 33220.7 33437.5 26323.6 26645.7 27212.3 28465.4 28734.3 01:52:14 INFO - 2015-11-20 01:52:14,636 DEBUG : BROWSER_OUTPUT: 01:52:14 INFO - 2015-11-20 01:52:14,636 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29095.42 Median:4061.41 stddev:91967.69 (2264.4%) stddev-sans-first:92200.35 01:52:14 INFO - 2015-11-20 01:52:14,637 DEBUG : BROWSER_OUTPUT: Values: 346.2 346.7 349.6 352.7 356.6 16320.8 16922.3 17538.9 17981.0 18252.0 10382.0 10945.6 16081.5 16095.4 16188.5 4688.9 4996.6 5115.4 5123.8 5131.2 5075.3 5130.4 5163.3 5909.0 6082.5 5155.6 5314.4 5973.9 6019.0 6022.2 5255.6 5284.9 5288.2 5293.2 5321.4 4963.5 5113.8 5115.8 5128.3 5141.7 11750.6 11803.5 12968.8 20265.3 20269.9 1990.2 2024.9 2032.8 2033.5 2098.5 9041.8 9305.6 9327.9 10433.3 13548.9 1807.4 1815.7 1885.5 1890.5 1898.2 58658.4 59740.4 61037.1 62387.7 62465.4 10104.7 10196.3 10327.7 10338.6 10361.4 13473.8 13516.4 13554.7 13581.5 13615.9 7602.8 7618.2 7631.8 7649.7 7731.2 7384.2 7440.4 7475.6 7482.9 7495.4 4009.5 4113.3 4393.4 4428.3 4443.2 1820.7 1841.1 1843.2 1849.3 1856.2 422.9 438.6 455.0 458.4 467.8 9755.9 10509.6 10564.2 10827.1 10833.2 444.5 449.5 465.6 475.4 480.3 5674.8 5751.0 5778.9 5784.7 5822.0 552056.0 557800.0 560296.0 565846.0 574323.0 71020.3 86502.6 86566.0 87137.6 88585.1 485.8 495.0 497.6 499.5 500.3 10561.2 10682.5 10716.1 10792.9 14601.3 33496.5 33740.3 35513.6 35848.1 36028.0 44567.8 44819.8 45758.0 47187.5 49473.8 9143.1 9582.0 10148.0 10163.9 10165.8 17825.0 17885.7 17891.9 18007.2 18255.8 14032.4 14467.5 14770.6 14786.5 14941.3 14729.4 14989.1 15017.9 15308.3 15348.7 15172.2 15333.8 15468.8 15931.0 15953.1 9012.9 9133.0 9181.3 9720.5 10099.8 14190.6 14647.5 14697.6 14857.9 15127.7 01:52:14 INFO - 2015-11-20 01:52:14,637 DEBUG : BROWSER_OUTPUT: 01:52:14 INFO - 2015-11-20 01:52:14,638 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5332.11 Median:6364.40 stddev:2659.42 (41.8%) stddev-sans-first:2651.11 01:52:14 INFO - 2015-11-20 01:52:14,638 DEBUG : BROWSER_OUTPUT: Values: 1479.4 1698.7 1738.7 1753.9 1768.1 7218.9 7363.4 7396.6 7708.6 7722.9 7639.2 7696.9 7767.3 7776.3 7780.7 2234.3 2242.0 2261.7 2261.9 2279.3 2239.7 2266.9 2276.9 2278.0 2278.7 2158.0 2194.2 2221.2 2225.2 2226.4 2205.7 2258.6 2280.0 2283.6 2286.2 2203.9 2252.7 2265.8 2267.8 2268.0 7419.2 7487.2 7493.0 7496.7 7506.3 4657.4 4670.1 4684.7 4719.6 4729.0 3091.6 3118.8 3164.6 3166.8 3184.1 1010.6 1029.1 1961.4 1964.3 1972.5 9836.9 9858.5 9867.9 9908.1 9923.7 4100.5 4108.6 4122.5 4198.7 4274.6 8361.2 8364.7 8380.7 8388.7 8391.7 4577.9 4616.4 4619.1 4631.7 4642.7 4227.3 4239.6 4257.9 4261.8 4274.0 3372.5 3377.0 3407.3 3412.0 3428.3 1060.7 1065.2 1066.5 1072.5 1076.1 1078.1 1089.1 1092.1 1258.6 1363.8 6794.8 6933.8 6947.5 6948.5 7080.4 1164.1 1165.8 1166.5 1170.5 1175.9 5672.7 5675.1 5688.7 5692.7 5711.9 8827.9 8852.4 9006.5 9131.0 9158.9 8890.5 8993.5 9033.4 9056.5 9058.2 6805.0 6855.6 7052.9 7074.4 7103.0 7105.8 7116.0 7145.0 7165.9 7171.5 7796.0 8132.1 8138.9 8226.1 8248.5 8227.0 8275.7 8348.0 8367.0 8413.4 6675.9 6691.0 6830.0 6832.9 6854.2 7368.3 7392.7 7407.9 7413.6 7415.0 6677.1 6777.8 6892.2 7022.8 7092.1 6672.1 6839.0 6912.3 6970.7 6995.0 6831.3 6978.2 6984.4 6994.4 6995.4 6292.8 6333.5 6334.8 6348.5 6377.4 6346.6 6357.7 6371.1 6403.4 6423.5 01:52:14 INFO - 2015-11-20 01:52:14,638 DEBUG : BROWSER_OUTPUT: 01:52:14 INFO - 2015-11-20 01:52:14,638 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5632.39 Median:6380.35 stddev:1737.76 (27.2%) stddev-sans-first:1696.40 01:52:14 INFO - 2015-11-20 01:52:14,638 DEBUG : BROWSER_OUTPUT: Values: 327.5 327.9 334.3 336.8 348.4 6209.9 6212.4 6289.9 6296.2 6330.9 6134.9 6224.9 6275.5 6276.7 6290.8 4763.6 4767.0 4786.5 4792.4 4793.4 4765.1 4791.4 4796.3 4814.3 4826.6 4678.6 4773.1 4775.6 4777.6 4780.1 4730.0 4751.5 4752.7 4772.0 4775.0 4111.3 4121.2 4136.4 4140.2 4140.4 5933.3 5962.9 5972.8 5980.8 5986.1 5428.9 5554.5 5557.0 5560.6 5562.4 6667.4 6673.1 6691.1 6692.2 6695.4 4580.5 4581.6 4584.1 4599.7 4607.9 6834.5 6986.3 7000.1 7008.7 7014.7 4711.9 4712.4 4716.7 4717.5 4719.1 4766.9 4772.5 4773.0 4773.3 4783.2 5562.1 5567.7 5570.8 5572.4 5574.9 6608.8 6764.8 6775.8 6780.1 6788.0 1615.8 1647.9 1649.2 1655.3 1680.9 1064.3 1071.8 1075.7 1084.2 1092.3 6375.8 6384.9 6420.9 6450.9 6477.4 6895.2 6916.0 6925.0 6932.8 6937.3 6418.6 6449.2 6461.1 6462.5 6464.0 3791.1 3796.1 3804.0 3830.6 3839.7 7390.9 7404.3 7425.3 7426.5 7432.8 7055.9 7150.9 7239.3 7294.6 7296.6 7272.4 7357.0 7380.5 7387.0 7430.2 7032.8 7095.3 7101.0 7104.6 7114.1 6792.5 6893.3 6912.9 6950.5 6993.4 7325.0 7365.3 7391.1 7392.3 7407.5 4724.5 4769.3 4772.2 4774.9 4775.7 6847.7 6885.2 6983.1 7003.4 7006.9 6743.8 6754.2 6758.9 6792.0 6803.7 6777.2 6790.5 6812.6 6820.0 6845.4 6474.2 6605.8 6634.5 6636.3 6636.9 6835.1 6851.1 6852.2 6865.5 6891.9 6688.2 6713.5 6713.7 6721.4 6724.7 01:52:14 INFO - 2015-11-20 01:52:14,638 DEBUG : BROWSER_OUTPUT: 01:52:14 INFO - 2015-11-20 01:52:14,639 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13566.37 Median:47068.65 stddev:15591.26 (33.1%) stddev-sans-first:15605.15 01:52:14 INFO - 2015-11-20 01:52:14,640 DEBUG : BROWSER_OUTPUT: Values: 719.3 813.8 818.8 827.9 828.5 11590.7 11651.7 12110.4 12319.0 12337.4 12421.4 12472.3 12502.5 12553.3 12649.2 809.3 810.6 821.4 825.4 826.1 808.7 813.7 814.3 820.5 823.6 848.3 859.1 860.4 863.4 863.7 856.6 856.8 857.3 857.4 858.3 626.3 630.6 631.3 631.4 632.5 11987.1 12389.2 12399.8 12417.4 12423.0 12299.8 12313.9 12379.8 12388.2 12816.4 9981.0 9986.9 10142.8 10183.7 10439.6 3612.0 3622.1 3643.6 3645.7 3761.9 45057.5 45389.8 45699.0 45729.0 45831.5 9746.9 9751.5 9809.1 9885.7 9980.6 17867.6 17999.8 18277.9 18303.6 18316.8 7385.7 7387.3 7419.4 7648.2 7710.4 4230.3 4314.4 4349.1 4356.2 4370.2 3099.1 3118.4 3121.9 3127.7 3127.8 561.1 568.3 568.5 575.9 582.4 635.4 640.9 644.8 654.7 716.7 8300.1 8646.5 8669.4 8925.0 8980.0 508.2 613.8 637.7 643.4 645.3 3826.1 3882.4 3914.3 4119.6 4152.2 53091.5 54313.0 54881.2 55887.4 56586.7 48786.0 49054.5 49186.8 49526.0 49545.0 45981.5 46869.3 47268.0 47381.8 47480.8 8270.1 8429.3 8451.0 8559.9 8691.9 34234.5 34680.3 35392.8 35420.8 35691.1 45721.0 45771.5 45887.0 46184.3 46365.5 10827.4 10920.7 10991.6 11097.5 11105.7 12435.4 12456.8 12501.6 12527.0 13143.7 11188.8 11309.6 11435.3 11559.2 11630.5 11358.7 11666.7 11704.4 11731.9 11915.1 10762.0 11109.8 11248.3 11494.6 11574.2 9823.2 9881.2 9910.5 9983.0 10107.2 8461.7 8502.0 8731.0 9413.3 9464.7 01:52:14 INFO - 2015-11-20 01:52:14,640 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:52:14 INFO - 2015-11-20 01:52:14,640 DEBUG : BROWSER_OUTPUT: 01:52:15 INFO - 2015-11-20 01:52:15,241 INFO : Browser exited with error code: 0 01:52:15 INFO - 2015-11-20 01:52:15,260 INFO : Completed test dromaeo_css (00:18:29) 01:52:15 INFO - 2015-11-20 01:52:15,260 INFO : Starting test kraken 01:52:15 INFO - 2015-11-20 01:52:15,260 DEBUG : operating with platform_type : linux_ 01:52:15 INFO - 2015-11-20 01:52:15,260 INFO : Initialising browser for kraken test... 01:52:15 INFO - 2015-11-20 01:52:15,266 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbTDeM0/profile http://localhost:59301/getInfo.html 01:52:19 INFO - 2015-11-20 01:52:19,590 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:52:19 INFO - 2015-11-20 01:52:19,590 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:52:19 INFO - 2015-11-20 01:52:19,590 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:52:19 INFO - 2015-11-20 01:52:19,591 DEBUG : BROWSER_OUTPUT: __metrics 01:52:20 INFO - 2015-11-20 01:52:20,573 INFO : Browser initialized. 01:52:20 INFO - 2015-11-20 01:52:20,573 INFO : Running cycle 1/1 for kraken test... 01:52:20 INFO - 2015-11-20 01:52:20,574 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbTDeM0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:52:32 INFO - 2015-11-20 01:52:32,401 DEBUG : BROWSER_OUTPUT: RSS: Main: 141840384 01:52:32 INFO - 2015-11-20 01:52:32,402 DEBUG : BROWSER_OUTPUT: 01:52:34 INFO - 2015-11-20 01:52:34,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59301/tests/kraken/driver.html?testName=audio-beat-detection) 01:52:35 INFO - 2015-11-20 01:52:35,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 141881344 01:52:35 INFO - 2015-11-20 01:52:35,508 DEBUG : BROWSER_OUTPUT: 01:52:38 INFO - 2015-11-20 01:52:38,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59301/tests/kraken/driver.html?testName=audio-dft) 01:52:38 INFO - 2015-11-20 01:52:38,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 142635008 01:52:38 INFO - 2015-11-20 01:52:38,739 DEBUG : BROWSER_OUTPUT: 01:52:41 INFO - 2015-11-20 01:52:41,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59301/tests/kraken/driver.html?testName=audio-fft) 01:52:42 INFO - 2015-11-20 01:52:42,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 137150464 01:52:42 INFO - 2015-11-20 01:52:42,165 DEBUG : BROWSER_OUTPUT: 01:52:44 INFO - 2015-11-20 01:52:44,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59301/tests/kraken/driver.html?testName=audio-oscillator) 01:52:44 INFO - 2015-11-20 01:52:44,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 137998336 01:52:44 INFO - 2015-11-20 01:52:44,682 DEBUG : BROWSER_OUTPUT: 01:52:46 INFO - 2015-11-20 01:52:46,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59301/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:52:47 INFO - 2015-11-20 01:52:47,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 138235904 01:52:47 INFO - 2015-11-20 01:52:47,436 DEBUG : BROWSER_OUTPUT: 01:52:50 INFO - 2015-11-20 01:52:50,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59301/tests/kraken/driver.html?testName=imaging-darkroom) 01:52:50 INFO - 2015-11-20 01:52:50,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 137752576 01:52:50 INFO - 2015-11-20 01:52:50,989 DEBUG : BROWSER_OUTPUT: 01:52:54 INFO - 2015-11-20 01:52:54,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59301/tests/kraken/driver.html?testName=imaging-desaturate) 01:52:54 INFO - 2015-11-20 01:52:54,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 138977280 01:52:54 INFO - 2015-11-20 01:52:54,981 DEBUG : BROWSER_OUTPUT: 01:52:57 INFO - 2015-11-20 01:52:57,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59301/tests/kraken/driver.html?testName=json-parse-financial) 01:52:58 INFO - 2015-11-20 01:52:58,427 DEBUG : BROWSER_OUTPUT: RSS: Main: 139706368 01:52:58 INFO - 2015-11-20 01:52:58,427 DEBUG : BROWSER_OUTPUT: 01:53:00 INFO - 2015-11-20 01:53:00,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59301/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:53:00 INFO - 2015-11-20 01:53:00,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 140275712 01:53:00 INFO - 2015-11-20 01:53:00,586 DEBUG : BROWSER_OUTPUT: 01:53:02 INFO - 2015-11-20 01:53:02,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59301/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:53:03 INFO - 2015-11-20 01:53:03,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 139923456 01:53:03 INFO - 2015-11-20 01:53:03,043 DEBUG : BROWSER_OUTPUT: 01:53:05 INFO - 2015-11-20 01:53:05,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59301/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:53:05 INFO - 2015-11-20 01:53:05,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 139673600 01:53:05 INFO - 2015-11-20 01:53:05,722 DEBUG : BROWSER_OUTPUT: 01:53:08 INFO - 2015-11-20 01:53:08,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:53:08 INFO - 2015-11-20 01:53:08,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 140398592 01:53:08 INFO - 2015-11-20 01:53:08,803 DEBUG : BROWSER_OUTPUT: 01:53:11 INFO - 2015-11-20 01:53:11,383 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:53:11 INFO - 2015-11-20 01:53:11,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 140451840 01:53:11 INFO - 2015-11-20 01:53:11,969 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59301/tests/kraken/driver.html?testName=ai-astar) 01:53:13 INFO - 2015-11-20 01:53:13,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 138817536 01:53:13 INFO - 2015-11-20 01:53:13,905 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,906 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:53:13 INFO - 2015-11-20 01:53:13,906 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:53:13 INFO - 2015-11-20 01:53:13,906 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:53:13 INFO - 2015-11-20 01:53:13,907 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:53:13 INFO - 2015-11-20 01:53:13,907 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;108;112;112;112;123;112;111;111;112 01:53:13 INFO - 2015-11-20 01:53:13,907 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;125;157;164;126;165;153;127;160;124 01:53:13 INFO - 2015-11-20 01:53:13,907 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;166;161;161;163;159;163;168;168;164 01:53:13 INFO - 2015-11-20 01:53:13,908 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;74;73;72;130;71;73;73;73 01:53:13 INFO - 2015-11-20 01:53:13,908 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;134;90;92;93;133;91;92;135 01:53:13 INFO - 2015-11-20 01:53:13,908 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;111;110;110;109;110;110;110 01:53:13 INFO - 2015-11-20 01:53:13,908 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;146;147;147;148;148;146;146;146 01:53:13 INFO - 2015-11-20 01:53:13,908 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;96;97;97;96;96;96 01:53:13 INFO - 2015-11-20 01:53:13,908 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;62;63;61;61;66;65;62;58;62 01:53:13 INFO - 2015-11-20 01:53:13,908 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;74;69;69;70;71;69;69;69;70 01:53:13 INFO - 2015-11-20 01:53:13,909 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;93;86;86;85;84;86;93;85 01:53:13 INFO - 2015-11-20 01:53:13,909 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;125;125;121;129;119;116;126;128;121 01:53:13 INFO - 2015-11-20 01:53:13,909 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;151;150;151;151;143;155;150;154;151 01:53:13 INFO - 2015-11-20 01:53:13,909 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;68;69;68;66;66;67;68;70 01:53:13 INFO - 2015-11-20 01:53:13,909 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:53:13 INFO - 2015-11-20 01:53:13,909 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:53:13 INFO - 2015-11-20 01:53:13,909 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,715 01:53:13 INFO - 2015-11-20 01:53:13,909 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:53:13 INFO - 2015-11-20 01:53:13,909 DEBUG : BROWSER_OUTPUT: __startTimestamp1448013193905__endTimestamp 01:53:13 INFO - 2015-11-20 01:53:13,909 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,913 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:53:13 INFO - 2015-11-20 01:53:13,913 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:53:13 INFO - 2015-11-20 01:53:13,913 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,913 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.60 Median:112.00 stddev:3.89 (3.5%) stddev-sans-first:4.13 01:53:13 INFO - 2015-11-20 01:53:13,913 DEBUG : BROWSER_OUTPUT: Values: 113.0 108.0 112.0 112.0 112.0 123.0 112.0 111.0 111.0 112.0 01:53:13 INFO - 2015-11-20 01:53:13,913 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,913 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.40 Median:155.00 stddev:17.58 (11.3%) stddev-sans-first:18.43 01:53:13 INFO - 2015-11-20 01:53:13,914 DEBUG : BROWSER_OUTPUT: Values: 153.0 125.0 157.0 164.0 126.0 165.0 153.0 127.0 160.0 124.0 01:53:13 INFO - 2015-11-20 01:53:13,914 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,914 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:3.10 (1.9%) stddev-sans-first:3.16 01:53:13 INFO - 2015-11-20 01:53:13,914 DEBUG : BROWSER_OUTPUT: Values: 161.0 166.0 161.0 161.0 163.0 159.0 163.0 168.0 168.0 164.0 01:53:13 INFO - 2015-11-20 01:53:13,914 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,914 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.20 Median:73.00 stddev:18.23 (25.0%) stddev-sans-first:19.19 01:53:13 INFO - 2015-11-20 01:53:13,914 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 74.0 73.0 72.0 130.0 71.0 73.0 73.0 73.0 01:53:13 INFO - 2015-11-20 01:53:13,914 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,915 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.30 Median:91.50 stddev:20.52 (22.4%) stddev-sans-first:21.27 01:53:13 INFO - 2015-11-20 01:53:13,915 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 134.0 90.0 92.0 93.0 133.0 91.0 92.0 135.0 01:53:13 INFO - 2015-11-20 01:53:13,915 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,915 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 01:53:13 INFO - 2015-11-20 01:53:13,915 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 111.0 110.0 110.0 109.0 110.0 110.0 110.0 01:53:13 INFO - 2015-11-20 01:53:13,915 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,915 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 01:53:13 INFO - 2015-11-20 01:53:13,915 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 146.0 147.0 147.0 148.0 148.0 146.0 146.0 146.0 01:53:13 INFO - 2015-11-20 01:53:13,915 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,915 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 01:53:13 INFO - 2015-11-20 01:53:13,915 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 96.0 97.0 97.0 96.0 96.0 96.0 01:53:13 INFO - 2015-11-20 01:53:13,915 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,915 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.00 stddev:2.20 (3.6%) stddev-sans-first:2.33 01:53:13 INFO - 2015-11-20 01:53:13,916 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 63.0 61.0 61.0 66.0 65.0 62.0 58.0 62.0 01:53:13 INFO - 2015-11-20 01:53:13,916 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,916 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:69.50 stddev:1.60 (2.3%) stddev-sans-first:1.66 01:53:13 INFO - 2015-11-20 01:53:13,916 DEBUG : BROWSER_OUTPUT: Values: 69.0 74.0 69.0 69.0 70.0 71.0 69.0 69.0 69.0 70.0 01:53:13 INFO - 2015-11-20 01:53:13,916 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,916 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.00 stddev:3.57 (4.1%) stddev-sans-first:3.67 01:53:13 INFO - 2015-11-20 01:53:13,916 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 93.0 86.0 86.0 85.0 84.0 86.0 93.0 85.0 01:53:13 INFO - 2015-11-20 01:53:13,916 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,916 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:125.50 stddev:4.75 (3.8%) stddev-sans-first:4.33 01:53:13 INFO - 2015-11-20 01:53:13,916 DEBUG : BROWSER_OUTPUT: Values: 131.0 125.0 125.0 121.0 129.0 119.0 116.0 126.0 128.0 121.0 01:53:13 INFO - 2015-11-20 01:53:13,917 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,917 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:151.00 stddev:4.62 (3.1%) stddev-sans-first:3.35 01:53:13 INFO - 2015-11-20 01:53:13,917 DEBUG : BROWSER_OUTPUT: Values: 140.0 151.0 150.0 151.0 151.0 143.0 155.0 150.0 154.0 151.0 01:53:13 INFO - 2015-11-20 01:53:13,917 DEBUG : BROWSER_OUTPUT: 01:53:13 INFO - 2015-11-20 01:53:13,917 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.33 (1.9%) stddev-sans-first:1.36 01:53:13 INFO - 2015-11-20 01:53:13,917 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 69.0 68.0 66.0 66.0 67.0 68.0 70.0 01:53:13 INFO - 2015-11-20 01:53:13,917 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:53:13 INFO - 2015-11-20 01:53:13,917 DEBUG : BROWSER_OUTPUT: 01:53:14 INFO - 2015-11-20 01:53:14,749 INFO : Browser exited with error code: 0 01:53:14 INFO - 2015-11-20 01:53:14,800 INFO : Completed test kraken (00:00:59) 01:53:14 INFO - 2015-11-20 01:53:14,800 INFO : Starting test v8_7 01:53:14 INFO - 2015-11-20 01:53:14,800 DEBUG : operating with platform_type : linux_ 01:53:14 INFO - 2015-11-20 01:53:14,800 INFO : Initialising browser for v8_7 test... 01:53:14 INFO - 2015-11-20 01:53:14,806 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt1Y_hE/profile http://localhost:59301/getInfo.html 01:53:19 INFO - 2015-11-20 01:53:19,112 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:53:19 INFO - 2015-11-20 01:53:19,112 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:53:19 INFO - 2015-11-20 01:53:19,112 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:53:19 INFO - 2015-11-20 01:53:19,112 DEBUG : BROWSER_OUTPUT: __metrics 01:53:20 INFO - 2015-11-20 01:53:20,101 INFO : Browser initialized. 01:53:20 INFO - 2015-11-20 01:53:20,101 INFO : Running cycle 1/1 for v8_7 test... 01:53:20 INFO - 2015-11-20 01:53:20,102 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt1Y_hE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:53:31 INFO - 2015-11-20 01:53:31,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 141402112 01:53:31 INFO - 2015-11-20 01:53:31,944 DEBUG : BROWSER_OUTPUT: 01:53:53 INFO - 2015-11-20 01:53:53,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59301/tests/v8_7/run.html (next: http://localhost:59301/tests/v8_7/run.html) 01:53:53 INFO - 2015-11-20 01:53:53,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 137613312 01:53:53 INFO - 2015-11-20 01:53:53,624 DEBUG : BROWSER_OUTPUT: 01:53:53 INFO - 2015-11-20 01:53:53,624 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:53:53 INFO - 2015-11-20 01:53:53,624 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:53:53 INFO - 2015-11-20 01:53:53,624 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:53:53 INFO - 2015-11-20 01:53:53,625 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:53:53 INFO - 2015-11-20 01:53:53,625 DEBUG : BROWSER_OUTPUT: |0;Richards;164.06890894175552 01:53:53 INFO - 2015-11-20 01:53:53,625 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.0219675262655 01:53:53 INFO - 2015-11-20 01:53:53,625 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.662363177098 01:53:53 INFO - 2015-11-20 01:53:53,625 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025.125628140703 01:53:53 INFO - 2015-11-20 01:53:53,626 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1058.2010582010582 01:53:53 INFO - 2015-11-20 01:53:53,626 DEBUG : BROWSER_OUTPUT: |5;Earley;709.2198581560284 01:53:53 INFO - 2015-11-20 01:53:53,626 DEBUG : BROWSER_OUTPUT: |6;Boyer;12204.819277108434 01:53:53 INFO - 2015-11-20 01:53:53,626 DEBUG : BROWSER_OUTPUT: |7;RegExp;25250 01:53:53 INFO - 2015-11-20 01:53:53,626 DEBUG : BROWSER_OUTPUT: |8;Splay;636.1323155216285 01:53:53 INFO - 2015-11-20 01:53:53,627 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 01:53:53 INFO - 2015-11-20 01:53:53,627 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:53:53 INFO - 2015-11-20 01:53:53,627 DEBUG : BROWSER_OUTPUT: __startTimestamp1448013233618__endTimestamp 01:53:53 INFO - 2015-11-20 01:53:53,627 DEBUG : BROWSER_OUTPUT: 01:53:53 INFO - 2015-11-20 01:53:53,627 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:53:53 INFO - 2015-11-20 01:53:53,628 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:53:53 INFO - 2015-11-20 01:53:53,628 DEBUG : BROWSER_OUTPUT: 01:53:53 INFO - 2015-11-20 01:53:53,628 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.07 Median:164.07 stddev:0.00 (0.0%) 01:53:53 INFO - 2015-11-20 01:53:53,628 DEBUG : BROWSER_OUTPUT: Values: 164.1 01:53:53 INFO - 2015-11-20 01:53:53,628 DEBUG : BROWSER_OUTPUT: 01:53:53 INFO - 2015-11-20 01:53:53,629 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.02 Median:191.02 stddev:0.00 (0.0%) 01:53:53 INFO - 2015-11-20 01:53:53,629 DEBUG : BROWSER_OUTPUT: Values: 191.0 01:53:53 INFO - 2015-11-20 01:53:53,629 DEBUG : BROWSER_OUTPUT: 01:53:53 INFO - 2015-11-20 01:53:53,629 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.66 Median:280.66 stddev:0.00 (0.0%) 01:53:53 INFO - 2015-11-20 01:53:53,629 DEBUG : BROWSER_OUTPUT: Values: 280.7 01:53:53 INFO - 2015-11-20 01:53:53,629 DEBUG : BROWSER_OUTPUT: 01:53:53 INFO - 2015-11-20 01:53:53,629 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.13 Median:5025.13 stddev:0.00 (0.0%) 01:53:53 INFO - 2015-11-20 01:53:53,629 DEBUG : BROWSER_OUTPUT: Values: 5025.1 01:53:53 INFO - 2015-11-20 01:53:53,629 DEBUG : BROWSER_OUTPUT: 01:53:53 INFO - 2015-11-20 01:53:53,629 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1058.20 Median:1058.20 stddev:0.00 (0.0%) 01:53:53 INFO - 2015-11-20 01:53:53,630 DEBUG : BROWSER_OUTPUT: Values: 1058.2 01:53:53 INFO - 2015-11-20 01:53:53,630 DEBUG : BROWSER_OUTPUT: 01:53:53 INFO - 2015-11-20 01:53:53,630 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:709.22 Median:709.22 stddev:0.00 (0.0%) 01:53:53 INFO - 2015-11-20 01:53:53,630 DEBUG : BROWSER_OUTPUT: Values: 709.2 01:53:53 INFO - 2015-11-20 01:53:53,630 DEBUG : BROWSER_OUTPUT: 01:53:53 INFO - 2015-11-20 01:53:53,630 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12204.82 Median:12204.82 stddev:0.00 (0.0%) 01:53:53 INFO - 2015-11-20 01:53:53,630 DEBUG : BROWSER_OUTPUT: Values: 12204.8 01:53:53 INFO - 2015-11-20 01:53:53,630 DEBUG : BROWSER_OUTPUT: 01:53:53 INFO - 2015-11-20 01:53:53,630 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25250.00 Median:25250.00 stddev:0.00 (0.0%) 01:53:53 INFO - 2015-11-20 01:53:53,630 DEBUG : BROWSER_OUTPUT: Values: 25250.0 01:53:53 INFO - 2015-11-20 01:53:53,631 DEBUG : BROWSER_OUTPUT: 01:53:53 INFO - 2015-11-20 01:53:53,631 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:636.13 Median:636.13 stddev:0.00 (0.0%) 01:53:53 INFO - 2015-11-20 01:53:53,631 DEBUG : BROWSER_OUTPUT: Values: 636.1 01:53:53 INFO - 2015-11-20 01:53:53,631 DEBUG : BROWSER_OUTPUT: 01:53:53 INFO - 2015-11-20 01:53:53,631 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 01:53:53 INFO - 2015-11-20 01:53:53,631 DEBUG : BROWSER_OUTPUT: Values: 4840.6 01:53:53 INFO - 2015-11-20 01:53:53,631 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:53:53 INFO - 2015-11-20 01:53:53,631 DEBUG : BROWSER_OUTPUT: 01:53:54 INFO - 2015-11-20 01:53:54,517 INFO : Browser exited with error code: 0 01:53:54 INFO - 2015-11-20 01:53:54,531 INFO : Completed test v8_7 (00:00:39) 01:53:54 INFO - 2015-11-20 01:53:54,684 INFO : Completed test suite (00:20:09) 01:53:54 INFO - 2015-11-20 01:53:54,684 DEBUG : Working with test: dromaeo_css 01:53:54 INFO - 2015-11-20 01:53:54,684 DEBUG : Generating results file: dromaeo_css 01:53:54 INFO - 2015-11-20 01:53:54,685 DEBUG : Working with test: kraken 01:53:54 INFO - 2015-11-20 01:53:54,685 DEBUG : Generating results file: kraken 01:53:54 INFO - 2015-11-20 01:53:54,685 INFO : javascript benchmark 01:53:54 INFO - 2015-11-20 01:53:54,686 DEBUG : Working with test: v8_7 01:53:54 INFO - 2015-11-20 01:53:54,686 DEBUG : Generating results file: v8_7 01:53:54 INFO - 2015-11-20 01:53:54,686 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:53:54 INFO - 2015-11-20 01:53:54,736 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 01:53:54 INFO - 2015-11-20 01:53:54,737 DEBUG : process_Request line: dromaeo_css 6959.15 graph.html#tests=[[72,64,43]] 01:53:54 INFO - 2015-11-20 01:53:54,737 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:53:54 INFO - 2015-11-20 01:53:54,769 DEBUG : process_Request line: kraken 1517.50 graph.html#tests=[[232,64,43]] 01:53:54 INFO - 2015-11-20 01:53:54,769 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:53:54 INFO - 2015-11-20 01:53:54,796 DEBUG : process_Request line: v8_7 21362.25 graph.html#tests=[[230,64,43]] 01:53:54 INFO - 2015-11-20 01:53:54,797 INFO : javascript benchmark 01:53:54 INFO - 2015-11-20 01:53:54,801 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3255.739540836733, 3330.7668463207583, 3351.631320554737, 3375.9493607595873, 3389.559357283554, 5268.341457317835, 5497.862553436166, 5511.283533140691, 5518.91721624176, 5524.64089834161, 5440.510354068133, 5454.645448045874, 5457.536109430703, 5510.972445137769, 5533.47431993961, 4640.303954406849, 4952.331435256248, 5074.416442109149, 5079.136546787036, 5106.131957567204, 4942.18453955097, 5052.772625231855, 5096.311997880276, 5121.3342265505435, 5149.0, 5012.147934851102, 5045.091883460976, 5072.568831649277, 5091.1854103343285, 5130.0, 5049.495050494921, 5060.873478163038, 5066.290719299301, 5076.568491678212, 5108.131617624976, 4966.106100901836, 5023.171176755831, 5029.119904016819, 5032.547070763649, 5062.620303477254, 5166.819161329373, 5172.069027575035, 5203.427622961472, 5228.607854410896, 5283.894322113536, 5899.174115623816, 5899.292084949833, 5899.793507227227, 5911.142884281755, 5914.556408269397, 5848.239728835267, 5927.851803704942, 5949.286085669704, 5996.700164991733, 6052.697365131769, 5566.777328906839, 5596.412376700469, 5601.383847776741, 5605.859853503654, 5627.6904770237625, 6007.459328660441, 6024.0, 6053.818385448443, 6057.969710151421, 6090.786822461193, 5761.53907687384, 5826.533877289891, 5874.795666888278, 5888.440598143169, 5943.227380440515, 5904.114382842522, 5905.40945905406, 5934.584579079423, 5948.762049517971, 5951.196588460589, 5883.14694369314, 5915.201447804578, 5933.228680271537, 5934.43622855828, 5938.376470470625, 5720.856978575569, 5785.1322301654245, 5819.854503637443, 5890.970545147246, 5932.228810254639, 4556.17988762026, 4559.817607295738, 4571.994161284512, 4595.862124136282, 4611.5619016193405, 3989.0027493126718, 4057.2899742544937, 4072.511298644182, 4077.2660921033907, 4100.6924480664065, 5520.171974203821, 5548.77804887808, 5560.916586251209, 5618.775248989995, 5627.943720562824, 6011.759529618854, 6035.547333949971, 6037.78867739627, 6038.698065096728, 6048.395160484004, 5461.590380721462, 5548.722563871871, 5639.097744360883, 5672.290963629546, 5699.629524080921, 5068.493150684902, 5114.590832733373, 5136.845894623168, 5145.845624631267, 5180.948190518122, 6060.696965151725, 6080.270367555921, 6086.117512960596, 6135.9079613805825, 6188.659623720739, 5759.193712880284, 5850.531957443309, 5851.239338886088, 5977.760889564369, 5987.34139244674, 6060.272822245639, 6116.149912098478, 6168.25980882297, 6182.0, 6193.81418557444, 5832.445917637818, 5891.23413956183, 5902.970485147547, 5908.822735317947, 5917.733701983335, 5775.768969241351, 5872.882542349214, 5907.9704601476715, 5976.462118409364, 5998.70006499682, 5813.94186058134, 5822.155787410887, 5823.272090988627, 5831.096180092092, 5881.970590147193, 5769.019266724583, 5769.07694768835, 5773.364929857628, 5773.797917072882, 5808.738606762621, 5467.617266791286, 5514.255575497417, 5542.251796007487, 5636.0418728815375, 5642.210090587403, 5727.942720572908, 5761.971190144022, 5762.510186634183, 5770.451807078321, 5818.796342128006, 5664.122061080539, 5706.914396284142, 5721.313442386941, 5724.026915424304, 5741.45456181662], "unit": "ms", "name": "dojo.html", "value": 5455.54339647385}, {"lowerIsBetter": false, "replicates": [526.3999041093155, 557.0863783395232, 564.5511818104608, 570.7089384413947, 600.3336296710653, 30895.0, 31861.36277274453, 39188.60811391885, 39593.20813583727, 39718.0, 42156.0, 42557.57442425575, 42577.78711106448, 42680.0, 42752.35871461923, 8723.520206388646, 8886.73339799807, 8897.866532002025, 8916.821663566725, 8926.46441213526, 8627.79210910473, 8630.223279904807, 8695.087015863339, 8727.781805454852, 8737.7815554611, 8686.348523860705, 8787.604557794883, 8787.78030549235, 8789.340799440035, 8812.074732153127, 8701.825963480727, 8733.34499912509, 8788.16512431318, 8790.472571645658, 8818.382713210078, 8585.656573737044, 8628.266597339234, 8685.044645089036, 8716.869246961302, 8736.388452808305, 39247.0, 39578.80210598958, 39669.60330396688, 39681.0, 39741.80129099365, 3290.654481279455, 3321.110216736723, 3360.0, 3430.1939044324563, 3544.149404143013, 29471.705282947325, 29892.8235100674, 30139.09582712522, 30193.245168870733, 30688.693113068806, 3864.7487913285545, 3962.5046869141356, 3969.166475040245, 3970.4838371011874, 3980.920381592352, 258831.0, 261103.9448027591, 261353.0, 262188.0, 262893.685531573, 41230.79384603058, 42190.0, 42451.0, 57361.0, 57735.42264577385, 41215.587844121175, 41366.37950430746, 41397.37903931444, 41605.583944160775, 41747.0, 14824.258787060604, 14994.425585313604, 15038.172900490577, 15041.849581504264, 15042.097474151367, 11691.824622630667, 11772.411379430994, 11773.704892461994, 11781.469833857496, 11785.0, 14070.085444446078, 14217.36021879018, 14294.428222871176, 14351.210683412513, 14372.191369287148, 5784.768609255667, 5819.709014549256, 5826.271716035496, 5864.706764661835, 5910.143029260819, 969.4474149734724, 978.3542861711236, 1026.6868605075374, 1043.8695163104612, 1078.1051727066515, 28358.149255522367, 28883.56674649882, 28931.0, 28984.710152898624, 29245.707542924723, 1012.792377562598, 1063.5798859450474, 1070.9946450267698, 1111.4942701070993, 1142.845715828369, 14245.287735613178, 14589.270536473134, 14745.11529308245, 14787.186704731343, 16610.833891661172, 362556.0, 363679.0, 364983.0, 367662.0, 369438.0, 54368.18447723287, 54690.0, 54866.451335486934, 54995.72502137464, 55050.724746376014, 1367.2138520350838, 1387.4450219912117, 1404.908680935736, 1405.4588983241322, 1409.9224542650047, 29119.85440072786, 29980.400391991603, 30025.249368765955, 30410.0, 32393.0, 49712.0, 50055.74972125116, 50121.74939125281, 50545.74727126341, 50688.23967640415, 292457.0, 292556.0, 294665.0, 295134.0, 295776.0, 42042.57957420387, 45835.54164458313, 45880.541194588965, 45934.31098533458, 47110.0, 43269.350959735, 43587.12825743531, 43974.78012610044, 44267.77866110649, 44387.77806111078, 37136.07159821026, 37515.43726844045, 40777.0, 42763.14473710571, 42805.35791963185, 36881.44677829889, 37416.43875341817, 37689.43465848069, 37722.81138594289, 38027.61972380241, 36538.8173059133, 36819.81590092139, 36834.71078512239, 37208.44187337246, 37232.81383593065, 32891.17772055622, 33018.12607626673, 33184.0, 33220.66779332176, 33437.49843752297, 26323.605145922444, 26645.733542664326, 27212.31969200786, 28465.43069138564, 28734.281642958256], "unit": "ms", "name": "ext.html", "value": 18384.81980970797}, {"lowerIsBetter": false, "replicates": [346.21063974138974, 346.74860725973673, 349.6101846441217, 352.6808238544117, 356.568552052017, 16320.755188672165, 16922.323107075717, 17538.912305438487, 17980.999999999985, 18252.0, 10382.0, 10945.616903408381, 16081.517554473356, 16095.436659716912, 16188.514344569681, 4688.85933421997, 4996.575291100261, 5115.411727651331, 5123.769430375623, 5131.2303154526935, 5075.289459475676, 5130.410002849664, 5163.328767260251, 5909.025010873201, 6082.482988945945, 5155.587552995751, 5314.388845282803, 5973.850653733648, 6019.036954087347, 6022.156898034279, 5255.579553635719, 5284.894302113975, 5288.153895376721, 5293.179557168645, 5321.4412486688725, 4963.45402005779, 5113.846584602468, 5115.846524604268, 5128.282040514331, 5141.742912854343, 11750.588729394516, 11803.468843902045, 12968.80546791799, 20265.290714825056, 20269.898650506802, 1990.2238127130286, 2024.9493762655904, 2032.8373730101705, 2033.4712974626705, 2098.464891452685, 9041.773955651095, 9305.627774888997, 9327.906720932771, 10433.32183408076, 13548.93225533876, 1807.430659342303, 1815.7035975803967, 1885.538043179416, 1890.5179179309189, 1898.2027548429692, 58658.41341586615, 59740.402595973916, 61037.08444373338, 62387.6880615594, 62465.37534624641, 10104.74738131538, 10196.3372380795, 10327.741806454898, 10338.638147664795, 10361.4301213434, 13473.797893031613, 13516.391762370717, 13554.661133471545, 13581.456741730417, 13615.931920340336, 7602.771916842504, 7618.200088990687, 7631.771046868603, 7649.655765490566, 7731.226877312336, 7384.2246564111065, 7440.367568756608, 7475.5888426136, 7482.8877566836545, 7495.400367970549, 4009.518857737032, 4113.300738874398, 4393.406890069799, 4428.2914733642465, 4443.244648409778, 1820.6995845685578, 1841.1254654039492, 1843.1613615805045, 1849.2695385322722, 1856.201833211705, 422.86679695895697, 438.5789641943706, 454.9545045495424, 458.429255576809, 467.8011844965876, 9755.902440975642, 10509.579616815394, 10564.207684423698, 10827.079698225582, 10833.241673082808, 444.4555419611015, 449.4808496186909, 465.5949324088065, 475.372508289062, 480.34672844930867, 5674.77300907959, 5751.0, 5778.913316300259, 5784.71076446176, 5821.970890145607, 552056.0, 557800.0, 560296.0, 565846.0, 574323.0, 71020.2897971024, 86502.56748716343, 86566.0, 87137.56431217803, 88585.11414885768, 485.82995951416723, 495.0396231311245, 497.56711660855285, 499.5129748495261, 500.2521230760037, 10561.207909406672, 10682.465876705977, 10716.142708583451, 10792.892071079503, 14601.342939567958, 33496.49755253722, 33740.32519349649, 35513.64486355103, 35848.103797404234, 36028.0, 44567.77716111398, 44819.77590112029, 45758.0, 47187.528124718316, 49473.75263123661, 9143.13140251675, 9582.0, 10147.985201479793, 10163.89836101659, 10165.796684066425, 17825.0, 17885.73171402456, 17891.910540447214, 18007.189676464328, 18255.817441825944, 14032.438702451787, 14467.49363772305, 14770.63073423173, 14786.48247311382, 14941.252937353307, 14729.410823567367, 14989.100653960797, 15017.924910375816, 15308.31112599958, 15348.693026139637, 15172.165530895907, 15333.76999345033, 15468.84531154674, 15931.0, 15953.122578258308, 9012.86480702803, 9132.954335228282, 9181.311401644769, 9720.513974301115, 10099.848502272325, 14190.645233868823, 14647.487337943121, 14697.596355571386, 14857.925710371379, 15127.697446051237], "unit": "ms", "name": "jquery.html", "value": 8034.902288993988}, {"lowerIsBetter": false, "replicates": [1479.4304192885736, 1698.6602679464106, 1738.7044202485577, 1753.8775183882317, 1768.080598088993, 7218.8917166242545, 7363.374113200378, 7396.593187374692, 7708.614569271528, 7722.884156737647, 7639.236076392358, 7696.884546731803, 7767.262110099546, 7776.261255180763, 7780.688772449095, 2234.2626933112033, 2241.9663705044436, 2261.728592568894, 2261.8642881427168, 2279.282026161754, 2239.7200349956256, 2266.8526545774553, 2276.8747718875456, 2277.9658305125436, 2278.6582012698063, 2157.9892100539555, 2194.1771835561663, 2221.1559607349186, 2225.2434172381386, 2226.421130506064, 2205.6801763744247, 2258.5934531784274, 2280.04238219948, 2283.5889539882814, 2286.211257116292, 2203.8567493112896, 2252.68462415262, 2265.8187345012525, 2267.807236384909, 2267.977320226793, 7419.183889772121, 7487.1764105948305, 7493.025906632158, 7496.700131994714, 7506.3244308012, 4657.4411070671395, 4670.065986802653, 4684.718916864999, 4719.598834099105, 4728.976355118237, 3091.5517249998848, 3118.8304385855304, 3164.5886034815558, 3166.778325517215, 3184.1243657994005, 1010.600812678995, 1029.0995379043336, 1961.3625571689258, 1964.312490628283, 1972.5167334003118, 9836.90163098367, 9858.457784821832, 9867.90132098677, 9908.108270255712, 9923.652672156511, 4100.507939047334, 4108.589141085928, 4122.525909520444, 4198.685098617616, 4274.572542745763, 8361.205685459872, 8364.707235246737, 8380.748577542683, 8388.748337549883, 8391.664333426594, 4577.931331030038, 4616.422947131608, 4619.099275641218, 4631.698939568917, 4642.744649044335, 4227.323628219531, 4239.576042395735, 4257.936130958038, 4261.765602891871, 4273.957260427356, 3372.5278461015478, 3376.983115084458, 3407.3185362927516, 3411.9658803412144, 3428.3314753623304, 1060.6552870317023, 1065.195777188218, 1066.5467176449977, 1072.4905669806778, 1076.1390887290136, 1078.0513148429332, 1089.0851684584986, 1092.0662833277593, 1258.5972488803495, 1363.8431580368185, 6794.8448763710285, 6933.826654333581, 6947.513674042769, 6948.5483443576, 7080.398166155935, 1164.0861923390098, 1165.7610189911047, 1166.5100657723776, 1170.5025364220173, 1175.9353235572125, 5672.716364181774, 5675.091985282417, 5688.658680479184, 5692.658440493584, 5711.914321285184, 8827.911720882708, 8852.38033337673, 9006.459612423276, 9130.954345228363, 9158.90841091594, 8890.511021893857, 8993.460392376479, 9033.412828166149, 9056.547172641342, 9058.230050445785, 6804.965975170093, 6855.588664680035, 7052.92947070533, 7074.3633073023675, 7103.0, 7105.82235444118, 7116.039334689751, 7145.0, 7165.856682866418, 7171.533850299714, 7795.961020194863, 8132.105468398589, 8138.87791683137, 8226.095129535626, 8248.54632995191, 8227.0, 8275.668973241243, 8348.0, 8367.0, 8413.411061225655, 6675.899861502178, 6691.0, 6830.0, 6832.931670683429, 6854.246032936473, 7368.263173682589, 7392.704291828267, 7407.851842963003, 7413.592252425952, 7414.962925185339, 6677.131972843499, 6777.796666100025, 6892.241853396022, 7022.754203603054, 7092.148942126978, 6672.099266599141, 6839.0, 6912.27421120775, 6970.721171153097, 6994.965025174842, 6831.282715315019, 6978.197507286524, 6984.371406573433, 6994.405475534433, 6995.370416662525, 6292.842678933063, 6333.524985626004, 6334.828056809505, 6348.492120630246, 6377.394147555975, 6346.555741098079, 6357.650329231937, 6371.139896113966, 6403.391677790602, 6423.454006409321], "unit": "ms", "name": "mootools.html", "value": 4460.875396922524}, {"lowerIsBetter": false, "replicates": [327.5414419812262, 327.91310302769756, 334.2929703676721, 336.81811821616327, 348.4164025257693, 6209.9068513972325, 6212.378762123785, 6289.874202515953, 6296.212973378328, 6330.936690633092, 6134.938650613492, 6224.875502489947, 6275.497960163188, 6276.717547710353, 6290.811275661726, 4763.642726795496, 4766.976165119169, 4786.521347865203, 4792.353032340642, 4793.376861008064, 4765.094632019923, 4791.3531673224015, 4796.3045358423005, 4814.277858321262, 4826.589739872115, 4678.5789278964885, 4773.06925149596, 4775.570198682118, 4777.641676874231, 4780.139574876521, 4730.006698593316, 4751.453582837983, 4752.691075080109, 4771.9761401192945, 4774.952250477486, 4111.342185250375, 4121.175764847043, 4136.420901073852, 4140.15126898985, 4140.399642051916, 5933.3473317934995, 5962.940370596325, 5972.820815375546, 5980.820575382745, 5986.132010858445, 5428.891422171574, 5554.527865131468, 5556.9719601873785, 5560.582956278296, 5562.415946325658, 6667.366600172976, 6673.132492775908, 6691.063251144844, 6692.230393504712, 6695.430888374494, 4580.450345958473, 4581.63346932248, 4584.060267645124, 4599.747013914233, 4607.9078418431445, 6834.521583489158, 6986.266442023565, 7000.054992575988, 7008.719651213996, 7014.684339204697, 4711.858644240679, 4712.434507859079, 4716.6698331116495, 4717.481077081518, 4719.126961512063, 4766.928496072562, 4772.451168115642, 4772.976135119302, 4773.284007398918, 4783.210770222874, 5562.054450743383, 5567.66594004361, 5570.832875013756, 5572.414896435897, 5574.86062848432, 6608.801735947929, 6764.797056088325, 6775.830604234933, 6780.050792888999, 6788.049673045777, 1615.781869447633, 1647.9176041197893, 1649.150687395992, 1655.3213182595077, 1680.9411670591714, 1064.3188359449803, 1071.8070747265567, 1075.704181350135, 1084.2356138922041, 1092.2900114925362, 6375.768481031602, 6384.936150638434, 6420.903686444707, 6450.870982580323, 6477.352264773485, 6895.207051189077, 6915.965420172967, 6924.965375173092, 6932.826679333057, 6937.340952609494, 6418.550701450854, 6449.193850768654, 6461.095446637474, 6462.48300135988, 6463.9980802975615, 3791.052236940765, 3796.0699628591174, 3803.9919421353366, 3830.578636349999, 3839.7120215983914, 7390.926090739132, 7404.2595740426605, 7425.294597013275, 7426.517276377018, 7432.7770166894, 7055.929440705528, 7150.892736608955, 7239.348458638642, 7294.598797066213, 7296.562206267535, 7272.418206543463, 7357.006804081488, 7380.483366164317, 7387.0, 7430.219826918095, 7032.824179395556, 7095.290470952863, 7101.0, 7104.57908418308, 7114.14630244374, 6792.490563207681, 6893.276205998499, 6912.861742765016, 6950.54821436605, 6993.370596646327, 7324.974503569611, 7365.263473652806, 7391.113066432063, 7392.297731715478, 7407.518511296748, 4724.48030716614, 4769.260764581495, 4772.188727916332, 4774.880627984189, 4775.689580177277, 6847.657617119224, 6885.173779146535, 6983.127109111361, 7003.369696727319, 7006.894896576454, 6743.763968261087, 6754.18949726036, 6758.898616520658, 6792.0, 6803.693833777591, 6777.220619628806, 6790.45676345901, 6812.591244525344, 6820.04519367279, 6845.418139458202, 6474.1907261592305, 6605.834854128685, 6634.502412318999, 6636.2700102987665, 6636.867262654817, 6835.14560679915, 6851.075104860979, 6852.246252912076, 6865.519413641197, 6891.896621550581, 6688.230853451915, 6713.530052896251, 6713.697883595348, 6721.395074443323, 6724.697388617622], "unit": "ms", "name": "prototype.html", "value": 5054.733166580745}, {"lowerIsBetter": false, "replicates": [719.3202423709595, 813.7680760983121, 818.7748369198473, 827.9006519217695, 828.5277391886625, 11590.710232244199, 11651.708707282321, 12110.394480275983, 12319.0, 12337.383130843456, 12421.378931053434, 12472.314022728746, 12502.49990000399, 12553.309567973758, 12649.241045537274, 809.2878267124922, 810.5703976892227, 821.40858581821, 825.3933358981144, 826.0665448043702, 808.7169490678245, 813.7314686153585, 814.2712272516095, 820.4789958376414, 823.6211342782327, 848.2535368875411, 859.0550394565959, 860.4493124400389, 863.3913091270639, 863.6847550644032, 856.6273670953124, 856.7943693513512, 857.2627540315324, 857.391252210931, 858.3476557816074, 626.2922897126264, 630.6216270237867, 631.343402861024, 631.3907079668143, 632.4845251120322, 11987.10096742739, 12389.194702344408, 12399.814002789966, 12417.379131043412, 12423.0, 12299.815502767466, 12313.876861231363, 12379.75240495194, 12388.194767340094, 12816.423260953186, 9981.0, 9986.850197247048, 10142.833574138995, 10183.694489165337, 10439.582416703322, 3611.981940090283, 3622.094476380905, 3643.617420170897, 3645.7265705072227, 3761.887143385703, 45057.54942450566, 45389.773051134536, 45699.0, 45729.0, 45831.54168458306, 9746.853797193047, 9751.512424378752, 9809.117179453884, 9885.654002109892, 9980.550875210633, 17867.642647146986, 17999.820001800075, 18277.90861045713, 18303.633927321378, 18316.816831831777, 7385.66764495599, 7387.261273872569, 7419.406447484188, 7648.158702542716, 7710.4217183710325, 4230.344296634026, 4314.417553630283, 4349.064951035542, 4356.215881141425, 4370.169667763115, 3099.0857696979447, 3118.438681037435, 3121.9219519512194, 3127.6559578446354, 3127.8436078196455, 561.0574235284761, 568.3066658676408, 568.5451638689033, 575.8963386590453, 582.4292193650247, 635.4090695653088, 640.9455196308367, 644.7807745366504, 654.7184710574498, 716.6667499612705, 8300.128486508951, 8646.524441155796, 8669.393142479967, 8924.955375223211, 8980.0, 508.1640701046831, 613.828128124126, 637.6811594202899, 643.3598569423453, 645.3320812958565, 3826.100866296418, 3882.378819388884, 3914.3345631242755, 4119.608637179464, 4152.211079894811, 53091.46908530942, 54313.0, 54881.176782348295, 55887.44112558904, 56586.71706641441, 48786.02427951421, 49054.50945490571, 49186.754066230154, 49526.0, 49545.0, 45981.540184598394, 46869.29696054562, 47268.0, 47381.763091185014, 47480.76259618749, 8270.131636178356, 8429.283510901396, 8450.957745211235, 8559.914400856162, 8691.869621955802, 34234.48648270228, 34680.30639387148, 35392.823035884656, 35420.82289588536, 35691.10772230715, 45721.0, 45771.542284576724, 45887.0, 46184.30723539217, 46365.53634463747, 10827.350358978172, 10920.726981825517, 10991.560337586407, 11097.500612472297, 11105.666829995112, 12435.44040518197, 12456.833370599561, 12501.624951251477, 12527.0, 13143.685631437162, 11188.83216751733, 11309.604163854226, 11435.313881167156, 11559.248648837798, 11630.53477860876, 11358.659240222807, 11666.650000499998, 11704.356260405759, 11731.88268117308, 11915.106367022681, 10762.0, 11109.83335249988, 11248.325100493996, 11494.597689080842, 11574.189806713786, 9823.214142868695, 9881.160101391175, 9910.454924979196, 9982.950085249528, 10107.19142468586, 8461.661533538589, 8502.0, 8730.956345218234, 9413.294002949942, 9464.668736594185], "unit": "ms", "name": "yui.html", "value": 6250.366151762164}], "name": "dromaeo_css", "value": 6959.15049140722}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 112.0, 112.0, 112.0, 123.0, 112.0, 111.0, 111.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [153.0, 125.0, 157.0, 164.0, 126.0, 165.0, 153.0, 127.0, 160.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [161.0, 166.0, 161.0, 161.0, 163.0, 159.0, 163.0, 168.0, 168.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 74.0, 73.0, 72.0, 130.0, 71.0, 73.0, 73.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 78.2}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 134.0, 90.0, 92.0, 93.0, 133.0, 91.0, 92.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 104.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 146.0, 147.0, 147.0, 148.0, 148.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 63.0, 61.0, 61.0, 66.0, 65.0, 62.0, 58.0, 62.0], "unit": "ms", "name": "json-parse-financial", "value": 62.2}, {"lowerIsBetter": true, "replicates": [69.0, 74.0, 69.0, 69.0, 70.0, 71.0, 69.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 93.0, 86.0, 86.0, 85.0, 84.0, 86.0, 93.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [131.0, 125.0, 125.0, 121.0, 129.0, 119.0, 116.0, 126.0, 128.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [140.0, 151.0, 150.0, 151.0, 151.0, 143.0, 155.0, 150.0, 154.0, 151.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 68.0, 66.0, 66.0, 67.0, 68.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1517.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.06890894175552], "unit": "score", "name": "Richards", "value": 215.16568999999998}, {"lowerIsBetter": false, "replicates": [191.0219675262655], "unit": "score", "name": "DeltaBlue", "value": 346.12773000000004}, {"lowerIsBetter": false, "replicates": [280.662363177098], "unit": "score", "name": "Encrypt", "value": 948.4029029999999}, {"lowerIsBetter": false, "replicates": [5025.125628140703], "unit": "score", "name": "Decrypt", "value": 52.970019}, {"lowerIsBetter": false, "replicates": [1058.2010582010582], "unit": "score", "name": "RayTrace", "value": 699.2896049999997}, {"lowerIsBetter": false, "replicates": [709.2198581560284], "unit": "score", "name": "Earley", "value": 939.71283}, {"lowerIsBetter": false, "replicates": [12204.819277108434], "unit": "score", "name": "Boyer", "value": 54.606543928923976}, {"lowerIsBetter": false, "replicates": [25250.0], "unit": "score", "name": "RegExp", "value": 36.07861386138617}, {"lowerIsBetter": false, "replicates": [636.1323155216285], "unit": "score", "name": "Splay", "value": 128.10385200000002}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21362.25428273915}]} 01:53:54 INFO - RETURN: dromaeo_css: 6959.15 01:53:54 INFO - RETURN: kraken: 1517.50 01:53:54 INFO - RETURN: v8_7: 21362.25 01:53:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21362.25"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1517.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6959.15"}}} 01:53:54 INFO - Return code: 0 01:53:54 INFO - # TBPL SUCCESS # 01:53:54 INFO - Running post-action listener: _resource_record_post_action 01:53:54 INFO - Running post-run listener: _resource_record_post_run 01:53:55 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 512000; Write bytes: 509026304; Read time: 100; Write time: 280064 01:53:55 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 126730240; Read time: 0; Write time: 79932 01:53:55 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 512000; Write bytes: 274882560; Read time: 100; Write time: 114868 01:53:55 INFO - Running post-run listener: _upload_blobber_files 01:53:55 INFO - Blob upload gear active. 01:53:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:53:55 INFO - Copying logs to upload dir... 01:53:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1265.901816 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-20 01:53:55.761236) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 01:53:55.765204) ========= 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=5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/LJzXHVDxTAynr1kwWevkyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010020 build_url: 'https://queue.taskcluster.net/v1/task/LJzXHVDxTAynr1kwWevkyw/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-20 01:53:55.817007) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:53:55.817345) ========= 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=5804b9f07a53938c557deee7000001c5-1448011343.138049-551838167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004627 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:53:55.866596) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 01:53:55.866914) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 01:53:55.867270) ========= ========= Total master_lag: 0.19 =========