builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1447954952.19 results: success (0) buildid: 20151119083115 builduid: e43a1f6daf2042f8b3ac3ff9a0c1360d revision: d052d9447bf90d0fedaae937afb76e672ca6d49b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:32.190404) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:32.190906) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:32.191196) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006638 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:32.226818) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:32.227131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:32.251972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:32.252319) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:32.302712) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:32.302997) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:32.303358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:32.303630) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 09:42:32-- 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% 207M=0s 2015-11-19 09:42:32 (207 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180711 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:32.504114) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:32.504389) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015669 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:32.553840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:32.554190) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d052d9447bf90d0fedaae937afb76e672ca6d49b --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 d052d9447bf90d0fedaae937afb76e672ca6d49b --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=cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 09:42:32,570 truncating revision to first 12 chars 2015-11-19 09:42:32,570 Setting DEBUG logging. 2015-11-19 09:42:32,570 attempt 1/10 2015-11-19 09:42:32,570 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d052d9447bf9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 09:42:32,841 unpacking tar archive at: fx-team-d052d9447bf9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.580873 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:33.147520) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:33.147811) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:33.159169) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:33.159485) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 09:42:33.159959) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-19 09:42:33.160284) ========= /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=cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:42:33 INFO - MultiFileLogger online at 20151119 09:42:33 in /builds/slave/test-pgo 09:42:33 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 09:42:33 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:42:33 INFO - {'append_to_log': False, 09:42:33 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:42:33 INFO - 'blob_upload_branch': 'Fx-Team', 09:42:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:42:33 INFO - 'branch': 'Fx-Team', 09:42:33 INFO - 'buildbot_json_path': 'buildprops.json', 09:42:33 INFO - 'config_files': ('talos/linux_config.py',), 09:42:33 INFO - 'default_actions': ('clobber', 09:42:33 INFO - 'read-buildbot-config', 09:42:33 INFO - 'download-and-extract', 09:42:33 INFO - 'populate-webroot', 09:42:33 INFO - 'create-virtualenv', 09:42:33 INFO - 'install', 09:42:33 INFO - 'run-tests'), 09:42:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:42:33 INFO - 'download_minidump_stackwalk': True, 09:42:33 INFO - 'download_symbols': 'ondemand', 09:42:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:42:33 INFO - 'tooltool.py': '/tools/tooltool.py', 09:42:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:42:33 INFO - '/tools/misc-python/virtualenv.py')}, 09:42:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:42:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:42:33 INFO - 'installer_path': 'installer.exe', 09:42:33 INFO - 'log_level': 'info', 09:42:33 INFO - 'log_name': 'talos', 09:42:33 INFO - 'log_to_console': True, 09:42:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:42:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:42:33 INFO - 'opt_config_files': (), 09:42:33 INFO - 'pip_index': False, 09:42:33 INFO - 'sps_profile': False, 09:42:33 INFO - 'sps_profile_interval': 0, 09:42:33 INFO - 'suite': 'dromaeojs-e10s', 09:42:33 INFO - 'system_bits': '64', 09:42:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:42:33 INFO - 'title': 'talos-linux64-ix-010', 09:42:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:42:33 INFO - 'use_talos_json': True, 09:42:33 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:42:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:42:33 INFO - 'work_dir': 'build'} 09:42:33 INFO - ##### 09:42:33 INFO - ##### Running clobber step. 09:42:33 INFO - ##### 09:42:33 INFO - Running pre-action listener: _resource_record_pre_action 09:42:33 INFO - Running main action method: clobber 09:42:33 INFO - rmtree: /builds/slave/test-pgo/build 09:42:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:42:33 INFO - Running post-action listener: _resource_record_post_action 09:42:33 INFO - ##### 09:42:33 INFO - ##### Running read-buildbot-config step. 09:42:33 INFO - ##### 09:42:33 INFO - Running pre-action listener: _resource_record_pre_action 09:42:33 INFO - Running main action method: read_buildbot_config 09:42:33 INFO - Using buildbot properties: 09:42:33 INFO - { 09:42:33 INFO - "properties": { 09:42:33 INFO - "buildnumber": 98, 09:42:33 INFO - "product": "firefox", 09:42:33 INFO - "script_repo_revision": "production", 09:42:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:42:33 INFO - "repository": "", 09:42:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 09:42:33 INFO - "buildid": "20151119083115", 09:42:33 INFO - "slavename": "talos-linux64-ix-010", 09:42:33 INFO - "pgo_build": "True", 09:42:33 INFO - "basedir": "/builds/slave/test-pgo", 09:42:33 INFO - "project": "", 09:42:33 INFO - "platform": "ubuntu64_hw", 09:42:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:42:33 INFO - "slavebuilddir": "test", 09:42:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:42:33 INFO - "branch": "fx-team", 09:42:33 INFO - "repo_path": "integration/fx-team", 09:42:33 INFO - "stage_platform": "linux64-pgo", 09:42:33 INFO - "builduid": "e43a1f6daf2042f8b3ac3ff9a0c1360d", 09:42:33 INFO - "revision": "d052d9447bf90d0fedaae937afb76e672ca6d49b" 09:42:33 INFO - }, 09:42:33 INFO - "sourcestamp": { 09:42:33 INFO - "repository": "", 09:42:33 INFO - "hasPatch": false, 09:42:33 INFO - "project": "", 09:42:33 INFO - "branch": "fx-team-linux64-pgo-talos", 09:42:33 INFO - "changes": [ 09:42:33 INFO - { 09:42:33 INFO - "category": null, 09:42:33 INFO - "files": [ 09:42:33 INFO - { 09:42:33 INFO - "url": null, 09:42:33 INFO - "name": "https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:42:33 INFO - } 09:42:33 INFO - ], 09:42:33 INFO - "repository": "", 09:42:33 INFO - "rev": "d052d9447bf90d0fedaae937afb76e672ca6d49b", 09:42:33 INFO - "who": "sendchange", 09:42:33 INFO - "when": 1447954913, 09:42:33 INFO - "number": 6683950, 09:42:33 INFO - "comments": "", 09:42:33 INFO - "project": "", 09:42:33 INFO - "at": "Thu 19 Nov 2015 09:41:53", 09:42:33 INFO - "branch": "fx-team-linux64-pgo-talos", 09:42:33 INFO - "revlink": "", 09:42:33 INFO - "properties": [ 09:42:33 INFO - [ 09:42:33 INFO - "buildid", 09:42:33 INFO - "20151119083115", 09:42:33 INFO - "Change" 09:42:33 INFO - ], 09:42:33 INFO - [ 09:42:33 INFO - "builduid", 09:42:33 INFO - "e43a1f6daf2042f8b3ac3ff9a0c1360d", 09:42:33 INFO - "Change" 09:42:33 INFO - ], 09:42:33 INFO - [ 09:42:33 INFO - "pgo_build", 09:42:33 INFO - "True", 09:42:33 INFO - "Change" 09:42:33 INFO - ] 09:42:33 INFO - ], 09:42:33 INFO - "revision": "d052d9447bf90d0fedaae937afb76e672ca6d49b" 09:42:33 INFO - } 09:42:33 INFO - ], 09:42:33 INFO - "revision": "d052d9447bf90d0fedaae937afb76e672ca6d49b" 09:42:33 INFO - } 09:42:33 INFO - } 09:42:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:42:33 INFO - Running post-action listener: _resource_record_post_action 09:42:33 INFO - ##### 09:42:33 INFO - ##### Running download-and-extract step. 09:42:33 INFO - ##### 09:42:33 INFO - Running pre-action listener: _resource_record_pre_action 09:42:33 INFO - Running main action method: download_and_extract 09:42:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:33 INFO - https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:42:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/test_packages.json 09:42:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/test_packages.json 09:42:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:42:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:42:44 INFO - Downloaded 1302 bytes. 09:42:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:42:44 INFO - Using the following test package requirements: 09:42:44 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:42:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:42:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:44 INFO - u'jsshell-linux-x86_64.zip'], 09:42:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:42:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:42:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:42:44 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:42:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:42:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:42:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:42:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:44 INFO - https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:42:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:42:45 INFO - Downloaded 22520742 bytes. 09:42:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:42:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:42:47 INFO - Return code: 0 09:42:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:47 INFO - https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:42:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:42:59 INFO - Downloaded 22520742 bytes. 09:42: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 09:42:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42: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 09:43:00 INFO - Return code: 0 09:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:00 INFO - https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:43:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:43:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:43:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:43:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:43:01 INFO - Downloaded 11130997 bytes. 09:43:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 09:43:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:43:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:43:01 INFO - Return code: 0 09:43: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')]} 09:43:01 INFO - https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:43:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:43:03 INFO - Downloaded 57346257 bytes. 09:43:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:03 INFO - mkdir: /builds/slave/test-pgo/properties 09:43:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:43:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:43:03 INFO - Contents: 09:43:03 INFO - build_url:https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:03 INFO - Running post-action listener: _resource_record_post_action 09:43:03 INFO - Running post-action listener: set_extra_try_arguments 09:43:03 INFO - ##### 09:43:03 INFO - ##### Running populate-webroot step. 09:43:03 INFO - ##### 09:43:03 INFO - Running pre-action listener: _resource_record_pre_action 09:43:03 INFO - Running main action method: populate_webroot 09:43:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:43:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:43:03 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:43:03 INFO - '../fennec_ids.txt'], 09:43:03 INFO - 'tests': ['tcheck2']}, 09:43:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:43:03 INFO - '--tppagecycles', 09:43:03 INFO - '7'], 09:43:03 INFO - 'tests': ['tsvgm']}}, 09:43:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:43:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:43:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:43:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:43:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:43:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:43:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:03 INFO - 'talos_options': ['--e10s'], 09:43:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:03 INFO - 'tests': ['damp', 'tps']}, 09:43:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:03 INFO - 'talos_options': ['--e10s'], 09:43:03 INFO - 'tests': ['damp', 'tps']}, 09:43:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:43:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:43:03 INFO - 'other': {'tests': ['a11yr', 09:43:03 INFO - 'ts_paint', 09:43:03 INFO - 'tpaint', 09:43:03 INFO - 'sessionrestore', 09:43:03 INFO - 'sessionrestore_no_auto_restore']}, 09:43:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:43:03 INFO - 'tests': ['a11yr', 09:43:03 INFO - 'ts_paint', 09:43:03 INFO - 'tpaint', 09:43:03 INFO - 'sessionrestore', 09:43:03 INFO - 'sessionrestore_no_auto_restore']}, 09:43:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:43:03 INFO - 'tests': ['a11yr', 09:43:03 INFO - 'ts_paint', 09:43:03 INFO - 'tpaint', 09:43:03 INFO - 'sessionrestore', 09:43:03 INFO - 'sessionrestore_no_auto_restore']}, 09:43:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:43:03 INFO - 'tests': ['a11yr', 09:43:03 INFO - 'ts_paint', 09:43:03 INFO - 'tpaint', 09:43:03 INFO - 'sessionrestore', 09:43:03 INFO - 'sessionrestore_no_auto_restore']}, 09:43:03 INFO - 'other_l64': {'tests': ['a11yr', 09:43:03 INFO - 'ts_paint', 09:43:03 INFO - 'tpaint', 09:43:03 INFO - 'sessionrestore', 09:43:03 INFO - 'sessionrestore_no_auto_restore']}, 09:43:03 INFO - 'other_nol64': {'tests': ['a11yr', 09:43:03 INFO - 'ts_paint', 09:43:03 INFO - 'tpaint', 09:43:03 INFO - 'sessionrestore', 09:43:03 INFO - 'sessionrestore_no_auto_restore']}, 09:43:03 INFO - 'svgr': {'tests': ['tsvgx', 09:43:03 INFO - 'tsvgr_opacity', 09:43:03 INFO - 'tart', 09:43:03 INFO - 'tscrollx', 09:43:03 INFO - 'cart']}, 09:43:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:43:03 INFO - 'tests': ['tsvgx', 09:43:03 INFO - 'tsvgr_opacity', 09:43:03 INFO - 'tart', 09:43:03 INFO - 'tscrollx', 09:43:03 INFO - 'cart']}, 09:43:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:03 INFO - 'tests': ['tp5o']}, 09:43:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:03 INFO - 'talos_options': ['--e10s'], 09:43:03 INFO - 'tests': ['tp5o']}, 09:43:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:03 INFO - 'talos_options': ['--xperf_path', 09:43:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:03 INFO - 'tests': ['tp5n']}, 09:43:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:03 INFO - 'talos_options': ['--e10s', 09:43:03 INFO - '--xperf_path', 09:43:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:03 INFO - 'tests': ['tp5n']}}, 09:43:03 INFO - 'talos.zip': {'path': '', 09:43:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:43:03 INFO - Running post-action listener: _resource_record_post_action 09:43:03 INFO - ##### 09:43:03 INFO - ##### Running create-virtualenv step. 09:43:03 INFO - ##### 09:43:03 INFO - Running pre-action listener: _resource_record_pre_action 09:43:03 INFO - Running main action method: create_virtualenv 09:43:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:43:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 09:43:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:43:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:43:03 INFO - Using real prefix '/usr' 09:43:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:43:03 INFO - Installing distribute.............................................................................................................................................................................................done. 09:43:05 INFO - Installing pip.................done. 09:43:05 INFO - Return code: 0 09:43:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3832bbac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a96e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dfa90>, '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 0x2731f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27322e0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:43:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:43:05 INFO - Using env: {'DISPLAY': ':0', 09:43:05 INFO - 'HOME': '/home/cltbld', 09:43:05 INFO - 'LANG': 'en_US.UTF-8', 09:43:05 INFO - 'LANGUAGE': 'en_US:en', 09:43:05 INFO - 'LOGNAME': 'cltbld', 09:43:05 INFO - 'MAIL': '/var/mail/cltbld', 09:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:05 INFO - 'MOZ_NO_REMOTE': '1', 09:43:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:05 INFO - 'NO_EM_RESTART': '1', 09:43:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:05 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:05 INFO - 'SHELL': '/bin/bash', 09:43:05 INFO - 'SHLVL': '1', 09:43:05 INFO - 'TERM': 'linux', 09:43:05 INFO - 'TMOUT': '86400', 09:43:05 INFO - 'USER': 'cltbld', 09:43:05 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106', 09:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:05 INFO - '_': '/tools/buildbot/bin/python'} 09:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:43:06 INFO - Cleaning up... 09:43:06 INFO - Return code: 0 09:43:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3832bbac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a96e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dfa90>, '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 0x2731f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27322e0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:43:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:43:06 INFO - Using env: {'DISPLAY': ':0', 09:43:06 INFO - 'HOME': '/home/cltbld', 09:43:06 INFO - 'LANG': 'en_US.UTF-8', 09:43:06 INFO - 'LANGUAGE': 'en_US:en', 09:43:06 INFO - 'LOGNAME': 'cltbld', 09:43:06 INFO - 'MAIL': '/var/mail/cltbld', 09:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:06 INFO - 'MOZ_NO_REMOTE': '1', 09:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:06 INFO - 'NO_EM_RESTART': '1', 09:43:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:06 INFO - 'SHELL': '/bin/bash', 09:43:06 INFO - 'SHLVL': '1', 09:43:06 INFO - 'TERM': 'linux', 09:43:06 INFO - 'TMOUT': '86400', 09:43:06 INFO - 'USER': 'cltbld', 09:43:06 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106', 09:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:06 INFO - '_': '/tools/buildbot/bin/python'} 09:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:06 INFO - Downloading/unpacking psutil>=0.7.1 09:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:07 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:43:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:43:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:43:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:43:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:43:08 INFO - Installing collected packages: psutil 09:43:08 INFO - Running setup.py install for psutil 09:43:08 INFO - building 'psutil._psutil_linux' extension 09:43:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:43:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:43:08 INFO - building 'psutil._psutil_posix' extension 09:43:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:43:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:43:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:43:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:43:08 INFO - Successfully installed psutil 09:43:08 INFO - Cleaning up... 09:43:08 INFO - Return code: 0 09:43:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:08 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 0x7f3832bbac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a96e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dfa90>, '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 0x2731f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27322e0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:43:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:43:08 INFO - Using env: {'DISPLAY': ':0', 09:43:08 INFO - 'HOME': '/home/cltbld', 09:43:08 INFO - 'LANG': 'en_US.UTF-8', 09:43:08 INFO - 'LANGUAGE': 'en_US:en', 09:43:08 INFO - 'LOGNAME': 'cltbld', 09:43:08 INFO - 'MAIL': '/var/mail/cltbld', 09:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:08 INFO - 'MOZ_NO_REMOTE': '1', 09:43:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:08 INFO - 'NO_EM_RESTART': '1', 09:43:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:08 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:08 INFO - 'SHELL': '/bin/bash', 09:43:08 INFO - 'SHLVL': '1', 09:43:08 INFO - 'TERM': 'linux', 09:43:08 INFO - 'TMOUT': '86400', 09:43:08 INFO - 'USER': 'cltbld', 09:43:08 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106', 09:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:08 INFO - '_': '/tools/buildbot/bin/python'} 09:43:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:43:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:43:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:43:10 INFO - Installing collected packages: mozsystemmonitor 09:43:10 INFO - Running setup.py install for mozsystemmonitor 09:43:10 INFO - Successfully installed mozsystemmonitor 09:43:10 INFO - Cleaning up... 09:43:10 INFO - Return code: 0 09:43:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:10 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 0x7f3832bbac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a96e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dfa90>, '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 0x2731f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27322e0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:43:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:43:10 INFO - Using env: {'DISPLAY': ':0', 09:43:10 INFO - 'HOME': '/home/cltbld', 09:43:10 INFO - 'LANG': 'en_US.UTF-8', 09:43:10 INFO - 'LANGUAGE': 'en_US:en', 09:43:10 INFO - 'LOGNAME': 'cltbld', 09:43:10 INFO - 'MAIL': '/var/mail/cltbld', 09:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:10 INFO - 'MOZ_NO_REMOTE': '1', 09:43:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:10 INFO - 'NO_EM_RESTART': '1', 09:43:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:10 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:10 INFO - 'SHELL': '/bin/bash', 09:43:10 INFO - 'SHLVL': '1', 09:43:10 INFO - 'TERM': 'linux', 09:43:10 INFO - 'TMOUT': '86400', 09:43:10 INFO - 'USER': 'cltbld', 09:43:10 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106', 09:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:10 INFO - '_': '/tools/buildbot/bin/python'} 09:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:10 INFO - Downloading/unpacking blobuploader==1.2.4 09:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:12 INFO - Downloading blobuploader-1.2.4.tar.gz 09:43:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:43:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:43:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:43:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:43:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:13 INFO - Downloading docopt-0.6.1.tar.gz 09:43:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:43:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:43:13 INFO - Installing collected packages: blobuploader, requests, docopt 09:43:13 INFO - Running setup.py install for blobuploader 09:43:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:43:13 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:43:13 INFO - Running setup.py install for requests 09:43:15 INFO - Running setup.py install for docopt 09:43:15 INFO - Successfully installed blobuploader requests docopt 09:43:15 INFO - Cleaning up... 09:43:15 INFO - Return code: 0 09:43:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:43: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')]} 09:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43: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')]} 09:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:15 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 0x7f3832bbac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a96e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dfa90>, '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 0x2731f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27322e0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:43:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:43:15 INFO - Using env: {'DISPLAY': ':0', 09:43:15 INFO - 'HOME': '/home/cltbld', 09:43:15 INFO - 'LANG': 'en_US.UTF-8', 09:43:15 INFO - 'LANGUAGE': 'en_US:en', 09:43:15 INFO - 'LOGNAME': 'cltbld', 09:43:15 INFO - 'MAIL': '/var/mail/cltbld', 09:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:15 INFO - 'MOZ_NO_REMOTE': '1', 09:43:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:15 INFO - 'NO_EM_RESTART': '1', 09:43:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:15 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:15 INFO - 'SHELL': '/bin/bash', 09:43:15 INFO - 'SHLVL': '1', 09:43:15 INFO - 'TERM': 'linux', 09:43:15 INFO - 'TMOUT': '86400', 09:43:15 INFO - 'USER': 'cltbld', 09:43:15 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106', 09:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:15 INFO - '_': '/tools/buildbot/bin/python'} 09:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:43:15 INFO - Running setup.py (path:/tmp/pip-rCjEau-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:43:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:43:15 INFO - Running setup.py (path:/tmp/pip-irsQiz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:43:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:43:15 INFO - Running setup.py (path:/tmp/pip-IcO0yH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:43:16 INFO - Running setup.py (path:/tmp/pip-e3qpNF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:43:16 INFO - Running setup.py (path:/tmp/pip-l6hp1m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:43:16 INFO - Running setup.py (path:/tmp/pip-s7XzSN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:43:16 INFO - Running setup.py (path:/tmp/pip-NTktc6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:43:16 INFO - Running setup.py (path:/tmp/pip-YnD1bG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:43:16 INFO - Running setup.py (path:/tmp/pip-F2KS1g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:43:16 INFO - Running setup.py (path:/tmp/pip-wIyxXU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:43:16 INFO - Running setup.py (path:/tmp/pip-UTqVyv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:43:16 INFO - Running setup.py (path:/tmp/pip-Ts0E_Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:43:16 INFO - Running setup.py (path:/tmp/pip-fbmC_I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:43:16 INFO - Running setup.py (path:/tmp/pip-hUncWq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:43:16 INFO - Running setup.py (path:/tmp/pip-mt4Uzo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:43:16 INFO - Running setup.py (path:/tmp/pip-bgkojJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:43:16 INFO - Running setup.py (path:/tmp/pip-UzDemo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:43:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:43:17 INFO - Running setup.py install for manifestparser 09:43:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:43:17 INFO - Running setup.py install for mozcrash 09:43:17 INFO - Running setup.py install for mozdebug 09:43:17 INFO - Running setup.py install for mozdevice 09:43:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:43:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:43:17 INFO - Running setup.py install for mozfile 09:43:17 INFO - Running setup.py install for mozhttpd 09:43:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:43:17 INFO - Running setup.py install for mozinfo 09:43:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:43:17 INFO - Running setup.py install for mozInstall 09:43:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:43:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:43:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:43:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:43:17 INFO - Running setup.py install for mozleak 09:43:17 INFO - Running setup.py install for mozlog 09:43:18 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:43:18 INFO - Running setup.py install for moznetwork 09:43:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:43:18 INFO - Running setup.py install for mozprocess 09:43:18 INFO - Running setup.py install for mozprofile 09:43:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:43:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:43:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:43:18 INFO - Running setup.py install for mozrunner 09:43:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:43:18 INFO - Running setup.py install for mozscreenshot 09:43:18 INFO - Running setup.py install for moztest 09:43:18 INFO - Running setup.py install for mozversion 09:43:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:43:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:43:18 INFO - Cleaning up... 09:43:18 INFO - Return code: 0 09:43:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:43: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')]} 09:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43: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')]} 09:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3832bbac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a96e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dfa90>, '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 0x2731f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27322e0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:43:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:43:18 INFO - Using env: {'DISPLAY': ':0', 09:43:18 INFO - 'HOME': '/home/cltbld', 09:43:18 INFO - 'LANG': 'en_US.UTF-8', 09:43:18 INFO - 'LANGUAGE': 'en_US:en', 09:43:18 INFO - 'LOGNAME': 'cltbld', 09:43:18 INFO - 'MAIL': '/var/mail/cltbld', 09:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:18 INFO - 'MOZ_NO_REMOTE': '1', 09:43:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:18 INFO - 'NO_EM_RESTART': '1', 09:43:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:18 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:18 INFO - 'SHELL': '/bin/bash', 09:43:18 INFO - 'SHLVL': '1', 09:43:18 INFO - 'TERM': 'linux', 09:43:18 INFO - 'TMOUT': '86400', 09:43:18 INFO - 'USER': 'cltbld', 09:43:18 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106', 09:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:18 INFO - '_': '/tools/buildbot/bin/python'} 09:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:43:19 INFO - Running setup.py (path:/tmp/pip-usAP5t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 09:43:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:43:19 INFO - Running setup.py (path:/tmp/pip-Ko5AHk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:43:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:43:19 INFO - Running setup.py (path:/tmp/pip-MCFOSv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:43:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:43:19 INFO - Running setup.py (path:/tmp/pip-z_jlLz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:43:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:43:19 INFO - Running setup.py (path:/tmp/pip-f8sLNr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 09:43:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:43:19 INFO - Running setup.py (path:/tmp/pip-LXM6iG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 09:43:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:43:19 INFO - Running setup.py (path:/tmp/pip-D1xaii-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 09:43:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:43:19 INFO - Running setup.py (path:/tmp/pip-gFtzwN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 09:43:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:43:19 INFO - Running setup.py (path:/tmp/pip-j53et4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 09:43:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:43:19 INFO - Running setup.py (path:/tmp/pip-77JXrH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:43:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:43:19 INFO - Running setup.py (path:/tmp/pip-PDdXKN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 09:43:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:43:19 INFO - Running setup.py (path:/tmp/pip-zK5Amt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 09:43:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:43:19 INFO - Running setup.py (path:/tmp/pip-r11b5f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 09:43:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:43:20 INFO - Running setup.py (path:/tmp/pip-XD1Fx2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 09:43:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:43:20 INFO - Running setup.py (path:/tmp/pip-HGJqHQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 09:43:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:43:20 INFO - Running setup.py (path:/tmp/pip-MTKDz7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 09:43:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:43:20 INFO - Running setup.py (path:/tmp/pip-RZWHgj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 09:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:43:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43:21 INFO - Downloading blessings-1.5.1.tar.gz 09:43:21 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:43:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:43:22 INFO - Installing collected packages: blessings 09:43:22 INFO - Running setup.py install for blessings 09:43:22 INFO - Successfully installed blessings 09:43:22 INFO - Cleaning up... 09:43:22 INFO - Return code: 0 09:43:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:43:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:43:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:43:22 INFO - Reading from file tmpfile_stdout 09:43:22 INFO - Current package versions: 09:43:22 INFO - argparse == 1.2.1 09:43:22 INFO - blessings == 1.5.1 09:43:22 INFO - blobuploader == 1.2.4 09:43:22 INFO - docopt == 0.6.1 09:43:22 INFO - manifestparser == 1.1 09:43:22 INFO - mozInstall == 1.12 09:43:22 INFO - mozcrash == 0.16 09:43:22 INFO - mozdebug == 0.1 09:43:22 INFO - mozdevice == 0.47 09:43:22 INFO - mozfile == 1.2 09:43:22 INFO - mozhttpd == 0.7 09:43:22 INFO - mozinfo == 0.9 09:43:22 INFO - mozleak == 0.1 09:43:22 INFO - mozlog == 3.0 09:43:22 INFO - moznetwork == 0.27 09:43:22 INFO - mozprocess == 0.22 09:43:22 INFO - mozprofile == 0.27 09:43:22 INFO - mozrunner == 6.11 09:43:22 INFO - mozscreenshot == 0.1 09:43:22 INFO - mozsystemmonitor == 0.0 09:43:22 INFO - moztest == 0.7 09:43:22 INFO - mozversion == 1.4 09:43:22 INFO - psutil == 3.1.1 09:43:22 INFO - requests == 1.2.3 09:43:22 INFO - wsgiref == 0.1.2 09:43:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:22 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 0x7f3832bbac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a96e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dfa90>, '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 0x2731f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27322e0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 09:43:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:43:22 INFO - Using env: {'DISPLAY': ':0', 09:43:22 INFO - 'HOME': '/home/cltbld', 09:43:22 INFO - 'LANG': 'en_US.UTF-8', 09:43:22 INFO - 'LANGUAGE': 'en_US:en', 09:43:22 INFO - 'LOGNAME': 'cltbld', 09:43:22 INFO - 'MAIL': '/var/mail/cltbld', 09:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:22 INFO - 'MOZ_NO_REMOTE': '1', 09:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:22 INFO - 'NO_EM_RESTART': '1', 09:43:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:22 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:22 INFO - 'SHELL': '/bin/bash', 09:43:22 INFO - 'SHLVL': '1', 09:43:22 INFO - 'TERM': 'linux', 09:43:22 INFO - 'TMOUT': '86400', 09:43:22 INFO - 'USER': 'cltbld', 09:43:22 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106', 09:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:22 INFO - '_': '/tools/buildbot/bin/python'} 09:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 09:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 09:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 09:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 09:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 09:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:43:22 INFO - Cleaning up... 09:43:22 INFO - Return code: 0 09:43:22 INFO - Running post-action listener: _resource_record_post_action 09:43:22 INFO - Running post-action listener: _start_resource_monitoring 09:43:22 INFO - Starting resource monitoring. 09:43:22 INFO - ##### 09:43:22 INFO - ##### Running install step. 09:43:22 INFO - ##### 09:43:22 INFO - Running pre-action listener: _resource_record_pre_action 09:43:22 INFO - Running main action method: install 09:43:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:43:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:43:22 INFO - Reading from file tmpfile_stdout 09:43:22 INFO - Detecting whether we're running mozinstall >=1.0... 09:43:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:43:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:43:22 INFO - Reading from file tmpfile_stdout 09:43:22 INFO - Output received: 09:43:22 INFO - Usage: mozinstall [options] installer 09:43:22 INFO - Options: 09:43:22 INFO - -h, --help show this help message and exit 09:43:22 INFO - -d DEST, --destination=DEST 09:43:22 INFO - Directory to install application into. [default: 09:43:22 INFO - "/builds/slave/test-pgo"] 09:43:22 INFO - --app=APP Application being installed. [default: firefox] 09:43:22 INFO - mkdir: /builds/slave/test-pgo/build/application 09:43:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:43:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:43:37 INFO - Reading from file tmpfile_stdout 09:43:37 INFO - Output received: 09:43:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:43:37 INFO - Running post-action listener: _resource_record_post_action 09:43:37 INFO - ##### 09:43:37 INFO - ##### Running run-tests step. 09:43:37 INFO - ##### 09:43:37 INFO - Running pre-action listener: _resource_record_pre_action 09:43:37 INFO - Running main action method: run_tests 09:43:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:43:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:43:37 INFO - Python 2.7.3 09:43:37 INFO - Return code: 0 09:43:37 INFO - grabbing minidump binary from tooltool 09:43:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:37 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 0x26dfa90>, '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 0x2731f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27322e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:43:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 09:43:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:43:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:43:37 INFO - Return code: 0 09:43:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:43:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:43:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:43:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:43:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:43:37 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/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:43:37 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/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost 09:43:37 INFO - Using env: {'DISPLAY': ':0', 09:43:37 INFO - 'HOME': '/home/cltbld', 09:43:37 INFO - 'LANG': 'en_US.UTF-8', 09:43:37 INFO - 'LANGUAGE': 'en_US:en', 09:43:37 INFO - 'LOGNAME': 'cltbld', 09:43:37 INFO - 'MAIL': '/var/mail/cltbld', 09:43:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:43:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:43:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:37 INFO - 'MOZ_NO_REMOTE': '1', 09:43:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:43:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:37 INFO - 'NO_EM_RESTART': '1', 09:43:37 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:37 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:37 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:43:37 INFO - 'SHELL': '/bin/bash', 09:43:37 INFO - 'SHLVL': '1', 09:43:37 INFO - 'TERM': 'linux', 09:43:37 INFO - 'TMOUT': '86400', 09:43:37 INFO - 'USER': 'cltbld', 09:43:37 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106', 09:43:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:37 INFO - '_': '/tools/buildbot/bin/python'} 09:43:37 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/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] with output_timeout 3600 09:43:37 INFO - mozversion INFO | application_buildid: 20151119083115 09:43:37 INFO - mozversion INFO | application_changeset: d052d9447bf90d0fedaae937afb76e672ca6d49b 09:43:37 INFO - mozversion INFO | application_display_name: Nightly 09:43:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:43:37 INFO - mozversion INFO | application_name: Firefox 09:43:37 INFO - mozversion INFO | application_remotingname: firefox 09:43:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:43:37 INFO - mozversion INFO | application_vendor: Mozilla 09:43:37 INFO - mozversion INFO | application_version: 45.0a1 09:43:37 INFO - mozversion INFO | platform_buildid: 20151119083115 09:43:37 INFO - mozversion INFO | platform_changeset: d052d9447bf90d0fedaae937afb76e672ca6d49b 09:43:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:43:37 INFO - mozversion INFO | platform_version: 45.0a1 09:43:37 INFO - 2015-11-19 09:43:37,566 DEBUG : using testdate: 1447955017 09:43:37 INFO - 2015-11-19 09:43:37,566 DEBUG : actual date: 1447955017 09:43:37 INFO - 2015-11-19 09:43:37,575 INFO : starting webserver on 'localhost:58870' 09:43:37 INFO - 2015-11-19 09:43:37,576 INFO : Starting test suite talos-linux64-ix-010.e 09:43:37 INFO - 2015-11-19 09:43:37,576 INFO : Starting test dromaeo_css 09:43:37 INFO - 2015-11-19 09:43:37,576 DEBUG : operating with platform_type : linux_ 09:43:37 INFO - 2015-11-19 09:43:37,577 INFO : Initialising browser for dromaeo_css test... 09:43:37 INFO - 2015-11-19 09:43:37,591 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpygzUdi/profile http://localhost:58870/getInfo.html 09:43:42 INFO - 2015-11-19 09:43:42,014 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:43:42 INFO - 2015-11-19 09:43:42,014 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:43:42 INFO - 2015-11-19 09:43:42,014 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:43:42 INFO - 2015-11-19 09:43:42,014 DEBUG : BROWSER_OUTPUT: __metrics 09:43:43 INFO - 2015-11-19 09:43:43,073 INFO : Browser initialized. 09:43:43 INFO - 2015-11-19 09:43:43,073 INFO : Running cycle 1/1 for dromaeo_css test... 09:43:43 INFO - 2015-11-19 09:43:43,074 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpygzUdi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:43:54 INFO - 2015-11-19 09:43:54,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 139444224 09:43:54 INFO - 2015-11-19 09:43:54,909 DEBUG : BROWSER_OUTPUT: 09:44:44 INFO - 2015-11-19 09:44:44,546 DEBUG : BROWSER_OUTPUT: 1447955084541 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:46:54 INFO - 2015-11-19 09:46:54,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58870/tests/dromaeo/cssquery-ext.html) 09:46:55 INFO - 2015-11-19 09:46:55,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 144023552 09:46:55 INFO - 2015-11-19 09:46:55,515 DEBUG : BROWSER_OUTPUT: 09:49:57 INFO - 2015-11-19 09:49:57,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/dromaeo/cssquery-ext.html (next: http://localhost:58870/tests/dromaeo/cssquery-jquery.html) 09:49:58 INFO - 2015-11-19 09:49:58,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 141873152 09:49:58 INFO - 2015-11-19 09:49:58,039 DEBUG : BROWSER_OUTPUT: 09:52:59 INFO - 2015-11-19 09:52:59,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58870/tests/dromaeo/cssquery-mootools.html) 09:53:00 INFO - 2015-11-19 09:53:00,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 142659584 09:53:00 INFO - 2015-11-19 09:53:00,270 DEBUG : BROWSER_OUTPUT: 09:56:01 INFO - 2015-11-19 09:56:01,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58870/tests/dromaeo/cssquery-prototype.html) 09:56:02 INFO - 2015-11-19 09:56:02,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 141365248 09:56:02 INFO - 2015-11-19 09:56:02,505 DEBUG : BROWSER_OUTPUT: 09:59:04 INFO - 2015-11-19 09:59:04,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58870/tests/dromaeo/cssquery-yui.html) 09:59:05 INFO - 2015-11-19 09:59:05,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 141692928 09:59:05 INFO - 2015-11-19 09:59:05,389 DEBUG : BROWSER_OUTPUT: 10:02:07 INFO - 2015-11-19 10:02:07,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/dromaeo/cssquery-yui.html (next: http://localhost:58870/tests/dromaeo/cssquery-dojo.html) 10:02:07 INFO - 2015-11-19 10:02:07,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 144375808 10:02:07 INFO - 2015-11-19 10:02:07,698 DEBUG : BROWSER_OUTPUT: 10:02:07 INFO - 2015-11-19 10:02:07,698 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:02:07 INFO - 2015-11-19 10:02:07,698 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:02:07 INFO - 2015-11-19 10:02:07,698 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:02:07 INFO - 2015-11-19 10:02:07,699 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:02:07 INFO - 2015-11-19 10:02:07,700 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3269.5586095877056;3333.5999680038385;3359.445691460909;3365.983170084149;3389.7457690673205;5374.838754837351;5483.808066717661;5577.191307260455;5587.664740115596;5591.273134492515;5411.56707463402;5453.127499600065;5522.779088836442;5542.584306177033;5558.249636299099;5124.9487505125035;5141.228815677659;5161.30322406476;5162.896742065156;5209.921851172236;5082.161443361841;5182;5220.634555581092;5222.686638801665;5226.111561034633;4944.728039957801;5017.448080711119;5111.565516931066;5162.97418512905;5246.816361427351;5128.769205385766;5147.176451767737;5150.510701483353;5175.068487672217;5190.351206099238;4905.8773530661665;5053.317802096707;5090.236464530313;5136.357955255593;5137.6403651744395;5292.782659988225;5349.277847490617;5351.598630102758;5375.274337964403;5400.945990540084;6011;6029.8191054268445;6036.758529658809;6042.305134909498;6056.121862329982;5733.397993210736;5876.471117599393;6120.846978825521;6125.846853828645;6127.5404344674325;5523.6685798851795;5548.9722551386985;5560.110382338847;5566.025945459528;5649.491545760901;6019.819405417845;6065.636061836304;6093.268807743099;6097.9328617491765;6119.724612392364;5694.9179655865255;5953.583249172516;5960.8674351873005;5961.970190149108;5976.970115149396;5936.198613187251;5972.611780234271;6024.1566180734735;6054.455099041107;6122.632642041492;6016.097585362143;6020.69896505173;6024.186734790835;6033.4871535919065;6040.456358927718;5732.140178973187;5851.38560451155;5922.2597175353085;5940.910886336708;5962.25471816023;4523.411956445641;4595.724256544551;4598.448186217675;4615.076984603093;4646.140464014168;4103.589641035873;4111.7944102794745;4124.896877578025;4125.8968525787095;4165.12532368206;5516;5590;5731.885362292731;5745.6552606843725;5753.798617048383;6093.323220756535;6096.634201947897;6102.428659372087;6115.419035191739;6138.570300078952;5684.573656975661;5693.516051135617;5699.430056994267;5706.80026199081;5712.80005199816;5013.39839219296;5148.4851514848215;5150.768215430315;5153.742312884341;5200.167973124282;6105.914670190187;6115.816525504242;6121.296050954108;6134.263888333428;6147.907781383283;6032.668203248863;6032.939670603238;6036.3058248302;6054.878902421839;6094.939050609437;6200.255969283715;6217.316095229431;6257.8748425030335;6261.499080073674;6293.590916590407;5584.86037849057;5736.770529178786;5852.4147585241135;5863.765449382147;5881.05903055509;6062.878742425039;6080.118382834376;6085.756569737161;6085.786997455068;6139.4781443577795;5843.883122337445;5844.620099693507;5907.113932910098;5919.437653422918;5951.523878089656;5734.827955161185;5783.363829978614;5873.794417195378;5878.735456904364;5941.970290148522;5802.854928626818;5860.970695146497;5862.706864656665;5868.383819699041;5883.117532370179;5882.117682347511;5912.260967379078;5944.375840536854;5950.018246989198;5954.702264886825;5649.435056494318;5784.045632470596;5811.360750317546;5901.3213480448585;5953.76184952597 10:02:07 INFO - 2015-11-19 10:02:07,701 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.2143716640953;598.0909018292195;606.0333767640614;611.3611276216353;612.4579746923973;38112.428313575285;39032.41451378228;39127.80436097819;39231.607683923154;39285.41071883924;42757.358639620354;42992.57007429925;43099.569004309946;43261;43319;8616.827663446727;8708;8740.781480462976;8753.3872628916;8793.736187914341;8424.663013479485;8588.742337729878;8660.393772435931;8670.132986701343;8678.392512524126;8644;8734.170253825876;8752.212300892917;8752.474851508898;8760.737177884674;8556.101609331025;8692.304615630734;8699.60851761666;8711.346649001287;8715.520646364448;8528.829423411496;8639.39524233304;8642.092580279043;8645.438046526955;8675.696350627697;41008;41544.37683434751;41593.37609935853;41650.1669966599;41688.79155604233;3399.8640054397792;3410.7612467127065;3443.896683099511;3581.982090089559;3657.158853463718;30445.543316850264;30578.84710576455;30799.538006929914;30839.38321233585;31242.37515249682;3201.103690966533;3212.678732126792;3218;3317.08780085476;3374.190194353362;276973;278288;280354.5982270096;281122;281598;41383.1723365531;42236;42411.78794106071;57834.7108264456;58425.70787146037;41467.37798933018;41682.791586042484;41735.58264417377;41946.37080443796;41966;13217.405216765268;13411.664708382368;13431.19412835233;13501.864981350258;13531.932340338235;9994.10053095225;10054.09513143806;10147.34042287249;10148.695539133838;10149.949250253701;14431.855681443261;14445.855541444662;14459.27703614815;14477.276136193148;14486.85513144855;5523.978064058162;5663.490285874291;5686.943130568724;5714.628549144292;5734.971325143431;902.1519771414848;944.593824655391;952.7284723853807;960.3229723045237;1095.6274866545414;28739;28846.134615961553;29033.419331613248;29055.85472072626;29210;992.7021893432086;1018.3737001744022;1050.5745173204864;1105.220819322392;1107.3245320354577;14619.853801462063;14925.70148597022;15041.097534147986;15173.544793656209;15177.24113794306;408309;411537;416635;417474;417804;53604.46395535995;54404.45595543994;54434;54575.727121364136;54656.72671636696;1296.7665820152463;1320.2804471563022;1327.807467917166;1334.4061892457958;1338.5850386380253;27696.307592310353;28312.71687283101;28667.856660716563;28843.5673464894;28869.711302887543;45392.319115213955;46075;46094.30858537192;46202.53797461982;46277;306525;308464;309070;309466;309920;32418;32620.673793262715;33033;33107;33306.33387332288;43312.350314744675;43819;44016.77991610021;44162.779186103864;44757.77621111873;36612.08469788277;37342.2531549362;37447.2510549782;37782.62217377791;38075.428868566436;36781.06227324099;36937.63062369342;37410.62589374071;37611.2477750438;41582.37626435545;35954.28091438209;36633.63366366302;36925.815370922974;36964.81517592395;37005.629943700216;32759.836200818845;33783;34388.05492814212;34443;34702;25885;25955.351116222246;25975;26225.344366390993;26302 10:02:07 INFO - 2015-11-19 10:02:07,703 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.9276498317845;356.28209158545536;356.5097990263388;358.2441049385797;358.8241761536847;14523.273836308195;14693.632659183526;16655.500334989938;17248.310067597296;17919.641607167865;16130.274137663804;16316.918415407936;16383.508494745147;16421.261043253053;16620.75068873965;5088.694678319294;5314.388845282803;5338.01246769347;5346.625736198468;5354.330708661418;5386.407495175527;5400.729963501809;5434;5434.91847622286;5442.292501974738;5259.368875734898;5402.189671549259;5417.485338892799;5438.700871452069;5460.262864513299;5338.092524270884;5380.435054319299;5418.539424148952;5419.5393391561765;5420.593455490854;4735.786889589942;4778.880527986794;4789.185838407479;4820.204666230068;4829.806807727687;20803.16787328505;20869.68695469569;20962.266320678857;21152.259670911597;21239.469013274636;2061.9690704639443;2090.818363273453;2094.6020256151437;2225.6550234713645;2231.7400830829833;12901.874750698007;13034.543790967366;13091.279979601119;13115.86884131156;13459;1667.4247384652397;1674.4055860169585;1731.9134043297784;1741.1033317841323;1788.0702034941887;53884.73057634726;54311.456885431035;55600.44399556034;57504.42495575033;57668.42331576715;6561;6842.897356539655;6875.965620171967;6914.515983881181;6940.583564986117;8057.919420805834;8173.509589424653;8185.508869467851;8399.748007559783;8444.366672499587;5265.183896496049;5370;5371.4897084776885;5431.53831924283;5435.701036443033;5432.674039557639;5495.505404513613;5495.725213739297;5541.473560011793;5569.275994120739;3184.57008303876;3243.772935894512;3258.4623537116586;3276.1318250663594;3318.2699806042633;1160.5299853559322;1173.184636677518;1176.5705517486056;1183.946722397494;1215.0886834873845;462.4150449681156;470.7575598566741;474.743638435248;478.5716783478767;487.59285996193574;11951.940240298743;12038.277703337828;12121.575744848888;12171.695707607203;12183.147179697513;501.801788293622;508.6668232307844;515.0163188310385;522.3888050980286;528.857667438339;6506.186726659168;6609.570377925419;6616.669166541654;6671.3995740382625;6708.396244338033;529818;541313;544695;550379;554100;72740;76171;76455;77283.22716772872;79218.60390698125;547.843864498616;560.3527925246347;560.5459577742042;560.5991715923053;561.8539179813196;11094.611688590861;11223.60717374888;11467.31196128235;11519.30884146954;11694.88305116938;30150;30438.391232175676;33165.17087072843;35607.10982225465;36363.81818090893;47218.614502367665;48886.51113488962;50502.747486262335;50572;51299.48700512947;6386.9680651596445;6692.564983276072;6783.728650854108;6802.761903333359;6892.448604111759;11850.170488065753;12112.454939527566;12233.632991010283;12240.387980601112;12330.50677972871;10618.52216650268;10628.734281642712;10838.67483975482;10873.075788557744;10886.455677215949;9292.442453452815;9396.154346108882;9573.664921727706;10481.37111773296;10753.838692419777;10026.548805303924;10205.846912296172;10338.638147665097;10438.739031524272;10458.372497650165;15087.24563771829;15100.39598416095;15313.923430382776;15636.765448518054;15798.684026319179;14408.42366305336;16152.788540859248;16521.586960326087;16523.917380413022;16794 10:02:07 INFO - 2015-11-19 10:02:07,706 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1533.447958734856;1664.8917820341678;1736.3054778088763;1746.31020746805;1752.185233866251;6581.2760596334365;6593.604383736967;7639.968604238433;7721.073471183452;7724.150343462222;7670.117936437311;7846.411519136073;7907.762767116981;7923.48497347672;7938.801529961754;2218.4121207879884;2245.236619549353;2248.3816950338623;2256.17649557911;2260.9886950565224;2257.3905045637666;2264;2310.4916918277954;2316.0967222783042;2317.0268487235317;2246.1801442473543;2251.0995601759264;2274.647429648407;2284.588774020676;2301.4706617477905;2272.8068114210314;2293.346396277053;2315.0971121262805;2315.8610483371053;2316.9536609267802;2318.246569864784;2338.988305058481;2338.988305058481;2347.272345572878;2348.4011577047745;7811.7265895693945;7879.527228366316;7893.8026549336155;7909.1299957004685;7932.603369831485;4781;4842.44311904132;4843.1766599677785;4872.342233798463;4889;3152.1174071260084;3160.7945483543494;3251.7398608111293;3280.5899262592175;3313.337332533503;1098.993829948819;1103.2883789955433;1111.7220694826294;1116.1740312168936;1129.1644183304295;11014.669559913216;11047.060999815025;11050;11061.115110791117;11083.390413527253;4306.590873866978;4335.913281734348;4374.103308821684;4382.364557139197;4400;9400.764980875532;9427.76430589227;9429.057094290652;9450.810983780424;9489.098535639103;4823.348847905558;4870.902581948341;4879.487653796371;4880.023995200974;4896.657233993657;4259;4375.059362237134;4378.0806030733265;4400.9437734943385;4460.576245256695;3560.3413368526903;3574.0707416071486;3579.731520136;3599.4960705501253;3605.0987253186704;1136.198979719296;1137.374444055766;1138.4137169357787;1150.9482073306722;1152.176194021279;1336.5188532128425;1340.912840665373;1350.891928645706;1355.403622406138;1359.157322460081;7543.321101100818;7552.773416797395;7763.689452421952;7779.260970207822;7797;1091.7652704668535;1109.755853712182;1117.7820325036703;1121.3103941076342;1138.265818547049;5957.4042595740075;6026.397360263939;6032.336442991267;6034.879302413927;6038.426349496791;9366.250699943988;9466;9498.525073746285;9539.856902146474;9735.513224338754;9577.425354478753;9604.51977401127;9612.423254604746;9627.759306017266;9723.854142187873;7246.456515761339;7297.775202549544;7442.479026468203;7529.171791102975;7564.50830696003;7178.066851309296;7211.891821622785;7227.313405226495;7232.45756568249;7279.090113735783;8267.338612911073;8306.916930830614;8437.535935523605;8473.915260847312;8578.356623253405;8615.095414981337;8634.834297369775;8860.556972151495;8867.778305542155;8868;6960.164780226405;7091.11361079865;7156.354038571262;7239.963800180965;7316.743913962986;7699;7732.690692372242;7768.223177682186;7776.611169441392;7780.688772449039;7228.096487939008;7304.96347518259;7418.777436676908;7498.700051997859;7554.886676699744;7107.50247482692;7217.206107328295;7232.74685386009;7324.523905946309;7342.77971660851;7335.596542190231;7338.119425668954;7364.116306043309;7367.889481657672;7420.6660700269695;6649.900251496135;6757.358050985148;6776.15298087739;6798.558093723892;6799.830004249933;6850.9314906850295;6866.862662746817;6883.965580172267;6897.7585784497305;6921.8961715575315 10:02:07 INFO - 2015-11-19 10:02:07,706 DEBUG : BROWSER_OUTPUT: |4;prototype.html;324.3108394661343;324.31083946613444;330.2042078590597;334.3513583647723;334.6268910165165;6271.717772700228;6344.016677415002;6347.111404403381;6366.618002919828;6372.299047104815;6167.414095660916;6318.368163183679;6337.429631333179;6337.588056776306;6342.365763423655;4793.520647935196;4799.712017278957;4822.059698358821;4825.445073816512;4831.613470922335;4823.469418363977;4828.855134345975;4830.9371938173545;4832.057748738997;4840.15297322967;4696.97651511742;4776.235802271637;4793.065352256312;4798.7840547175465;4799.952000480003;4774.355462012636;4781.402324709411;4783.784729687138;4786.545278198566;4788.640851936118;4147.39862719907;4170;4171.249175148472;4172.7913604319965;4177.12280421112;5962.880742385171;5984.222051133324;5991.131285963511;5992.191054207669;5994.580379373446;5453.809116680897;5594.272744543224;5596.916046259309;5598.188262701886;5605.383407825136;6691.19705635322;6700.085462823638;6707.631080290582;6709.4296984755865;6711.5301928865;4617.2381557043045;4622.8150873965005;4626.398568186148;4630.83792067276;4646.1404640141345;6698.8995165072565;6985.965070174668;6986;6992.370686638176;6999.8600027999155;4589.541045895384;4603.746793926299;4608.331791890158;4609.516000819933;4617.2612382018715;4661.440627124767;4662.860114196579;4667.439907211156;4667.463241727177;4673.439187297546;5448.891022179613;5449.509544140967;5450.345958485007;5451.836444906659;5455.099908515051;6570.113034740344;6695.363940425652;6744.325567443217;6754.966225168941;6760.966195168992;1621.116491512105;1640.1307307127242;1660.3524625396105;1662.1938359895441;1665.7085010123421;1056;1082.783443311341;1084.4252546150553;1086.9076128529164;1093.5516438260274;6372.107904893319;6444.162258906406;6466.64433456155;6478;6493.38312860287;6864.107666003388;6904.275051119661;6916.066331045345;6924.203716572558;6932.272111428329;6397.712102955378;6398.9040164397575;6429.807105786834;6453.45145662624;6456.322086180883;3801.087738942689;3824.2733880562605;3824.579296277407;3835.9232815343535;3835.961640383616;7401.703931842773;7403.185649578542;7409.777706668809;7428.034355533854;7428.182899881009;7041.577505349593;7252.419806415474;7255.637218139072;7264.091988501437;7284.562926224444;7404.962975184982;7410.814729631802;7416.555006699616;7424.628768561658;7447.925520744723;7010.824729381602;7026.191987921455;7040.401565866959;7048.506604537633;7071.116110486189;6753.763618273337;6928.7228510859;6938.618375989369;6942.687579059056;6943.652817359213;7391.741289054858;7404.296591823768;7408.481406301723;7409.110906691231;7412.073490813648;4561.840335588238;4577.793999269974;4619.86140415788;4624.028953919715;4625.167469855458;6876.793696189123;6898.586084834926;7055.6594247094945;7088.716451341888;7102.680379383043;6827.146606674166;6831.28271531482;6863;6876.243613202444;6886.139232595926;6832.829179270558;6835.89746153818;6842.931570684428;6844.110265665432;6856.931430685829;6582.637954912526;6724.193096828412;6741.561798483083;6749.730010799513;6752.291009443938;6894.965525172543;6899.586024838526;6908.654567271516;6912.205096413775;6912.585244885323;6659.966700166468;6720.663966801542;6722.831929201809;6725.697343619451;6726.932730672631 10:02:07 INFO - 2015-11-19 10:02:07,710 DEBUG : BROWSER_OUTPUT: |5;yui.html;831.4387788242934;844.1516276142476;850.5207320660276;852.4160949749419;866.9826603467931;13886.583402497916;14002.089864158823;14054.508092216762;14059.859401405984;14196.14823110614;13245.867541324584;13649.931750341259;13651.863481365184;13672.248026358546;13740.862591374083;790.7746292306693;802.3420794948145;804.0592506767082;807.0114110214998;808.5795386399069;796.7291121018852;800.967961281548;801.7634797734682;808.3775492870486;808.5189312359137;816.9019717633862;829.8630725930215;829.9875501867476;831.0816547714779;831.2560258568577;818.0510607695045;820.2412768189431;823.9340852731767;824.3487644760631;825.6697321071559;599.7271241585069;600.0099835271793;601.4947444146937;601.5217901768104;604.6734763227852;13573.728525429437;13637.045406821526;13651.590452286448;13700.10949288303;13706.52027179054;9877.60489580416;10288.588456461732;10340.069393754524;10437.739056523647;10517.263791534595;9182.08179182083;9337.579808908615;9344.672936447192;9415.62337506499;9477.099675530813;2986.835724035177;3025.909222723322;3058.938821223563;3061.3112049788842;3091.7990330628436;46440.98133621338;46457.76771116123;46586.534134658556;46681.766591167165;46928;6890.8621827564175;7175.533590316612;7263.818404539928;9839.55721992512;10133.13868321201;18706;19221.90389048074;19236.903815480833;19237.519062023563;19272.903635482013;7467.925320746832;7526.5107767994905;7531.133919599207;7607.277308655669;7977.760667179994;4172;4243.533211346749;4270.423492828429;4316.374125751749;4343;3211.245357341023;3220.3076338587316;3221.7744757867194;3224;3227.2738633807676;481.07393267959037;491.5796993570517;492.6206820748076;496.4365445219702;503.4839289728058;485.56056768623745;632.9177206963066;633.9270983836825;643.6266965160196;651.2543138106842;7713.344365728976;7798.025246844145;7798.493097948615;7809.414293927978;7964.283214510606;617.8393617659351;621.273110460762;621.8196722950294;638.6072565372262;665.1951139121717;3629.8003609801185;3711.480392745018;3800.7149463790324;3855.7879316637855;3875.7868317242824;61009.69495152496;61714;61809.690951545854;62393;63671;53751.46248537464;54887.45112548903;54904;55731.442685573435;56237.87524249492;48640.51359486431;49268.26097608467;49768.50231497711;50079.24881126786;50160.74919625378;8038.035435747748;8135.674573017013;8254;8359.582020899052;8560.91439085626;34956;35726.28547429089;35782;35916.4612530807;36263.27473450464;44235.55764442314;47020.29469557891;47055.294170586785;47308.52691473041;47711.52288477071;7509.88735168962;7521.887171692539;7572.318491335806;7596.620168991639;7789.1821358756515;10506.369617822955;10591.152707783513;10933.617323393642;11114.05530529914;11359.659210223706;10137.543810528692;10194.949025255122;10267.435291058764;10329.225308102074;10339.896601033894;9945.651902183388;10098.09117179428;10452.111570516592;10574.10120139766;10665.306755061207;9621.615135394506;10149.79700405973;10172.694819155437;10206.285560010729;10295.227857910537;8847.292216622525;8995.730128096167;9472.763180920532;9515.714528564155;9573.138417542455;8383.826264322877;8926.464412135292;9110.681126160553;9241.21449676785;9276.304277179104 10:02:07 INFO - 2015-11-19 10:02:07,710 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:02:07 INFO - 2015-11-19 10:02:07,710 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:02:07 INFO - 2015-11-19 10:02:07,710 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,289 10:02:07 INFO - 2015-11-19 10:02:07,710 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:02:07 INFO - 2015-11-19 10:02:07,711 DEBUG : BROWSER_OUTPUT: __startTimestamp1447956127695__endTimestamp 10:02:07 INFO - 2015-11-19 10:02:07,711 DEBUG : BROWSER_OUTPUT: 10:02:07 INFO - 2015-11-19 10:02:07,711 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:02:07 INFO - 2015-11-19 10:02:07,711 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:02:07 INFO - 2015-11-19 10:02:07,711 DEBUG : BROWSER_OUTPUT: 10:02:07 INFO - 2015-11-19 10:02:07,711 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5571.94 Median:5783.36 stddev:622.32 (10.8%) stddev-sans-first:597.44 10:02:07 INFO - 2015-11-19 10:02:07,711 DEBUG : BROWSER_OUTPUT: Values: 3269.6 3333.6 3359.4 3366.0 3389.7 5374.8 5483.8 5577.2 5587.7 5591.3 5411.6 5453.1 5522.8 5542.6 5558.2 5124.9 5141.2 5161.3 5162.9 5209.9 5082.2 5182.0 5220.6 5222.7 5226.1 4944.7 5017.4 5111.6 5163.0 5246.8 5128.8 5147.2 5150.5 5175.1 5190.4 4905.9 5053.3 5090.2 5136.4 5137.6 5292.8 5349.3 5351.6 5375.3 5400.9 6011.0 6029.8 6036.8 6042.3 6056.1 5733.4 5876.5 6120.8 6125.8 6127.5 5523.7 5549.0 5560.1 5566.0 5649.5 6019.8 6065.6 6093.3 6097.9 6119.7 5694.9 5953.6 5960.9 5962.0 5977.0 5936.2 5972.6 6024.2 6054.5 6122.6 6016.1 6020.7 6024.2 6033.5 6040.5 5732.1 5851.4 5922.3 5940.9 5962.3 4523.4 4595.7 4598.4 4615.1 4646.1 4103.6 4111.8 4124.9 4125.9 4165.1 5516.0 5590.0 5731.9 5745.7 5753.8 6093.3 6096.6 6102.4 6115.4 6138.6 5684.6 5693.5 5699.4 5706.8 5712.8 5013.4 5148.5 5150.8 5153.7 5200.2 6105.9 6115.8 6121.3 6134.3 6147.9 6032.7 6032.9 6036.3 6054.9 6094.9 6200.3 6217.3 6257.9 6261.5 6293.6 5584.9 5736.8 5852.4 5863.8 5881.1 6062.9 6080.1 6085.8 6085.8 6139.5 5843.9 5844.6 5907.1 5919.4 5951.5 5734.8 5783.4 5873.8 5878.7 5942.0 5802.9 5861.0 5862.7 5868.4 5883.1 5882.1 5912.3 5944.4 5950.0 5954.7 5649.4 5784.0 5811.4 5901.3 5953.8 10:02:07 INFO - 2015-11-19 10:02:07,711 DEBUG : BROWSER_OUTPUT: 10:02:07 INFO - 2015-11-19 10:02:07,711 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49081.96 Median:37696.93 stddev:89319.56 (236.9%) stddev-sans-first:89495.81 10:02:07 INFO - 2015-11-19 10:02:07,711 DEBUG : BROWSER_OUTPUT: Values: 555.2 598.1 606.0 611.4 612.5 38112.4 39032.4 39127.8 39231.6 39285.4 42757.4 42992.6 43099.6 43261.0 43319.0 8616.8 8708.0 8740.8 8753.4 8793.7 8424.7 8588.7 8660.4 8670.1 8678.4 8644.0 8734.2 8752.2 8752.5 8760.7 8556.1 8692.3 8699.6 8711.3 8715.5 8528.8 8639.4 8642.1 8645.4 8675.7 41008.0 41544.4 41593.4 41650.2 41688.8 3399.9 3410.8 3443.9 3582.0 3657.2 30445.5 30578.8 30799.5 30839.4 31242.4 3201.1 3212.7 3218.0 3317.1 3374.2 276973.0 278288.0 280354.6 281122.0 281598.0 41383.2 42236.0 42411.8 57834.7 58425.7 41467.4 41682.8 41735.6 41946.4 41966.0 13217.4 13411.7 13431.2 13501.9 13531.9 9994.1 10054.1 10147.3 10148.7 10149.9 14431.9 14445.9 14459.3 14477.3 14486.9 5524.0 5663.5 5686.9 5714.6 5735.0 902.2 944.6 952.7 960.3 1095.6 28739.0 28846.1 29033.4 29055.9 29210.0 992.7 1018.4 1050.6 1105.2 1107.3 14619.9 14925.7 15041.1 15173.5 15177.2 408309.0 411537.0 416635.0 417474.0 417804.0 53604.5 54404.5 54434.0 54575.7 54656.7 1296.8 1320.3 1327.8 1334.4 1338.6 27696.3 28312.7 28667.9 28843.6 28869.7 45392.3 46075.0 46094.3 46202.5 46277.0 306525.0 308464.0 309070.0 309466.0 309920.0 32418.0 32620.7 33033.0 33107.0 33306.3 43312.4 43819.0 44016.8 44162.8 44757.8 36612.1 37342.3 37447.3 37782.6 38075.4 36781.1 36937.6 37410.6 37611.2 41582.4 35954.3 36633.6 36925.8 36964.8 37005.6 32759.8 33783.0 34388.1 34443.0 34702.0 25885.0 25955.4 25975.0 26225.3 26302.0 10:02:07 INFO - 2015-11-19 10:02:07,712 DEBUG : BROWSER_OUTPUT: 10:02:07 INFO - 2015-11-19 10:02:07,712 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27767.88 Median:2605.27 stddev:89012.74 (3416.6%) stddev-sans-first:89238.64 10:02:07 INFO - 2015-11-19 10:02:07,712 DEBUG : BROWSER_OUTPUT: Values: 352.9 356.3 356.5 358.2 358.8 14523.3 14693.6 16655.5 17248.3 17919.6 16130.3 16316.9 16383.5 16421.3 16620.8 5088.7 5314.4 5338.0 5346.6 5354.3 5386.4 5400.7 5434.0 5434.9 5442.3 5259.4 5402.2 5417.5 5438.7 5460.3 5338.1 5380.4 5418.5 5419.5 5420.6 4735.8 4778.9 4789.2 4820.2 4829.8 20803.2 20869.7 20962.3 21152.3 21239.5 2062.0 2090.8 2094.6 2225.7 2231.7 12901.9 13034.5 13091.3 13115.9 13459.0 1667.4 1674.4 1731.9 1741.1 1788.1 53884.7 54311.5 55600.4 57504.4 57668.4 6561.0 6842.9 6876.0 6914.5 6940.6 8057.9 8173.5 8185.5 8399.7 8444.4 5265.2 5370.0 5371.5 5431.5 5435.7 5432.7 5495.5 5495.7 5541.5 5569.3 3184.6 3243.8 3258.5 3276.1 3318.3 1160.5 1173.2 1176.6 1183.9 1215.1 462.4 470.8 474.7 478.6 487.6 11951.9 12038.3 12121.6 12171.7 12183.1 501.8 508.7 515.0 522.4 528.9 6506.2 6609.6 6616.7 6671.4 6708.4 529818.0 541313.0 544695.0 550379.0 554100.0 72740.0 76171.0 76455.0 77283.2 79218.6 547.8 560.4 560.5 560.6 561.9 11094.6 11223.6 11467.3 11519.3 11694.9 30150.0 30438.4 33165.2 35607.1 36363.8 47218.6 48886.5 50502.7 50572.0 51299.5 6387.0 6692.6 6783.7 6802.8 6892.4 11850.2 12112.5 12233.6 12240.4 12330.5 10618.5 10628.7 10838.7 10873.1 10886.5 9292.4 9396.2 9573.7 10481.4 10753.8 10026.5 10205.8 10338.6 10438.7 10458.4 15087.2 15100.4 15313.9 15636.8 15798.7 14408.4 16152.8 16521.6 16523.9 16794.0 10:02:07 INFO - 2015-11-19 10:02:07,712 DEBUG : BROWSER_OUTPUT: 10:02:07 INFO - 2015-11-19 10:02:07,712 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5606.79 Median:6587.44 stddev:2890.83 (43.9%) stddev-sans-first:2882.72 10:02:07 INFO - 2015-11-19 10:02:07,712 DEBUG : BROWSER_OUTPUT: Values: 1533.4 1664.9 1736.3 1746.3 1752.2 6581.3 6593.6 7640.0 7721.1 7724.2 7670.1 7846.4 7907.8 7923.5 7938.8 2218.4 2245.2 2248.4 2256.2 2261.0 2257.4 2264.0 2310.5 2316.1 2317.0 2246.2 2251.1 2274.6 2284.6 2301.5 2272.8 2293.3 2315.1 2315.9 2317.0 2318.2 2339.0 2339.0 2347.3 2348.4 7811.7 7879.5 7893.8 7909.1 7932.6 4781.0 4842.4 4843.2 4872.3 4889.0 3152.1 3160.8 3251.7 3280.6 3313.3 1099.0 1103.3 1111.7 1116.2 1129.2 11014.7 11047.1 11050.0 11061.1 11083.4 4306.6 4335.9 4374.1 4382.4 4400.0 9400.8 9427.8 9429.1 9450.8 9489.1 4823.3 4870.9 4879.5 4880.0 4896.7 4259.0 4375.1 4378.1 4400.9 4460.6 3560.3 3574.1 3579.7 3599.5 3605.1 1136.2 1137.4 1138.4 1150.9 1152.2 1336.5 1340.9 1350.9 1355.4 1359.2 7543.3 7552.8 7763.7 7779.3 7797.0 1091.8 1109.8 1117.8 1121.3 1138.3 5957.4 6026.4 6032.3 6034.9 6038.4 9366.3 9466.0 9498.5 9539.9 9735.5 9577.4 9604.5 9612.4 9627.8 9723.9 7246.5 7297.8 7442.5 7529.2 7564.5 7178.1 7211.9 7227.3 7232.5 7279.1 8267.3 8306.9 8437.5 8473.9 8578.4 8615.1 8634.8 8860.6 8867.8 8868.0 6960.2 7091.1 7156.4 7240.0 7316.7 7699.0 7732.7 7768.2 7776.6 7780.7 7228.1 7305.0 7418.8 7498.7 7554.9 7107.5 7217.2 7232.7 7324.5 7342.8 7335.6 7338.1 7364.1 7367.9 7420.7 6649.9 6757.4 6776.2 6798.6 6799.8 6850.9 6866.9 6884.0 6897.8 6921.9 10:02:07 INFO - 2015-11-19 10:02:07,712 DEBUG : BROWSER_OUTPUT: 10:02:07 INFO - 2015-11-19 10:02:07,712 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5637.86 Median:6385.01 stddev:1748.50 (27.4%) stddev-sans-first:1707.31 10:02:07 INFO - 2015-11-19 10:02:07,713 DEBUG : BROWSER_OUTPUT: Values: 324.3 324.3 330.2 334.4 334.6 6271.7 6344.0 6347.1 6366.6 6372.3 6167.4 6318.4 6337.4 6337.6 6342.4 4793.5 4799.7 4822.1 4825.4 4831.6 4823.5 4828.9 4830.9 4832.1 4840.2 4697.0 4776.2 4793.1 4798.8 4800.0 4774.4 4781.4 4783.8 4786.5 4788.6 4147.4 4170.0 4171.2 4172.8 4177.1 5962.9 5984.2 5991.1 5992.2 5994.6 5453.8 5594.3 5596.9 5598.2 5605.4 6691.2 6700.1 6707.6 6709.4 6711.5 4617.2 4622.8 4626.4 4630.8 4646.1 6698.9 6986.0 6986.0 6992.4 6999.9 4589.5 4603.7 4608.3 4609.5 4617.3 4661.4 4662.9 4667.4 4667.5 4673.4 5448.9 5449.5 5450.3 5451.8 5455.1 6570.1 6695.4 6744.3 6755.0 6761.0 1621.1 1640.1 1660.4 1662.2 1665.7 1056.0 1082.8 1084.4 1086.9 1093.6 6372.1 6444.2 6466.6 6478.0 6493.4 6864.1 6904.3 6916.1 6924.2 6932.3 6397.7 6398.9 6429.8 6453.5 6456.3 3801.1 3824.3 3824.6 3835.9 3836.0 7401.7 7403.2 7409.8 7428.0 7428.2 7041.6 7252.4 7255.6 7264.1 7284.6 7405.0 7410.8 7416.6 7424.6 7447.9 7010.8 7026.2 7040.4 7048.5 7071.1 6753.8 6928.7 6938.6 6942.7 6943.7 7391.7 7404.3 7408.5 7409.1 7412.1 4561.8 4577.8 4619.9 4624.0 4625.2 6876.8 6898.6 7055.7 7088.7 7102.7 6827.1 6831.3 6863.0 6876.2 6886.1 6832.8 6835.9 6842.9 6844.1 6856.9 6582.6 6724.2 6741.6 6749.7 6752.3 6895.0 6899.6 6908.7 6912.2 6912.6 6660.0 6720.7 6722.8 6725.7 6726.9 10:02:07 INFO - 2015-11-19 10:02:07,713 DEBUG : BROWSER_OUTPUT: 10:02:07 INFO - 2015-11-19 10:02:07,713 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13779.51 Median:54895.73 stddev:16920.79 (30.8%) stddev-sans-first:16940.32 10:02:07 INFO - 2015-11-19 10:02:07,713 DEBUG : BROWSER_OUTPUT: Values: 831.4 844.2 850.5 852.4 867.0 13886.6 14002.1 14054.5 14059.9 14196.1 13245.9 13649.9 13651.9 13672.2 13740.9 790.8 802.3 804.1 807.0 808.6 796.7 801.0 801.8 808.4 808.5 816.9 829.9 830.0 831.1 831.3 818.1 820.2 823.9 824.3 825.7 599.7 600.0 601.5 601.5 604.7 13573.7 13637.0 13651.6 13700.1 13706.5 9877.6 10288.6 10340.1 10437.7 10517.3 9182.1 9337.6 9344.7 9415.6 9477.1 2986.8 3025.9 3058.9 3061.3 3091.8 46441.0 46457.8 46586.5 46681.8 46928.0 6890.9 7175.5 7263.8 9839.6 10133.1 18706.0 19221.9 19236.9 19237.5 19272.9 7467.9 7526.5 7531.1 7607.3 7977.8 4172.0 4243.5 4270.4 4316.4 4343.0 3211.2 3220.3 3221.8 3224.0 3227.3 481.1 491.6 492.6 496.4 503.5 485.6 632.9 633.9 643.6 651.3 7713.3 7798.0 7798.5 7809.4 7964.3 617.8 621.3 621.8 638.6 665.2 3629.8 3711.5 3800.7 3855.8 3875.8 61009.7 61714.0 61809.7 62393.0 63671.0 53751.5 54887.5 54904.0 55731.4 56237.9 48640.5 49268.3 49768.5 50079.2 50160.7 8038.0 8135.7 8254.0 8359.6 8560.9 34956.0 35726.3 35782.0 35916.5 36263.3 44235.6 47020.3 47055.3 47308.5 47711.5 7509.9 7521.9 7572.3 7596.6 7789.2 10506.4 10591.2 10933.6 11114.1 11359.7 10137.5 10194.9 10267.4 10329.2 10339.9 9945.7 10098.1 10452.1 10574.1 10665.3 9621.6 10149.8 10172.7 10206.3 10295.2 8847.3 8995.7 9472.8 9515.7 9573.1 8383.8 8926.5 9110.7 9241.2 9276.3 10:02:07 INFO - 2015-11-19 10:02:07,714 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:02:07 INFO - 2015-11-19 10:02:07,714 DEBUG : BROWSER_OUTPUT: 10:02:08 INFO - 2015-11-19 10:02:08,429 INFO : Browser exited with error code: 0 10:02:08 INFO - 2015-11-19 10:02:08,448 INFO : Completed test dromaeo_css (00:18:30) 10:02:08 INFO - 2015-11-19 10:02:08,448 INFO : Starting test kraken 10:02:08 INFO - 2015-11-19 10:02:08,448 DEBUG : operating with platform_type : linux_ 10:02:08 INFO - 2015-11-19 10:02:08,448 INFO : Initialising browser for kraken test... 10:02:08 INFO - 2015-11-19 10:02:08,454 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIDEy3z/profile http://localhost:58870/getInfo.html 10:02:13 INFO - 2015-11-19 10:02:13,114 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:02:13 INFO - 2015-11-19 10:02:13,114 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:02:13 INFO - 2015-11-19 10:02:13,114 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:02:13 INFO - 2015-11-19 10:02:13,115 DEBUG : BROWSER_OUTPUT: __metrics 10:02:14 INFO - 2015-11-19 10:02:14,157 INFO : Browser initialized. 10:02:14 INFO - 2015-11-19 10:02:14,157 INFO : Running cycle 1/1 for kraken test... 10:02:14 INFO - 2015-11-19 10:02:14,158 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIDEy3z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:02:25 INFO - 2015-11-19 10:02:25,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 142086144 10:02:25 INFO - 2015-11-19 10:02:25,987 DEBUG : BROWSER_OUTPUT: 10:02:28 INFO - 2015-11-19 10:02:28,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58870/tests/kraken/driver.html?testName=audio-beat-detection) 10:02:29 INFO - 2015-11-19 10:02:29,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 141811712 10:02:29 INFO - 2015-11-19 10:02:29,053 DEBUG : BROWSER_OUTPUT: 10:02:31 INFO - 2015-11-19 10:02:31,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58870/tests/kraken/driver.html?testName=audio-dft) 10:02:32 INFO - 2015-11-19 10:02:32,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 142196736 10:02:32 INFO - 2015-11-19 10:02:32,299 DEBUG : BROWSER_OUTPUT: 10:02:35 INFO - 2015-11-19 10:02:35,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58870/tests/kraken/driver.html?testName=audio-fft) 10:02:35 INFO - 2015-11-19 10:02:35,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 137187328 10:02:35 INFO - 2015-11-19 10:02:35,724 DEBUG : BROWSER_OUTPUT: 10:02:37 INFO - 2015-11-19 10:02:37,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58870/tests/kraken/driver.html?testName=audio-oscillator) 10:02:38 INFO - 2015-11-19 10:02:38,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 137654272 10:02:38 INFO - 2015-11-19 10:02:38,392 DEBUG : BROWSER_OUTPUT: 10:02:40 INFO - 2015-11-19 10:02:40,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58870/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:02:41 INFO - 2015-11-19 10:02:41,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 137252864 10:02:41 INFO - 2015-11-19 10:02:41,191 DEBUG : BROWSER_OUTPUT: 10:02:44 INFO - 2015-11-19 10:02:44,192 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58870/tests/kraken/driver.html?testName=imaging-darkroom) 10:02:44 INFO - 2015-11-19 10:02:44,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 137826304 10:02:44 INFO - 2015-11-19 10:02:44,774 DEBUG : BROWSER_OUTPUT: 10:02:48 INFO - 2015-11-19 10:02:48,223 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58870/tests/kraken/driver.html?testName=imaging-desaturate) 10:02:48 INFO - 2015-11-19 10:02:48,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 139091968 10:02:48 INFO - 2015-11-19 10:02:48,810 DEBUG : BROWSER_OUTPUT: 10:02:51 INFO - 2015-11-19 10:02:51,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58870/tests/kraken/driver.html?testName=json-parse-financial) 10:02:52 INFO - 2015-11-19 10:02:52,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 139534336 10:02:52 INFO - 2015-11-19 10:02:52,312 DEBUG : BROWSER_OUTPUT: 10:02:53 INFO - 2015-11-19 10:02:53,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58870/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:02:54 INFO - 2015-11-19 10:02:54,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 139706368 10:02:54 INFO - 2015-11-19 10:02:54,491 DEBUG : BROWSER_OUTPUT: 10:02:56 INFO - 2015-11-19 10:02:56,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58870/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:02:56 INFO - 2015-11-19 10:02:56,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 139251712 10:02:56 INFO - 2015-11-19 10:02:56,927 DEBUG : BROWSER_OUTPUT: 10:02:59 INFO - 2015-11-19 10:02:59,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58870/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:02:59 INFO - 2015-11-19 10:02:59,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 139960320 10:02:59 INFO - 2015-11-19 10:02:59,626 DEBUG : BROWSER_OUTPUT: 10:03:02 INFO - 2015-11-19 10:03:02,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:03:02 INFO - 2015-11-19 10:03:02,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 139726848 10:03:02 INFO - 2015-11-19 10:03:02,688 DEBUG : BROWSER_OUTPUT: 10:03:05 INFO - 2015-11-19 10:03:05,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:03:05 INFO - 2015-11-19 10:03:05,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 140177408 10:03:05 INFO - 2015-11-19 10:03:05,881 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58870/tests/kraken/driver.html?testName=ai-astar) 10:03:07 INFO - 2015-11-19 10:03:07,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 138772480 10:03:07 INFO - 2015-11-19 10:03:07,822 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,822 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:03:07 INFO - 2015-11-19 10:03:07,823 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:03:07 INFO - 2015-11-19 10:03:07,823 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:03:07 INFO - 2015-11-19 10:03:07,823 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:03:07 INFO - 2015-11-19 10:03:07,823 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;105;111;109;111;123;110;112;112;110 10:03:07 INFO - 2015-11-19 10:03:07,824 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;125;155;165;127;159;147;135;166;130 10:03:07 INFO - 2015-11-19 10:03:07,824 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;164;162;161;164;161;164;175;163 10:03:07 INFO - 2015-11-19 10:03:07,824 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;71;148;74;73;73;73;158;73 10:03:07 INFO - 2015-11-19 10:03:07,824 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;146;90;91;92;141;91;91;141 10:03:07 INFO - 2015-11-19 10:03:07,824 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;112;110;110;109;111;111;112;110;110 10:03:07 INFO - 2015-11-19 10:03:07,825 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;148;147;148;147;147;155;146;147;147 10:03:07 INFO - 2015-11-19 10:03:07,825 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;96;97;96;95;97;96;97 10:03:07 INFO - 2015-11-19 10:03:07,825 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;62;61;61;63;62;63;60;63;65 10:03:07 INFO - 2015-11-19 10:03:07,825 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;70;69;71;70;70;69;70;70;70 10:03:07 INFO - 2015-11-19 10:03:07,826 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;85;93;86;86;86;84;93;94 10:03:07 INFO - 2015-11-19 10:03:07,826 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;130;116;122;126;123;124;133;126;129 10:03:07 INFO - 2015-11-19 10:03:07,826 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;152;154;155;154;152;156;151;160;143 10:03:07 INFO - 2015-11-19 10:03:07,826 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;68;68;68;71;68;71;68;68;70 10:03:07 INFO - 2015-11-19 10:03:07,827 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:03:07 INFO - 2015-11-19 10:03:07,827 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:03:07 INFO - 2015-11-19 10:03:07,827 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,724 10:03:07 INFO - 2015-11-19 10:03:07,827 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:03:07 INFO - 2015-11-19 10:03:07,827 DEBUG : BROWSER_OUTPUT: __startTimestamp1447956187821__endTimestamp 10:03:07 INFO - 2015-11-19 10:03:07,828 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,829 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:03:07 INFO - 2015-11-19 10:03:07,829 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:03:07 INFO - 2015-11-19 10:03:07,829 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,829 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.50 Median:111.50 stddev:4.55 (4.1%) stddev-sans-first:4.82 10:03:07 INFO - 2015-11-19 10:03:07,830 DEBUG : BROWSER_OUTPUT: Values: 112.0 105.0 111.0 109.0 111.0 123.0 110.0 112.0 112.0 110.0 10:03:07 INFO - 2015-11-19 10:03:07,830 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,830 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.90 Median:152.50 stddev:15.66 (10.3%) stddev-sans-first:16.54 10:03:07 INFO - 2015-11-19 10:03:07,830 DEBUG : BROWSER_OUTPUT: Values: 150.0 125.0 155.0 165.0 127.0 159.0 147.0 135.0 166.0 130.0 10:03:07 INFO - 2015-11-19 10:03:07,830 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,830 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:4.10 (2.5%) stddev-sans-first:4.30 10:03:07 INFO - 2015-11-19 10:03:07,830 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 164.0 162.0 161.0 164.0 161.0 164.0 175.0 163.0 10:03:07 INFO - 2015-11-19 10:03:07,830 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,830 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.70 Median:73.00 stddev:33.98 (46.5%) stddev-sans-first:35.50 10:03:07 INFO - 2015-11-19 10:03:07,831 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 71.0 148.0 74.0 73.0 73.0 73.0 158.0 73.0 10:03:07 INFO - 2015-11-19 10:03:07,831 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,831 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:91.00 stddev:25.07 (27.5%) stddev-sans-first:25.96 10:03:07 INFO - 2015-11-19 10:03:07,831 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 146.0 90.0 91.0 92.0 141.0 91.0 91.0 141.0 10:03:07 INFO - 2015-11-19 10:03:07,831 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,831 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:110.50 stddev:0.97 (0.9%) stddev-sans-first:1.01 10:03:07 INFO - 2015-11-19 10:03:07,831 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 110.0 110.0 109.0 111.0 111.0 112.0 110.0 110.0 10:03:07 INFO - 2015-11-19 10:03:07,831 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,832 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.00 stddev:2.62 (1.8%) stddev-sans-first:2.69 10:03:07 INFO - 2015-11-19 10:03:07,832 DEBUG : BROWSER_OUTPUT: Values: 146.0 148.0 147.0 148.0 147.0 147.0 155.0 146.0 147.0 147.0 10:03:07 INFO - 2015-11-19 10:03:07,832 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,832 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 10:03:07 INFO - 2015-11-19 10:03:07,832 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 96.0 97.0 96.0 95.0 97.0 96.0 97.0 10:03:07 INFO - 2015-11-19 10:03:07,832 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,832 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.50 stddev:1.40 (2.2%) stddev-sans-first:1.48 10:03:07 INFO - 2015-11-19 10:03:07,833 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 61.0 61.0 63.0 62.0 63.0 60.0 63.0 65.0 10:03:07 INFO - 2015-11-19 10:03:07,833 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,833 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 10:03:07 INFO - 2015-11-19 10:03:07,833 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 69.0 71.0 70.0 70.0 69.0 70.0 70.0 70.0 10:03:07 INFO - 2015-11-19 10:03:07,833 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,833 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:86.00 stddev:3.97 (4.6%) stddev-sans-first:3.98 10:03:07 INFO - 2015-11-19 10:03:07,833 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 85.0 93.0 86.0 86.0 86.0 84.0 93.0 94.0 10:03:07 INFO - 2015-11-19 10:03:07,833 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,834 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:126.00 stddev:5.76 (4.6%) stddev-sans-first:5.00 10:03:07 INFO - 2015-11-19 10:03:07,834 DEBUG : BROWSER_OUTPUT: Values: 115.0 130.0 116.0 122.0 126.0 123.0 124.0 133.0 126.0 129.0 10:03:07 INFO - 2015-11-19 10:03:07,834 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,834 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:154.00 stddev:5.57 (3.6%) stddev-sans-first:4.61 10:03:07 INFO - 2015-11-19 10:03:07,834 DEBUG : BROWSER_OUTPUT: Values: 142.0 152.0 154.0 155.0 154.0 152.0 156.0 151.0 160.0 143.0 10:03:07 INFO - 2015-11-19 10:03:07,834 DEBUG : BROWSER_OUTPUT: 10:03:07 INFO - 2015-11-19 10:03:07,835 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.33 (1.9%) stddev-sans-first:1.36 10:03:07 INFO - 2015-11-19 10:03:07,836 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 68.0 68.0 71.0 68.0 71.0 68.0 68.0 70.0 10:03:07 INFO - 2015-11-19 10:03:07,836 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:03:07 INFO - 2015-11-19 10:03:07,836 DEBUG : BROWSER_OUTPUT: 10:03:08 INFO - 2015-11-19 10:03:08,689 INFO : Browser exited with error code: 0 10:03:08 INFO - 2015-11-19 10:03:08,742 INFO : Completed test kraken (00:01:00) 10:03:08 INFO - 2015-11-19 10:03:08,742 INFO : Starting test v8_7 10:03:08 INFO - 2015-11-19 10:03:08,743 DEBUG : operating with platform_type : linux_ 10:03:08 INFO - 2015-11-19 10:03:08,743 INFO : Initialising browser for v8_7 test... 10:03:08 INFO - 2015-11-19 10:03:08,749 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpouW2qN/profile http://localhost:58870/getInfo.html 10:03:13 INFO - 2015-11-19 10:03:13,327 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:03:13 INFO - 2015-11-19 10:03:13,327 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:03:13 INFO - 2015-11-19 10:03:13,327 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:03:13 INFO - 2015-11-19 10:03:13,327 DEBUG : BROWSER_OUTPUT: __metrics 10:03:14 INFO - 2015-11-19 10:03:14,361 INFO : Browser initialized. 10:03:14 INFO - 2015-11-19 10:03:14,361 INFO : Running cycle 1/1 for v8_7 test... 10:03:14 INFO - 2015-11-19 10:03:14,362 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpouW2qN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:03:26 INFO - 2015-11-19 10:03:26,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 141455360 10:03:26 INFO - 2015-11-19 10:03:26,141 DEBUG : BROWSER_OUTPUT: 10:03:47 INFO - 2015-11-19 10:03:47,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58870/tests/v8_7/run.html (next: http://localhost:58870/tests/v8_7/run.html) 10:03:47 INFO - 2015-11-19 10:03:47,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 139022336 10:03:47 INFO - 2015-11-19 10:03:47,869 DEBUG : BROWSER_OUTPUT: 10:03:47 INFO - 2015-11-19 10:03:47,869 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:03:47 INFO - 2015-11-19 10:03:47,870 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:03:47 INFO - 2015-11-19 10:03:47,870 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:03:47 INFO - 2015-11-19 10:03:47,870 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:03:47 INFO - 2015-11-19 10:03:47,870 DEBUG : BROWSER_OUTPUT: |0;Richards;165.8649859014762 10:03:47 INFO - 2015-11-19 10:03:47,870 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.38755980861245 10:03:47 INFO - 2015-11-19 10:03:47,870 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.662363177098 10:03:47 INFO - 2015-11-19 10:03:47,870 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5081.218274111675 10:03:47 INFO - 2015-11-19 10:03:47,871 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1061.5711252653928 10:03:47 INFO - 2015-11-19 10:03:47,871 DEBUG : BROWSER_OUTPUT: |5;Earley;746.2686567164179 10:03:47 INFO - 2015-11-19 10:03:47,871 DEBUG : BROWSER_OUTPUT: |6;Boyer;11686.046511627907 10:03:47 INFO - 2015-11-19 10:03:47,871 DEBUG : BROWSER_OUTPUT: |7;RegExp;25175 10:03:47 INFO - 2015-11-19 10:03:47,871 DEBUG : BROWSER_OUTPUT: |8;Splay;696.6136834830684 10:03:47 INFO - 2015-11-19 10:03:47,871 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 10:03:47 INFO - 2015-11-19 10:03:47,872 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:03:47 INFO - 2015-11-19 10:03:47,872 DEBUG : BROWSER_OUTPUT: __startTimestamp1447956227867__endTimestamp 10:03:47 INFO - 2015-11-19 10:03:47,872 DEBUG : BROWSER_OUTPUT: 10:03:47 INFO - 2015-11-19 10:03:47,872 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:03:47 INFO - 2015-11-19 10:03:47,872 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:03:47 INFO - 2015-11-19 10:03:47,872 DEBUG : BROWSER_OUTPUT: 10:03:47 INFO - 2015-11-19 10:03:47,873 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.86 Median:165.86 stddev:0.00 (0.0%) 10:03:47 INFO - 2015-11-19 10:03:47,873 DEBUG : BROWSER_OUTPUT: Values: 165.9 10:03:47 INFO - 2015-11-19 10:03:47,873 DEBUG : BROWSER_OUTPUT: 10:03:47 INFO - 2015-11-19 10:03:47,873 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.39 Median:191.39 stddev:0.00 (0.0%) 10:03:47 INFO - 2015-11-19 10:03:47,873 DEBUG : BROWSER_OUTPUT: Values: 191.4 10:03:47 INFO - 2015-11-19 10:03:47,873 DEBUG : BROWSER_OUTPUT: 10:03:47 INFO - 2015-11-19 10:03:47,874 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.66 Median:280.66 stddev:0.00 (0.0%) 10:03:47 INFO - 2015-11-19 10:03:47,874 DEBUG : BROWSER_OUTPUT: Values: 280.7 10:03:47 INFO - 2015-11-19 10:03:47,874 DEBUG : BROWSER_OUTPUT: 10:03:47 INFO - 2015-11-19 10:03:47,875 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5081.22 Median:5081.22 stddev:0.00 (0.0%) 10:03:47 INFO - 2015-11-19 10:03:47,875 DEBUG : BROWSER_OUTPUT: Values: 5081.2 10:03:47 INFO - 2015-11-19 10:03:47,875 DEBUG : BROWSER_OUTPUT: 10:03:47 INFO - 2015-11-19 10:03:47,875 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1061.57 Median:1061.57 stddev:0.00 (0.0%) 10:03:47 INFO - 2015-11-19 10:03:47,875 DEBUG : BROWSER_OUTPUT: Values: 1061.6 10:03:47 INFO - 2015-11-19 10:03:47,875 DEBUG : BROWSER_OUTPUT: 10:03:47 INFO - 2015-11-19 10:03:47,875 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:746.27 Median:746.27 stddev:0.00 (0.0%) 10:03:47 INFO - 2015-11-19 10:03:47,875 DEBUG : BROWSER_OUTPUT: Values: 746.3 10:03:47 INFO - 2015-11-19 10:03:47,875 DEBUG : BROWSER_OUTPUT: 10:03:47 INFO - 2015-11-19 10:03:47,875 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11686.05 Median:11686.05 stddev:0.00 (0.0%) 10:03:47 INFO - 2015-11-19 10:03:47,875 DEBUG : BROWSER_OUTPUT: Values: 11686.0 10:03:47 INFO - 2015-11-19 10:03:47,876 DEBUG : BROWSER_OUTPUT: 10:03:47 INFO - 2015-11-19 10:03:47,876 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25175.00 Median:25175.00 stddev:0.00 (0.0%) 10:03:47 INFO - 2015-11-19 10:03:47,876 DEBUG : BROWSER_OUTPUT: Values: 25175.0 10:03:47 INFO - 2015-11-19 10:03:47,876 DEBUG : BROWSER_OUTPUT: 10:03:47 INFO - 2015-11-19 10:03:47,876 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:696.61 Median:696.61 stddev:0.00 (0.0%) 10:03:47 INFO - 2015-11-19 10:03:47,876 DEBUG : BROWSER_OUTPUT: Values: 696.6 10:03:47 INFO - 2015-11-19 10:03:47,876 DEBUG : BROWSER_OUTPUT: 10:03:47 INFO - 2015-11-19 10:03:47,876 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 10:03:47 INFO - 2015-11-19 10:03:47,876 DEBUG : BROWSER_OUTPUT: Values: 4830.9 10:03:47 INFO - 2015-11-19 10:03:47,876 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:03:47 INFO - 2015-11-19 10:03:47,876 DEBUG : BROWSER_OUTPUT: 10:03:48 INFO - 2015-11-19 10:03:48,749 INFO : Browser exited with error code: 0 10:03:48 INFO - 2015-11-19 10:03:48,764 INFO : Completed test v8_7 (00:00:40) 10:03:48 INFO - 2015-11-19 10:03:48,894 INFO : Completed test suite (00:20:11) 10:03:48 INFO - 2015-11-19 10:03:48,894 DEBUG : Working with test: dromaeo_css 10:03:48 INFO - 2015-11-19 10:03:48,894 DEBUG : Generating results file: dromaeo_css 10:03:48 INFO - 2015-11-19 10:03:48,895 DEBUG : Working with test: kraken 10:03:48 INFO - 2015-11-19 10:03:48,896 DEBUG : Generating results file: kraken 10:03:48 INFO - 2015-11-19 10:03:48,896 INFO : javascript benchmark 10:03:48 INFO - 2015-11-19 10:03:48,896 DEBUG : Working with test: v8_7 10:03:48 INFO - 2015-11-19 10:03:48,896 DEBUG : Generating results file: v8_7 10:03:48 INFO - 2015-11-19 10:03:48,897 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:03:48 INFO - 2015-11-19 10:03:48,945 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 10:03:48 INFO - 2015-11-19 10:03:48,945 DEBUG : process_Request line: dromaeo_css 6867.66 graph.html#tests=[[72,64,43]] 10:03:48 INFO - 2015-11-19 10:03:48,946 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:03:48 INFO - 2015-11-19 10:03:48,974 DEBUG : process_Request line: kraken 1536.00 graph.html#tests=[[232,64,43]] 10:03:48 INFO - 2015-11-19 10:03:48,974 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:03:49 INFO - 2015-11-19 10:03:49,004 DEBUG : process_Request line: v8_7 21105.80 graph.html#tests=[[230,64,43]] 10:03:49 INFO - 2015-11-19 10:03:49,005 INFO : javascript benchmark 10:03:49 INFO - 2015-11-19 10:03:49,009 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3269.5586095877056, 3333.5999680038385, 3359.445691460909, 3365.983170084149, 3389.7457690673205, 5374.838754837351, 5483.808066717661, 5577.191307260455, 5587.664740115596, 5591.273134492515, 5411.56707463402, 5453.127499600065, 5522.779088836442, 5542.584306177033, 5558.249636299099, 5124.9487505125035, 5141.228815677659, 5161.30322406476, 5162.896742065156, 5209.921851172236, 5082.161443361841, 5182.0, 5220.634555581092, 5222.686638801665, 5226.111561034633, 4944.728039957801, 5017.448080711119, 5111.565516931066, 5162.97418512905, 5246.816361427351, 5128.769205385766, 5147.176451767737, 5150.510701483353, 5175.068487672217, 5190.351206099238, 4905.8773530661665, 5053.317802096707, 5090.236464530313, 5136.357955255593, 5137.6403651744395, 5292.782659988225, 5349.277847490617, 5351.598630102758, 5375.274337964403, 5400.945990540084, 6011.0, 6029.8191054268445, 6036.758529658809, 6042.305134909498, 6056.121862329982, 5733.397993210736, 5876.471117599393, 6120.846978825521, 6125.846853828645, 6127.5404344674325, 5523.6685798851795, 5548.9722551386985, 5560.110382338847, 5566.025945459528, 5649.491545760901, 6019.819405417845, 6065.636061836304, 6093.268807743099, 6097.9328617491765, 6119.724612392364, 5694.9179655865255, 5953.583249172516, 5960.8674351873005, 5961.970190149108, 5976.970115149396, 5936.198613187251, 5972.611780234271, 6024.1566180734735, 6054.455099041107, 6122.632642041492, 6016.097585362143, 6020.69896505173, 6024.186734790835, 6033.4871535919065, 6040.456358927718, 5732.140178973187, 5851.38560451155, 5922.2597175353085, 5940.910886336708, 5962.25471816023, 4523.411956445641, 4595.724256544551, 4598.448186217675, 4615.076984603093, 4646.140464014168, 4103.589641035873, 4111.7944102794745, 4124.896877578025, 4125.8968525787095, 4165.12532368206, 5516.0, 5590.0, 5731.885362292731, 5745.6552606843725, 5753.798617048383, 6093.323220756535, 6096.634201947897, 6102.428659372087, 6115.419035191739, 6138.570300078952, 5684.573656975661, 5693.516051135617, 5699.430056994267, 5706.80026199081, 5712.80005199816, 5013.39839219296, 5148.4851514848215, 5150.768215430315, 5153.742312884341, 5200.167973124282, 6105.914670190187, 6115.816525504242, 6121.296050954108, 6134.263888333428, 6147.907781383283, 6032.668203248863, 6032.939670603238, 6036.3058248302, 6054.878902421839, 6094.939050609437, 6200.255969283715, 6217.316095229431, 6257.8748425030335, 6261.499080073674, 6293.590916590407, 5584.86037849057, 5736.770529178786, 5852.4147585241135, 5863.765449382147, 5881.05903055509, 6062.878742425039, 6080.118382834376, 6085.756569737161, 6085.786997455068, 6139.4781443577795, 5843.883122337445, 5844.620099693507, 5907.113932910098, 5919.437653422918, 5951.523878089656, 5734.827955161185, 5783.363829978614, 5873.794417195378, 5878.735456904364, 5941.970290148522, 5802.854928626818, 5860.970695146497, 5862.706864656665, 5868.383819699041, 5883.117532370179, 5882.117682347511, 5912.260967379078, 5944.375840536854, 5950.018246989198, 5954.702264886825, 5649.435056494318, 5784.045632470596, 5811.360750317546, 5901.3213480448585, 5953.76184952597], "unit": "ms", "name": "dojo.html", "value": 5531.455601246963}, {"lowerIsBetter": false, "replicates": [555.2143716640953, 598.0909018292195, 606.0333767640614, 611.3611276216353, 612.4579746923973, 38112.428313575285, 39032.41451378228, 39127.80436097819, 39231.607683923154, 39285.41071883924, 42757.358639620354, 42992.57007429925, 43099.569004309946, 43261.0, 43319.0, 8616.827663446727, 8708.0, 8740.781480462976, 8753.3872628916, 8793.736187914341, 8424.663013479485, 8588.742337729878, 8660.393772435931, 8670.132986701343, 8678.392512524126, 8644.0, 8734.170253825876, 8752.212300892917, 8752.474851508898, 8760.737177884674, 8556.101609331025, 8692.304615630734, 8699.60851761666, 8711.346649001287, 8715.520646364448, 8528.829423411496, 8639.39524233304, 8642.092580279043, 8645.438046526955, 8675.696350627697, 41008.0, 41544.37683434751, 41593.37609935853, 41650.1669966599, 41688.79155604233, 3399.8640054397792, 3410.7612467127065, 3443.896683099511, 3581.982090089559, 3657.158853463718, 30445.543316850264, 30578.84710576455, 30799.538006929914, 30839.38321233585, 31242.37515249682, 3201.103690966533, 3212.678732126792, 3218.0, 3317.08780085476, 3374.190194353362, 276973.0, 278288.0, 280354.5982270096, 281122.0, 281598.0, 41383.1723365531, 42236.0, 42411.78794106071, 57834.7108264456, 58425.70787146037, 41467.37798933018, 41682.791586042484, 41735.58264417377, 41946.37080443796, 41966.0, 13217.405216765268, 13411.664708382368, 13431.19412835233, 13501.864981350258, 13531.932340338235, 9994.10053095225, 10054.09513143806, 10147.34042287249, 10148.695539133838, 10149.949250253701, 14431.855681443261, 14445.855541444662, 14459.27703614815, 14477.276136193148, 14486.85513144855, 5523.978064058162, 5663.490285874291, 5686.943130568724, 5714.628549144292, 5734.971325143431, 902.1519771414848, 944.593824655391, 952.7284723853807, 960.3229723045237, 1095.6274866545414, 28739.0, 28846.134615961553, 29033.419331613248, 29055.85472072626, 29210.0, 992.7021893432086, 1018.3737001744022, 1050.5745173204864, 1105.220819322392, 1107.3245320354577, 14619.853801462063, 14925.70148597022, 15041.097534147986, 15173.544793656209, 15177.24113794306, 408309.0, 411537.0, 416635.0, 417474.0, 417804.0, 53604.46395535995, 54404.45595543994, 54434.0, 54575.727121364136, 54656.72671636696, 1296.7665820152463, 1320.2804471563022, 1327.807467917166, 1334.4061892457958, 1338.5850386380253, 27696.307592310353, 28312.71687283101, 28667.856660716563, 28843.5673464894, 28869.711302887543, 45392.319115213955, 46075.0, 46094.30858537192, 46202.53797461982, 46277.0, 306525.0, 308464.0, 309070.0, 309466.0, 309920.0, 32418.0, 32620.673793262715, 33033.0, 33107.0, 33306.33387332288, 43312.350314744675, 43819.0, 44016.77991610021, 44162.779186103864, 44757.77621111873, 36612.08469788277, 37342.2531549362, 37447.2510549782, 37782.62217377791, 38075.428868566436, 36781.06227324099, 36937.63062369342, 37410.62589374071, 37611.2477750438, 41582.37626435545, 35954.28091438209, 36633.63366366302, 36925.815370922974, 36964.81517592395, 37005.629943700216, 32759.836200818845, 33783.0, 34388.05492814212, 34443.0, 34702.0, 25885.0, 25955.351116222246, 25975.0, 26225.344366390993, 26302.0], "unit": "ms", "name": "ext.html", "value": 18025.121769724254}, {"lowerIsBetter": false, "replicates": [352.9276498317845, 356.28209158545536, 356.5097990263388, 358.2441049385797, 358.8241761536847, 14523.273836308195, 14693.632659183526, 16655.500334989938, 17248.310067597296, 17919.641607167865, 16130.274137663804, 16316.918415407936, 16383.508494745147, 16421.261043253053, 16620.75068873965, 5088.694678319294, 5314.388845282803, 5338.01246769347, 5346.625736198468, 5354.330708661418, 5386.407495175527, 5400.729963501809, 5434.0, 5434.91847622286, 5442.292501974738, 5259.368875734898, 5402.189671549259, 5417.485338892799, 5438.700871452069, 5460.262864513299, 5338.092524270884, 5380.435054319299, 5418.539424148952, 5419.5393391561765, 5420.593455490854, 4735.786889589942, 4778.880527986794, 4789.185838407479, 4820.204666230068, 4829.806807727687, 20803.16787328505, 20869.68695469569, 20962.266320678857, 21152.259670911597, 21239.469013274636, 2061.9690704639443, 2090.818363273453, 2094.6020256151437, 2225.6550234713645, 2231.7400830829833, 12901.874750698007, 13034.543790967366, 13091.279979601119, 13115.86884131156, 13459.0, 1667.4247384652397, 1674.4055860169585, 1731.9134043297784, 1741.1033317841323, 1788.0702034941887, 53884.73057634726, 54311.456885431035, 55600.44399556034, 57504.42495575033, 57668.42331576715, 6561.0, 6842.897356539655, 6875.965620171967, 6914.515983881181, 6940.583564986117, 8057.919420805834, 8173.509589424653, 8185.508869467851, 8399.748007559783, 8444.366672499587, 5265.183896496049, 5370.0, 5371.4897084776885, 5431.53831924283, 5435.701036443033, 5432.674039557639, 5495.505404513613, 5495.725213739297, 5541.473560011793, 5569.275994120739, 3184.57008303876, 3243.772935894512, 3258.4623537116586, 3276.1318250663594, 3318.2699806042633, 1160.5299853559322, 1173.184636677518, 1176.5705517486056, 1183.946722397494, 1215.0886834873845, 462.4150449681156, 470.7575598566741, 474.743638435248, 478.5716783478767, 487.59285996193574, 11951.940240298743, 12038.277703337828, 12121.575744848888, 12171.695707607203, 12183.147179697513, 501.801788293622, 508.6668232307844, 515.0163188310385, 522.3888050980286, 528.857667438339, 6506.186726659168, 6609.570377925419, 6616.669166541654, 6671.3995740382625, 6708.396244338033, 529818.0, 541313.0, 544695.0, 550379.0, 554100.0, 72740.0, 76171.0, 76455.0, 77283.22716772872, 79218.60390698125, 547.843864498616, 560.3527925246347, 560.5459577742042, 560.5991715923053, 561.8539179813196, 11094.611688590861, 11223.60717374888, 11467.31196128235, 11519.30884146954, 11694.88305116938, 30150.0, 30438.391232175676, 33165.17087072843, 35607.10982225465, 36363.81818090893, 47218.614502367665, 48886.51113488962, 50502.747486262335, 50572.0, 51299.48700512947, 6386.9680651596445, 6692.564983276072, 6783.728650854108, 6802.761903333359, 6892.448604111759, 11850.170488065753, 12112.454939527566, 12233.632991010283, 12240.387980601112, 12330.50677972871, 10618.52216650268, 10628.734281642712, 10838.67483975482, 10873.075788557744, 10886.455677215949, 9292.442453452815, 9396.154346108882, 9573.664921727706, 10481.37111773296, 10753.838692419777, 10026.548805303924, 10205.846912296172, 10338.638147665097, 10438.739031524272, 10458.372497650165, 15087.24563771829, 15100.39598416095, 15313.923430382776, 15636.765448518054, 15798.684026319179, 14408.42366305336, 16152.788540859248, 16521.586960326087, 16523.917380413022, 16794.0], "unit": "ms", "name": "jquery.html", "value": 7460.075834048371}, {"lowerIsBetter": false, "replicates": [1533.447958734856, 1664.8917820341678, 1736.3054778088763, 1746.31020746805, 1752.185233866251, 6581.2760596334365, 6593.604383736967, 7639.968604238433, 7721.073471183452, 7724.150343462222, 7670.117936437311, 7846.411519136073, 7907.762767116981, 7923.48497347672, 7938.801529961754, 2218.4121207879884, 2245.236619549353, 2248.3816950338623, 2256.17649557911, 2260.9886950565224, 2257.3905045637666, 2264.0, 2310.4916918277954, 2316.0967222783042, 2317.0268487235317, 2246.1801442473543, 2251.0995601759264, 2274.647429648407, 2284.588774020676, 2301.4706617477905, 2272.8068114210314, 2293.346396277053, 2315.0971121262805, 2315.8610483371053, 2316.9536609267802, 2318.246569864784, 2338.988305058481, 2338.988305058481, 2347.272345572878, 2348.4011577047745, 7811.7265895693945, 7879.527228366316, 7893.8026549336155, 7909.1299957004685, 7932.603369831485, 4781.0, 4842.44311904132, 4843.1766599677785, 4872.342233798463, 4889.0, 3152.1174071260084, 3160.7945483543494, 3251.7398608111293, 3280.5899262592175, 3313.337332533503, 1098.993829948819, 1103.2883789955433, 1111.7220694826294, 1116.1740312168936, 1129.1644183304295, 11014.669559913216, 11047.060999815025, 11050.0, 11061.115110791117, 11083.390413527253, 4306.590873866978, 4335.913281734348, 4374.103308821684, 4382.364557139197, 4400.0, 9400.764980875532, 9427.76430589227, 9429.057094290652, 9450.810983780424, 9489.098535639103, 4823.348847905558, 4870.902581948341, 4879.487653796371, 4880.023995200974, 4896.657233993657, 4259.0, 4375.059362237134, 4378.0806030733265, 4400.9437734943385, 4460.576245256695, 3560.3413368526903, 3574.0707416071486, 3579.731520136, 3599.4960705501253, 3605.0987253186704, 1136.198979719296, 1137.374444055766, 1138.4137169357787, 1150.9482073306722, 1152.176194021279, 1336.5188532128425, 1340.912840665373, 1350.891928645706, 1355.403622406138, 1359.157322460081, 7543.321101100818, 7552.773416797395, 7763.689452421952, 7779.260970207822, 7797.0, 1091.7652704668535, 1109.755853712182, 1117.7820325036703, 1121.3103941076342, 1138.265818547049, 5957.4042595740075, 6026.397360263939, 6032.336442991267, 6034.879302413927, 6038.426349496791, 9366.250699943988, 9466.0, 9498.525073746285, 9539.856902146474, 9735.513224338754, 9577.425354478753, 9604.51977401127, 9612.423254604746, 9627.759306017266, 9723.854142187873, 7246.456515761339, 7297.775202549544, 7442.479026468203, 7529.171791102975, 7564.50830696003, 7178.066851309296, 7211.891821622785, 7227.313405226495, 7232.45756568249, 7279.090113735783, 8267.338612911073, 8306.916930830614, 8437.535935523605, 8473.915260847312, 8578.356623253405, 8615.095414981337, 8634.834297369775, 8860.556972151495, 8867.778305542155, 8868.0, 6960.164780226405, 7091.11361079865, 7156.354038571262, 7239.963800180965, 7316.743913962986, 7699.0, 7732.690692372242, 7768.223177682186, 7776.611169441392, 7780.688772449039, 7228.096487939008, 7304.96347518259, 7418.777436676908, 7498.700051997859, 7554.886676699744, 7107.50247482692, 7217.206107328295, 7232.74685386009, 7324.523905946309, 7342.77971660851, 7335.596542190231, 7338.119425668954, 7364.116306043309, 7367.889481657672, 7420.6660700269695, 6649.900251496135, 6757.358050985148, 6776.15298087739, 6798.558093723892, 6799.830004249933, 6850.9314906850295, 6866.862662746817, 6883.965580172267, 6897.7585784497305, 6921.8961715575315], "unit": "ms", "name": "mootools.html", "value": 4620.652464411716}, {"lowerIsBetter": false, "replicates": [324.3108394661343, 324.31083946613444, 330.2042078590597, 334.3513583647723, 334.6268910165165, 6271.717772700228, 6344.016677415002, 6347.111404403381, 6366.618002919828, 6372.299047104815, 6167.414095660916, 6318.368163183679, 6337.429631333179, 6337.588056776306, 6342.365763423655, 4793.520647935196, 4799.712017278957, 4822.059698358821, 4825.445073816512, 4831.613470922335, 4823.469418363977, 4828.855134345975, 4830.9371938173545, 4832.057748738997, 4840.15297322967, 4696.97651511742, 4776.235802271637, 4793.065352256312, 4798.7840547175465, 4799.952000480003, 4774.355462012636, 4781.402324709411, 4783.784729687138, 4786.545278198566, 4788.640851936118, 4147.39862719907, 4170.0, 4171.249175148472, 4172.7913604319965, 4177.12280421112, 5962.880742385171, 5984.222051133324, 5991.131285963511, 5992.191054207669, 5994.580379373446, 5453.809116680897, 5594.272744543224, 5596.916046259309, 5598.188262701886, 5605.383407825136, 6691.19705635322, 6700.085462823638, 6707.631080290582, 6709.4296984755865, 6711.5301928865, 4617.2381557043045, 4622.8150873965005, 4626.398568186148, 4630.83792067276, 4646.1404640141345, 6698.8995165072565, 6985.965070174668, 6986.0, 6992.370686638176, 6999.8600027999155, 4589.541045895384, 4603.746793926299, 4608.331791890158, 4609.516000819933, 4617.2612382018715, 4661.440627124767, 4662.860114196579, 4667.439907211156, 4667.463241727177, 4673.439187297546, 5448.891022179613, 5449.509544140967, 5450.345958485007, 5451.836444906659, 5455.099908515051, 6570.113034740344, 6695.363940425652, 6744.325567443217, 6754.966225168941, 6760.966195168992, 1621.116491512105, 1640.1307307127242, 1660.3524625396105, 1662.1938359895441, 1665.7085010123421, 1056.0, 1082.783443311341, 1084.4252546150553, 1086.9076128529164, 1093.5516438260274, 6372.107904893319, 6444.162258906406, 6466.64433456155, 6478.0, 6493.38312860287, 6864.107666003388, 6904.275051119661, 6916.066331045345, 6924.203716572558, 6932.272111428329, 6397.712102955378, 6398.9040164397575, 6429.807105786834, 6453.45145662624, 6456.322086180883, 3801.087738942689, 3824.2733880562605, 3824.579296277407, 3835.9232815343535, 3835.961640383616, 7401.703931842773, 7403.185649578542, 7409.777706668809, 7428.034355533854, 7428.182899881009, 7041.577505349593, 7252.419806415474, 7255.637218139072, 7264.091988501437, 7284.562926224444, 7404.962975184982, 7410.814729631802, 7416.555006699616, 7424.628768561658, 7447.925520744723, 7010.824729381602, 7026.191987921455, 7040.401565866959, 7048.506604537633, 7071.116110486189, 6753.763618273337, 6928.7228510859, 6938.618375989369, 6942.687579059056, 6943.652817359213, 7391.741289054858, 7404.296591823768, 7408.481406301723, 7409.110906691231, 7412.073490813648, 4561.840335588238, 4577.793999269974, 4619.86140415788, 4624.028953919715, 4625.167469855458, 6876.793696189123, 6898.586084834926, 7055.6594247094945, 7088.716451341888, 7102.680379383043, 6827.146606674166, 6831.28271531482, 6863.0, 6876.243613202444, 6886.139232595926, 6832.829179270558, 6835.89746153818, 6842.931570684428, 6844.110265665432, 6856.931430685829, 6582.637954912526, 6724.193096828412, 6741.561798483083, 6749.730010799513, 6752.291009443938, 6894.965525172543, 6899.586024838526, 6908.654567271516, 6912.205096413775, 6912.585244885323, 6659.966700166468, 6720.663966801542, 6722.831929201809, 6725.697343619451, 6726.932730672631], "unit": "ms", "name": "prototype.html", "value": 5055.23290733845}, {"lowerIsBetter": false, "replicates": [831.4387788242934, 844.1516276142476, 850.5207320660276, 852.4160949749419, 866.9826603467931, 13886.583402497916, 14002.089864158823, 14054.508092216762, 14059.859401405984, 14196.14823110614, 13245.867541324584, 13649.931750341259, 13651.863481365184, 13672.248026358546, 13740.862591374083, 790.7746292306693, 802.3420794948145, 804.0592506767082, 807.0114110214998, 808.5795386399069, 796.7291121018852, 800.967961281548, 801.7634797734682, 808.3775492870486, 808.5189312359137, 816.9019717633862, 829.8630725930215, 829.9875501867476, 831.0816547714779, 831.2560258568577, 818.0510607695045, 820.2412768189431, 823.9340852731767, 824.3487644760631, 825.6697321071559, 599.7271241585069, 600.0099835271793, 601.4947444146937, 601.5217901768104, 604.6734763227852, 13573.728525429437, 13637.045406821526, 13651.590452286448, 13700.10949288303, 13706.52027179054, 9877.60489580416, 10288.588456461732, 10340.069393754524, 10437.739056523647, 10517.263791534595, 9182.08179182083, 9337.579808908615, 9344.672936447192, 9415.62337506499, 9477.099675530813, 2986.835724035177, 3025.909222723322, 3058.938821223563, 3061.3112049788842, 3091.7990330628436, 46440.98133621338, 46457.76771116123, 46586.534134658556, 46681.766591167165, 46928.0, 6890.8621827564175, 7175.533590316612, 7263.818404539928, 9839.55721992512, 10133.13868321201, 18706.0, 19221.90389048074, 19236.903815480833, 19237.519062023563, 19272.903635482013, 7467.925320746832, 7526.5107767994905, 7531.133919599207, 7607.277308655669, 7977.760667179994, 4172.0, 4243.533211346749, 4270.423492828429, 4316.374125751749, 4343.0, 3211.245357341023, 3220.3076338587316, 3221.7744757867194, 3224.0, 3227.2738633807676, 481.07393267959037, 491.5796993570517, 492.6206820748076, 496.4365445219702, 503.4839289728058, 485.56056768623745, 632.9177206963066, 633.9270983836825, 643.6266965160196, 651.2543138106842, 7713.344365728976, 7798.025246844145, 7798.493097948615, 7809.414293927978, 7964.283214510606, 617.8393617659351, 621.273110460762, 621.8196722950294, 638.6072565372262, 665.1951139121717, 3629.8003609801185, 3711.480392745018, 3800.7149463790324, 3855.7879316637855, 3875.7868317242824, 61009.69495152496, 61714.0, 61809.690951545854, 62393.0, 63671.0, 53751.46248537464, 54887.45112548903, 54904.0, 55731.442685573435, 56237.87524249492, 48640.51359486431, 49268.26097608467, 49768.50231497711, 50079.24881126786, 50160.74919625378, 8038.035435747748, 8135.674573017013, 8254.0, 8359.582020899052, 8560.91439085626, 34956.0, 35726.28547429089, 35782.0, 35916.4612530807, 36263.27473450464, 44235.55764442314, 47020.29469557891, 47055.294170586785, 47308.52691473041, 47711.52288477071, 7509.88735168962, 7521.887171692539, 7572.318491335806, 7596.620168991639, 7789.1821358756515, 10506.369617822955, 10591.152707783513, 10933.617323393642, 11114.05530529914, 11359.659210223706, 10137.543810528692, 10194.949025255122, 10267.435291058764, 10329.225308102074, 10339.896601033894, 9945.651902183388, 10098.09117179428, 10452.111570516592, 10574.10120139766, 10665.306755061207, 9621.615135394506, 10149.79700405973, 10172.694819155437, 10206.285560010729, 10295.227857910537, 8847.292216622525, 8995.730128096167, 9472.763180920532, 9515.714528564155, 9573.138417542455, 8383.826264322877, 8926.464412135292, 9110.681126160553, 9241.21449676785, 9276.304277179104], "unit": "ms", "name": "yui.html", "value": 6038.280356628201}], "name": "dromaeo_css", "value": 6867.657688034691}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 111.0, 109.0, 111.0, 123.0, 110.0, 112.0, 112.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [150.0, 125.0, 155.0, 165.0, 127.0, 159.0, 147.0, 135.0, 166.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 164.0, 162.0, 161.0, 164.0, 161.0, 164.0, 175.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 148.0, 74.0, 73.0, 73.0, 73.0, 158.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 88.7}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 146.0, 90.0, 91.0, 92.0, 141.0, 91.0, 91.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [110.0, 112.0, 110.0, 110.0, 109.0, 111.0, 111.0, 112.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 147.0, 148.0, 147.0, 147.0, 155.0, 146.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 97.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 61.0, 61.0, 63.0, 62.0, 63.0, 60.0, 63.0, 65.0], "unit": "ms", "name": "json-parse-financial", "value": 62.2}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 71.0, 70.0, 70.0, 69.0, 70.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 85.0, 93.0, 86.0, 86.0, 86.0, 84.0, 93.0, 94.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.7}, {"lowerIsBetter": true, "replicates": [115.0, 130.0, 116.0, 122.0, 126.0, 123.0, 124.0, 133.0, 126.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [142.0, 152.0, 154.0, 155.0, 154.0, 152.0, 156.0, 151.0, 160.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.9}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 68.0, 68.0, 71.0, 68.0, 71.0, 68.0, 68.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1536.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.8649859014762], "unit": "score", "name": "Richards", "value": 212.835758}, {"lowerIsBetter": false, "replicates": [191.38755980861245], "unit": "score", "name": "DeltaBlue", "value": 345.4665499999999}, {"lowerIsBetter": false, "replicates": [280.662363177098], "unit": "score", "name": "Encrypt", "value": 948.4029029999999}, {"lowerIsBetter": false, "replicates": [5081.218274111675], "unit": "score", "name": "Decrypt", "value": 52.38527172827171}, {"lowerIsBetter": false, "replicates": [1061.5711252653928], "unit": "score", "name": "RayTrace", "value": 697.0696380000003}, {"lowerIsBetter": false, "replicates": [746.2686567164179], "unit": "score", "name": "Earley", "value": 893.0604200000004}, {"lowerIsBetter": false, "replicates": [11686.046511627907], "unit": "score", "name": "Boyer", "value": 57.0306646766169}, {"lowerIsBetter": false, "replicates": [25175.0], "unit": "score", "name": "RegExp", "value": 36.186097318768596}, {"lowerIsBetter": false, "replicates": [696.6136834830684], "unit": "score", "name": "Splay", "value": 116.98162400793647}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21105.804409533448}]} 10:03:49 INFO - RETURN: dromaeo_css: 6867.66 10:03:49 INFO - RETURN: kraken: 1536.00 10:03:49 INFO - RETURN: v8_7: 21105.80 10:03:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21105.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1536.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6867.66"}}} 10:03:49 INFO - Return code: 0 10:03:49 INFO - # TBPL SUCCESS # 10:03:49 INFO - Running post-action listener: _resource_record_post_action 10:03:49 INFO - Running post-run listener: _resource_record_post_run 10:03:50 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 270336; Write bytes: 272384000; Read time: 88; Write time: 179416 10:03:50 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 548864; Read time: 0; Write time: 40 10:03:50 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 266240; Write bytes: 271835136; Read time: 80; Write time: 179376 10:03:50 INFO - Running post-run listener: _upload_blobber_files 10:03:50 INFO - Blob upload gear active. 10:03:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:03:50 INFO - Copying logs to upload dir... 10:03:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.055258 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-19 10:03:50.225291) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 10:03:50.229110) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009946 build_url: 'https://queue.taskcluster.net/v1/task/o4BSBD9WTt-xj7e468WSIg/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-19 10:03:50.282458) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:03:50.282823) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1447954606.980187-970674106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:03:50.332479) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 10:03:50.332839) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 10:03:50.333167) ========= ========= Total master_lag: 0.24 =========