builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1447826255.98 results: success (0) buildid: 20151117203118 builduid: 706f7c419c5b4c02ba7fa934a09010be revision: 6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:35.981237) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:35.981707) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:35.982000) ========= 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=a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006639 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:36.009841) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:36.010149) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:36.659697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:36.659944) ========= 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=a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:36.774112) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:36.774374) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:36.774725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:36.775016) ========= 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=a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 21:57:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 73.8M=0s 2015-11-17 21:57:36 (73.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173714 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:36.972398) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:36.972703) ========= 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=a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020224 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:37.022832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:37.023175) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36 --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 6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36 --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=a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 21:57:37,100 truncating revision to first 12 chars 2015-11-17 21:57:37,100 Setting DEBUG logging. 2015-11-17 21:57:37,100 attempt 1/10 2015-11-17 21:57:37,100 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6fa3b2df62cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 21:57:37,357 unpacking tar archive at: fx-team-6fa3b2df62cc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.519768 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:37.555845) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:37.556172) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:37.567179) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:37.567588) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 21:57:37.568166) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2015-11-17 21:57:37.568602) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:57:37 INFO - MultiFileLogger online at 20151117 21:57:37 in /builds/slave/test-pgo 21:57:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 21:57:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:57:37 INFO - {'append_to_log': False, 21:57:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:57:37 INFO - 'blob_upload_branch': 'Fx-Team', 21:57:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:57:37 INFO - 'branch': 'Fx-Team', 21:57:37 INFO - 'buildbot_json_path': 'buildprops.json', 21:57:37 INFO - 'config_files': ('talos/linux_config.py',), 21:57:37 INFO - 'default_actions': ('clobber', 21:57:37 INFO - 'read-buildbot-config', 21:57:37 INFO - 'download-and-extract', 21:57:37 INFO - 'populate-webroot', 21:57:37 INFO - 'create-virtualenv', 21:57:37 INFO - 'install', 21:57:37 INFO - 'run-tests'), 21:57:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:57:37 INFO - 'download_minidump_stackwalk': True, 21:57:37 INFO - 'download_symbols': 'ondemand', 21:57:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:57:37 INFO - 'tooltool.py': '/tools/tooltool.py', 21:57:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:57:37 INFO - '/tools/misc-python/virtualenv.py')}, 21:57:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:57:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:57:37 INFO - 'installer_path': 'installer.exe', 21:57:37 INFO - 'log_level': 'info', 21:57:37 INFO - 'log_name': 'talos', 21:57:37 INFO - 'log_to_console': True, 21:57:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:57:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:57:37 INFO - 'opt_config_files': (), 21:57:37 INFO - 'pip_index': False, 21:57:37 INFO - 'sps_profile': False, 21:57:37 INFO - 'sps_profile_interval': 0, 21:57:37 INFO - 'suite': 'dromaeojs', 21:57:37 INFO - 'system_bits': '64', 21:57:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:57:37 INFO - 'title': 'talos-linux64-ix-031', 21:57:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:57:37 INFO - 'use_talos_json': True, 21:57:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:57:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:57:37 INFO - 'work_dir': 'build'} 21:57:37 INFO - ##### 21:57:37 INFO - ##### Running clobber step. 21:57:37 INFO - ##### 21:57:37 INFO - Running pre-action listener: _resource_record_pre_action 21:57:37 INFO - Running main action method: clobber 21:57:37 INFO - rmtree: /builds/slave/test-pgo/build 21:57:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:57:38 INFO - Running post-action listener: _resource_record_post_action 21:57:38 INFO - ##### 21:57:38 INFO - ##### Running read-buildbot-config step. 21:57:38 INFO - ##### 21:57:38 INFO - Running pre-action listener: _resource_record_pre_action 21:57:38 INFO - Running main action method: read_buildbot_config 21:57:38 INFO - Using buildbot properties: 21:57:38 INFO - { 21:57:38 INFO - "properties": { 21:57:38 INFO - "buildnumber": 789, 21:57:38 INFO - "product": "firefox", 21:57:38 INFO - "script_repo_revision": "production", 21:57:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:57:38 INFO - "repository": "", 21:57:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:57:38 INFO - "buildid": "20151117203118", 21:57:38 INFO - "slavename": "talos-linux64-ix-031", 21:57:38 INFO - "pgo_build": "True", 21:57:38 INFO - "basedir": "/builds/slave/test-pgo", 21:57:38 INFO - "project": "", 21:57:38 INFO - "platform": "ubuntu64_hw", 21:57:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:57:38 INFO - "slavebuilddir": "test", 21:57:38 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:57:38 INFO - "branch": "fx-team", 21:57:38 INFO - "repo_path": "integration/fx-team", 21:57:38 INFO - "stage_platform": "linux64-pgo", 21:57:38 INFO - "builduid": "706f7c419c5b4c02ba7fa934a09010be", 21:57:38 INFO - "revision": "6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36" 21:57:38 INFO - }, 21:57:38 INFO - "sourcestamp": { 21:57:38 INFO - "repository": "", 21:57:38 INFO - "hasPatch": false, 21:57:38 INFO - "project": "", 21:57:38 INFO - "branch": "fx-team-linux64-pgo-talos", 21:57:38 INFO - "changes": [ 21:57:38 INFO - { 21:57:38 INFO - "category": null, 21:57:38 INFO - "files": [ 21:57:38 INFO - { 21:57:38 INFO - "url": null, 21:57:38 INFO - "name": "https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:57:38 INFO - } 21:57:38 INFO - ], 21:57:38 INFO - "repository": "", 21:57:38 INFO - "rev": "6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36", 21:57:38 INFO - "who": "sendchange", 21:57:38 INFO - "when": 1447826238, 21:57:38 INFO - "number": 6676100, 21:57:38 INFO - "comments": "", 21:57:38 INFO - "project": "", 21:57:38 INFO - "at": "Tue 17 Nov 2015 21:57:18", 21:57:38 INFO - "branch": "fx-team-linux64-pgo-talos", 21:57:38 INFO - "revlink": "", 21:57:38 INFO - "properties": [ 21:57:38 INFO - [ 21:57:38 INFO - "buildid", 21:57:38 INFO - "20151117203118", 21:57:38 INFO - "Change" 21:57:38 INFO - ], 21:57:38 INFO - [ 21:57:38 INFO - "builduid", 21:57:38 INFO - "706f7c419c5b4c02ba7fa934a09010be", 21:57:38 INFO - "Change" 21:57:38 INFO - ], 21:57:38 INFO - [ 21:57:38 INFO - "pgo_build", 21:57:38 INFO - "True", 21:57:38 INFO - "Change" 21:57:38 INFO - ] 21:57:38 INFO - ], 21:57:38 INFO - "revision": "6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36" 21:57:38 INFO - } 21:57:38 INFO - ], 21:57:38 INFO - "revision": "6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36" 21:57:38 INFO - } 21:57:38 INFO - } 21:57:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:57:38 INFO - Running post-action listener: _resource_record_post_action 21:57:38 INFO - ##### 21:57:38 INFO - ##### Running download-and-extract step. 21:57:38 INFO - ##### 21:57:38 INFO - Running pre-action listener: _resource_record_pre_action 21:57:38 INFO - Running main action method: download_and_extract 21:57:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:57:38 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')]} 21:57:38 INFO - https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:57:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/test_packages.json 21:57:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/test_packages.json 21:57:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:57:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:57:39 INFO - Downloaded 1302 bytes. 21:57:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:57:39 INFO - Using the following test package requirements: 21:57:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:57:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:57:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:39 INFO - u'jsshell-linux-x86_64.zip'], 21:57:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:57:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:57:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:57:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:57:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:57:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:57:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:57:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:39 INFO - https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:57:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:57:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:57:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 21:57:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 21:57:40 INFO - Downloaded 22462057 bytes. 21:57:40 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 21:57:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:57:40 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 21:57:41 INFO - Return code: 0 21:57:41 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 21:57:41 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')]} 21:57:41 INFO - https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:57:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:57:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:57:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 21:57:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 21:57:42 INFO - Downloaded 22462057 bytes. 21:57:42 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 21:57:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:57:42 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 21:57:43 INFO - Return code: 0 21:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:43 INFO - https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:57:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:57:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:57:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 21:57:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 21:57:45 INFO - Downloaded 11131693 bytes. 21:57:45 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 21:57:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:57:45 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 21:57:45 INFO - Return code: 0 21:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:45 INFO - https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:57:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:57:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:57:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 21:57:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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 21:57:46 INFO - Downloaded 57198400 bytes. 21:57:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:57:46 INFO - mkdir: /builds/slave/test-pgo/properties 21:57:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:57:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:57:46 INFO - Contents: 21:57:46 INFO - build_url:https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:57:46 INFO - Running post-action listener: _resource_record_post_action 21:57:46 INFO - Running post-action listener: set_extra_try_arguments 21:57:46 INFO - ##### 21:57:46 INFO - ##### Running populate-webroot step. 21:57:46 INFO - ##### 21:57:46 INFO - Running pre-action listener: _resource_record_pre_action 21:57:46 INFO - Running main action method: populate_webroot 21:57:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:57:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:57:46 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:57:46 INFO - '../fennec_ids.txt'], 21:57:46 INFO - 'tests': ['tcheck2']}, 21:57:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:57:46 INFO - '--tppagecycles', 21:57:46 INFO - '7'], 21:57:46 INFO - 'tests': ['tsvgm']}}, 21:57:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:57:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:57:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:57:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:57:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:57:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:57:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:57:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:46 INFO - 'talos_options': ['--e10s'], 21:57:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:57:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:46 INFO - 'tests': ['damp', 'tps']}, 21:57:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:46 INFO - 'talos_options': ['--e10s'], 21:57:46 INFO - 'tests': ['damp', 'tps']}, 21:57:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:57:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:57:46 INFO - 'other': {'tests': ['a11yr', 21:57:46 INFO - 'ts_paint', 21:57:46 INFO - 'tpaint', 21:57:46 INFO - 'sessionrestore', 21:57:46 INFO - 'sessionrestore_no_auto_restore']}, 21:57:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:57:46 INFO - 'tests': ['a11yr', 21:57:46 INFO - 'ts_paint', 21:57:46 INFO - 'tpaint', 21:57:46 INFO - 'sessionrestore', 21:57:46 INFO - 'sessionrestore_no_auto_restore']}, 21:57:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:57:46 INFO - 'tests': ['a11yr', 21:57:46 INFO - 'ts_paint', 21:57:46 INFO - 'tpaint', 21:57:46 INFO - 'sessionrestore', 21:57:46 INFO - 'sessionrestore_no_auto_restore']}, 21:57:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:57:46 INFO - 'tests': ['a11yr', 21:57:46 INFO - 'ts_paint', 21:57:46 INFO - 'tpaint', 21:57:46 INFO - 'sessionrestore', 21:57:46 INFO - 'sessionrestore_no_auto_restore']}, 21:57:46 INFO - 'other_l64': {'tests': ['a11yr', 21:57:46 INFO - 'ts_paint', 21:57:46 INFO - 'tpaint', 21:57:46 INFO - 'sessionrestore', 21:57:46 INFO - 'sessionrestore_no_auto_restore']}, 21:57:46 INFO - 'other_nol64': {'tests': ['a11yr', 21:57:46 INFO - 'ts_paint', 21:57:46 INFO - 'tpaint', 21:57:46 INFO - 'sessionrestore', 21:57:46 INFO - 'sessionrestore_no_auto_restore']}, 21:57:46 INFO - 'svgr': {'tests': ['tsvgx', 21:57:46 INFO - 'tsvgr_opacity', 21:57:46 INFO - 'tart', 21:57:46 INFO - 'tscrollx', 21:57:46 INFO - 'cart']}, 21:57:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:57:46 INFO - 'tests': ['tsvgx', 21:57:46 INFO - 'tsvgr_opacity', 21:57:46 INFO - 'tart', 21:57:46 INFO - 'tscrollx', 21:57:46 INFO - 'cart']}, 21:57:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:46 INFO - 'tests': ['tp5o']}, 21:57:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:46 INFO - 'talos_options': ['--e10s'], 21:57:46 INFO - 'tests': ['tp5o']}, 21:57:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:46 INFO - 'talos_options': ['--xperf_path', 21:57:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:57:46 INFO - 'tests': ['tp5n']}, 21:57:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:46 INFO - 'talos_options': ['--e10s', 21:57:46 INFO - '--xperf_path', 21:57:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:57:46 INFO - 'tests': ['tp5n']}}, 21:57:46 INFO - 'talos.zip': {'path': '', 21:57:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:57:46 INFO - Running post-action listener: _resource_record_post_action 21:57:46 INFO - ##### 21:57:46 INFO - ##### Running create-virtualenv step. 21:57:46 INFO - ##### 21:57:46 INFO - Running pre-action listener: _resource_record_pre_action 21:57:46 INFO - Running main action method: create_virtualenv 21:57:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:57:46 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 21:57:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:57:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:57:46 INFO - Using real prefix '/usr' 21:57:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:57:47 INFO - Installing distribute.............................................................................................................................................................................................done. 21:57:49 INFO - Installing pip.................done. 21:57:49 INFO - Return code: 0 21:57:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:57:49 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')]} 21:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:49 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')]} 21:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:49 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 0x7f8ba596dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11393d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c28c0>, '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 0x116f420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116f8b0>, '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': 'a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261', '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 21:57:49 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 21:57:49 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 21:57:49 INFO - Using env: {'DISPLAY': ':0', 21:57:49 INFO - 'HOME': '/home/cltbld', 21:57:49 INFO - 'LANG': 'en_US.UTF-8', 21:57:49 INFO - 'LANGUAGE': 'en_US:en', 21:57:49 INFO - 'LOGNAME': 'cltbld', 21:57:49 INFO - 'MAIL': '/var/mail/cltbld', 21:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:49 INFO - 'MOZ_NO_REMOTE': '1', 21:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:49 INFO - 'NO_EM_RESTART': '1', 21:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:49 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:49 INFO - 'SHELL': '/bin/bash', 21:57:49 INFO - 'SHLVL': '1', 21:57:49 INFO - 'TERM': 'linux', 21:57:49 INFO - 'TMOUT': '86400', 21:57:49 INFO - 'USER': 'cltbld', 21:57:49 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261', 21:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:49 INFO - '_': '/tools/buildbot/bin/python'} 21:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:49 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 21:57:49 INFO - Cleaning up... 21:57:49 INFO - Return code: 0 21:57:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:57:49 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')]} 21:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:49 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')]} 21:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:49 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 0x7f8ba596dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11393d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c28c0>, '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 0x116f420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116f8b0>, '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': 'a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261', '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 21:57:49 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 21:57:49 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 21:57:49 INFO - Using env: {'DISPLAY': ':0', 21:57:49 INFO - 'HOME': '/home/cltbld', 21:57:49 INFO - 'LANG': 'en_US.UTF-8', 21:57:49 INFO - 'LANGUAGE': 'en_US:en', 21:57:49 INFO - 'LOGNAME': 'cltbld', 21:57:49 INFO - 'MAIL': '/var/mail/cltbld', 21:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:49 INFO - 'MOZ_NO_REMOTE': '1', 21:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:49 INFO - 'NO_EM_RESTART': '1', 21:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:49 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:49 INFO - 'SHELL': '/bin/bash', 21:57:49 INFO - 'SHLVL': '1', 21:57:49 INFO - 'TERM': 'linux', 21:57:49 INFO - 'TMOUT': '86400', 21:57:49 INFO - 'USER': 'cltbld', 21:57:49 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261', 21:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:49 INFO - '_': '/tools/buildbot/bin/python'} 21:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:49 INFO - Downloading/unpacking psutil>=0.7.1 21:57:49 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 21:57:49 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 21:57:49 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 21:57:49 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 21:57:49 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 21:57:49 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 21:57:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:57:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:57:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:57:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:57:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:57:51 INFO - Installing collected packages: psutil 21:57:51 INFO - Running setup.py install for psutil 21:57:51 INFO - building 'psutil._psutil_linux' extension 21:57:51 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 21:57:51 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 21:57:51 INFO - building 'psutil._psutil_posix' extension 21:57:51 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 21:57:51 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 21:57:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:57:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:57:51 INFO - Successfully installed psutil 21:57:51 INFO - Cleaning up... 21:57:51 INFO - Return code: 0 21:57:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:51 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 0x7f8ba596dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11393d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c28c0>, '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 0x116f420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116f8b0>, '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': 'a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261', '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 21:57:51 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 21:57:51 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 21:57:51 INFO - Using env: {'DISPLAY': ':0', 21:57:51 INFO - 'HOME': '/home/cltbld', 21:57:51 INFO - 'LANG': 'en_US.UTF-8', 21:57:51 INFO - 'LANGUAGE': 'en_US:en', 21:57:51 INFO - 'LOGNAME': 'cltbld', 21:57:51 INFO - 'MAIL': '/var/mail/cltbld', 21:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:51 INFO - 'MOZ_NO_REMOTE': '1', 21:57:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:51 INFO - 'NO_EM_RESTART': '1', 21:57:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:51 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:51 INFO - 'SHELL': '/bin/bash', 21:57:51 INFO - 'SHLVL': '1', 21:57:51 INFO - 'TERM': 'linux', 21:57:51 INFO - 'TMOUT': '86400', 21:57:51 INFO - 'USER': 'cltbld', 21:57:51 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261', 21:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:51 INFO - '_': '/tools/buildbot/bin/python'} 21:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:57:52 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 21:57:52 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 21:57:52 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 21:57:52 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 21:57:52 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 21:57:52 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 21:57:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:57:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:57:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:57:53 INFO - Installing collected packages: mozsystemmonitor 21:57:53 INFO - Running setup.py install for mozsystemmonitor 21:57:53 INFO - Successfully installed mozsystemmonitor 21:57:53 INFO - Cleaning up... 21:57:53 INFO - Return code: 0 21:57:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:57:53 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')]} 21:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:53 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')]} 21:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:53 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 0x7f8ba596dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11393d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c28c0>, '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 0x116f420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116f8b0>, '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': 'a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261', '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 21:57:53 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 21:57:53 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 21:57:53 INFO - Using env: {'DISPLAY': ':0', 21:57:53 INFO - 'HOME': '/home/cltbld', 21:57:53 INFO - 'LANG': 'en_US.UTF-8', 21:57:53 INFO - 'LANGUAGE': 'en_US:en', 21:57:53 INFO - 'LOGNAME': 'cltbld', 21:57:53 INFO - 'MAIL': '/var/mail/cltbld', 21:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:53 INFO - 'MOZ_NO_REMOTE': '1', 21:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:53 INFO - 'NO_EM_RESTART': '1', 21:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:53 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:53 INFO - 'SHELL': '/bin/bash', 21:57:53 INFO - 'SHLVL': '1', 21:57:53 INFO - 'TERM': 'linux', 21:57:53 INFO - 'TMOUT': '86400', 21:57:53 INFO - 'USER': 'cltbld', 21:57:53 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261', 21:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:53 INFO - '_': '/tools/buildbot/bin/python'} 21:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:54 INFO - Downloading/unpacking blobuploader==1.2.4 21:57:54 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 21:57:54 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 21:57:54 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 21:57:54 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 21:57:54 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 21:57:54 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 21:57:55 INFO - Downloading blobuploader-1.2.4.tar.gz 21:57:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:57:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:57:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:57:55 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 21:57:55 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 21:57:55 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 21:57:55 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 21:57:55 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 21:57:55 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 21:57:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:57:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:57:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:57:56 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 21:57:56 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 21:57:56 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 21:57:56 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 21:57:56 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 21:57:56 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 21:57:56 INFO - Downloading docopt-0.6.1.tar.gz 21:57:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:57:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:57:56 INFO - Installing collected packages: blobuploader, requests, docopt 21:57:56 INFO - Running setup.py install for blobuploader 21:57:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:57:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:57:56 INFO - Running setup.py install for requests 21:57:56 INFO - Running setup.py install for docopt 21:57:56 INFO - Successfully installed blobuploader requests docopt 21:57:56 INFO - Cleaning up... 21:57:57 INFO - Return code: 0 21:57:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:57 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 0x7f8ba596dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11393d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c28c0>, '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 0x116f420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116f8b0>, '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': 'a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261', '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 21:57:57 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 21:57:57 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 21:57:57 INFO - Using env: {'DISPLAY': ':0', 21:57:57 INFO - 'HOME': '/home/cltbld', 21:57:57 INFO - 'LANG': 'en_US.UTF-8', 21:57:57 INFO - 'LANGUAGE': 'en_US:en', 21:57:57 INFO - 'LOGNAME': 'cltbld', 21:57:57 INFO - 'MAIL': '/var/mail/cltbld', 21:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:57 INFO - 'MOZ_NO_REMOTE': '1', 21:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:57 INFO - 'NO_EM_RESTART': '1', 21:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:57 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:57 INFO - 'SHELL': '/bin/bash', 21:57:57 INFO - 'SHLVL': '1', 21:57:57 INFO - 'TERM': 'linux', 21:57:57 INFO - 'TMOUT': '86400', 21:57:57 INFO - 'USER': 'cltbld', 21:57:57 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261', 21:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:57 INFO - '_': '/tools/buildbot/bin/python'} 21:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:57:57 INFO - Running setup.py (path:/tmp/pip-L9KGjy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:57:57 INFO - Running setup.py (path:/tmp/pip-KGdc0K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:57:57 INFO - Running setup.py (path:/tmp/pip-ujpJ5S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:57:57 INFO - Running setup.py (path:/tmp/pip-MXvWmL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:57:57 INFO - Running setup.py (path:/tmp/pip-kHuGjT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:57:57 INFO - Running setup.py (path:/tmp/pip-BaviuG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:57:57 INFO - Running setup.py (path:/tmp/pip-rkz79_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:57:57 INFO - Running setup.py (path:/tmp/pip-Se4Wtn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:57:57 INFO - Running setup.py (path:/tmp/pip-pICiNQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:57:57 INFO - Running setup.py (path:/tmp/pip-5qdHcD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:57:57 INFO - Running setup.py (path:/tmp/pip-rAiUMJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:57:58 INFO - Running setup.py (path:/tmp/pip-KKu83x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:57:58 INFO - Running setup.py (path:/tmp/pip-T77HfT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:57:58 INFO - Running setup.py (path:/tmp/pip-ZqC_Vs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:57:58 INFO - Running setup.py (path:/tmp/pip-FcsUUv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:57:58 INFO - Running setup.py (path:/tmp/pip-oV6NjA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:57:58 INFO - Running setup.py (path:/tmp/pip-E6FxZW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:57:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:57:58 INFO - Running setup.py install for manifestparser 21:57:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:57:58 INFO - Running setup.py install for mozcrash 21:57:58 INFO - Running setup.py install for mozdebug 21:57:58 INFO - Running setup.py install for mozdevice 21:57:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:57:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:57:58 INFO - Running setup.py install for mozfile 21:57:59 INFO - Running setup.py install for mozhttpd 21:57:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:57:59 INFO - Running setup.py install for mozinfo 21:57:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:57:59 INFO - Running setup.py install for mozInstall 21:57:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:57:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:57:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:57:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:57:59 INFO - Running setup.py install for mozleak 21:57:59 INFO - Running setup.py install for mozlog 21:57:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:57:59 INFO - Running setup.py install for moznetwork 21:57:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:57:59 INFO - Running setup.py install for mozprocess 21:57:59 INFO - Running setup.py install for mozprofile 21:57:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:57:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:57:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:57:59 INFO - Running setup.py install for mozrunner 21:57:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:57:59 INFO - Running setup.py install for mozscreenshot 21:58:00 INFO - Running setup.py install for moztest 21:58:00 INFO - Running setup.py install for mozversion 21:58:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:58:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:58:00 INFO - Cleaning up... 21:58:00 INFO - Return code: 0 21:58:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:58: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')]} 21:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58: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')]} 21:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:00 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 0x7f8ba596dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11393d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c28c0>, '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 0x116f420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116f8b0>, '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': 'a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261', '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 21:58:00 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 21:58:00 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 21:58:00 INFO - Using env: {'DISPLAY': ':0', 21:58:00 INFO - 'HOME': '/home/cltbld', 21:58:00 INFO - 'LANG': 'en_US.UTF-8', 21:58:00 INFO - 'LANGUAGE': 'en_US:en', 21:58:00 INFO - 'LOGNAME': 'cltbld', 21:58:00 INFO - 'MAIL': '/var/mail/cltbld', 21:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:00 INFO - 'MOZ_NO_REMOTE': '1', 21:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:00 INFO - 'NO_EM_RESTART': '1', 21:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:58:00 INFO - 'PWD': '/builds/slave/test-pgo', 21:58:00 INFO - 'SHELL': '/bin/bash', 21:58:00 INFO - 'SHLVL': '1', 21:58:00 INFO - 'TERM': 'linux', 21:58:00 INFO - 'TMOUT': '86400', 21:58:00 INFO - 'USER': 'cltbld', 21:58:00 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261', 21:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:00 INFO - '_': '/tools/buildbot/bin/python'} 21:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:58:00 INFO - Running setup.py (path:/tmp/pip-dgf2qH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:58:00 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)) 21:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:58:00 INFO - Running setup.py (path:/tmp/pip-cvrcuf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:58:00 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)) 21:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:58:00 INFO - Running setup.py (path:/tmp/pip-nuKxRj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:58:00 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)) 21:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:58:00 INFO - Running setup.py (path:/tmp/pip-tdqczJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:58:00 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)) 21:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:58:00 INFO - Running setup.py (path:/tmp/pip-ewxy9R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:58:00 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)) 21:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:58:00 INFO - Running setup.py (path:/tmp/pip-SMs8k_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:58:00 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)) 21:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:58:00 INFO - Running setup.py (path:/tmp/pip-vWTPKy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:58:00 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)) 21:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:58:00 INFO - Running setup.py (path:/tmp/pip-kexbtw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:58:01 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)) 21:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:58:01 INFO - Running setup.py (path:/tmp/pip-YJdjGl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:58:01 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)) 21:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:58:01 INFO - Running setup.py (path:/tmp/pip-GTscx6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:58:01 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)) 21:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:58:01 INFO - Running setup.py (path:/tmp/pip-0vdsWl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:58:01 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)) 21:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:58:01 INFO - Running setup.py (path:/tmp/pip-u71zNm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:58:01 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)) 21:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:58:01 INFO - Running setup.py (path:/tmp/pip-ySldOD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:58:01 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)) 21:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:58:01 INFO - Running setup.py (path:/tmp/pip-GDx1py-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:58:01 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)) 21:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:58:01 INFO - Running setup.py (path:/tmp/pip-pzhttP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:58:01 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)) 21:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:58:01 INFO - Running setup.py (path:/tmp/pip-z8dOyD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:58:01 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)) 21:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:58:01 INFO - Running setup.py (path:/tmp/pip-hqqwOC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:58:01 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)) 21:58:01 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)) 21:58:01 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)) 21:58:01 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)) 21:58:01 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)) 21:58:01 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)) 21:58:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:58:01 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 21:58:01 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 21:58:01 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 21:58:01 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 21:58:01 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 21:58:01 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 21:58:03 INFO - Downloading blessings-1.5.1.tar.gz 21:58:03 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 21:58:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:58:03 INFO - Installing collected packages: blessings 21:58:03 INFO - Running setup.py install for blessings 21:58:03 INFO - Successfully installed blessings 21:58:03 INFO - Cleaning up... 21:58:03 INFO - Return code: 0 21:58:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:58:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:58:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:58:03 INFO - Reading from file tmpfile_stdout 21:58:03 INFO - Current package versions: 21:58:03 INFO - argparse == 1.2.1 21:58:03 INFO - blessings == 1.5.1 21:58:03 INFO - blobuploader == 1.2.4 21:58:03 INFO - docopt == 0.6.1 21:58:03 INFO - manifestparser == 1.1 21:58:03 INFO - mozInstall == 1.12 21:58:03 INFO - mozcrash == 0.16 21:58:03 INFO - mozdebug == 0.1 21:58:03 INFO - mozdevice == 0.47 21:58:03 INFO - mozfile == 1.2 21:58:03 INFO - mozhttpd == 0.7 21:58:03 INFO - mozinfo == 0.9 21:58:03 INFO - mozleak == 0.1 21:58:03 INFO - mozlog == 3.0 21:58:03 INFO - moznetwork == 0.27 21:58:03 INFO - mozprocess == 0.22 21:58:03 INFO - mozprofile == 0.27 21:58:03 INFO - mozrunner == 6.11 21:58:03 INFO - mozscreenshot == 0.1 21:58:03 INFO - mozsystemmonitor == 0.0 21:58:03 INFO - moztest == 0.7 21:58:03 INFO - mozversion == 1.4 21:58:03 INFO - psutil == 3.1.1 21:58:03 INFO - requests == 1.2.3 21:58:03 INFO - wsgiref == 0.1.2 21:58:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:58:03 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')]} 21:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:03 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')]} 21:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:03 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 0x7f8ba596dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11393d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c28c0>, '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 0x116f420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116f8b0>, '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': 'a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261', '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 21:58:03 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 21:58:03 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 21:58:03 INFO - Using env: {'DISPLAY': ':0', 21:58:03 INFO - 'HOME': '/home/cltbld', 21:58:03 INFO - 'LANG': 'en_US.UTF-8', 21:58:03 INFO - 'LANGUAGE': 'en_US:en', 21:58:03 INFO - 'LOGNAME': 'cltbld', 21:58:03 INFO - 'MAIL': '/var/mail/cltbld', 21:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:03 INFO - 'MOZ_NO_REMOTE': '1', 21:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:03 INFO - 'NO_EM_RESTART': '1', 21:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:58:03 INFO - 'PWD': '/builds/slave/test-pgo', 21:58:03 INFO - 'SHELL': '/bin/bash', 21:58:03 INFO - 'SHLVL': '1', 21:58:03 INFO - 'TERM': 'linux', 21:58:03 INFO - 'TMOUT': '86400', 21:58:03 INFO - 'USER': 'cltbld', 21:58:03 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261', 21:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:03 INFO - '_': '/tools/buildbot/bin/python'} 21:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:04 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)) 21:58:04 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)) 21:58:04 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)) 21:58:04 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)) 21:58:04 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)) 21:58:04 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)) 21:58:04 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)) 21:58:04 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)) 21:58:04 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)) 21:58:04 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)) 21:58:04 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)) 21:58:04 INFO - Cleaning up... 21:58:04 INFO - Return code: 0 21:58:04 INFO - Running post-action listener: _resource_record_post_action 21:58:04 INFO - Running post-action listener: _start_resource_monitoring 21:58:04 INFO - Starting resource monitoring. 21:58:04 INFO - ##### 21:58:04 INFO - ##### Running install step. 21:58:04 INFO - ##### 21:58:04 INFO - Running pre-action listener: _resource_record_pre_action 21:58:04 INFO - Running main action method: install 21:58:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:58:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:58:04 INFO - Reading from file tmpfile_stdout 21:58:04 INFO - Detecting whether we're running mozinstall >=1.0... 21:58:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:58:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:58:04 INFO - Reading from file tmpfile_stdout 21:58:04 INFO - Output received: 21:58:04 INFO - Usage: mozinstall [options] installer 21:58:04 INFO - Options: 21:58:04 INFO - -h, --help show this help message and exit 21:58:04 INFO - -d DEST, --destination=DEST 21:58:04 INFO - Directory to install application into. [default: 21:58:04 INFO - "/builds/slave/test-pgo"] 21:58:04 INFO - --app=APP Application being installed. [default: firefox] 21:58:04 INFO - mkdir: /builds/slave/test-pgo/build/application 21:58:04 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'] 21:58:04 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 21:58:19 INFO - Reading from file tmpfile_stdout 21:58:19 INFO - Output received: 21:58:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:58:19 INFO - Running post-action listener: _resource_record_post_action 21:58:19 INFO - ##### 21:58:19 INFO - ##### Running run-tests step. 21:58:19 INFO - ##### 21:58:19 INFO - Running pre-action listener: _resource_record_pre_action 21:58:19 INFO - Running main action method: run_tests 21:58:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:58:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:58:19 INFO - Python 2.7.3 21:58:19 INFO - Return code: 0 21:58:19 INFO - grabbing minidump binary from tooltool 21:58:19 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')]} 21:58:19 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 0x11c28c0>, '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 0x116f420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116f8b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:58:19 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 21:58:19 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 21:58:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:58:19 INFO - Return code: 0 21:58:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:58:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:58:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:58:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:58:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:58:19 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 21:58:19 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost 21:58:19 INFO - Using env: {'DISPLAY': ':0', 21:58:19 INFO - 'HOME': '/home/cltbld', 21:58:19 INFO - 'LANG': 'en_US.UTF-8', 21:58:19 INFO - 'LANGUAGE': 'en_US:en', 21:58:19 INFO - 'LOGNAME': 'cltbld', 21:58:19 INFO - 'MAIL': '/var/mail/cltbld', 21:58:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:58:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:19 INFO - 'MOZ_NO_REMOTE': '1', 21:58:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:58:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:19 INFO - 'NO_EM_RESTART': '1', 21:58:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:58:19 INFO - 'PWD': '/builds/slave/test-pgo', 21:58:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:58:19 INFO - 'SHELL': '/bin/bash', 21:58:19 INFO - 'SHLVL': '1', 21:58:19 INFO - 'TERM': 'linux', 21:58:19 INFO - 'TMOUT': '86400', 21:58:19 INFO - 'USER': 'cltbld', 21:58:19 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261', 21:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:19 INFO - '_': '/tools/buildbot/bin/python'} 21:58:19 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost'] with output_timeout 3600 21:58:19 INFO - mozversion INFO | application_buildid: 20151117203118 21:58:19 INFO - mozversion INFO | application_changeset: 6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36 21:58:19 INFO - mozversion INFO | application_display_name: Nightly 21:58:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:58:19 INFO - mozversion INFO | application_name: Firefox 21:58:19 INFO - mozversion INFO | application_remotingname: firefox 21:58:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 21:58:19 INFO - mozversion INFO | application_vendor: Mozilla 21:58:19 INFO - mozversion INFO | application_version: 45.0a1 21:58:19 INFO - mozversion INFO | platform_buildid: 20151117203118 21:58:19 INFO - mozversion INFO | platform_changeset: 6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36 21:58:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 21:58:19 INFO - mozversion INFO | platform_version: 45.0a1 21:58:19 INFO - 2015-11-17 21:58:19,562 DEBUG : using testdate: 1447826299 21:58:19 INFO - 2015-11-17 21:58:19,562 DEBUG : actual date: 1447826299 21:58:19 INFO - 2015-11-17 21:58:19,577 INFO : starting webserver on 'localhost:41597' 21:58:19 INFO - 2015-11-17 21:58:19,579 INFO : Starting test suite talos-linux64-ix-031 21:58:19 INFO - 2015-11-17 21:58:19,579 INFO : Starting test dromaeo_css 21:58:19 INFO - 2015-11-17 21:58:19,579 DEBUG : operating with platform_type : linux_ 21:58:19 INFO - 2015-11-17 21:58:19,579 INFO : Initialising browser for dromaeo_css test... 21:58:19 INFO - 2015-11-17 21:58:19,594 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXL2mKB/profile http://localhost:41597/getInfo.html 21:58:23 INFO - 2015-11-17 21:58:23,327 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:58:23 INFO - 2015-11-17 21:58:23,327 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:58:23 INFO - 2015-11-17 21:58:23,327 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:58:23 INFO - 2015-11-17 21:58:23,327 DEBUG : BROWSER_OUTPUT: __metrics 21:58:23 INFO - 2015-11-17 21:58:23,408 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:58:24 INFO - 2015-11-17 21:58:24,763 INFO : Browser initialized. 21:58:24 INFO - 2015-11-17 21:58:24,763 INFO : Running cycle 1/1 for dromaeo_css test... 21:58:24 INFO - 2015-11-17 21:58:24,763 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXL2mKB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:58:36 INFO - 2015-11-17 21:58:36,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 141619200 21:58:36 INFO - 2015-11-17 21:58:36,531 DEBUG : BROWSER_OUTPUT: 21:59:28 INFO - 2015-11-17 21:59:28,045 DEBUG : BROWSER_OUTPUT: 1447826368040 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] 22:01:36 INFO - 2015-11-17 22:01:36,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41597/tests/dromaeo/cssquery-ext.html) 22:01:37 INFO - 2015-11-17 22:01:37,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 232706048 22:01:37 INFO - 2015-11-17 22:01:37,350 DEBUG : BROWSER_OUTPUT: 22:04:39 INFO - 2015-11-17 22:04:39,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/dromaeo/cssquery-ext.html (next: http://localhost:41597/tests/dromaeo/cssquery-jquery.html) 22:04:40 INFO - 2015-11-17 22:04:40,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 221294592 22:04:40 INFO - 2015-11-17 22:04:40,182 DEBUG : BROWSER_OUTPUT: 22:07:42 INFO - 2015-11-17 22:07:42,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41597/tests/dromaeo/cssquery-mootools.html) 22:07:42 INFO - 2015-11-17 22:07:42,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 207609856 22:07:42 INFO - 2015-11-17 22:07:42,616 DEBUG : BROWSER_OUTPUT: 22:10:44 INFO - 2015-11-17 22:10:44,464 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41597/tests/dromaeo/cssquery-prototype.html) 22:10:45 INFO - 2015-11-17 22:10:45,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 202690560 22:10:45 INFO - 2015-11-17 22:10:45,052 DEBUG : BROWSER_OUTPUT: 22:13:47 INFO - 2015-11-17 22:13:47,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41597/tests/dromaeo/cssquery-yui.html) 22:13:48 INFO - 2015-11-17 22:13:48,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 201900032 22:13:48 INFO - 2015-11-17 22:13:48,097 DEBUG : BROWSER_OUTPUT: 22:16:50 INFO - 2015-11-17 22:16:50,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/dromaeo/cssquery-yui.html (next: http://localhost:41597/tests/dromaeo/cssquery-dojo.html) 22:16:50 INFO - 2015-11-17 22:16:50,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 250609664 22:16:50 INFO - 2015-11-17 22:16:50,640 DEBUG : BROWSER_OUTPUT: 22:16:50 INFO - 2015-11-17 22:16:50,641 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:16:50 INFO - 2015-11-17 22:16:50,641 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:16:50 INFO - 2015-11-17 22:16:50,641 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:16:50 INFO - 2015-11-17 22:16:50,641 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:16:50 INFO - 2015-11-17 22:16:50,641 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3190.856411461484;3259.3807176636424;3299.05976796613;3302.8018318900854;3308.0406682062203;5111.846644600668;5237.47625237476;5364.141737322025;5454.509094181523;5465.453454654537;5312.309399778023;5341.706206158659;5394.083005888999;5407.242985981956;5420.214068960008;4895.926561101577;4916.975415122919;4949.604031677457;5006.04885071837;5065.240213967916;4862.5380588844;5008.84973450797;5024.246363045536;5062.848114556551;5082.822101226458;4871.220604703248;4900.019996000797;4996.225585034325;4997.875053123665;5003.199488081889;4978.950210497885;4995.950040499585;5001.724905130216;5013.147764879979;5039.79840806371;4776.928346074812;4899.706017638918;4932.975335123338;4953.950460495421;5006.4743201964;5201.427842937273;5268.60485463588;5277.683338999673;5281.735913204363;5284.973575132138;5813.157092221646;5866.354700982888;5868.061110222387;5872.5889187756875;5883.735231914574;5768.567357448208;5870.530357571384;5873.089671100986;5888.146218798293;5912.113183022538;5401.243825864382;5512.862178445571;5523.972380138073;5532.087205611069;5571.9721401393135;5988;5993.850153746192;6008.459238668541;6017.398260174035;6057.545684073712;5659.405762394889;5679.488846003796;5791.8552036199435;5819.098039803837;5842.036064049385;5798.82603521895;5808.912866307009;5811.27359080115;5811.94188058114;5866.530677545786;5794.565407594448;5799.536037117021;5807.5644326675665;5809.738561764731;5816;5742.425757424307;5753.165790960287;5764.193012978187;5846.824595262064;5875.41245875409;4432.401625780542;4440.933385999213;4448.688591798607;4464.084862603158;4470.083632855257;3990.3016972029777;3992.341263691458;3994.5406278277787;4029.899252518652;4032.233875563692;5289;5364.490373414597;5421.674699518042;5552.333719953632;5582.134769110794;5853.765849365977;5877.294724633071;5891.41085891416;5891.764329426775;5893.410658934073;5313.149896016619;5555.638883472561;5568.777248909998;5575.888482230333;5583.553315734813;5032.169692000779;5057.595392368602;5134.358205224347;5139.177731562932;5159.974200129051;6103.572749907553;6106.267247930188;6109.14471973924;6111.022236442148;6112.144299798032;5618.185363122406;5719.942800572107;5892.7642894283745;5893.557983151195;5898.764049438146;5923.407659234214;6000.909986350121;6015.2781666200335;6024.9397506026135;6044.184035155374;5753.050746626927;5782.710864456676;5788.594798364074;5795.072788354012;5816.651000939957;5698.116791897262;5701.087825947829;5796.797112101056;5848.766049358148;5858.648481091148;5703.8859222816145;5709.286339207599;5714.457126572969;5741.110127930177;5792.4497172768515;5682.857928551819;5684.317881854204;5685.573581981285;5686.488216060409;5689.800856969986;5468.316460442445;5522.420145884785;5547.750351234285;5607.5513958882375;5611.046122159161;5697.173909782975;5698.1452782083015;5712.485876270989;5725.6850873202375;5812.21535092774;5583.664980101207;5583.972080139573;5587.832365029056;5589.80435684749;5607 22:16:50 INFO - 2015-11-17 22:16:50,642 DEBUG : BROWSER_OUTPUT: |1;ext.html;567.5232804444269;601.278465840991;605.9515238780897;623.7910300049483;629.8614304852931;30720.53919191211;31551.21121971952;31556.211094722614;39774.40338394926;39908.40137397941;42387.15225695492;42873.35689964653;42881;42919.3562096568;43015.78492107535;8492;8675.869861952076;8676.86984695227;8679.826403471927;8682.218600325969;7796.961015194916;7982.880256796153;10338.948305258464;10604.893951060507;10605.78788424231;10171.440570768606;10226.795464090714;10292.073713365833;10319.58721651133;10324.896751032506;7875.054993400771;8039.236272554098;10268.74328141795;10324.277300589;10331.948340258288;10303.175745940307;10512.526936287886;10589.04698577124;10611.31026483276;10614.416207108607;40045.19909601821;40488.190236195405;40495.7975210125;40572.18855622871;40596.188076238606;3058.709422604849;3087.706667866549;3125.7811953163286;3174.9206269843207;3725.2549490102087;30544.847275763703;30790.692093079007;30808.229794255323;31033.37933241345;31631;3123.8281894495794;3143.9685603143903;3149.5433162191584;3171.2864605463815;3215.1479857837694;278844;279486;279794;280074;280436.59781701164;52417.2137417939;53489.46510534923;62935.370646293864;64003;64192.679036605456;61663;61761.69119154375;61785;61798.69100654468;62046;14587.562373128823;14769.113853168845;14779.039362441406;14792.408303667948;14793.260336983109;10923.453827308604;10969.561217551369;10981;11088.112950963903;11110;19832.70250946237;19928.402147935583;19970.201191952157;19981.700274495895;20099.49751256201;7532.661030253542;7642.273983971514;7713.884291735629;7727.459077864608;7825.765227043198;842.5492361586522;887.689308741948;914.8993610702818;934.9111834375724;950.3680052764972;25578.232653020066;25825.870870645525;26165.476690466083;26593.202203933914;26818.5977210342;989.8564708117283;992.1269283030887;1002.173207104142;1022.6880801355658;1032.02989190161;12684.746305073846;13947.930260348634;14053.78919316211;15435.922820385826;15686.529404117895;318349;322508;322662;322671;322973;52128.47871521312;52403.47596523986;52539.21191182135;52649.736751316;52669.73665131727;1311.2001678975817;1314.0276195615177;1343.9126456780277;1353.729254149174;1364.8430430500619;28509.287267818472;28693.856530717214;29233.123006309845;29565.85217073901;29756.404871902007;45446;45899.311510328036;45931;45995.77002114968;46009.76995115003;366035;371899;374290;380403;380817;30307.09078727642;30313.545296821005;30457.54313685252;30500.237494062825;30864.845675771478;40568.79715601403;41272;41401.585984139776;41971.58028419799;42270.78864605657;35476.822615886755;35750.28499430049;36110.45834312435;36140.45789313215;37176;36304.93345261687;36360;36607;36711.449328259565;36938.630613693516;34679.306413871076;35371.11572210612;35636.28727425385;35693.28613427769;35714.10714732049;30154.547681784352;33118.834405827816;33240;33495.66504335023;33526.83236583802;24953;25006.62490062687;25511.15195221632;25640.743592563835;25683.743162568135 22:16:50 INFO - 2015-11-17 22:16:50,644 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.8114199474278;358.66106529329784;361.4921035944499;362.6029497700018;364.5898364340117;13845.584632461017;13919.582412527641;16780.83219167808;17555.824441755594;18260.90869545652;11981.520739170423;12290.692732681688;16496.75254871175;16963.660726785456;16964.709764181833;4506.053728716965;4585.633149348061;4588.4723256825555;4611.7232966021975;4631.745254011028;3415.0949998250485;3502.6497350265026;4544.454665440152;4572.131295053946;4822.373091498101;4868.221084626461;4890.0708865315655;4891.217405215166;4910.779014944336;4943.4562198158355;4898.681585696936;4997.6501644884875;5015.648904576681;5020.0712868119335;5042.495750424965;4348.760818155;4349.586789255016;4349.782510874444;4355.477342718862;4363.040131171138;14048.086874353134;14293;14366.281685915767;14381.496647617283;14391.496297629532;1886.509507528039;2031.1063132221775;2065.390709740615;2078.1064142418754;2096.308218287961;9905.80188396228;10109.292349535535;10192.694219173436;10193.388396696222;10477.947610261976;1688.2571668465835;1690.6280618263963;1720.2344956494364;1742.1898817050132;1756.8067512573607;61848.69075654638;62104.37895621031;62487.68756156236;62519.6874015627;63059.684701576196;6590.340965903467;7091.787246382617;7104.325089116525;7129.215786263507;7149.785506434815;8518.148185181557;8544.060153383123;8559.572021398904;8567.700130495403;8570;5509.3664228614225;5520.889582208413;5542.861428464321;5556.444355564411;5566.55467562594;5639.605227634026;5639.689817060019;5651.378348381675;5684.772609095672;5686.772529098873;3214.3249917517114;3257.8371081446307;3269.4278501262183;3279.950800737991;3307.818070006125;1114.916381271408;1137.1073707139856;1143.6912033750841;1149.0348107589664;1187.7565099154654;424.60511724096887;468.25547379666494;473.16722568280073;477.0863795831014;521.0490854191116;11602.129840262014;11630.6510804676;11748.94125529384;11793.52580927384;11900.940495297642;461.73450266097126;483.0387528817628;484.4840245138916;490.93617829682626;491.7000629615931;6199.597026193283;6231.657258850716;6488.124103246001;6497.18785151856;6511.3163117871945;360288;365235;365534;365737;476090;73642.63178684072;74038;74858.62570687111;75084.62457687677;76704.61647691726;468.23911144390365;546.2461802712311;550.7659244820935;551.4650788734921;551.7020808763303;9436.433813971184;9535.094166054214;9616.615335386787;9697.127258546765;9768.023197680175;33487.33025339528;33576.832115839265;34237.144071397415;36486.45270320894;37215.25569488541;47615.28577071416;48339.27491087566;48601.513984859695;49892.750536247084;50348.748256258485;7750.883736743841;8028.718994835152;8051.033875934925;8059.073206581318;8253.546054966795;12001.879981200425;12115.575954841539;12186.146969712036;12218.938905305416;12236.327002014974;9053.77365565866;10912.181586380895;10951.671449856518;10974.615888443866;11045;10590.788184236426;10697.197710171924;10734.892651073702;10743.409112498888;10758.623448179276;10172.28793984414;10475.738106547396;10484.633037843943;10501;10928.289661171999;8022.358211343195;8095.5142691438705;8138.633761480866;8151.551664658501;8151.918480815116;10775.461226938465;10831.187660925305;10897.78204435891;11053.226274161054;11317.264377815416 22:16:50 INFO - 2015-11-17 22:16:50,645 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1354.566538707614;1472.1093738288334;1489.5307977986934;1712.2209394725398;1777.2091419318403;6815.863682726349;6950.409215216706;7084.433245340367;7094.574325540471;7100.360967512923;7276.636168191596;7335.559866408019;7348.926510734891;7376.594287314209;7381.261873812616;2001.5196352875278;2042.274992377707;2205.625043742564;2225.0654725015534;2226.14293497004;2292.5758734634064;2332.4402143485613;2337.263761915;2337.333859849943;2339.356676913854;2198.681191227271;2231.7098777158944;2254.1321591187348;2254.571631390039;2256.5035692147785;1952.8632995690307;2003.0285311623923;2195.923142690006;2205.1730601024615;2245.8091062259728;2245.5508898220423;2270.182734215681;2275.2832857649787;2276.8178545716305;2277.10054528462;7694.5383277003;7811;7819.452638315321;7833.177516360757;7843.37253019757;4677.111348843743;4750.263709125091;4766.332713420124;4776.164171270014;4779.378680771512;2866.641669791276;2950.572167035768;3023.712747289004;3062.908112756621;3064.9233769155726;970.1414248390155;985.4284514981293;990.8711867457256;1011.9747006324827;1062.8405739139114;10597.894021059768;10736.087432568163;10737.570497180104;10757.354558726423;10758.569657213624;4055.655269302142;4180.122174343361;4182.707210495236;4191.958080419217;4265.978670106691;8665.870011949826;8670.739877803677;8673.522956237468;8677.349198809989;8686.52224127679;4665.5567721066445;4669.696469729524;4707.576318131316;4710.057988402334;4714.693544919569;4295.4415925929425;4324.870253892388;4325.8269669213505;4330.891727706769;4337.696361254745;3380.7464440167087;3424.417848965682;3443.500692399588;3447.913802154916;3458.187325978393;1038.3977293169944;1044.8171569975225;1048.1038711901367;1049.6168898352198;1050.2963014780116;1186.6973921649924;1268.105985280375;1280.7630588341187;1281.6027031620229;1285.6400207941792;7063.894041589278;7141;7143.82140446493;7146.606936618432;7150.856982860314;466.54511850945056;471.0367298873811;474.9905001899943;476.3402687278145;485.06866815713914;5818.33089194748;5819.76720931158;5865.794697185664;5874.471297583238;5884;9031.096890311048;9334.299927505328;9417.952910235404;9471.810563788686;9473.952630236943;9385;9434.19809316202;9441.952790236004;9445.622175113056;9471.337006409623;7060.6116663584;7142.178649455275;7196.316349946746;7206.2793720627515;7218.783436496913;7328.560286382834;7386.4090872728975;7406.777796666109;7408.481406301723;7415.1101867776215;7911.564863932539;8022.638981245741;8289.33685305162;8306.210909963544;8310.085890551914;8309.542975136426;8392.733048744265;8490.660373584988;8499.447535910145;8533.658653654033;6676.432503237085;6802.931970680428;6806.421454176252;6832.692528836114;6849.5205335628025;7642.923570764444;7669.7315593953945;7673.386129109546;7697.923020769945;7702.345300649284;6900.527827755127;7059.117610298713;7124.073870396815;7133.108361454818;7220.819479513054;5912.73392697321;6148.569600128127;6635.701393437211;7163.498555101093;7177.712891484282;6842.213145488134;6860.897086543606;6897.206821215625;6918.965405172942;7198.388137008413;6502.057201705821;6503.414692677682;6510.934890651033;6521.836954076186;6531.836704082436;6673.566218195801;6679.833004174934;6723.4957378197805;6735.090762746966;6735.090762747162 22:16:50 INFO - 2015-11-17 22:16:50,645 DEBUG : BROWSER_OUTPUT: |4;prototype.html;328.5367631639388;331.5242626830497;340.58788865472775;341.02296919326125;342.9211281405277;6010.8797824043495;6122.602030867991;6148.200733904591;6167.167432396625;6209.254889413265;5930.021546444831;6078.483328917047;6126.571140020201;6140.877182456348;6141.416565426289;4647.209974304359;4649.930251046237;4652.6510511711585;4667.76661166942;4678.859634210962;4463.73217606943;4551.453825540923;4592.163134746112;4673.672842900998;4715;4635.8145674173165;4641.675082744209;4660.16117098922;4661.277501987197;4675.462321832999;4687.718736875799;4695.530446955311;4697.271922851964;4704.341392205094;4708.0819240248165;4128.318827393477;4142.109446469024;4142.875713728593;4145.79271036447;4150.979245103756;5692.345380281238;5783.363829978699;5798.420157984167;5800.390958949291;5800.53595712342;5426.728663566845;5427.45725427458;5433.239346491494;5437.374701909292;5482.424345443751;6147.2930612979635;6449.06488559161;6451.258105317902;6453.193350831146;6456.838579035515;4401.515833258339;4446.733196008217;4579.862604121881;4585.380973568559;4585.633149348044;6635.601863888182;6748.190217173921;6753.3584309490025;6757.358050985198;6757.763478278237;4699.530046995274;4700.55344742249;4703.576678098988;4705.764711764398;4706.788194531255;4669.60308373792;4744.95610965587;4757.238841785367;4761.95238047622;4770.499097594703;5420.7289635518855;5423.538999185034;5436.456354364532;5443.292371991616;5455.454454554513;6495.188101487314;6541.345865413516;6542.934570654328;6543;6546.803595892131;1673.707101257275;1695.3472912928612;1697.770800941857;1698.2612563534901;1702.6339337042596;1123.1407972900738;1149.735560821016;1166.5275563396838;1170.1341007654275;1180.952761889532;6258.43674069336;6281.560290779693;6282.654454005074;6283.59156654816;6289.779857704958;6640.136782218281;6683.532152749261;6699.430548403343;6700.2294736105;6703.12859328294;6145;6261.060840873905;6262.3111457739615;6268.529860260499;6269.404406581368;3601.9639803602154;3648.179159689049;3650.10572409756;3653.488511608377;3657.4879516867127;6965;6970.954356846412;6980.336867997532;6986;6988.056612357368;6756.966215168893;6880.58716477013;6886.793396198122;6888.138982627172;6893.172819261721;6929.653517324215;6953.096097507291;6966.616836073963;6969.05917701114;6974.755883544051;6451.483881289391;6598.670066496752;6703.731850725916;6713.261541230559;6718.496112791462;6596.175478065242;6722.697478613376;6735;6744.662766861539;6747.696353663999;7042.154941407064;7047.189573199148;7050.365467107985;7062.505624606229;7066.752663656747;4583.19794036049;4629.421322334708;4653.976730116327;4654.906097067254;4696.107739529479;6748.426383757239;6750.189977202767;6750.5274630775375;6761.594304341756;6766.966165169143;6595.472362211108;6600.141981542369;6602.84450221219;6603.306652801387;6605.504587156079;6454.419102280817;6579.703913323816;6585.80242592723;6591.934080659132;6606.711691220166;6469.8706025880165;6481.837954050998;6485.286618472059;6485.513586481127;6493.22081350241;6630.23752268476;6634.369734875179;6634.800955971328;6636.2368327642935;6644.103046088716;6337.176167098248;6462.838429039311;6462.935370646422;6462.967685161544;6465.806025819233 22:16:50 INFO - 2015-11-17 22:16:50,649 DEBUG : BROWSER_OUTPUT: |5;yui.html;710.8613820305039;724.4566575068699;806.7942674617972;831.2103501673412;862.6894318045503;13614.047016708835;14119.78820317696;14125.364358603862;14132.505362312308;14137.78793318101;11064;13023.348832558382;13180;13280.867191328083;13348.733025339512;812.0701796443069;822.5887056471764;827.3381294964034;828.9751307460785;829.3779665251062;813.3371302388534;819.8975128108987;820.1511435664089;820.2535692519808;820.4379999700225;858.4034096303072;863.4258218284833;865.0484467086218;866.7789713623017;867.440500876934;862.5213006781233;866.6230189867365;867.7483529776357;868.7263511993733;868.7958329792493;635.7679447001811;637.8309747916805;640.9262934762515;641.3586413586413;641.4034947498824;12209.816852747215;12348.629541113782;12389.93805030978;12396.566120185751;12399.75200495994;10352.948235258775;10503.264771466;10818.72953176169;10848.566057357697;10876.945615271952;8624.137586241388;8764.517951512664;8854.911450885473;8888.822223555493;9030.142136497023;3547.787132772042;3565.073080998933;3567.6432356764117;3572.7677700949357;3701.222743223926;40591.59408405937;44943.55056449426;45446.77276613596;45561.08877822425;45858.54141458576;7655.578943158069;7721.7683469496005;7768.145503994556;7830.804229894185;7833.020872390951;11815.172937894265;11912.76174476523;11966.22219555726;11990.700232494257;12016.158868879094;6513.413792758674;6636.203655561363;6646.468282537386;6655.500837437212;6817.045613614098;4187.246295666749;4228.1966426378885;4235.767032813224;4257.063446041866;4285.421468101828;2672.5857492088758;2707.039001154601;2708.7426694463993;2709.0789131694924;2710.9051183208494;403.7678334957411;417.30726993191155;417.67212738000524;419.32279368819746;434.23357773529744;617.2839506172818;636.7971388833661;665.2482694555218;665.5707068940507;711.9857602847914;8285.50286982771;8432.686233841127;8510.106438823957;8514.70198543048;8545.59984017588;633.2053273142269;635.4185919883347;635.9919527548794;667.9131712877391;701.7578935267325;3915.8629447969183;4030.052937559671;4065.10567675111;4082.3468245080644;4098.6516146127915;55157;56669;56987.14519282214;57192;57456.138157927664;42823;44462.555374445845;48797.26804097941;49386.50613493891;52597.474025260024;43498.56501435008;44712;45332.773336133105;46393.5360646396;46969.765151174026;7275.090613673291;7364.5581265124265;8128.3497320213055;8208.302294304813;8503.8724419135;30553;30579.694203057683;31595.684043160192;35221.471677925365;35527;41280;41303.7934810324;41541.58458415498;41924.580754192066;42156.57843421526;8188.5905704715715;8307.08622051586;8342.431539117242;8362.832743345221;8631.741047768577;12423.31671758062;12432.067594930235;12573.057020723665;12666.746665066832;12982.15615984958;11265.831012534982;11333.659990200307;11337.603183888525;11529.135314851252;11870.881291187323;11625.941870290595;11848.466818993338;11932.343721095423;11964.222325548812;12284.324362160167;11242.718932026764;11439.599614013803;11530.596429125277;11564.132690048113;11914.702132446759;10089.445080520349;10159.542820572944;10280.07479326864;10311.896881031395;10490.737731556466;9078.727638170865;9126.5436728162;9550.856737149088;9724.9027509724;9731.756706082404 22:16:50 INFO - 2015-11-17 22:16:50,649 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:16:50 INFO - 2015-11-17 22:16:50,649 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:16:50 INFO - 2015-11-17 22:16:50,649 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,764 22:16:50 INFO - 2015-11-17 22:16:50,649 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:16:50 INFO - 2015-11-17 22:16:50,649 DEBUG : BROWSER_OUTPUT: __startTimestamp1447827410638__endTimestamp 22:16:50 INFO - 2015-11-17 22:16:50,649 DEBUG : BROWSER_OUTPUT: 22:16:50 INFO - 2015-11-17 22:16:50,650 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:16:50 INFO - 2015-11-17 22:16:50,650 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:16:50 INFO - 2015-11-17 22:16:50,650 DEBUG : BROWSER_OUTPUT: 22:16:50 INFO - 2015-11-17 22:16:50,650 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5414.80 Median:5607.00 stddev:601.92 (10.7%) stddev-sans-first:577.93 22:16:50 INFO - 2015-11-17 22:16:50,650 DEBUG : BROWSER_OUTPUT: Values: 3190.9 3259.4 3299.1 3302.8 3308.0 5111.8 5237.5 5364.1 5454.5 5465.5 5312.3 5341.7 5394.1 5407.2 5420.2 4895.9 4917.0 4949.6 5006.0 5065.2 4862.5 5008.8 5024.2 5062.8 5082.8 4871.2 4900.0 4996.2 4997.9 5003.2 4979.0 4996.0 5001.7 5013.1 5039.8 4776.9 4899.7 4933.0 4954.0 5006.5 5201.4 5268.6 5277.7 5281.7 5285.0 5813.2 5866.4 5868.1 5872.6 5883.7 5768.6 5870.5 5873.1 5888.1 5912.1 5401.2 5512.9 5524.0 5532.1 5572.0 5988.0 5993.9 6008.5 6017.4 6057.5 5659.4 5679.5 5791.9 5819.1 5842.0 5798.8 5808.9 5811.3 5811.9 5866.5 5794.6 5799.5 5807.6 5809.7 5816.0 5742.4 5753.2 5764.2 5846.8 5875.4 4432.4 4440.9 4448.7 4464.1 4470.1 3990.3 3992.3 3994.5 4029.9 4032.2 5289.0 5364.5 5421.7 5552.3 5582.1 5853.8 5877.3 5891.4 5891.8 5893.4 5313.1 5555.6 5568.8 5575.9 5583.6 5032.2 5057.6 5134.4 5139.2 5160.0 6103.6 6106.3 6109.1 6111.0 6112.1 5618.2 5719.9 5892.8 5893.6 5898.8 5923.4 6000.9 6015.3 6024.9 6044.2 5753.1 5782.7 5788.6 5795.1 5816.7 5698.1 5701.1 5796.8 5848.8 5858.6 5703.9 5709.3 5714.5 5741.1 5792.4 5682.9 5684.3 5685.6 5686.5 5689.8 5468.3 5522.4 5547.8 5607.6 5611.0 5697.2 5698.1 5712.5 5725.7 5812.2 5583.7 5584.0 5587.8 5589.8 5607.0 22:16:50 INFO - 2015-11-17 22:16:50,650 DEBUG : BROWSER_OUTPUT: 22:16:50 INFO - 2015-11-17 22:16:50,651 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49015.15 Median:322822.00 stddev:86027.33 (26.6%) stddev-sans-first:86191.76 22:16:50 INFO - 2015-11-17 22:16:50,651 DEBUG : BROWSER_OUTPUT: Values: 567.5 601.3 606.0 623.8 629.9 30720.5 31551.2 31556.2 39774.4 39908.4 42387.2 42873.4 42881.0 42919.4 43015.8 8492.0 8675.9 8676.9 8679.8 8682.2 7797.0 7982.9 10338.9 10604.9 10605.8 10171.4 10226.8 10292.1 10319.6 10324.9 7875.1 8039.2 10268.7 10324.3 10331.9 10303.2 10512.5 10589.0 10611.3 10614.4 40045.2 40488.2 40495.8 40572.2 40596.2 3058.7 3087.7 3125.8 3174.9 3725.3 30544.8 30790.7 30808.2 31033.4 31631.0 3123.8 3144.0 3149.5 3171.3 3215.1 278844.0 279486.0 279794.0 280074.0 280436.6 52417.2 53489.5 62935.4 64003.0 64192.7 61663.0 61761.7 61785.0 61798.7 62046.0 14587.6 14769.1 14779.0 14792.4 14793.3 10923.5 10969.6 10981.0 11088.1 11110.0 19832.7 19928.4 19970.2 19981.7 20099.5 7532.7 7642.3 7713.9 7727.5 7825.8 842.5 887.7 914.9 934.9 950.4 25578.2 25825.9 26165.5 26593.2 26818.6 989.9 992.1 1002.2 1022.7 1032.0 12684.7 13947.9 14053.8 15435.9 15686.5 318349.0 322508.0 322662.0 322671.0 322973.0 52128.5 52403.5 52539.2 52649.7 52669.7 1311.2 1314.0 1343.9 1353.7 1364.8 28509.3 28693.9 29233.1 29565.9 29756.4 45446.0 45899.3 45931.0 45995.8 46009.8 366035.0 371899.0 374290.0 380403.0 380817.0 30307.1 30313.5 30457.5 30500.2 30864.8 40568.8 41272.0 41401.6 41971.6 42270.8 35476.8 35750.3 36110.5 36140.5 37176.0 36304.9 36360.0 36607.0 36711.4 36938.6 34679.3 35371.1 35636.3 35693.3 35714.1 30154.5 33118.8 33240.0 33495.7 33526.8 24953.0 25006.6 25511.2 25640.7 25683.7 22:16:50 INFO - 2015-11-17 22:16:50,651 DEBUG : BROWSER_OUTPUT: 22:16:50 INFO - 2015-11-17 22:16:50,652 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22829.92 Median:4525.25 stddev:64281.27 (1420.5%) stddev-sans-first:64439.45 22:16:50 INFO - 2015-11-17 22:16:50,653 DEBUG : BROWSER_OUTPUT: Values: 355.8 358.7 361.5 362.6 364.6 13845.6 13919.6 16780.8 17555.8 18260.9 11981.5 12290.7 16496.8 16963.7 16964.7 4506.1 4585.6 4588.5 4611.7 4631.7 3415.1 3502.6 4544.5 4572.1 4822.4 4868.2 4890.1 4891.2 4910.8 4943.5 4898.7 4997.7 5015.6 5020.1 5042.5 4348.8 4349.6 4349.8 4355.5 4363.0 14048.1 14293.0 14366.3 14381.5 14391.5 1886.5 2031.1 2065.4 2078.1 2096.3 9905.8 10109.3 10192.7 10193.4 10477.9 1688.3 1690.6 1720.2 1742.2 1756.8 61848.7 62104.4 62487.7 62519.7 63059.7 6590.3 7091.8 7104.3 7129.2 7149.8 8518.1 8544.1 8559.6 8567.7 8570.0 5509.4 5520.9 5542.9 5556.4 5566.6 5639.6 5639.7 5651.4 5684.8 5686.8 3214.3 3257.8 3269.4 3280.0 3307.8 1114.9 1137.1 1143.7 1149.0 1187.8 424.6 468.3 473.2 477.1 521.0 11602.1 11630.7 11748.9 11793.5 11900.9 461.7 483.0 484.5 490.9 491.7 6199.6 6231.7 6488.1 6497.2 6511.3 360288.0 365235.0 365534.0 365737.0 476090.0 73642.6 74038.0 74858.6 75084.6 76704.6 468.2 546.2 550.8 551.5 551.7 9436.4 9535.1 9616.6 9697.1 9768.0 33487.3 33576.8 34237.1 36486.5 37215.3 47615.3 48339.3 48601.5 49892.8 50348.7 7750.9 8028.7 8051.0 8059.1 8253.5 12001.9 12115.6 12186.1 12218.9 12236.3 9053.8 10912.2 10951.7 10974.6 11045.0 10590.8 10697.2 10734.9 10743.4 10758.6 10172.3 10475.7 10484.6 10501.0 10928.3 8022.4 8095.5 8138.6 8151.6 8151.9 10775.5 10831.2 10897.8 11053.2 11317.3 22:16:50 INFO - 2015-11-17 22:16:50,653 DEBUG : BROWSER_OUTPUT: 22:16:50 INFO - 2015-11-17 22:16:50,653 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5378.30 Median:6507.17 stddev:2824.80 (43.4%) stddev-sans-first:2816.53 22:16:50 INFO - 2015-11-17 22:16:50,653 DEBUG : BROWSER_OUTPUT: Values: 1354.6 1472.1 1489.5 1712.2 1777.2 6815.9 6950.4 7084.4 7094.6 7100.4 7276.6 7335.6 7348.9 7376.6 7381.3 2001.5 2042.3 2205.6 2225.1 2226.1 2292.6 2332.4 2337.3 2337.3 2339.4 2198.7 2231.7 2254.1 2254.6 2256.5 1952.9 2003.0 2195.9 2205.2 2245.8 2245.6 2270.2 2275.3 2276.8 2277.1 7694.5 7811.0 7819.5 7833.2 7843.4 4677.1 4750.3 4766.3 4776.2 4779.4 2866.6 2950.6 3023.7 3062.9 3064.9 970.1 985.4 990.9 1012.0 1062.8 10597.9 10736.1 10737.6 10757.4 10758.6 4055.7 4180.1 4182.7 4192.0 4266.0 8665.9 8670.7 8673.5 8677.3 8686.5 4665.6 4669.7 4707.6 4710.1 4714.7 4295.4 4324.9 4325.8 4330.9 4337.7 3380.7 3424.4 3443.5 3447.9 3458.2 1038.4 1044.8 1048.1 1049.6 1050.3 1186.7 1268.1 1280.8 1281.6 1285.6 7063.9 7141.0 7143.8 7146.6 7150.9 466.5 471.0 475.0 476.3 485.1 5818.3 5819.8 5865.8 5874.5 5884.0 9031.1 9334.3 9418.0 9471.8 9474.0 9385.0 9434.2 9442.0 9445.6 9471.3 7060.6 7142.2 7196.3 7206.3 7218.8 7328.6 7386.4 7406.8 7408.5 7415.1 7911.6 8022.6 8289.3 8306.2 8310.1 8309.5 8392.7 8490.7 8499.4 8533.7 6676.4 6802.9 6806.4 6832.7 6849.5 7642.9 7669.7 7673.4 7697.9 7702.3 6900.5 7059.1 7124.1 7133.1 7220.8 5912.7 6148.6 6635.7 7163.5 7177.7 6842.2 6860.9 6897.2 6919.0 7198.4 6502.1 6503.4 6510.9 6521.8 6531.8 6673.6 6679.8 6723.5 6735.1 6735.1 22:16:50 INFO - 2015-11-17 22:16:50,653 DEBUG : BROWSER_OUTPUT: 22:16:50 INFO - 2015-11-17 22:16:50,653 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5461.04 Median:6188.21 stddev:1639.67 (26.5%) stddev-sans-first:1598.38 22:16:50 INFO - 2015-11-17 22:16:50,655 DEBUG : BROWSER_OUTPUT: Values: 328.5 331.5 340.6 341.0 342.9 6010.9 6122.6 6148.2 6167.2 6209.3 5930.0 6078.5 6126.6 6140.9 6141.4 4647.2 4649.9 4652.7 4667.8 4678.9 4463.7 4551.5 4592.2 4673.7 4715.0 4635.8 4641.7 4660.2 4661.3 4675.5 4687.7 4695.5 4697.3 4704.3 4708.1 4128.3 4142.1 4142.9 4145.8 4151.0 5692.3 5783.4 5798.4 5800.4 5800.5 5426.7 5427.5 5433.2 5437.4 5482.4 6147.3 6449.1 6451.3 6453.2 6456.8 4401.5 4446.7 4579.9 4585.4 4585.6 6635.6 6748.2 6753.4 6757.4 6757.8 4699.5 4700.6 4703.6 4705.8 4706.8 4669.6 4745.0 4757.2 4762.0 4770.5 5420.7 5423.5 5436.5 5443.3 5455.5 6495.2 6541.3 6542.9 6543.0 6546.8 1673.7 1695.3 1697.8 1698.3 1702.6 1123.1 1149.7 1166.5 1170.1 1181.0 6258.4 6281.6 6282.7 6283.6 6289.8 6640.1 6683.5 6699.4 6700.2 6703.1 6145.0 6261.1 6262.3 6268.5 6269.4 3602.0 3648.2 3650.1 3653.5 3657.5 6965.0 6971.0 6980.3 6986.0 6988.1 6757.0 6880.6 6886.8 6888.1 6893.2 6929.7 6953.1 6966.6 6969.1 6974.8 6451.5 6598.7 6703.7 6713.3 6718.5 6596.2 6722.7 6735.0 6744.7 6747.7 7042.2 7047.2 7050.4 7062.5 7066.8 4583.2 4629.4 4654.0 4654.9 4696.1 6748.4 6750.2 6750.5 6761.6 6767.0 6595.5 6600.1 6602.8 6603.3 6605.5 6454.4 6579.7 6585.8 6591.9 6606.7 6469.9 6481.8 6485.3 6485.5 6493.2 6630.2 6634.4 6634.8 6636.2 6644.1 6337.2 6462.8 6462.9 6463.0 6465.8 22:16:50 INFO - 2015-11-17 22:16:50,655 DEBUG : BROWSER_OUTPUT: 22:16:50 INFO - 2015-11-17 22:16:50,655 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12961.42 Median:45138.16 stddev:15203.18 (33.7%) stddev-sans-first:15217.99 22:16:50 INFO - 2015-11-17 22:16:50,655 DEBUG : BROWSER_OUTPUT: Values: 710.9 724.5 806.8 831.2 862.7 13614.0 14119.8 14125.4 14132.5 14137.8 11064.0 13023.3 13180.0 13280.9 13348.7 812.1 822.6 827.3 829.0 829.4 813.3 819.9 820.2 820.3 820.4 858.4 863.4 865.0 866.8 867.4 862.5 866.6 867.7 868.7 868.8 635.8 637.8 640.9 641.4 641.4 12209.8 12348.6 12389.9 12396.6 12399.8 10352.9 10503.3 10818.7 10848.6 10876.9 8624.1 8764.5 8854.9 8888.8 9030.1 3547.8 3565.1 3567.6 3572.8 3701.2 40591.6 44943.6 45446.8 45561.1 45858.5 7655.6 7721.8 7768.1 7830.8 7833.0 11815.2 11912.8 11966.2 11990.7 12016.2 6513.4 6636.2 6646.5 6655.5 6817.0 4187.2 4228.2 4235.8 4257.1 4285.4 2672.6 2707.0 2708.7 2709.1 2710.9 403.8 417.3 417.7 419.3 434.2 617.3 636.8 665.2 665.6 712.0 8285.5 8432.7 8510.1 8514.7 8545.6 633.2 635.4 636.0 667.9 701.8 3915.9 4030.1 4065.1 4082.3 4098.7 55157.0 56669.0 56987.1 57192.0 57456.1 42823.0 44462.6 48797.3 49386.5 52597.5 43498.6 44712.0 45332.8 46393.5 46969.8 7275.1 7364.6 8128.3 8208.3 8503.9 30553.0 30579.7 31595.7 35221.5 35527.0 41280.0 41303.8 41541.6 41924.6 42156.6 8188.6 8307.1 8342.4 8362.8 8631.7 12423.3 12432.1 12573.1 12666.7 12982.2 11265.8 11333.7 11337.6 11529.1 11870.9 11625.9 11848.5 11932.3 11964.2 12284.3 11242.7 11439.6 11530.6 11564.1 11914.7 10089.4 10159.5 10280.1 10311.9 10490.7 9078.7 9126.5 9550.9 9724.9 9731.8 22:16:50 INFO - 2015-11-17 22:16:50,655 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:16:50 INFO - 2015-11-17 22:16:50,655 DEBUG : BROWSER_OUTPUT: 22:16:51 INFO - 2015-11-17 22:16:51,369 INFO : Browser exited with error code: 0 22:16:51 INFO - 2015-11-17 22:16:51,388 INFO : Completed test dromaeo_css (00:18:31) 22:16:51 INFO - 2015-11-17 22:16:51,388 INFO : Starting test kraken 22:16:51 INFO - 2015-11-17 22:16:51,388 DEBUG : operating with platform_type : linux_ 22:16:51 INFO - 2015-11-17 22:16:51,388 INFO : Initialising browser for kraken test... 22:16:51 INFO - 2015-11-17 22:16:51,394 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZnhR4X/profile http://localhost:41597/getInfo.html 22:16:54 INFO - 2015-11-17 22:16:54,931 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:16:54 INFO - 2015-11-17 22:16:54,931 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:16:54 INFO - 2015-11-17 22:16:54,931 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:16:54 INFO - 2015-11-17 22:16:54,931 DEBUG : BROWSER_OUTPUT: __metrics 22:16:55 INFO - 2015-11-17 22:16:55,088 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:16:56 INFO - 2015-11-17 22:16:56,265 INFO : Browser initialized. 22:16:56 INFO - 2015-11-17 22:16:56,265 INFO : Running cycle 1/1 for kraken test... 22:16:56 INFO - 2015-11-17 22:16:56,265 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZnhR4X/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:17:08 INFO - 2015-11-17 22:17:07,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 141684736 22:17:08 INFO - 2015-11-17 22:17:08,000 DEBUG : BROWSER_OUTPUT: 22:17:10 INFO - 2015-11-17 22:17:10,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41597/tests/kraken/driver.html?testName=audio-beat-detection) 22:17:11 INFO - 2015-11-17 22:17:11,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 181248000 22:17:11 INFO - 2015-11-17 22:17:11,019 DEBUG : BROWSER_OUTPUT: 22:17:13 INFO - 2015-11-17 22:17:13,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41597/tests/kraken/driver.html?testName=audio-dft) 22:17:14 INFO - 2015-11-17 22:17:14,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 169627648 22:17:14 INFO - 2015-11-17 22:17:14,209 DEBUG : BROWSER_OUTPUT: 22:17:17 INFO - 2015-11-17 22:17:17,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41597/tests/kraken/driver.html?testName=audio-fft) 22:17:17 INFO - 2015-11-17 22:17:17,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 150679552 22:17:17 INFO - 2015-11-17 22:17:17,639 DEBUG : BROWSER_OUTPUT: 22:17:19 INFO - 2015-11-17 22:17:19,597 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41597/tests/kraken/driver.html?testName=audio-oscillator) 22:17:20 INFO - 2015-11-17 22:17:20,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 152375296 22:17:20 INFO - 2015-11-17 22:17:20,163 DEBUG : BROWSER_OUTPUT: 22:17:22 INFO - 2015-11-17 22:17:22,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41597/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:17:22 INFO - 2015-11-17 22:17:22,860 DEBUG : BROWSER_OUTPUT: RSS: Main: 154816512 22:17:22 INFO - 2015-11-17 22:17:22,861 DEBUG : BROWSER_OUTPUT: 22:17:25 INFO - 2015-11-17 22:17:25,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41597/tests/kraken/driver.html?testName=imaging-darkroom) 22:17:26 INFO - 2015-11-17 22:17:26,329 DEBUG : BROWSER_OUTPUT: RSS: Main: 154931200 22:17:26 INFO - 2015-11-17 22:17:26,330 DEBUG : BROWSER_OUTPUT: 22:17:29 INFO - 2015-11-17 22:17:29,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41597/tests/kraken/driver.html?testName=imaging-desaturate) 22:17:30 INFO - 2015-11-17 22:17:30,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 156786688 22:17:30 INFO - 2015-11-17 22:17:30,274 DEBUG : BROWSER_OUTPUT: 22:17:33 INFO - 2015-11-17 22:17:33,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41597/tests/kraken/driver.html?testName=json-parse-financial) 22:17:33 INFO - 2015-11-17 22:17:33,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 155656192 22:17:33 INFO - 2015-11-17 22:17:33,656 DEBUG : BROWSER_OUTPUT: 22:17:35 INFO - 2015-11-17 22:17:35,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41597/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:17:35 INFO - 2015-11-17 22:17:35,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 166707200 22:17:35 INFO - 2015-11-17 22:17:35,760 DEBUG : BROWSER_OUTPUT: 22:17:37 INFO - 2015-11-17 22:17:37,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41597/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:17:38 INFO - 2015-11-17 22:17:38,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 166600704 22:17:38 INFO - 2015-11-17 22:17:38,198 DEBUG : BROWSER_OUTPUT: 22:17:40 INFO - 2015-11-17 22:17:40,241 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41597/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:17:40 INFO - 2015-11-17 22:17:40,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 169549824 22:17:40 INFO - 2015-11-17 22:17:40,808 DEBUG : BROWSER_OUTPUT: 22:17:43 INFO - 2015-11-17 22:17:43,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:17:43 INFO - 2015-11-17 22:17:43,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 179314688 22:17:43 INFO - 2015-11-17 22:17:43,863 DEBUG : BROWSER_OUTPUT: 22:17:46 INFO - 2015-11-17 22:17:46,418 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:17:46 INFO - 2015-11-17 22:17:46,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 179732480 22:17:46 INFO - 2015-11-17 22:17:46,992 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41597/tests/kraken/driver.html?testName=ai-astar) 22:17:48 INFO - 2015-11-17 22:17:48,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 237408256 22:17:48 INFO - 2015-11-17 22:17:48,897 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,897 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:17:48 INFO - 2015-11-17 22:17:48,898 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:17:48 INFO - 2015-11-17 22:17:48,899 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:17:48 INFO - 2015-11-17 22:17:48,899 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:17:48 INFO - 2015-11-17 22:17:48,899 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;110;103;108;108;108;98;110;109;106 22:17:48 INFO - 2015-11-17 22:17:48,899 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;124;152;160;125;155;157;140;169;132 22:17:48 INFO - 2015-11-17 22:17:48,899 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;162;161;163;168;162;161;160;160 22:17:48 INFO - 2015-11-17 22:17:48,900 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;81;91;71;71;72;97;89;72 22:17:48 INFO - 2015-11-17 22:17:48,900 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;135;89;90;89;132;89;90;134 22:17:48 INFO - 2015-11-17 22:17:48,900 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;110;110 22:17:48 INFO - 2015-11-17 22:17:48,900 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;147;144;145;144;146;145;145;146 22:17:48 INFO - 2015-11-17 22:17:48,901 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;96 22:17:48 INFO - 2015-11-17 22:17:48,901 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;58;58;60;59;58;66;55;55 22:17:48 INFO - 2015-11-17 22:17:48,901 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;69;68;69;81;69;68;68 22:17:48 INFO - 2015-11-17 22:17:48,901 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;84;86;85;85;85;85;84;84 22:17:48 INFO - 2015-11-17 22:17:48,901 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;124;126;130;127;122;120;128;133;122 22:17:48 INFO - 2015-11-17 22:17:48,902 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;150;151;147;148;140;152;156;146;137 22:17:48 INFO - 2015-11-17 22:17:48,902 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;67;66;67;68;68;66;66;67 22:17:48 INFO - 2015-11-17 22:17:48,902 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:17:48 INFO - 2015-11-17 22:17:48,902 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:17:48 INFO - 2015-11-17 22:17:48,903 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,911 22:17:48 INFO - 2015-11-17 22:17:48,903 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:17:48 INFO - 2015-11-17 22:17:48,903 DEBUG : BROWSER_OUTPUT: __startTimestamp1447827468897__endTimestamp 22:17:48 INFO - 2015-11-17 22:17:48,903 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,907 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:17:48 INFO - 2015-11-17 22:17:48,907 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:17:48 INFO - 2015-11-17 22:17:48,907 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,907 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.70 Median:108.50 stddev:3.68 (3.4%) stddev-sans-first:3.91 22:17:48 INFO - 2015-11-17 22:17:48,908 DEBUG : BROWSER_OUTPUT: Values: 107.0 110.0 103.0 108.0 108.0 108.0 98.0 110.0 109.0 106.0 22:17:48 INFO - 2015-11-17 22:17:48,908 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,908 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.70 Median:154.00 stddev:15.51 (10.1%) stddev-sans-first:16.28 22:17:48 INFO - 2015-11-17 22:17:48,909 DEBUG : BROWSER_OUTPUT: Values: 153.0 124.0 152.0 160.0 125.0 155.0 157.0 140.0 169.0 132.0 22:17:48 INFO - 2015-11-17 22:17:48,909 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,909 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:2.38 (1.5%) stddev-sans-first:2.52 22:17:48 INFO - 2015-11-17 22:17:48,909 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 162.0 161.0 163.0 168.0 162.0 161.0 160.0 160.0 22:17:48 INFO - 2015-11-17 22:17:48,909 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,909 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.70 Median:76.50 stddev:10.06 (13.1%) stddev-sans-first:10.37 22:17:48 INFO - 2015-11-17 22:17:48,909 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 81.0 91.0 71.0 71.0 72.0 97.0 89.0 72.0 22:17:48 INFO - 2015-11-17 22:17:48,910 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,910 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.80 Median:89.50 stddev:21.32 (23.8%) stddev-sans-first:22.10 22:17:48 INFO - 2015-11-17 22:17:48,911 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 135.0 89.0 90.0 89.0 132.0 89.0 90.0 134.0 22:17:48 INFO - 2015-11-17 22:17:48,911 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,911 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:17:48 INFO - 2015-11-17 22:17:48,911 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 22:17:48 INFO - 2015-11-17 22:17:48,911 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,912 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 22:17:48 INFO - 2015-11-17 22:17:48,912 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 147.0 144.0 145.0 144.0 146.0 145.0 145.0 146.0 22:17:48 INFO - 2015-11-17 22:17:48,912 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,912 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:17:48 INFO - 2015-11-17 22:17:48,912 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 22:17:48 INFO - 2015-11-17 22:17:48,912 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,912 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.70 Median:59.00 stddev:3.06 (5.2%) stddev-sans-first:3.24 22:17:48 INFO - 2015-11-17 22:17:48,912 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 58.0 58.0 60.0 59.0 58.0 66.0 55.0 55.0 22:17:48 INFO - 2015-11-17 22:17:48,912 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,912 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:69.00 stddev:3.97 (5.7%) stddev-sans-first:4.20 22:17:48 INFO - 2015-11-17 22:17:48,913 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 69.0 68.0 69.0 81.0 69.0 68.0 68.0 22:17:48 INFO - 2015-11-17 22:17:48,913 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,913 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 22:17:48 INFO - 2015-11-17 22:17:48,913 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 84.0 86.0 85.0 85.0 85.0 85.0 84.0 84.0 22:17:48 INFO - 2015-11-17 22:17:48,913 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,913 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:126.50 stddev:4.14 (3.3%) stddev-sans-first:4.21 22:17:48 INFO - 2015-11-17 22:17:48,913 DEBUG : BROWSER_OUTPUT: Values: 122.0 124.0 126.0 130.0 127.0 122.0 120.0 128.0 133.0 122.0 22:17:48 INFO - 2015-11-17 22:17:48,913 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,913 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.00 Median:149.00 stddev:5.75 (3.9%) stddev-sans-first:5.92 22:17:48 INFO - 2015-11-17 22:17:48,914 DEBUG : BROWSER_OUTPUT: Values: 143.0 150.0 151.0 147.0 148.0 140.0 152.0 156.0 146.0 137.0 22:17:48 INFO - 2015-11-17 22:17:48,914 DEBUG : BROWSER_OUTPUT: 22:17:48 INFO - 2015-11-17 22:17:48,914 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 22:17:48 INFO - 2015-11-17 22:17:48,914 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 67.0 66.0 67.0 68.0 68.0 66.0 66.0 67.0 22:17:48 INFO - 2015-11-17 22:17:48,914 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:17:48 INFO - 2015-11-17 22:17:48,914 DEBUG : BROWSER_OUTPUT: 22:17:49 INFO - 2015-11-17 22:17:49,757 INFO : Browser exited with error code: 0 22:17:49 INFO - 2015-11-17 22:17:49,810 INFO : Completed test kraken (00:00:58) 22:17:49 INFO - 2015-11-17 22:17:49,810 INFO : Starting test v8_7 22:17:49 INFO - 2015-11-17 22:17:49,810 DEBUG : operating with platform_type : linux_ 22:17:49 INFO - 2015-11-17 22:17:49,810 INFO : Initialising browser for v8_7 test... 22:17:49 INFO - 2015-11-17 22:17:49,816 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxwwJ3L/profile http://localhost:41597/getInfo.html 22:17:53 INFO - 2015-11-17 22:17:53,416 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:17:53 INFO - 2015-11-17 22:17:53,417 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:17:53 INFO - 2015-11-17 22:17:53,417 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:17:53 INFO - 2015-11-17 22:17:53,418 DEBUG : BROWSER_OUTPUT: __metrics 22:17:53 INFO - 2015-11-17 22:17:53,534 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:17:54 INFO - 2015-11-17 22:17:54,828 INFO : Browser initialized. 22:17:54 INFO - 2015-11-17 22:17:54,829 INFO : Running cycle 1/1 for v8_7 test... 22:17:54 INFO - 2015-11-17 22:17:54,829 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxwwJ3L/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:18:06 INFO - 2015-11-17 22:18:06,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 140845056 22:18:06 INFO - 2015-11-17 22:18:06,581 DEBUG : BROWSER_OUTPUT: 22:18:28 INFO - 2015-11-17 22:18:28,028 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41597/tests/v8_7/run.html (next: http://localhost:41597/tests/v8_7/run.html) 22:18:28 INFO - 2015-11-17 22:18:28,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 627048448 22:18:28 INFO - 2015-11-17 22:18:28,287 DEBUG : BROWSER_OUTPUT: 22:18:28 INFO - 2015-11-17 22:18:28,287 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:18:28 INFO - 2015-11-17 22:18:28,287 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:18:28 INFO - 2015-11-17 22:18:28,287 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:18:28 INFO - 2015-11-17 22:18:28,287 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:18:28 INFO - 2015-11-17 22:18:28,287 DEBUG : BROWSER_OUTPUT: |0;Richards;163.05233980107616 22:18:28 INFO - 2015-11-17 22:18:28,288 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.53590090961873 22:18:28 INFO - 2015-11-17 22:18:28,288 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.97780275358247 22:18:28 INFO - 2015-11-17 22:18:28,288 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 22:18:28 INFO - 2015-11-17 22:18:28,288 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1103.7527593818984 22:18:28 INFO - 2015-11-17 22:18:28,288 DEBUG : BROWSER_OUTPUT: |5;Earley;773.9938080495356 22:18:28 INFO - 2015-11-17 22:18:28,288 DEBUG : BROWSER_OUTPUT: |6;Boyer;12231.707317073171 22:18:28 INFO - 2015-11-17 22:18:28,288 DEBUG : BROWSER_OUTPUT: |7;RegExp;25871.79487179487 22:18:28 INFO - 2015-11-17 22:18:28,288 DEBUG : BROWSER_OUTPUT: |8;Splay;658.2849774339136 22:18:28 INFO - 2015-11-17 22:18:28,289 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 22:18:28 INFO - 2015-11-17 22:18:28,289 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:18:28 INFO - 2015-11-17 22:18:28,289 DEBUG : BROWSER_OUTPUT: __startTimestamp1447827508280__endTimestamp 22:18:28 INFO - 2015-11-17 22:18:28,289 DEBUG : BROWSER_OUTPUT: 22:18:28 INFO - 2015-11-17 22:18:28,289 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:18:28 INFO - 2015-11-17 22:18:28,289 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:18:28 INFO - 2015-11-17 22:18:28,289 DEBUG : BROWSER_OUTPUT: 22:18:28 INFO - 2015-11-17 22:18:28,289 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.05 Median:163.05 stddev:0.00 (0.0%) 22:18:28 INFO - 2015-11-17 22:18:28,290 DEBUG : BROWSER_OUTPUT: Values: 163.1 22:18:28 INFO - 2015-11-17 22:18:28,290 DEBUG : BROWSER_OUTPUT: 22:18:28 INFO - 2015-11-17 22:18:28,290 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.54 Median:193.54 stddev:0.00 (0.0%) 22:18:28 INFO - 2015-11-17 22:18:28,290 DEBUG : BROWSER_OUTPUT: Values: 193.5 22:18:28 INFO - 2015-11-17 22:18:28,290 DEBUG : BROWSER_OUTPUT: 22:18:28 INFO - 2015-11-17 22:18:28,290 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 22:18:28 INFO - 2015-11-17 22:18:28,290 DEBUG : BROWSER_OUTPUT: Values: 281.0 22:18:28 INFO - 2015-11-17 22:18:28,290 DEBUG : BROWSER_OUTPUT: 22:18:28 INFO - 2015-11-17 22:18:28,291 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 22:18:28 INFO - 2015-11-17 22:18:28,291 DEBUG : BROWSER_OUTPUT: Values: 5035.2 22:18:28 INFO - 2015-11-17 22:18:28,291 DEBUG : BROWSER_OUTPUT: 22:18:28 INFO - 2015-11-17 22:18:28,291 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1103.75 Median:1103.75 stddev:0.00 (0.0%) 22:18:28 INFO - 2015-11-17 22:18:28,291 DEBUG : BROWSER_OUTPUT: Values: 1103.8 22:18:28 INFO - 2015-11-17 22:18:28,291 DEBUG : BROWSER_OUTPUT: 22:18:28 INFO - 2015-11-17 22:18:28,291 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:773.99 Median:773.99 stddev:0.00 (0.0%) 22:18:28 INFO - 2015-11-17 22:18:28,291 DEBUG : BROWSER_OUTPUT: Values: 774.0 22:18:28 INFO - 2015-11-17 22:18:28,292 DEBUG : BROWSER_OUTPUT: 22:18:28 INFO - 2015-11-17 22:18:28,292 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 22:18:28 INFO - 2015-11-17 22:18:28,292 DEBUG : BROWSER_OUTPUT: Values: 12231.7 22:18:28 INFO - 2015-11-17 22:18:28,292 DEBUG : BROWSER_OUTPUT: 22:18:28 INFO - 2015-11-17 22:18:28,292 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25871.79 Median:25871.79 stddev:0.00 (0.0%) 22:18:28 INFO - 2015-11-17 22:18:28,292 DEBUG : BROWSER_OUTPUT: Values: 25871.8 22:18:28 INFO - 2015-11-17 22:18:28,292 DEBUG : BROWSER_OUTPUT: 22:18:28 INFO - 2015-11-17 22:18:28,292 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:658.28 Median:658.28 stddev:0.00 (0.0%) 22:18:28 INFO - 2015-11-17 22:18:28,293 DEBUG : BROWSER_OUTPUT: Values: 658.3 22:18:28 INFO - 2015-11-17 22:18:28,293 DEBUG : BROWSER_OUTPUT: 22:18:28 INFO - 2015-11-17 22:18:28,293 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 22:18:28 INFO - 2015-11-17 22:18:28,293 DEBUG : BROWSER_OUTPUT: Values: 4835.7 22:18:28 INFO - 2015-11-17 22:18:28,293 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:18:28 INFO - 2015-11-17 22:18:28,293 DEBUG : BROWSER_OUTPUT: 22:18:29 INFO - 2015-11-17 22:18:29,177 INFO : Browser exited with error code: 0 22:18:29 INFO - 2015-11-17 22:18:29,187 INFO : Completed test v8_7 (00:00:39) 22:18:29 INFO - 2015-11-17 22:18:29,244 INFO : Completed test suite (00:20:09) 22:18:29 INFO - 2015-11-17 22:18:29,244 DEBUG : Working with test: dromaeo_css 22:18:29 INFO - 2015-11-17 22:18:29,244 DEBUG : Generating results file: dromaeo_css 22:18:29 INFO - 2015-11-17 22:18:29,245 DEBUG : Working with test: kraken 22:18:29 INFO - 2015-11-17 22:18:29,246 DEBUG : Generating results file: kraken 22:18:29 INFO - 2015-11-17 22:18:29,246 INFO : javascript benchmark 22:18:29 INFO - 2015-11-17 22:18:29,246 DEBUG : Working with test: v8_7 22:18:29 INFO - 2015-11-17 22:18:29,246 DEBUG : Generating results file: v8_7 22:18:29 INFO - 2015-11-17 22:18:29,246 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:18:29 INFO - 2015-11-17 22:18:29,290 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 22:18:29 INFO - 2015-11-17 22:18:29,291 DEBUG : process_Request line: dromaeo_css 6667.22 graph.html#tests=[[72,64,35]] 22:18:29 INFO - 2015-11-17 22:18:29,291 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:18:29 INFO - 2015-11-17 22:18:29,321 DEBUG : process_Request line: kraken 1498.80 graph.html#tests=[[232,64,35]] 22:18:29 INFO - 2015-11-17 22:18:29,321 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:18:29 INFO - 2015-11-17 22:18:29,363 DEBUG : process_Request line: v8_7 20941.25 graph.html#tests=[[230,64,35]] 22:18:29 INFO - 2015-11-17 22:18:29,365 INFO : javascript benchmark 22:18:29 INFO - 2015-11-17 22:18:29,369 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [355.8114199474278, 358.66106529329784, 361.4921035944499, 362.6029497700018, 364.5898364340117, 13845.584632461017, 13919.582412527641, 16780.83219167808, 17555.824441755594, 18260.90869545652, 11981.520739170423, 12290.692732681688, 16496.75254871175, 16963.660726785456, 16964.709764181833, 4506.053728716965, 4585.633149348061, 4588.4723256825555, 4611.7232966021975, 4631.745254011028, 3415.0949998250485, 3502.6497350265026, 4544.454665440152, 4572.131295053946, 4822.373091498101, 4868.221084626461, 4890.0708865315655, 4891.217405215166, 4910.779014944336, 4943.4562198158355, 4898.681585696936, 4997.6501644884875, 5015.648904576681, 5020.0712868119335, 5042.495750424965, 4348.760818155, 4349.586789255016, 4349.782510874444, 4355.477342718862, 4363.040131171138, 14048.086874353134, 14293.0, 14366.281685915767, 14381.496647617283, 14391.496297629532, 1886.509507528039, 2031.1063132221775, 2065.390709740615, 2078.1064142418754, 2096.308218287961, 9905.80188396228, 10109.292349535535, 10192.694219173436, 10193.388396696222, 10477.947610261976, 1688.2571668465835, 1690.6280618263963, 1720.2344956494364, 1742.1898817050132, 1756.8067512573607, 61848.69075654638, 62104.37895621031, 62487.68756156236, 62519.6874015627, 63059.684701576196, 6590.340965903467, 7091.787246382617, 7104.325089116525, 7129.215786263507, 7149.785506434815, 8518.148185181557, 8544.060153383123, 8559.572021398904, 8567.700130495403, 8570.0, 5509.3664228614225, 5520.889582208413, 5542.861428464321, 5556.444355564411, 5566.55467562594, 5639.605227634026, 5639.689817060019, 5651.378348381675, 5684.772609095672, 5686.772529098873, 3214.3249917517114, 3257.8371081446307, 3269.4278501262183, 3279.950800737991, 3307.818070006125, 1114.916381271408, 1137.1073707139856, 1143.6912033750841, 1149.0348107589664, 1187.7565099154654, 424.60511724096887, 468.25547379666494, 473.16722568280073, 477.0863795831014, 521.0490854191116, 11602.129840262014, 11630.6510804676, 11748.94125529384, 11793.52580927384, 11900.940495297642, 461.73450266097126, 483.0387528817628, 484.4840245138916, 490.93617829682626, 491.7000629615931, 6199.597026193283, 6231.657258850716, 6488.124103246001, 6497.18785151856, 6511.3163117871945, 360288.0, 365235.0, 365534.0, 365737.0, 476090.0, 73642.63178684072, 74038.0, 74858.62570687111, 75084.62457687677, 76704.61647691726, 468.23911144390365, 546.2461802712311, 550.7659244820935, 551.4650788734921, 551.7020808763303, 9436.433813971184, 9535.094166054214, 9616.615335386787, 9697.127258546765, 9768.023197680175, 33487.33025339528, 33576.832115839265, 34237.144071397415, 36486.45270320894, 37215.25569488541, 47615.28577071416, 48339.27491087566, 48601.513984859695, 49892.750536247084, 50348.748256258485, 7750.883736743841, 8028.718994835152, 8051.033875934925, 8059.073206581318, 8253.546054966795, 12001.879981200425, 12115.575954841539, 12186.146969712036, 12218.938905305416, 12236.327002014974, 9053.77365565866, 10912.181586380895, 10951.671449856518, 10974.615888443866, 11045.0, 10590.788184236426, 10697.197710171924, 10734.892651073702, 10743.409112498888, 10758.623448179276, 10172.28793984414, 10475.738106547396, 10484.633037843943, 10501.0, 10928.289661171999, 8022.358211343195, 8095.5142691438705, 8138.633761480866, 8151.551664658501, 8151.918480815116, 10775.461226938465, 10831.187660925305, 10897.78204435891, 11053.226274161054, 11317.264377815416], "dojo.html": [3190.856411461484, 3259.3807176636424, 3299.05976796613, 3302.8018318900854, 3308.0406682062203, 5111.846644600668, 5237.47625237476, 5364.141737322025, 5454.509094181523, 5465.453454654537, 5312.309399778023, 5341.706206158659, 5394.083005888999, 5407.242985981956, 5420.214068960008, 4895.926561101577, 4916.975415122919, 4949.604031677457, 5006.04885071837, 5065.240213967916, 4862.5380588844, 5008.84973450797, 5024.246363045536, 5062.848114556551, 5082.822101226458, 4871.220604703248, 4900.019996000797, 4996.225585034325, 4997.875053123665, 5003.199488081889, 4978.950210497885, 4995.950040499585, 5001.724905130216, 5013.147764879979, 5039.79840806371, 4776.928346074812, 4899.706017638918, 4932.975335123338, 4953.950460495421, 5006.4743201964, 5201.427842937273, 5268.60485463588, 5277.683338999673, 5281.735913204363, 5284.973575132138, 5813.157092221646, 5866.354700982888, 5868.061110222387, 5872.5889187756875, 5883.735231914574, 5768.567357448208, 5870.530357571384, 5873.089671100986, 5888.146218798293, 5912.113183022538, 5401.243825864382, 5512.862178445571, 5523.972380138073, 5532.087205611069, 5571.9721401393135, 5988.0, 5993.850153746192, 6008.459238668541, 6017.398260174035, 6057.545684073712, 5659.405762394889, 5679.488846003796, 5791.8552036199435, 5819.098039803837, 5842.036064049385, 5798.82603521895, 5808.912866307009, 5811.27359080115, 5811.94188058114, 5866.530677545786, 5794.565407594448, 5799.536037117021, 5807.5644326675665, 5809.738561764731, 5816.0, 5742.425757424307, 5753.165790960287, 5764.193012978187, 5846.824595262064, 5875.41245875409, 4432.401625780542, 4440.933385999213, 4448.688591798607, 4464.084862603158, 4470.083632855257, 3990.3016972029777, 3992.341263691458, 3994.5406278277787, 4029.899252518652, 4032.233875563692, 5289.0, 5364.490373414597, 5421.674699518042, 5552.333719953632, 5582.134769110794, 5853.765849365977, 5877.294724633071, 5891.41085891416, 5891.764329426775, 5893.410658934073, 5313.149896016619, 5555.638883472561, 5568.777248909998, 5575.888482230333, 5583.553315734813, 5032.169692000779, 5057.595392368602, 5134.358205224347, 5139.177731562932, 5159.974200129051, 6103.572749907553, 6106.267247930188, 6109.14471973924, 6111.022236442148, 6112.144299798032, 5618.185363122406, 5719.942800572107, 5892.7642894283745, 5893.557983151195, 5898.764049438146, 5923.407659234214, 6000.909986350121, 6015.2781666200335, 6024.9397506026135, 6044.184035155374, 5753.050746626927, 5782.710864456676, 5788.594798364074, 5795.072788354012, 5816.651000939957, 5698.116791897262, 5701.087825947829, 5796.797112101056, 5848.766049358148, 5858.648481091148, 5703.8859222816145, 5709.286339207599, 5714.457126572969, 5741.110127930177, 5792.4497172768515, 5682.857928551819, 5684.317881854204, 5685.573581981285, 5686.488216060409, 5689.800856969986, 5468.316460442445, 5522.420145884785, 5547.750351234285, 5607.5513958882375, 5611.046122159161, 5697.173909782975, 5698.1452782083015, 5712.485876270989, 5725.6850873202375, 5812.21535092774, 5583.664980101207, 5583.972080139573, 5587.832365029056, 5589.80435684749, 5607.0], "mootools.html": [1354.566538707614, 1472.1093738288334, 1489.5307977986934, 1712.2209394725398, 1777.2091419318403, 6815.863682726349, 6950.409215216706, 7084.433245340367, 7094.574325540471, 7100.360967512923, 7276.636168191596, 7335.559866408019, 7348.926510734891, 7376.594287314209, 7381.261873812616, 2001.5196352875278, 2042.274992377707, 2205.625043742564, 2225.0654725015534, 2226.14293497004, 2292.5758734634064, 2332.4402143485613, 2337.263761915, 2337.333859849943, 2339.356676913854, 2198.681191227271, 2231.7098777158944, 2254.1321591187348, 2254.571631390039, 2256.5035692147785, 1952.8632995690307, 2003.0285311623923, 2195.923142690006, 2205.1730601024615, 2245.8091062259728, 2245.5508898220423, 2270.182734215681, 2275.2832857649787, 2276.8178545716305, 2277.10054528462, 7694.5383277003, 7811.0, 7819.452638315321, 7833.177516360757, 7843.37253019757, 4677.111348843743, 4750.263709125091, 4766.332713420124, 4776.164171270014, 4779.378680771512, 2866.641669791276, 2950.572167035768, 3023.712747289004, 3062.908112756621, 3064.9233769155726, 970.1414248390155, 985.4284514981293, 990.8711867457256, 1011.9747006324827, 1062.8405739139114, 10597.894021059768, 10736.087432568163, 10737.570497180104, 10757.354558726423, 10758.569657213624, 4055.655269302142, 4180.122174343361, 4182.707210495236, 4191.958080419217, 4265.978670106691, 8665.870011949826, 8670.739877803677, 8673.522956237468, 8677.349198809989, 8686.52224127679, 4665.5567721066445, 4669.696469729524, 4707.576318131316, 4710.057988402334, 4714.693544919569, 4295.4415925929425, 4324.870253892388, 4325.8269669213505, 4330.891727706769, 4337.696361254745, 3380.7464440167087, 3424.417848965682, 3443.500692399588, 3447.913802154916, 3458.187325978393, 1038.3977293169944, 1044.8171569975225, 1048.1038711901367, 1049.6168898352198, 1050.2963014780116, 1186.6973921649924, 1268.105985280375, 1280.7630588341187, 1281.6027031620229, 1285.6400207941792, 7063.894041589278, 7141.0, 7143.82140446493, 7146.606936618432, 7150.856982860314, 466.54511850945056, 471.0367298873811, 474.9905001899943, 476.3402687278145, 485.06866815713914, 5818.33089194748, 5819.76720931158, 5865.794697185664, 5874.471297583238, 5884.0, 9031.096890311048, 9334.299927505328, 9417.952910235404, 9471.810563788686, 9473.952630236943, 9385.0, 9434.19809316202, 9441.952790236004, 9445.622175113056, 9471.337006409623, 7060.6116663584, 7142.178649455275, 7196.316349946746, 7206.2793720627515, 7218.783436496913, 7328.560286382834, 7386.4090872728975, 7406.777796666109, 7408.481406301723, 7415.1101867776215, 7911.564863932539, 8022.638981245741, 8289.33685305162, 8306.210909963544, 8310.085890551914, 8309.542975136426, 8392.733048744265, 8490.660373584988, 8499.447535910145, 8533.658653654033, 6676.432503237085, 6802.931970680428, 6806.421454176252, 6832.692528836114, 6849.5205335628025, 7642.923570764444, 7669.7315593953945, 7673.386129109546, 7697.923020769945, 7702.345300649284, 6900.527827755127, 7059.117610298713, 7124.073870396815, 7133.108361454818, 7220.819479513054, 5912.73392697321, 6148.569600128127, 6635.701393437211, 7163.498555101093, 7177.712891484282, 6842.213145488134, 6860.897086543606, 6897.206821215625, 6918.965405172942, 7198.388137008413, 6502.057201705821, 6503.414692677682, 6510.934890651033, 6521.836954076186, 6531.836704082436, 6673.566218195801, 6679.833004174934, 6723.4957378197805, 6735.090762746966, 6735.090762747162], "ext.html": [567.5232804444269, 601.278465840991, 605.9515238780897, 623.7910300049483, 629.8614304852931, 30720.53919191211, 31551.21121971952, 31556.211094722614, 39774.40338394926, 39908.40137397941, 42387.15225695492, 42873.35689964653, 42881.0, 42919.3562096568, 43015.78492107535, 8492.0, 8675.869861952076, 8676.86984695227, 8679.826403471927, 8682.218600325969, 7796.961015194916, 7982.880256796153, 10338.948305258464, 10604.893951060507, 10605.78788424231, 10171.440570768606, 10226.795464090714, 10292.073713365833, 10319.58721651133, 10324.896751032506, 7875.054993400771, 8039.236272554098, 10268.74328141795, 10324.277300589, 10331.948340258288, 10303.175745940307, 10512.526936287886, 10589.04698577124, 10611.31026483276, 10614.416207108607, 40045.19909601821, 40488.190236195405, 40495.7975210125, 40572.18855622871, 40596.188076238606, 3058.709422604849, 3087.706667866549, 3125.7811953163286, 3174.9206269843207, 3725.2549490102087, 30544.847275763703, 30790.692093079007, 30808.229794255323, 31033.37933241345, 31631.0, 3123.8281894495794, 3143.9685603143903, 3149.5433162191584, 3171.2864605463815, 3215.1479857837694, 278844.0, 279486.0, 279794.0, 280074.0, 280436.59781701164, 52417.2137417939, 53489.46510534923, 62935.370646293864, 64003.0, 64192.679036605456, 61663.0, 61761.69119154375, 61785.0, 61798.69100654468, 62046.0, 14587.562373128823, 14769.113853168845, 14779.039362441406, 14792.408303667948, 14793.260336983109, 10923.453827308604, 10969.561217551369, 10981.0, 11088.112950963903, 11110.0, 19832.70250946237, 19928.402147935583, 19970.201191952157, 19981.700274495895, 20099.49751256201, 7532.661030253542, 7642.273983971514, 7713.884291735629, 7727.459077864608, 7825.765227043198, 842.5492361586522, 887.689308741948, 914.8993610702818, 934.9111834375724, 950.3680052764972, 25578.232653020066, 25825.870870645525, 26165.476690466083, 26593.202203933914, 26818.5977210342, 989.8564708117283, 992.1269283030887, 1002.173207104142, 1022.6880801355658, 1032.02989190161, 12684.746305073846, 13947.930260348634, 14053.78919316211, 15435.922820385826, 15686.529404117895, 318349.0, 322508.0, 322662.0, 322671.0, 322973.0, 52128.47871521312, 52403.47596523986, 52539.21191182135, 52649.736751316, 52669.73665131727, 1311.2001678975817, 1314.0276195615177, 1343.9126456780277, 1353.729254149174, 1364.8430430500619, 28509.287267818472, 28693.856530717214, 29233.123006309845, 29565.85217073901, 29756.404871902007, 45446.0, 45899.311510328036, 45931.0, 45995.77002114968, 46009.76995115003, 366035.0, 371899.0, 374290.0, 380403.0, 380817.0, 30307.09078727642, 30313.545296821005, 30457.54313685252, 30500.237494062825, 30864.845675771478, 40568.79715601403, 41272.0, 41401.585984139776, 41971.58028419799, 42270.78864605657, 35476.822615886755, 35750.28499430049, 36110.45834312435, 36140.45789313215, 37176.0, 36304.93345261687, 36360.0, 36607.0, 36711.449328259565, 36938.630613693516, 34679.306413871076, 35371.11572210612, 35636.28727425385, 35693.28613427769, 35714.10714732049, 30154.547681784352, 33118.834405827816, 33240.0, 33495.66504335023, 33526.83236583802, 24953.0, 25006.62490062687, 25511.15195221632, 25640.743592563835, 25683.743162568135], "prototype.html": [328.5367631639388, 331.5242626830497, 340.58788865472775, 341.02296919326125, 342.9211281405277, 6010.8797824043495, 6122.602030867991, 6148.200733904591, 6167.167432396625, 6209.254889413265, 5930.021546444831, 6078.483328917047, 6126.571140020201, 6140.877182456348, 6141.416565426289, 4647.209974304359, 4649.930251046237, 4652.6510511711585, 4667.76661166942, 4678.859634210962, 4463.73217606943, 4551.453825540923, 4592.163134746112, 4673.672842900998, 4715.0, 4635.8145674173165, 4641.675082744209, 4660.16117098922, 4661.277501987197, 4675.462321832999, 4687.718736875799, 4695.530446955311, 4697.271922851964, 4704.341392205094, 4708.0819240248165, 4128.318827393477, 4142.109446469024, 4142.875713728593, 4145.79271036447, 4150.979245103756, 5692.345380281238, 5783.363829978699, 5798.420157984167, 5800.390958949291, 5800.53595712342, 5426.728663566845, 5427.45725427458, 5433.239346491494, 5437.374701909292, 5482.424345443751, 6147.2930612979635, 6449.06488559161, 6451.258105317902, 6453.193350831146, 6456.838579035515, 4401.515833258339, 4446.733196008217, 4579.862604121881, 4585.380973568559, 4585.633149348044, 6635.601863888182, 6748.190217173921, 6753.3584309490025, 6757.358050985198, 6757.763478278237, 4699.530046995274, 4700.55344742249, 4703.576678098988, 4705.764711764398, 4706.788194531255, 4669.60308373792, 4744.95610965587, 4757.238841785367, 4761.95238047622, 4770.499097594703, 5420.7289635518855, 5423.538999185034, 5436.456354364532, 5443.292371991616, 5455.454454554513, 6495.188101487314, 6541.345865413516, 6542.934570654328, 6543.0, 6546.803595892131, 1673.707101257275, 1695.3472912928612, 1697.770800941857, 1698.2612563534901, 1702.6339337042596, 1123.1407972900738, 1149.735560821016, 1166.5275563396838, 1170.1341007654275, 1180.952761889532, 6258.43674069336, 6281.560290779693, 6282.654454005074, 6283.59156654816, 6289.779857704958, 6640.136782218281, 6683.532152749261, 6699.430548403343, 6700.2294736105, 6703.12859328294, 6145.0, 6261.060840873905, 6262.3111457739615, 6268.529860260499, 6269.404406581368, 3601.9639803602154, 3648.179159689049, 3650.10572409756, 3653.488511608377, 3657.4879516867127, 6965.0, 6970.954356846412, 6980.336867997532, 6986.0, 6988.056612357368, 6756.966215168893, 6880.58716477013, 6886.793396198122, 6888.138982627172, 6893.172819261721, 6929.653517324215, 6953.096097507291, 6966.616836073963, 6969.05917701114, 6974.755883544051, 6451.483881289391, 6598.670066496752, 6703.731850725916, 6713.261541230559, 6718.496112791462, 6596.175478065242, 6722.697478613376, 6735.0, 6744.662766861539, 6747.696353663999, 7042.154941407064, 7047.189573199148, 7050.365467107985, 7062.505624606229, 7066.752663656747, 4583.19794036049, 4629.421322334708, 4653.976730116327, 4654.906097067254, 4696.107739529479, 6748.426383757239, 6750.189977202767, 6750.5274630775375, 6761.594304341756, 6766.966165169143, 6595.472362211108, 6600.141981542369, 6602.84450221219, 6603.306652801387, 6605.504587156079, 6454.419102280817, 6579.703913323816, 6585.80242592723, 6591.934080659132, 6606.711691220166, 6469.8706025880165, 6481.837954050998, 6485.286618472059, 6485.513586481127, 6493.22081350241, 6630.23752268476, 6634.369734875179, 6634.800955971328, 6636.2368327642935, 6644.103046088716, 6337.176167098248, 6462.838429039311, 6462.935370646422, 6462.967685161544, 6465.806025819233], "yui.html": [710.8613820305039, 724.4566575068699, 806.7942674617972, 831.2103501673412, 862.6894318045503, 13614.047016708835, 14119.78820317696, 14125.364358603862, 14132.505362312308, 14137.78793318101, 11064.0, 13023.348832558382, 13180.0, 13280.867191328083, 13348.733025339512, 812.0701796443069, 822.5887056471764, 827.3381294964034, 828.9751307460785, 829.3779665251062, 813.3371302388534, 819.8975128108987, 820.1511435664089, 820.2535692519808, 820.4379999700225, 858.4034096303072, 863.4258218284833, 865.0484467086218, 866.7789713623017, 867.440500876934, 862.5213006781233, 866.6230189867365, 867.7483529776357, 868.7263511993733, 868.7958329792493, 635.7679447001811, 637.8309747916805, 640.9262934762515, 641.3586413586413, 641.4034947498824, 12209.816852747215, 12348.629541113782, 12389.93805030978, 12396.566120185751, 12399.75200495994, 10352.948235258775, 10503.264771466, 10818.72953176169, 10848.566057357697, 10876.945615271952, 8624.137586241388, 8764.517951512664, 8854.911450885473, 8888.822223555493, 9030.142136497023, 3547.787132772042, 3565.073080998933, 3567.6432356764117, 3572.7677700949357, 3701.222743223926, 40591.59408405937, 44943.55056449426, 45446.77276613596, 45561.08877822425, 45858.54141458576, 7655.578943158069, 7721.7683469496005, 7768.145503994556, 7830.804229894185, 7833.020872390951, 11815.172937894265, 11912.76174476523, 11966.22219555726, 11990.700232494257, 12016.158868879094, 6513.413792758674, 6636.203655561363, 6646.468282537386, 6655.500837437212, 6817.045613614098, 4187.246295666749, 4228.1966426378885, 4235.767032813224, 4257.063446041866, 4285.421468101828, 2672.5857492088758, 2707.039001154601, 2708.7426694463993, 2709.0789131694924, 2710.9051183208494, 403.7678334957411, 417.30726993191155, 417.67212738000524, 419.32279368819746, 434.23357773529744, 617.2839506172818, 636.7971388833661, 665.2482694555218, 665.5707068940507, 711.9857602847914, 8285.50286982771, 8432.686233841127, 8510.106438823957, 8514.70198543048, 8545.59984017588, 633.2053273142269, 635.4185919883347, 635.9919527548794, 667.9131712877391, 701.7578935267325, 3915.8629447969183, 4030.052937559671, 4065.10567675111, 4082.3468245080644, 4098.6516146127915, 55157.0, 56669.0, 56987.14519282214, 57192.0, 57456.138157927664, 42823.0, 44462.555374445845, 48797.26804097941, 49386.50613493891, 52597.474025260024, 43498.56501435008, 44712.0, 45332.773336133105, 46393.5360646396, 46969.765151174026, 7275.090613673291, 7364.5581265124265, 8128.3497320213055, 8208.302294304813, 8503.8724419135, 30553.0, 30579.694203057683, 31595.684043160192, 35221.471677925365, 35527.0, 41280.0, 41303.7934810324, 41541.58458415498, 41924.580754192066, 42156.57843421526, 8188.5905704715715, 8307.08622051586, 8342.431539117242, 8362.832743345221, 8631.741047768577, 12423.31671758062, 12432.067594930235, 12573.057020723665, 12666.746665066832, 12982.15615984958, 11265.831012534982, 11333.659990200307, 11337.603183888525, 11529.135314851252, 11870.881291187323, 11625.941870290595, 11848.466818993338, 11932.343721095423, 11964.222325548812, 12284.324362160167, 11242.718932026764, 11439.599614013803, 11530.596429125277, 11564.132690048113, 11914.702132446759, 10089.445080520349, 10159.542820572944, 10280.07479326864, 10311.896881031395, 10490.737731556466, 9078.727638170865, 9126.5436728162, 9550.856737149088, 9724.9027509724, 9731.756706082404]}, "summary": {"lowerIsBetter": false, "suite": 6667.215097228592, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6923.904253183346, "unit": "ms", "value": 6923.904253183346}, "dojo.html": {"lowerIsBetter": false, "filtered": 5375.883145409559, "unit": "ms", "value": 5375.883145409559}, "mootools.html": {"lowerIsBetter": false, "filtered": 4328.979184722366, "unit": "ms", "value": 4328.979184722366}, "ext.html": {"lowerIsBetter": false, "filtered": 18562.30950577307, "unit": "ms", "value": 18562.30950577307}, "prototype.html": {"lowerIsBetter": false, "filtered": 4929.545254779581, "unit": "ms", "value": 4929.545254779581}, "yui.html": {"lowerIsBetter": false, "filtered": 5956.678564365732, "unit": "ms", "value": 5956.678564365732}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-031"}, "testrun": {"date": 1447826299, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117203118", "branch": "Fx-Team", "revision": "6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 160.0, 162.0, 161.0, 163.0, 168.0, 162.0, 161.0, 160.0, 160.0], "ai-astar": [107.0, 110.0, 103.0, 108.0, 108.0, 108.0, 98.0, 110.0, 109.0, 106.0], "imaging-gaussian-blur": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0], "audio-beat-detection": [153.0, 124.0, 152.0, 160.0, 125.0, 155.0, 157.0, 140.0, 169.0, 132.0], "json-stringify-tinderbox": [69.0, 69.0, 68.0, 69.0, 68.0, 69.0, 81.0, 69.0, 68.0, 68.0], "stanford-crypto-pbkdf2": [143.0, 150.0, 151.0, 147.0, 148.0, 140.0, 152.0, 156.0, 146.0, 137.0], "json-parse-financial": [59.0, 59.0, 58.0, 58.0, 60.0, 59.0, 58.0, 66.0, 55.0, 55.0], "stanford-crypto-sha256-iterative": [66.0, 66.0, 67.0, 66.0, 67.0, 68.0, 68.0, 66.0, 66.0, 67.0], "audio-fft": [72.0, 71.0, 81.0, 91.0, 71.0, 71.0, 72.0, 97.0, 89.0, 72.0], "imaging-darkroom": [145.0, 145.0, 147.0, 144.0, 145.0, 144.0, 146.0, 145.0, 145.0, 146.0], "stanford-crypto-ccm": [122.0, 124.0, 126.0, 130.0, 127.0, 122.0, 120.0, 128.0, 133.0, 122.0], "audio-oscillator": [90.0, 90.0, 135.0, 89.0, 90.0, 89.0, 132.0, 89.0, 90.0, 134.0], "stanford-crypto-aes": [85.0, 86.0, 84.0, 86.0, 85.0, 85.0, 85.0, 85.0, 84.0, 84.0], "imaging-desaturate": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1498.8000000000004, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.7, "unit": "ms", "value": 78.7}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.0, "unit": "ms", "value": 147.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 146.7, "unit": "ms", "value": 146.7}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 125.4, "unit": "ms", "value": 125.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.2, "unit": "ms", "value": 145.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 58.7, "unit": "ms", "value": 58.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.8, "unit": "ms", "value": 102.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 106.7, "unit": "ms", "value": 106.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.9, "unit": "ms", "value": 161.9}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.7, "unit": "ms", "value": 66.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.8, "unit": "ms", "value": 69.8}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.2, "unit": "ms", "value": 109.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.9, "unit": "ms", "value": 84.9}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.1, "unit": "ms", "value": 95.1}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-031"}, "testrun": {"date": 1447826299, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117203118", "branch": "Fx-Team", "revision": "6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.53590090961873], "Encrypt": [280.97780275358247], "NavierStokes": [4835.748792270531], "Decrypt": [5035.175879396985], "Splay": [658.2849774339136], "Richards": [163.05233980107616], "RegExp": [25871.79487179487], "Earley": [773.9938080495356], "Boyer": [12231.707317073171], "RayTrace": [1103.7527593818984]}, "summary": {"lowerIsBetter": false, "suite": 20941.25126028128, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 341.6317059999999, "unit": "score", "value": 341.6317059999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 947.3381789999996, "unit": "score", "value": 947.3381789999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.881118881119, "unit": "score", "value": 306.881118881119}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 123.7928903036239, "unit": "score", "value": 123.7928903036239}, "RegExp": {"lowerIsBetter": false, "filtered": 35.21151139742318, "unit": "score", "value": 35.21151139742318}, "Richards": {"lowerIsBetter": false, "filtered": 216.50716599999996, "unit": "score", "value": 216.50716599999996}, "Earley": {"lowerIsBetter": false, "filtered": 861.070196, "unit": "score", "value": 861.070196}, "Boyer": {"lowerIsBetter": false, "filtered": 54.4865064805583, "unit": "score", "value": 54.4865064805583}, "RayTrace": {"lowerIsBetter": false, "filtered": 670.4300340000001, "unit": "score", "value": 670.4300340000001}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-031"}, "testrun": {"date": 1447826299, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117203118", "branch": "Fx-Team", "revision": "6fa3b2df62cc80058ea2f63834dcbdd6ec7caa36"}}] 22:18:29 INFO - RETURN: dromaeo_css: 6667.22 22:18:29 INFO - RETURN: kraken: 1498.80 22:18:29 INFO - RETURN: v8_7: 20941.25 22:18:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20941.25"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1498.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6667.22"}}} 22:18:29 INFO - Return code: 0 22:18:29 INFO - # TBPL SUCCESS # 22:18:29 INFO - Running post-action listener: _resource_record_post_action 22:18:29 INFO - Running post-run listener: _resource_record_post_run 22:18:30 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 8192; Write bytes: 507445248; Read time: 28; Write time: 566048 22:18:30 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 233345024; Read time: 0; Write time: 330616 22:18:30 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 267227136; Read time: 12; Write time: 199668 22:18:30 INFO - Running post-run listener: _upload_blobber_files 22:18:30 INFO - Blob upload gear active. 22:18:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:18:30 INFO - Copying logs to upload dir... 22:18:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1252.971590 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2015-11-17 22:18:30.559198) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 22:18:30.562494) ========= 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=a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010002 build_url: 'https://queue.taskcluster.net/v1/task/PJxJ9qNeRh2akSOhdy9cIQ/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-17 22:18:30.613192) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 22:18:30.613600) ========= 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=a9e534cca236dfa67d42a089000001c1-1447825961.923606-1607197261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 22:18:30.662809) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 22:18:30.663135) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 22:18:30.663425) ========= ========= Total master_lag: 0.30 =========