builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1448527716.47 results: success (0) buildid: 20151125233002 builduid: 9f3ff17dc2b548568256f6483a4fb839 revision: b5910e3f070c3a5e4c5e0474169479915ad1c7fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:36.472968) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:36.473450) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:36.473831) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006445 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:36.495698) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:36.496202) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:36.512274) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:36.512653) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020925 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:36.565059) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:36.565555) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:36.566319) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:36.566820) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-26 00:48: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% 40.5M=0s 2015-11-26 00:48:36 (40.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125675 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:36.709159) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:36.709475) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.117630 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:36.840533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 00:48:36.840930) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev b5910e3f070c3a5e4c5e0474169479915ad1c7fc --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/b2g-inbound --rev b5910e3f070c3a5e4c5e0474169479915ad1c7fc --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=5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-26 00:48:37,006 truncating revision to first 12 chars 2015-11-26 00:48:37,006 Setting DEBUG logging. 2015-11-26 00:48:37,006 attempt 1/10 2015-11-26 00:48:37,006 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/b5910e3f070c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 00:48:38,198 unpacking tar archive at: b2g-inbound-b5910e3f070c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.484937 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 00:48:38.338707) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:38.339042) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:38.349020) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:38.349350) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 00:48:38.350086) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-26 00:48:38.350412) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:48:38 INFO - MultiFileLogger online at 20151126 00:48:38 in /builds/slave/test-pgo 00:48:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 00:48:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:48:38 INFO - {'append_to_log': False, 00:48:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:48:38 INFO - 'blob_upload_branch': 'B2G-Inbound', 00:48:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:48:38 INFO - 'branch': 'B2G-Inbound', 00:48:38 INFO - 'buildbot_json_path': 'buildprops.json', 00:48:38 INFO - 'config_files': ('talos/linux_config.py',), 00:48:38 INFO - 'default_actions': ('clobber', 00:48:38 INFO - 'read-buildbot-config', 00:48:38 INFO - 'download-and-extract', 00:48:38 INFO - 'populate-webroot', 00:48:38 INFO - 'create-virtualenv', 00:48:38 INFO - 'install', 00:48:38 INFO - 'run-tests'), 00:48:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:48:38 INFO - 'download_minidump_stackwalk': True, 00:48:38 INFO - 'download_symbols': 'ondemand', 00:48:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:48:38 INFO - 'tooltool.py': '/tools/tooltool.py', 00:48:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:48:38 INFO - '/tools/misc-python/virtualenv.py')}, 00:48:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:48:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:48:38 INFO - 'installer_path': 'installer.exe', 00:48:38 INFO - 'log_level': 'info', 00:48:38 INFO - 'log_name': 'talos', 00:48:38 INFO - 'log_to_console': True, 00:48:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:48:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:48:38 INFO - 'opt_config_files': (), 00:48:38 INFO - 'pip_index': False, 00:48:38 INFO - 'sps_profile': False, 00:48:38 INFO - 'sps_profile_interval': 0, 00:48:38 INFO - 'suite': 'dromaeojs', 00:48:38 INFO - 'system_bits': '64', 00:48:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:48:38 INFO - 'title': 'talos-linux64-ix-024', 00:48:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:48:38 INFO - 'use_talos_json': True, 00:48:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:48:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:48:38 INFO - 'work_dir': 'build'} 00:48:38 INFO - ##### 00:48:38 INFO - ##### Running clobber step. 00:48:38 INFO - ##### 00:48:38 INFO - Running pre-action listener: _resource_record_pre_action 00:48:38 INFO - Running main action method: clobber 00:48:38 INFO - rmtree: /builds/slave/test-pgo/build 00:48:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:48:39 INFO - Running post-action listener: _resource_record_post_action 00:48:39 INFO - ##### 00:48:39 INFO - ##### Running read-buildbot-config step. 00:48:39 INFO - ##### 00:48:39 INFO - Running pre-action listener: _resource_record_pre_action 00:48:39 INFO - Running main action method: read_buildbot_config 00:48:39 INFO - Using buildbot properties: 00:48:39 INFO - { 00:48:39 INFO - "properties": { 00:48:39 INFO - "buildnumber": 55, 00:48:39 INFO - "product": "firefox", 00:48:39 INFO - "script_repo_revision": "production", 00:48:39 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 00:48:39 INFO - "repository": "", 00:48:39 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 00:48:39 INFO - "buildid": "20151125233002", 00:48:39 INFO - "slavename": "talos-linux64-ix-024", 00:48:39 INFO - "pgo_build": "True", 00:48:39 INFO - "basedir": "/builds/slave/test-pgo", 00:48:39 INFO - "project": "", 00:48:39 INFO - "platform": "ubuntu64_hw", 00:48:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:48:39 INFO - "slavebuilddir": "test", 00:48:39 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 00:48:39 INFO - "branch": "b2g-inbound", 00:48:39 INFO - "repo_path": "integration/b2g-inbound", 00:48:39 INFO - "stage_platform": "linux64-pgo", 00:48:39 INFO - "builduid": "9f3ff17dc2b548568256f6483a4fb839", 00:48:39 INFO - "revision": "b5910e3f070c3a5e4c5e0474169479915ad1c7fc" 00:48:39 INFO - }, 00:48:39 INFO - "sourcestamp": { 00:48:39 INFO - "repository": "", 00:48:39 INFO - "hasPatch": false, 00:48:39 INFO - "project": "", 00:48:39 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 00:48:39 INFO - "changes": [ 00:48:39 INFO - { 00:48:39 INFO - "category": null, 00:48:39 INFO - "files": [ 00:48:39 INFO - { 00:48:39 INFO - "url": null, 00:48:39 INFO - "name": "https://queue.taskcluster.net/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:48:39 INFO - } 00:48:39 INFO - ], 00:48:39 INFO - "repository": "", 00:48:39 INFO - "rev": "b5910e3f070c3a5e4c5e0474169479915ad1c7fc", 00:48:39 INFO - "who": "sendchange", 00:48:39 INFO - "when": 1448527703, 00:48:39 INFO - "number": 6709305, 00:48:39 INFO - "comments": "", 00:48:39 INFO - "project": "", 00:48:39 INFO - "at": "Thu 26 Nov 2015 00:48:23", 00:48:39 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 00:48:39 INFO - "revlink": "", 00:48:39 INFO - "properties": [ 00:48:39 INFO - [ 00:48:39 INFO - "buildid", 00:48:39 INFO - "20151125233002", 00:48:39 INFO - "Change" 00:48:39 INFO - ], 00:48:39 INFO - [ 00:48:39 INFO - "builduid", 00:48:39 INFO - "9f3ff17dc2b548568256f6483a4fb839", 00:48:39 INFO - "Change" 00:48:39 INFO - ], 00:48:39 INFO - [ 00:48:39 INFO - "pgo_build", 00:48:39 INFO - "True", 00:48:39 INFO - "Change" 00:48:39 INFO - ] 00:48:39 INFO - ], 00:48:39 INFO - "revision": "b5910e3f070c3a5e4c5e0474169479915ad1c7fc" 00:48:39 INFO - } 00:48:39 INFO - ], 00:48:39 INFO - "revision": "b5910e3f070c3a5e4c5e0474169479915ad1c7fc" 00:48:39 INFO - } 00:48:39 INFO - } 00:48:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:48:39 INFO - Running post-action listener: _resource_record_post_action 00:48:39 INFO - ##### 00:48:39 INFO - ##### Running download-and-extract step. 00:48:39 INFO - ##### 00:48:39 INFO - Running pre-action listener: _resource_record_pre_action 00:48:39 INFO - Running main action method: download_and_extract 00:48:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:48: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')]} 00:48:39 INFO - https://queue.taskcluster.net/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:48:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/test_packages.json 00:48:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/test_packages.json 00:48:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:48:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:48:40 INFO - Downloaded 1302 bytes. 00:48:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:48:40 INFO - Using the following test package requirements: 00:48:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:48:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:40 INFO - u'jsshell-linux-x86_64.zip'], 00:48:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:48:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:48:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:48:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:48:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:48:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:48:40 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')]} 00:48:40 INFO - https://queue.taskcluster.net/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/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 00:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/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 00:48:41 INFO - Downloaded 22754246 bytes. 00:48:41 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 00:48:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:41 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 00:48:42 INFO - Return code: 0 00:48:42 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 00:48:42 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')]} 00:48:42 INFO - https://queue.taskcluster.net/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:48:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/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 00:48:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/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 00:48:46 INFO - Downloaded 22754246 bytes. 00:48:46 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 00:48:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:46 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 00:48:47 INFO - Return code: 0 00:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:47 INFO - https://queue.taskcluster.net/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:48:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:48:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:48:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/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 00:48:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/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 00:48:48 INFO - Downloaded 11131717 bytes. 00:48:48 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 00:48:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:48:48 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 00:48:48 INFO - Return code: 0 00:48:48 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')]} 00:48:48 INFO - https://queue.taskcluster.net/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:48:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:48:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:48:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/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 00:48:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQB8YiosRnOtfZq0O42qNg/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 00:48:51 INFO - Downloaded 58382138 bytes. 00:48:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:48:51 INFO - mkdir: /builds/slave/test-pgo/properties 00:48:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:48:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:48:51 INFO - Contents: 00:48:51 INFO - build_url:https://queue.taskcluster.net/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:48:51 INFO - Running post-action listener: _resource_record_post_action 00:48:51 INFO - Running post-action listener: set_extra_try_arguments 00:48:51 INFO - ##### 00:48:51 INFO - ##### Running populate-webroot step. 00:48:51 INFO - ##### 00:48:51 INFO - Running pre-action listener: _resource_record_pre_action 00:48:51 INFO - Running main action method: populate_webroot 00:48:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:48:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:48:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:48:51 INFO - '../fennec_ids.txt'], 00:48:51 INFO - 'tests': ['tcheck2']}, 00:48:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:48:51 INFO - '--tppagecycles', 00:48:51 INFO - '7'], 00:48:51 INFO - 'tests': ['tsvgm']}}, 00:48:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:48:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:48:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:48:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:48:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:48:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:48:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:48:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:51 INFO - 'talos_options': ['--e10s'], 00:48:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:48:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:51 INFO - 'tests': ['damp', 'tps']}, 00:48:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:51 INFO - 'talos_options': ['--e10s'], 00:48:51 INFO - 'tests': ['damp', 'tps']}, 00:48:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:48:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:48:51 INFO - 'other': {'tests': ['a11yr', 00:48:51 INFO - 'ts_paint', 00:48:51 INFO - 'tpaint', 00:48:51 INFO - 'sessionrestore', 00:48:51 INFO - 'sessionrestore_no_auto_restore']}, 00:48:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:48:51 INFO - 'tests': ['a11yr', 00:48:51 INFO - 'ts_paint', 00:48:51 INFO - 'tpaint', 00:48:51 INFO - 'sessionrestore', 00:48:51 INFO - 'sessionrestore_no_auto_restore']}, 00:48:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:48:51 INFO - 'tests': ['a11yr', 00:48:51 INFO - 'ts_paint', 00:48:51 INFO - 'tpaint', 00:48:51 INFO - 'sessionrestore', 00:48:51 INFO - 'sessionrestore_no_auto_restore']}, 00:48:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:48:51 INFO - 'tests': ['a11yr', 00:48:51 INFO - 'ts_paint', 00:48:51 INFO - 'tpaint', 00:48:51 INFO - 'sessionrestore', 00:48:51 INFO - 'sessionrestore_no_auto_restore']}, 00:48:51 INFO - 'other_l64': {'tests': ['a11yr', 00:48:51 INFO - 'ts_paint', 00:48:51 INFO - 'tpaint', 00:48:51 INFO - 'sessionrestore', 00:48:51 INFO - 'sessionrestore_no_auto_restore']}, 00:48:51 INFO - 'other_nol64': {'tests': ['a11yr', 00:48:51 INFO - 'ts_paint', 00:48:51 INFO - 'tpaint', 00:48:51 INFO - 'sessionrestore', 00:48:51 INFO - 'sessionrestore_no_auto_restore']}, 00:48:51 INFO - 'svgr': {'tests': ['tsvgx', 00:48:51 INFO - 'tsvgr_opacity', 00:48:51 INFO - 'tart', 00:48:51 INFO - 'tscrollx', 00:48:51 INFO - 'cart']}, 00:48:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:48:51 INFO - 'tests': ['tsvgx', 00:48:51 INFO - 'tsvgr_opacity', 00:48:51 INFO - 'tart', 00:48:51 INFO - 'tscrollx', 00:48:51 INFO - 'cart']}, 00:48:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:51 INFO - 'tests': ['tp5o']}, 00:48:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:51 INFO - 'talos_options': ['--e10s'], 00:48:51 INFO - 'tests': ['tp5o']}, 00:48:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:51 INFO - 'talos_options': ['--xperf_path', 00:48:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:48:51 INFO - 'tests': ['tp5n']}, 00:48:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:51 INFO - 'talos_options': ['--e10s', 00:48:51 INFO - '--xperf_path', 00:48:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:48:51 INFO - 'tests': ['tp5n']}}, 00:48:51 INFO - 'talos.zip': {'path': '', 00:48:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:48:51 INFO - Running post-action listener: _resource_record_post_action 00:48:51 INFO - ##### 00:48:51 INFO - ##### Running create-virtualenv step. 00:48:51 INFO - ##### 00:48:51 INFO - Running pre-action listener: _resource_record_pre_action 00:48:51 INFO - Running main action method: create_virtualenv 00:48:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:48:51 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 00:48:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:48:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:48:51 INFO - Using real prefix '/usr' 00:48:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:48:52 INFO - Installing distribute.............................................................................................................................................................................................done. 00:48:54 INFO - Installing pip.................done. 00:48:54 INFO - Return code: 0 00:48:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:54 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 0x2432030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee640>, '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 0x26ef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef9d0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', '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 00:48:54 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 00:48:54 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 00:48:54 INFO - Using env: {'DISPLAY': ':0', 00:48:54 INFO - 'HOME': '/home/cltbld', 00:48:54 INFO - 'LANG': 'en_US.UTF-8', 00:48:54 INFO - 'LANGUAGE': 'en_US:en', 00:48:54 INFO - 'LOGNAME': 'cltbld', 00:48:54 INFO - 'MAIL': '/var/mail/cltbld', 00:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:54 INFO - 'MOZ_NO_REMOTE': '1', 00:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:54 INFO - 'NO_EM_RESTART': '1', 00:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:48:54 INFO - 'PWD': '/builds/slave/test-pgo', 00:48:54 INFO - 'SHELL': '/bin/bash', 00:48:54 INFO - 'SHLVL': '1', 00:48:54 INFO - 'TERM': 'linux', 00:48:54 INFO - 'TMOUT': '86400', 00:48:54 INFO - 'USER': 'cltbld', 00:48:54 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', 00:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:54 INFO - '_': '/tools/buildbot/bin/python'} 00:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:54 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 00:48:54 INFO - Cleaning up... 00:48:54 INFO - Return code: 0 00:48:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:54 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 0x2432030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee640>, '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 0x26ef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef9d0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', '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 00:48:54 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 00:48:54 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 00:48:54 INFO - Using env: {'DISPLAY': ':0', 00:48:54 INFO - 'HOME': '/home/cltbld', 00:48:54 INFO - 'LANG': 'en_US.UTF-8', 00:48:54 INFO - 'LANGUAGE': 'en_US:en', 00:48:54 INFO - 'LOGNAME': 'cltbld', 00:48:54 INFO - 'MAIL': '/var/mail/cltbld', 00:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:54 INFO - 'MOZ_NO_REMOTE': '1', 00:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:54 INFO - 'NO_EM_RESTART': '1', 00:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:48:54 INFO - 'PWD': '/builds/slave/test-pgo', 00:48:54 INFO - 'SHELL': '/bin/bash', 00:48:54 INFO - 'SHLVL': '1', 00:48:54 INFO - 'TERM': 'linux', 00:48:54 INFO - 'TMOUT': '86400', 00:48:54 INFO - 'USER': 'cltbld', 00:48:54 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', 00:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:54 INFO - '_': '/tools/buildbot/bin/python'} 00:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:54 INFO - Downloading/unpacking psutil>=0.7.1 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:48:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:48:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:48:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:48:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:48:56 INFO - Installing collected packages: psutil 00:48:56 INFO - Running setup.py install for psutil 00:48:56 INFO - building 'psutil._psutil_linux' extension 00:48:56 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 00:48:56 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 00:48:56 INFO - building 'psutil._psutil_posix' extension 00:48:56 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 00:48:57 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 00:48:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:48:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:48:57 INFO - Successfully installed psutil 00:48:57 INFO - Cleaning up... 00:48:57 INFO - Return code: 0 00:48:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:48: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')]} 00:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48: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')]} 00:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:57 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 0x2432030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee640>, '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 0x26ef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef9d0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', '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 00:48:57 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 00:48:57 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 00:48:57 INFO - Using env: {'DISPLAY': ':0', 00:48:57 INFO - 'HOME': '/home/cltbld', 00:48:57 INFO - 'LANG': 'en_US.UTF-8', 00:48:57 INFO - 'LANGUAGE': 'en_US:en', 00:48:57 INFO - 'LOGNAME': 'cltbld', 00:48:57 INFO - 'MAIL': '/var/mail/cltbld', 00:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:57 INFO - 'MOZ_NO_REMOTE': '1', 00:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:57 INFO - 'NO_EM_RESTART': '1', 00:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:48:57 INFO - 'PWD': '/builds/slave/test-pgo', 00:48:57 INFO - 'SHELL': '/bin/bash', 00:48:57 INFO - 'SHLVL': '1', 00:48:57 INFO - 'TERM': 'linux', 00:48:57 INFO - 'TMOUT': '86400', 00:48:57 INFO - 'USER': 'cltbld', 00:48:57 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', 00:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:57 INFO - '_': '/tools/buildbot/bin/python'} 00:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 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 00:48:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:48:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:48:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:48:59 INFO - Installing collected packages: mozsystemmonitor 00:48:59 INFO - Running setup.py install for mozsystemmonitor 00:48:59 INFO - Successfully installed mozsystemmonitor 00:48:59 INFO - Cleaning up... 00:48:59 INFO - Return code: 0 00:48:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:48:59 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')]} 00:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:59 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')]} 00:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:59 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 0x2432030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee640>, '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 0x26ef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef9d0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', '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 00:48:59 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 00:48:59 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 00:48:59 INFO - Using env: {'DISPLAY': ':0', 00:48:59 INFO - 'HOME': '/home/cltbld', 00:48:59 INFO - 'LANG': 'en_US.UTF-8', 00:48:59 INFO - 'LANGUAGE': 'en_US:en', 00:48:59 INFO - 'LOGNAME': 'cltbld', 00:48:59 INFO - 'MAIL': '/var/mail/cltbld', 00:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:59 INFO - 'MOZ_NO_REMOTE': '1', 00:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:59 INFO - 'NO_EM_RESTART': '1', 00:48:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:48:59 INFO - 'PWD': '/builds/slave/test-pgo', 00:48:59 INFO - 'SHELL': '/bin/bash', 00:48:59 INFO - 'SHLVL': '1', 00:48:59 INFO - 'TERM': 'linux', 00:48:59 INFO - 'TMOUT': '86400', 00:48:59 INFO - 'USER': 'cltbld', 00:48:59 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', 00:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:59 INFO - '_': '/tools/buildbot/bin/python'} 00:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:59 INFO - Downloading/unpacking blobuploader==1.2.4 00:48:59 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 00:48:59 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 00:48:59 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 00:48:59 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 00:48:59 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 00:48:59 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 00:49:01 INFO - Downloading blobuploader-1.2.4.tar.gz 00:49:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:49:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:49:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:49:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:49:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:02 INFO - Downloading docopt-0.6.1.tar.gz 00:49:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:49:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:49:02 INFO - Installing collected packages: blobuploader, requests, docopt 00:49:02 INFO - Running setup.py install for blobuploader 00:49:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:49:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:49:02 INFO - Running setup.py install for requests 00:49:02 INFO - Running setup.py install for docopt 00:49:02 INFO - Successfully installed blobuploader requests docopt 00:49:02 INFO - Cleaning up... 00:49:02 INFO - Return code: 0 00:49:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:02 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 0x2432030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee640>, '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 0x26ef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef9d0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', '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 00:49:02 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 00:49:02 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 00:49:02 INFO - Using env: {'DISPLAY': ':0', 00:49:02 INFO - 'HOME': '/home/cltbld', 00:49:02 INFO - 'LANG': 'en_US.UTF-8', 00:49:02 INFO - 'LANGUAGE': 'en_US:en', 00:49:02 INFO - 'LOGNAME': 'cltbld', 00:49:02 INFO - 'MAIL': '/var/mail/cltbld', 00:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:02 INFO - 'MOZ_NO_REMOTE': '1', 00:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:02 INFO - 'NO_EM_RESTART': '1', 00:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:02 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:02 INFO - 'SHELL': '/bin/bash', 00:49:02 INFO - 'SHLVL': '1', 00:49:02 INFO - 'TERM': 'linux', 00:49:02 INFO - 'TMOUT': '86400', 00:49:02 INFO - 'USER': 'cltbld', 00:49:02 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', 00:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:02 INFO - '_': '/tools/buildbot/bin/python'} 00:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:02 INFO - Running setup.py (path:/tmp/pip-qk0Ht5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:03 INFO - Running setup.py (path:/tmp/pip-Tpqa4x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:03 INFO - Running setup.py (path:/tmp/pip-BIuY9o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:03 INFO - Running setup.py (path:/tmp/pip-8TAyKN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:03 INFO - Running setup.py (path:/tmp/pip-kjkVor-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:03 INFO - Running setup.py (path:/tmp/pip-ruSrwO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:03 INFO - Running setup.py (path:/tmp/pip-uNQZMc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:03 INFO - Running setup.py (path:/tmp/pip-oR4q_f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:03 INFO - Running setup.py (path:/tmp/pip-0V6wvA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:03 INFO - Running setup.py (path:/tmp/pip-_MobZS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:03 INFO - Running setup.py (path:/tmp/pip-s5Xbh8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:03 INFO - Running setup.py (path:/tmp/pip-q1QVpc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:03 INFO - Running setup.py (path:/tmp/pip-95DjBI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:03 INFO - Running setup.py (path:/tmp/pip-kiafAD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:04 INFO - Running setup.py (path:/tmp/pip-3Iq3e5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:04 INFO - Running setup.py (path:/tmp/pip-fmO0sB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:04 INFO - Running setup.py (path:/tmp/pip-XwvBTp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:49:04 INFO - Running setup.py install for manifestparser 00:49:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:49:04 INFO - Running setup.py install for mozcrash 00:49:04 INFO - Running setup.py install for mozdebug 00:49:04 INFO - Running setup.py install for mozdevice 00:49:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:49:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:49:04 INFO - Running setup.py install for mozfile 00:49:04 INFO - Running setup.py install for mozhttpd 00:49:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:49:04 INFO - Running setup.py install for mozinfo 00:49:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:49:04 INFO - Running setup.py install for mozInstall 00:49:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:49:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:49:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:49:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:49:05 INFO - Running setup.py install for mozleak 00:49:05 INFO - Running setup.py install for mozlog 00:49:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:49:05 INFO - Running setup.py install for moznetwork 00:49:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:49:05 INFO - Running setup.py install for mozprocess 00:49:05 INFO - Running setup.py install for mozprofile 00:49:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:49:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:49:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:49:05 INFO - Running setup.py install for mozrunner 00:49:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:49:05 INFO - Running setup.py install for mozscreenshot 00:49:05 INFO - Running setup.py install for moztest 00:49:05 INFO - Running setup.py install for mozversion 00:49:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:49:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:49:05 INFO - Cleaning up... 00:49:05 INFO - Return code: 0 00:49:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x2432030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee640>, '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 0x26ef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef9d0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', '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 00:49:05 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 00:49:05 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 00:49:06 INFO - Using env: {'DISPLAY': ':0', 00:49:06 INFO - 'HOME': '/home/cltbld', 00:49:06 INFO - 'LANG': 'en_US.UTF-8', 00:49:06 INFO - 'LANGUAGE': 'en_US:en', 00:49:06 INFO - 'LOGNAME': 'cltbld', 00:49:06 INFO - 'MAIL': '/var/mail/cltbld', 00:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:06 INFO - 'MOZ_NO_REMOTE': '1', 00:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:06 INFO - 'NO_EM_RESTART': '1', 00:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:06 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:06 INFO - 'SHELL': '/bin/bash', 00:49:06 INFO - 'SHLVL': '1', 00:49:06 INFO - 'TERM': 'linux', 00:49:06 INFO - 'TMOUT': '86400', 00:49:06 INFO - 'USER': 'cltbld', 00:49:06 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', 00:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:06 INFO - '_': '/tools/buildbot/bin/python'} 00:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:06 INFO - Running setup.py (path:/tmp/pip-mODGG6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:06 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)) 00:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:06 INFO - Running setup.py (path:/tmp/pip-Cd5F9e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:06 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)) 00:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:06 INFO - Running setup.py (path:/tmp/pip-kNumQd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:06 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)) 00:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:06 INFO - Running setup.py (path:/tmp/pip-Nf8UVe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:06 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)) 00:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:06 INFO - Running setup.py (path:/tmp/pip-yQwWXc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:06 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)) 00:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:06 INFO - Running setup.py (path:/tmp/pip-aoPrdL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:06 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)) 00:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:06 INFO - Running setup.py (path:/tmp/pip-GsB2jB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:06 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)) 00:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:06 INFO - Running setup.py (path:/tmp/pip-dFBFGj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:06 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)) 00:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:06 INFO - Running setup.py (path:/tmp/pip-sZ6UMn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:06 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)) 00:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:06 INFO - Running setup.py (path:/tmp/pip-IQoG5E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 00:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:06 INFO - Running setup.py (path:/tmp/pip-oHrx_W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:07 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)) 00:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:07 INFO - Running setup.py (path:/tmp/pip-JFex5j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:07 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)) 00:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:07 INFO - Running setup.py (path:/tmp/pip-cpKa2Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:07 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)) 00:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:07 INFO - Running setup.py (path:/tmp/pip-pxopSE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:07 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)) 00:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:07 INFO - Running setup.py (path:/tmp/pip-3xgYvd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:07 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)) 00:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:07 INFO - Running setup.py (path:/tmp/pip-oR6zKN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:07 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)) 00:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:07 INFO - Running setup.py (path:/tmp/pip-XwVuzm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:07 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)) 00:49:07 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)) 00:49:07 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)) 00:49:07 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)) 00:49:07 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)) 00:49:07 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)) 00:49:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:09 INFO - Downloading blessings-1.5.1.tar.gz 00:49:09 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 00:49:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:49:09 INFO - Installing collected packages: blessings 00:49:09 INFO - Running setup.py install for blessings 00:49:09 INFO - Successfully installed blessings 00:49:09 INFO - Cleaning up... 00:49:09 INFO - Return code: 0 00:49:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:49:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:49:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:49:09 INFO - Reading from file tmpfile_stdout 00:49:09 INFO - Current package versions: 00:49:09 INFO - argparse == 1.2.1 00:49:09 INFO - blessings == 1.5.1 00:49:09 INFO - blobuploader == 1.2.4 00:49:09 INFO - docopt == 0.6.1 00:49:09 INFO - manifestparser == 1.1 00:49:09 INFO - mozInstall == 1.12 00:49:09 INFO - mozcrash == 0.16 00:49:09 INFO - mozdebug == 0.1 00:49:09 INFO - mozdevice == 0.47 00:49:09 INFO - mozfile == 1.2 00:49:09 INFO - mozhttpd == 0.7 00:49:09 INFO - mozinfo == 0.9 00:49:09 INFO - mozleak == 0.1 00:49:09 INFO - mozlog == 3.1 00:49:09 INFO - moznetwork == 0.27 00:49:09 INFO - mozprocess == 0.22 00:49:09 INFO - mozprofile == 0.27 00:49:09 INFO - mozrunner == 6.11 00:49:09 INFO - mozscreenshot == 0.1 00:49:09 INFO - mozsystemmonitor == 0.0 00:49:09 INFO - moztest == 0.7 00:49:09 INFO - mozversion == 1.4 00:49:09 INFO - psutil == 3.1.1 00:49:09 INFO - requests == 1.2.3 00:49:09 INFO - wsgiref == 0.1.2 00:49:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49:09 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')]} 00:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:09 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')]} 00:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:09 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 0x2432030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee640>, '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 0x26ef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef9d0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', '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 00:49:09 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 00:49:09 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 00:49:09 INFO - Using env: {'DISPLAY': ':0', 00:49:09 INFO - 'HOME': '/home/cltbld', 00:49:09 INFO - 'LANG': 'en_US.UTF-8', 00:49:09 INFO - 'LANGUAGE': 'en_US:en', 00:49:09 INFO - 'LOGNAME': 'cltbld', 00:49:09 INFO - 'MAIL': '/var/mail/cltbld', 00:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:09 INFO - 'MOZ_NO_REMOTE': '1', 00:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:09 INFO - 'NO_EM_RESTART': '1', 00:49:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:09 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:09 INFO - 'SHELL': '/bin/bash', 00:49:09 INFO - 'SHLVL': '1', 00:49:09 INFO - 'TERM': 'linux', 00:49:09 INFO - 'TMOUT': '86400', 00:49:09 INFO - 'USER': 'cltbld', 00:49:09 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', 00:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:09 INFO - '_': '/tools/buildbot/bin/python'} 00:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:09 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)) 00:49:09 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)) 00:49:09 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)) 00:49:09 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)) 00:49:09 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)) 00:49:09 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)) 00:49:09 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)) 00:49:09 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)) 00:49:09 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)) 00:49:09 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)) 00:49:09 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)) 00:49:09 INFO - Cleaning up... 00:49:09 INFO - Return code: 0 00:49:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 00:49:09 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')]} 00:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:09 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')]} 00:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:09 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2432030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee640>, '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 0x26ef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef9d0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', '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 00:49:09 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', 'jsonschema'] in /builds/slave/test-pgo/build 00:49:09 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 jsonschema 00:49:09 INFO - Using env: {'DISPLAY': ':0', 00:49:09 INFO - 'HOME': '/home/cltbld', 00:49:09 INFO - 'LANG': 'en_US.UTF-8', 00:49:09 INFO - 'LANGUAGE': 'en_US:en', 00:49:09 INFO - 'LOGNAME': 'cltbld', 00:49:09 INFO - 'MAIL': '/var/mail/cltbld', 00:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:09 INFO - 'MOZ_NO_REMOTE': '1', 00:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:09 INFO - 'NO_EM_RESTART': '1', 00:49:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:09 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:09 INFO - 'SHELL': '/bin/bash', 00:49:09 INFO - 'SHLVL': '1', 00:49:09 INFO - 'TERM': 'linux', 00:49:09 INFO - 'TMOUT': '86400', 00:49:09 INFO - 'USER': 'cltbld', 00:49:09 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', 00:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:09 INFO - '_': '/tools/buildbot/bin/python'} 00:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:10 INFO - Downloading/unpacking jsonschema 00:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:49:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 00:49:11 INFO - Downloading/unpacking functools32 (from jsonschema) 00:49:11 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 00:49:11 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 00:49:11 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 00:49:11 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 00:49:11 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 00:49:11 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 00:49:11 INFO - Downloading functools32-3.2.3-2.tar.gz 00:49:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 00:49:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 00:49:11 INFO - warning: no files found matching '*.txt' 00:49:11 INFO - no previously-included directories found matching 'build' 00:49:11 INFO - no previously-included directories found matching 'dist' 00:49:11 INFO - no previously-included directories found matching '.git*' 00:49:11 INFO - Installing collected packages: jsonschema, functools32 00:49:12 INFO - Running setup.py install for functools32 00:49:12 INFO - warning: no files found matching '*.txt' 00:49:12 INFO - no previously-included directories found matching 'build' 00:49:12 INFO - no previously-included directories found matching 'dist' 00:49:12 INFO - no previously-included directories found matching '.git*' 00:49:12 INFO - Successfully installed jsonschema functools32 00:49:12 INFO - Cleaning up... 00:49:12 INFO - Return code: 0 00:49:12 INFO - Running post-action listener: _resource_record_post_action 00:49:12 INFO - Running post-action listener: _start_resource_monitoring 00:49:12 INFO - Starting resource monitoring. 00:49:12 INFO - ##### 00:49:12 INFO - ##### Running install step. 00:49:12 INFO - ##### 00:49:12 INFO - Running pre-action listener: _resource_record_pre_action 00:49:12 INFO - Running main action method: install 00:49:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:49:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:49:12 INFO - Reading from file tmpfile_stdout 00:49:12 INFO - Detecting whether we're running mozinstall >=1.0... 00:49:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:49:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:49:12 INFO - Reading from file tmpfile_stdout 00:49:12 INFO - Output received: 00:49:12 INFO - Usage: mozinstall [options] installer 00:49:12 INFO - Options: 00:49:12 INFO - -h, --help show this help message and exit 00:49:12 INFO - -d DEST, --destination=DEST 00:49:12 INFO - Directory to install application into. [default: 00:49:12 INFO - "/builds/slave/test-pgo"] 00:49:12 INFO - --app=APP Application being installed. [default: firefox] 00:49:12 INFO - mkdir: /builds/slave/test-pgo/build/application 00:49:12 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'] 00:49:12 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 00:49:27 INFO - Reading from file tmpfile_stdout 00:49:27 INFO - Output received: 00:49:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:49:27 INFO - Running post-action listener: _resource_record_post_action 00:49:27 INFO - ##### 00:49:27 INFO - ##### Running run-tests step. 00:49:27 INFO - ##### 00:49:27 INFO - Running pre-action listener: _resource_record_pre_action 00:49:27 INFO - Running main action method: run_tests 00:49:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:49:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:49:27 INFO - Python 2.7.3 00:49:27 INFO - Return code: 0 00:49:27 INFO - grabbing minidump binary from tooltool 00:49:27 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')]} 00:49:27 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 0x26ee640>, '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 0x26ef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:49:27 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 00:49:27 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 00:49:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:49:27 INFO - Return code: 0 00:49:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:49:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:49:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:49:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:49:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:49:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 00:49:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost 00:49:27 INFO - Using env: {'DISPLAY': ':0', 00:49:27 INFO - 'HOME': '/home/cltbld', 00:49:27 INFO - 'LANG': 'en_US.UTF-8', 00:49:27 INFO - 'LANGUAGE': 'en_US:en', 00:49:27 INFO - 'LOGNAME': 'cltbld', 00:49:27 INFO - 'MAIL': '/var/mail/cltbld', 00:49:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:49:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:27 INFO - 'MOZ_NO_REMOTE': '1', 00:49:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:27 INFO - 'NO_EM_RESTART': '1', 00:49:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:27 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:49:27 INFO - 'SHELL': '/bin/bash', 00:49:27 INFO - 'SHLVL': '1', 00:49:27 INFO - 'TERM': 'linux', 00:49:27 INFO - 'TMOUT': '86400', 00:49:27 INFO - 'USER': 'cltbld', 00:49:27 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340', 00:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:27 INFO - '_': '/tools/buildbot/bin/python'} 00:49:27 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost'] with output_timeout 3600 00:49:27 INFO - mozversion INFO | application_buildid: 20151125233002 00:49:27 INFO - mozversion INFO | application_changeset: b5910e3f070c3a5e4c5e0474169479915ad1c7fc 00:49:27 INFO - mozversion INFO | application_display_name: Nightly 00:49:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:49:27 INFO - mozversion INFO | application_name: Firefox 00:49:27 INFO - mozversion INFO | application_remotingname: firefox 00:49:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 00:49:27 INFO - mozversion INFO | application_vendor: Mozilla 00:49:27 INFO - mozversion INFO | application_version: 45.0a1 00:49:27 INFO - mozversion INFO | platform_buildid: 20151125233002 00:49:27 INFO - mozversion INFO | platform_changeset: b5910e3f070c3a5e4c5e0474169479915ad1c7fc 00:49:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 00:49:27 INFO - mozversion INFO | platform_version: 45.0a1 00:49:27 INFO - 2015-11-26 00:49:27,326 DEBUG : using testdate: 1448527767 00:49:27 INFO - 2015-11-26 00:49:27,326 DEBUG : actual date: 1448527767 00:49:27 INFO - 2015-11-26 00:49:27,335 INFO : starting webserver on 'localhost:41792' 00:49:27 INFO - 2015-11-26 00:49:27,336 INFO : Starting test suite talos-linux64-ix-024 00:49:27 INFO - 2015-11-26 00:49:27,336 INFO : Starting test dromaeo_css 00:49:27 INFO - 2015-11-26 00:49:27,336 DEBUG : operating with platform_type : linux_ 00:49:27 INFO - 2015-11-26 00:49:27,337 INFO : Initialising browser for dromaeo_css test... 00:49:27 INFO - 2015-11-26 00:49:27,351 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYJ7dJd/profile http://localhost:41792/getInfo.html 00:49:31 INFO - 2015-11-26 00:49:31,021 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:49:31 INFO - 2015-11-26 00:49:31,021 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:49:31 INFO - 2015-11-26 00:49:31,022 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:49:31 INFO - 2015-11-26 00:49:31,022 DEBUG : BROWSER_OUTPUT: __metrics 00:49:31 INFO - 2015-11-26 00:49:31,103 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:49:32 INFO - 2015-11-26 00:49:32,355 INFO : Browser initialized. 00:49:32 INFO - 2015-11-26 00:49:32,356 INFO : Running cycle 1/1 for dromaeo_css test... 00:49:32 INFO - 2015-11-26 00:49:32,356 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYJ7dJd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:49:44 INFO - 2015-11-26 00:49:44,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 139264000 00:49:44 INFO - 2015-11-26 00:49:44,107 DEBUG : BROWSER_OUTPUT: 00:50:34 INFO - 2015-11-26 00:50:34,900 DEBUG : BROWSER_OUTPUT: 1448527834899 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] 00:52:43 INFO - 2015-11-26 00:52:43,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41792/tests/dromaeo/cssquery-ext.html) 00:52:44 INFO - 2015-11-26 00:52:44,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 231542784 00:52:44 INFO - 2015-11-26 00:52:44,675 DEBUG : BROWSER_OUTPUT: 00:55:46 INFO - 2015-11-26 00:55:46,991 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/dromaeo/cssquery-ext.html (next: http://localhost:41792/tests/dromaeo/cssquery-jquery.html) 00:55:47 INFO - 2015-11-26 00:55:47,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 224243712 00:55:47 INFO - 2015-11-26 00:55:47,561 DEBUG : BROWSER_OUTPUT: 00:58:49 INFO - 2015-11-26 00:58:49,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41792/tests/dromaeo/cssquery-mootools.html) 00:58:49 INFO - 2015-11-26 00:58:49,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 209833984 00:58:49 INFO - 2015-11-26 00:58:49,994 DEBUG : BROWSER_OUTPUT: 01:01:51 INFO - 2015-11-26 01:01:51,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41792/tests/dromaeo/cssquery-prototype.html) 01:01:52 INFO - 2015-11-26 01:01:52,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 199987200 01:01:52 INFO - 2015-11-26 01:01:52,495 DEBUG : BROWSER_OUTPUT: 01:04:54 INFO - 2015-11-26 01:04:54,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41792/tests/dromaeo/cssquery-yui.html) 01:04:55 INFO - 2015-11-26 01:04:55,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 205103104 01:04:55 INFO - 2015-11-26 01:04:55,546 DEBUG : BROWSER_OUTPUT: 01:07:58 INFO - 2015-11-26 01:07:58,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/dromaeo/cssquery-yui.html (next: http://localhost:41792/tests/dromaeo/cssquery-dojo.html) 01:07:58 INFO - 2015-11-26 01:07:58,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 296468480 01:07:58 INFO - 2015-11-26 01:07:58,325 DEBUG : BROWSER_OUTPUT: 01:07:58 INFO - 2015-11-26 01:07:58,325 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:07:58 INFO - 2015-11-26 01:07:58,325 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:07:58 INFO - 2015-11-26 01:07:58,325 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:07:58 INFO - 2015-11-26 01:07:58,325 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:07:58 INFO - 2015-11-26 01:07:58,325 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3200.5679233303504;3244.2700392411693;3284.7536434767385;3293.7529685273594;3311.0728995881163;5357.598180136496;5446.319210098738;5467.316585426822;5475.5072043516075;5478.7808487660495;5323.520883120518;5407.080796264635;5418.783248670058;5428.945710542894;5468.808591699291;4991.201407774757;5067.695938243708;5082.313887625179;5086.287919691246;5092.770825312869;83.13478988188783;5060.84817455477;5123.666961647499;5131.127708289581;5161.406438259592;5000.374953130859;5010.073136469765;5112.284280200774;5113.207452844777;5142.8714282143055;5103.923441148386;5106.361704786902;5112.014574553105;5115.104856650071;5160.664556803796;4848.393950756155;5103.974480127613;5109.4379618241965;5131.435542090367;5156.04613146569;5165.199394093884;5220.347456567929;5278;5286.629935904488;5286.656367336111;5940.821775346703;5941.346451890288;5942.851428714317;5946.286445626552;5953.345132035516;5599.888002239933;5801.361850196475;5975.581709280352;5979.2824861016525;5981.850453738648;5510.448955104497;5583;5588.804391846266;5593.356763972114;5637.661740295595;6122.357152498924;6165.907511387243;6166.969165154145;6170.876582468325;6175.505959523317;5742.310922689304;5864.32560255576;5865.35481097079;5891.646501209942;5984.2818861736;5857.677827719431;5946.940530594725;5957.076653118686;5957.1362152487645;5990.5507086968655;5831.3877042910735;5896.823095307148;5942.851428714317;5957.731902064417;5959.106134079836;5732.283464566929;5851.678157701367;5866.677332746654;5936.643801371932;5951.613145145551;4487.887802804956;4532.093581283756;4545.681802273809;4567.931481027787;4594.609458196091;4076.5719599442223;4078.5513593504693;4083.1017176221185;4083.509978802503;4115.8765237042935;5458.044842152607;5499.780008799603;5536.916946245809;5683.630564013326;5689.829305120853;5998;6015.729292181863;6019.398060193946;6026.216591843032;6054.122152287893;5672.14917762339;5676.489115979582;5676.744546495418;5679.204911312419;5685.829425117253;5042.067217564762;5126.4617215191865;5135.743212839343;5209.947900520946;5261.789528418821;6252.062190671436;6253.280872699606;6257.9687101564205;6260.280067792171;6266.24805023391;5994.430529099728;6002.579819412599;6002.909956350571;6007.48936340416;6009.579329447071;5935.436133567304;6015.729292181775;6032.155498230339;6087.208662873798;6120.294761999531;5862.355140934579;5915.408459154222;5917.082852157922;5925.9407405925385;5950.077737950452;5940.79207227745;6001.819945401645;6019.518438524995;6024.246969128859;6027.36712645166;5705.885882282414;5728.484436400744;5773.307203135482;5831.562632802642;5862.237909071793;5831.1836342912875;5839;5839.795607153729;5842.503387212135;5843.29880414353;5490.533304669148;5731.828045158652;5741.397153299011;5744.885102298014;5747.08046712524;5699.800506982236;5728.885422291614;5846.94153058481;5954.10688396744;6006.069059295816;5678.432156784289;5720.256366672306;5731.254936858182;5731.703672713066;5778.104393818965 01:07:58 INFO - 2015-11-26 01:07:58,326 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.7402194990304;599.289841537778;607.1196764691198;612.0390986151738;612.6967151260127;31414.68585314149;40286;41198;41209.969750756245;41254.79372603133;43479.3478097828;44285.114297714026;44294.77852610732;44307.55692443075;44416;7572.697092116308;7665.348445382149;8662.956685216564;8818.470891746483;8838.779030524223;10130.49347532624;10256.435896025716;10285.794284114314;10285.897141028569;10287.485625718722;10026.047525485068;10038.84941725871;10075.445850478221;10085.89914100857;10122.139618132467;7727.806804829868;7894.131645518988;7912.129665736765;10019.549120289568;10077.647282345157;10161.187105031653;10212.591496340137;10233.590656373735;10288.588456461732;10289.794204115875;40431.79784101061;40866.59133408657;40930.9301802366;40932.38601420981;40935.7953210235;3276.017194841538;3286.556314897482;3382.8477718502727;3581.982090089533;3624.5469316335457;30478.84760576205;30854.537181942287;30964.0710778677;30984.380312393852;31003.224919377197;3891.9610803892165;4058.2492238935893;4073.7555746655;4076.266272071026;4077.1234184650148;286059;286846;287218;287794;288295.5585222081;57733.711331443075;58370;60528.69735651294;60853.69573152195;60919.69540152271;72284;72569.2743072573;72638;72649;72698.63650681713;13675.452981880811;13735.381907814173;13802.240876751875;13810.309484525733;13907;10299.794004119876;10311.587536498457;10311.84532232017;10324.896751032544;10377;20588.27941022057;20816.27143049986;20849.270275540282;20877.68683469749;20900.581988360453;7758.3017528422715;7940.602969851484;7976.983131952351;7997.360211183208;8010.5994700264755;989.292655751127;999.3204620857887;1031.097789434245;1066.9916928502646;1071.9892801072046;27820.304492387448;28273.858630706716;28464.715352846622;28729.712702873123;28832.567511487345;1035.2701345551368;1059.0362769879528;1093.6117678224275;1111.7331840358418;1172.4137931034484;14578.562643120724;14821.629459263604;14927.626809329853;14970.40118395252;14979.153960747422;316934;321114;322061;326802;327022;52132.21801672978;52561.211581826305;52608.21087683688;52614.47385526172;52736.73631631817;1316.230005446805;1321.0752473268751;1322.3916998180753;1332.4670131947105;1337.2912356451097;27136.72863271342;28193.15420537387;28275.858620706764;32266;32955.34089318248;50432.24351634655;50940.490595095056;51115.233271501704;51118.74440627773;51213.48786512087;305402;307099;309378;309921;310705;36808.44787328139;37573;38832.6116738829;42260.78869605633;45585.77207113943;43170.784146079066;44259.55740442554;44689.32966005577;44787.104257915315;45437.772811135736;36733.26533469262;37386;37776.244475109794;38002.61997380101;38665;37233;37434.62565374311;38094.809525952194;38178.61821381862;38186.618133819415;34647.82676086603;35278.64721352753;37143.6285637151;41196.38205426981;41333.79333103315;29739.944209484005;33726;34428.31143377168;34494;34498.13754656053;25400.74599253984;25476.872615636803;25800.612990804777;25875.22374328773;26336 01:07:58 INFO - 2015-11-26 01:07:58,326 DEBUG : BROWSER_OUTPUT: |2;jquery.html;347.8365168370865;351.7678332300682;352.50649091272214;354.0564395884967;356.1452513966482;14739.778903316459;14871.182084985321;16899.746503802453;17360;18015.45953621392;15480.69038619227;15548.37806487742;15704.371825126982;16237.431689890856;16240.269187886544;5318.202269659553;5432.67403955762;5453.182022696587;5463.863403414906;5466.426025267349;4075.1849630073957;4177.582241775814;5383.757730902119;5437.8368648940595;5816.883662326751;5870.236869206997;5906.05503119501;5919.763209471616;5932.762689492415;5935.436133567304;5760.107183386561;5903.2325797646245;5904.261967254093;5906.940930590704;5907.202527658754;5269.894602107936;5272.156454967187;5276.918231762479;5293.841184764463;5301;19644.410667679993;19799;20076.39770806878;20127.798722012885;20174.092165852573;2144.3031014920057;2145.1848297646793;2154.8707077575395;2167.436466518701;2665.586834040727;12682.873171268262;13117.934410327982;13242.801357979542;13455.596332109955;13548.59354219375;1808.4574627611664;1828.1773202059126;1840.447865640316;1848.2052717331542;1870.3640762140801;58616;59251;59723.70138149325;61385;63200;9468.952655236817;9734.561944712505;9823.410595364301;9866.950665246772;9886.505674716236;12878.549250776177;12881.806772898226;12899.097063205672;12909.677258068623;12919.741605167845;7186.353228209487;7209.243029481934;7217.603031833194;7257.310555497219;7257.8548429031125;6904.585724856524;6909.205441374206;6946.687399066953;6964.233934267227;6974.337437943387;5728.169415434739;5794.304683438015;5812.215350927655;5814.738336774855;5868.119782032729;1659.5353301075718;1701.9404320848957;1721.4577408116404;1766.311138655925;1772.2290803500518;413.32215167125935;421.3700517726019;1007.6825799873017;1011.6797579159268;1054.4938429553704;9309.30180236485;9498.95250523743;10513.684589462327;10596.205284603686;10674.679759607225;409.6129157945713;415.15723082143296;424.5012110769895;426.4967338540552;442.1996186901718;5770.394108618619;5952.136940143655;6024.909626355608;6050.878982420415;6107.328193898667;510651;518802;520624;537290;539337;76762.84855727169;79414.602926985;79507.20492794998;79817.20182798097;80206.59896700596;454.25728933194466;463.1246943277209;465.6600681502454;465.9813607455664;466.08879640303803;10149.64476243328;10277.383356998604;14403.42386304578;15105.32026058852;15111.773323399937;18584.25662973466;29382.530873456668;31225.68774312228;31565.842170788997;32068.5189722159;43174.568254317055;44623.553764463235;44868.326975094744;44963.32555011612;44985;9020.368574199743;9554.61781528731;9572.377795443273;9667.516624168622;9724.513774311397;10958.178136639624;11007.954244346774;11044.668659940215;11136.276142050741;11740.647780566596;13436.462541498231;13627.454901804213;13731.519396821463;13736.10715303502;14684.265786710836;13930.930345348208;14278.975774698172;14455.927720361331;14525;15114.924425378242;15056.623584410478;15295.388184472497;15333.233338332815;15375.538733838002;15512.767308490156;9439.52802359893;9641.662541811003;9730.902690973;9874.358166719141;9900.554475048497;10216.131628811634;11524.308541487537;14548.49080282185;14922.477713279983;15038.62403439879 01:07:58 INFO - 2015-11-26 01:07:58,326 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1358.6331690443587;1454.2510607037377;1501.5045035138403;1632.7550867369894;1755.92098355574;6373.9362606373925;7084.114485689289;7102.751403700871;7126.287371262871;7132.9286707132915;7264.982902393669;7310.451716121299;7323.194448610649;7380.55716657001;7427.702891884318;1915.7605299337583;1960.5196726801883;2175.0647221694744;2205.746339171;2236.507968246983;2253.9323820285335;2259.2318611672026;2260.773922607734;2262.400463877074;2262.468319944812;2162.9891850540803;2225.521512874732;2230.029936977412;2233.564454931281;2234.910603575863;1908.3034692337267;1948.162290215207;2184.967225491611;2209.491816882126;2225.2990308052913;2196.6595177747477;2205.867647941129;2226.7773222677765;2230.185982116516;2252.9211477598205;7440.8139796504975;7476.177620461799;7497.737579184757;7505.474616776828;7513.661885215124;4423.491298500681;4507.368968344402;4525.841595544173;4528.139653465864;4535.614472769818;2979.8063125896747;2985.358147998191;2993.9700602993908;3013.2316259353724;3134.7492200623897;983.9950800246024;993.7664648807524;1009.9495025248708;1015.5683834370363;1015.8019186258682;10087.798244035079;10093.192544596415;10116.190704743529;10158.187345012382;10195.694129176063;4104.958950410517;4192.601702838226;4224.852130175429;4240.448741663564;4262.296721041055;8603.612837422332;8658.95670521656;8663.263622592025;8670.739877803677;8691.261242794308;4452.1763473757455;4472.351509031172;4497.05561832019;4524;4529.343245229424;4073.7759423231414;4114.835406583763;4119.608637179464;4119.7940102994735;4136.276151673445;3565.857365705395;3601.2797440512004;3607.0525953730303;3631.1829838286176;3640.5631324241263;1179.8053321201905;1181.4919584578543;1182.1134149387958;1191.3209470601673;1194.0566952107738;1019.143919107938;1303.9217646941213;1306.3337697774205;1307.5619667411333;1332.380443093966;6319.33646967071;6829.112215411965;6936.549124306904;6943.930560694429;6983.441324694012;591.544510726738;597.4503456819737;603.1013789453682;604.0606856338349;605.8697380063307;5533.087040638249;5554.250176226158;5630.352509461464;5638.830835074954;5639.943600564024;8545.145485451405;8581.35639827003;8600.268977136888;8636.784080397914;8722.956385218033;8493.150684931457;8531.189536993976;8534.658613655509;8554.144585541397;8593.95703021481;6718.335956645567;6850.417714494224;6860.656967151623;6933.3066693331275;6960.23437421873;6609.537332386687;6643.601383916787;6657.1345725055435;6671.966640166768;6700.798976030727;7449.776506704808;7704.614769261627;7814.57019863913;7825.295723384923;7830.92169078302;7843.56860372685;7918.445708800328;7925.564093974656;7942.007249093864;8033.397495187767;6429.903551446826;6500.707468164039;6523.739050437929;6559.409653131241;6571.178602674666;6962.825929351604;6967.268436814062;6972.895406569007;6982.930170698228;6986.685599147949;6494.09082728409;6625.370589793962;6640.335966403514;6643.534952553468;6709.295523969913;6529.67351632426;6533.607983521004;6587.604743715392;6618.569792963634;6707.3628005339415;6028.5177185825905;6324.0513922910095;6685.064091027163;6710.429613482908;6724.831879202863;5957.136215248851;6006.309274433496;6109;6122.938770612237;6137.202163718866;5965.940340596539;5972.940270597239;6019.789307374221;6023.1567580537885;6023.186869772525 01:07:58 INFO - 2015-11-26 01:07:58,326 DEBUG : BROWSER_OUTPUT: |4;prototype.html;309.1082227772875;313.1591676349003;315.089391658108;318.4061724883092;318.60811202221254;5878.559108066891;5896.380880007597;6022.427869352416;6063.211782468284;6083.3612470690605;5833.125031245316;5966.105084237367;5966.940330596693;5979.671118088514;5979.820605381835;4593.977030114845;4594.0582180653055;4599.080183963204;4603.125406172817;4606.930896036562;4399.164158809832;4487.977560112195;4501.077279157765;4605.861824145281;4609.147307748078;4535;4559.908801823962;4564.657650676196;4571.771411429432;4579;4523.977380113111;4555.407796986387;4561.726296422209;4573.199690054227;4574.222382195035;3997.1006523532265;4006.419069234945;4008.7394319369146;4009.3985902114623;4012.779297138656;5615.747291371898;5706;5727.541796656257;5776.249087618583;5784.07454807233;5350.892982140374;5351.892962140774;5352.090144675376;5360.088784906575;5363.115086010804;6127.846803829895;6428.614283143026;6441.871162576769;6444.162258906359;6445.871082578369;4337.84817531388;4380.737155770664;4430.800613972347;4449.17690227309;4450.176717307276;6502.057201705727;6605.834854128685;6607.636579988099;6608.834779130512;6613.437857782094;4520.932186017212;4522.909541809146;4535.637149028136;4539.296409056601;4540.682152249311;4504.211762941472;4588.2888152336445;4598.057398233354;4598.620413875824;4623.167829790603;5306.389765176977;5308.124159513637;5310.097283461821;5314.362276526765;5314.787408503694;6421.8715625688155;6429.421352078335;6433.485321174295;6438.776632439822;6442.774502892376;1619.6922584708868;1635.7382818748943;1637.287779815784;1638.6722655468955;1640.8031036275722;1084.7559299157626;1086.375334182848;1086.6088208245026;1102.6802227353978;1121.2375584602385;6229.875402491924;6253.280872699698;6253.5622506424115;6258.155149054819;6266.655333956676;6647.169103862017;6654.866902662016;6655.500837437212;6657.201135863727;6664.466842652576;6070.2108725865355;6248.31268560458;6248.4064013918605;6248.562600618004;6251.531135164881;3587.677109060197;3618.8371523281517;3619.113317237294;3620.800855952948;3625.0756057205244;6890.276520965327;6901.62041087735;6927.203371612329;6935.930640693629;6939.132608423947;6639.601623902581;6802.14973128359;6810.387065164159;6812.3187681232475;6822.488313376417;6900.689468973807;6903.827404314832;6923.065386172903;6929.0299358090915;6931.272216417305;6352.269489008823;6487.22153341602;6628.734850606114;6629.204495460575;6645.368689974444;6366.64983425916;6613.14029176204;6615.5038372123245;6627.966860165669;6635.502337324623;6955.826104347432;6972.605478904138;6974.651267436507;6976.825579360557;6977.1976222733;4394.890127746832;4475.1273501666865;4478.731276123443;4484.506704262594;4485.865424037284;6674.666266686743;6688.565243259172;6691.899621505779;6695.12963314766;6698.497612678971;6482.675866206765;6485.513586481127;6489.837754056186;6491.805245842632;6500;6250.562460627712;6439.8068057958335;6446.871062578628;6475.546711730133;6500.7399704013205;6363.713632886624;6400.423961843457;6412.743490260337;6419.646919419477;6421.518386121153;6492.805215843532;6516.478681705547;6544.640044797582;6552.3447655234095;6558.540902136805;6232.158658581215;6376.553641245068;6387.297397286387;6395.104685343963;6405.7117429714845 01:07:58 INFO - 2015-11-26 01:07:58,326 DEBUG : BROWSER_OUTPUT: |5;yui.html;698.5564166754116;798.4490701416023;807.4025221336211;824.6824972385633;829.067299288301;13632;13871.58385248443;13897.722045559083;13914.37385317662;13917.721645567082;11687.7078073048;11768.176227664046;12822.487100515968;12957.287349195814;13000.934995325033;656.6421300391298;805.4402190477606;812.8740045292989;814.1288820961573;814.3932770086265;680.4488364424807;681.3697329969783;684.0286792754301;779.2246714519033;820.4748960665179;807.6163822184445;848.0374774630808;856.5460306037779;860.290260535058;864.3560547392202;853.6414705823538;855.5850412549909;856.1310270075846;857.4555157475017;862.0861886400373;503.84632687030444;521.2207749414649;605.446016894541;630.3349965786094;633.5406830048224;13349.33253337339;13466.25935573543;13466.394012269471;13473.663158421019;13476.528321508798;10215.336003159771;10253.947824365176;10521.316114452537;10744.892551074467;11076;10050.648227312082;10227.488625568692;10435.47822608874;10504;10522.684319470352;3505.474178873164;3583.964160358389;3584.1577229351083;3591.1560783215923;3616.3129005489136;46880;47333.526664733254;47500.7624961873;47657.04685906297;47665;9373.484458354857;9598.520073996411;9619.27855410847;9693.563789629483;9721.805563888682;16974.575635608962;17050.147492625318;17058.829411705974;17081;17081.914590427215;7340.302671246223;7363.7422690205585;7388.298111679382;7520.1351844537485;7574.810629734301;4222.9577704223175;4246.061441024395;4257.489101307801;4274.273373526508;4321.956780432155;2842.332051967786;2875.0368626510353;2880.7839412043763;2887.0184137393385;2893.1899068260923;502.30430853267757;509.320057722944;512.1958525115607;516.1715446708055;528.0864105098202;614.9453686926853;619.891518984176;639.8112556795757;643.369497892059;643.5623775832386;8440.53577053268;8487.321014318839;8589.570521473901;8689.304855611535;8875.112488751203;513.6199212582662;652.6508318049915;662.536224642752;686.289690170671;693.7918624412656;4104.8768536943935;4242.215190189763;4258.446401967724;4298.699091063658;4347.978260108679;59934.40065599288;60851.08723369153;63724.36275637184;63772.68113659402;63895.680521597096;52942.735286323325;53490.73254633702;53503.73248133812;54239.45760542423;55042.449575503735;48716.26925596119;48821.26768098481;48947.755261223465;49607;50282.748586256836;9081.636734530544;9133.862992054992;9368.156865882103;9378.531073446164;9484.85772713396;37766.62233377631;37837.81081094577;37901.81049094737;37967.62032379641;38778.4183237246;44699.32951005803;48912;49365.50634493753;49369;49491.25763113484;10920;10977;11023.118150548098;11215.43922803873;11217.158713096713;12437.378131093228;12532.686682833002;12645.304508252135;12691.301978391277;12775.297358645365;11561.537538498365;11574.247673901169;11714.76570468603;11797.056235500968;12193.146479746332;11003.669889903316;11097.167712421762;11198.21612487118;11662.825057623973;12082;11360.204785664924;11555.42222888869;11693.356865372147;11803.645890623295;12062.51749930028;9951.37892555403;10223.7444063899;10323.225758068025;10461;10769.784604308026;9477.763055923382;10244.795104098026;10354.223433242387;10423.166146708396;10440.63457778974 01:07:58 INFO - 2015-11-26 01:07:58,326 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:07:58 INFO - 2015-11-26 01:07:58,326 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:07:58 INFO - 2015-11-26 01:07:58,326 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1000 01:07:58 INFO - 2015-11-26 01:07:58,326 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:07:58 INFO - 2015-11-26 01:07:58,326 DEBUG : BROWSER_OUTPUT: __startTimestamp1448528878318__endTimestamp 01:07:58 INFO - 2015-11-26 01:07:58,326 DEBUG : BROWSER_OUTPUT: 01:07:58 INFO - 2015-11-26 01:07:58,327 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:07:58 INFO - 2015-11-26 01:07:58,327 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:07:58 INFO - 2015-11-26 01:07:58,327 DEBUG : BROWSER_OUTPUT: 01:07:58 INFO - 2015-11-26 01:07:58,327 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5488.71 Median:5731.25 stddev:752.21 (13.1%) stddev-sans-first:732.79 01:07:58 INFO - 2015-11-26 01:07:58,328 DEBUG : BROWSER_OUTPUT: Values: 3200.6 3244.3 3284.8 3293.8 3311.1 5357.6 5446.3 5467.3 5475.5 5478.8 5323.5 5407.1 5418.8 5428.9 5468.8 4991.2 5067.7 5082.3 5086.3 5092.8 83.1 5060.8 5123.7 5131.1 5161.4 5000.4 5010.1 5112.3 5113.2 5142.9 5103.9 5106.4 5112.0 5115.1 5160.7 4848.4 5104.0 5109.4 5131.4 5156.0 5165.2 5220.3 5278.0 5286.6 5286.7 5940.8 5941.3 5942.9 5946.3 5953.3 5599.9 5801.4 5975.6 5979.3 5981.9 5510.4 5583.0 5588.8 5593.4 5637.7 6122.4 6165.9 6167.0 6170.9 6175.5 5742.3 5864.3 5865.4 5891.6 5984.3 5857.7 5946.9 5957.1 5957.1 5990.6 5831.4 5896.8 5942.9 5957.7 5959.1 5732.3 5851.7 5866.7 5936.6 5951.6 4487.9 4532.1 4545.7 4567.9 4594.6 4076.6 4078.6 4083.1 4083.5 4115.9 5458.0 5499.8 5536.9 5683.6 5689.8 5998.0 6015.7 6019.4 6026.2 6054.1 5672.1 5676.5 5676.7 5679.2 5685.8 5042.1 5126.5 5135.7 5209.9 5261.8 6252.1 6253.3 6258.0 6260.3 6266.2 5994.4 6002.6 6002.9 6007.5 6009.6 5935.4 6015.7 6032.2 6087.2 6120.3 5862.4 5915.4 5917.1 5925.9 5950.1 5940.8 6001.8 6019.5 6024.2 6027.4 5705.9 5728.5 5773.3 5831.6 5862.2 5831.2 5839.0 5839.8 5842.5 5843.3 5490.5 5731.8 5741.4 5744.9 5747.1 5699.8 5728.9 5846.9 5954.1 6006.1 5678.4 5720.3 5731.3 5731.7 5778.1 01:07:58 INFO - 2015-11-26 01:07:58,328 DEBUG : BROWSER_OUTPUT: 01:07:58 INFO - 2015-11-26 01:07:58,328 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48652.34 Median:18905.58 stddev:80129.90 (423.8%) stddev-sans-first:80273.34 01:07:58 INFO - 2015-11-26 01:07:58,328 DEBUG : BROWSER_OUTPUT: Values: 564.7 599.3 607.1 612.0 612.7 31414.7 40286.0 41198.0 41210.0 41254.8 43479.3 44285.1 44294.8 44307.6 44416.0 7572.7 7665.3 8663.0 8818.5 8838.8 10130.5 10256.4 10285.8 10285.9 10287.5 10026.0 10038.8 10075.4 10085.9 10122.1 7727.8 7894.1 7912.1 10019.5 10077.6 10161.2 10212.6 10233.6 10288.6 10289.8 40431.8 40866.6 40930.9 40932.4 40935.8 3276.0 3286.6 3382.8 3582.0 3624.5 30478.8 30854.5 30964.1 30984.4 31003.2 3892.0 4058.2 4073.8 4076.3 4077.1 286059.0 286846.0 287218.0 287794.0 288295.6 57733.7 58370.0 60528.7 60853.7 60919.7 72284.0 72569.3 72638.0 72649.0 72698.6 13675.5 13735.4 13802.2 13810.3 13907.0 10299.8 10311.6 10311.8 10324.9 10377.0 20588.3 20816.3 20849.3 20877.7 20900.6 7758.3 7940.6 7977.0 7997.4 8010.6 989.3 999.3 1031.1 1067.0 1072.0 27820.3 28273.9 28464.7 28729.7 28832.6 1035.3 1059.0 1093.6 1111.7 1172.4 14578.6 14821.6 14927.6 14970.4 14979.2 316934.0 321114.0 322061.0 326802.0 327022.0 52132.2 52561.2 52608.2 52614.5 52736.7 1316.2 1321.1 1322.4 1332.5 1337.3 27136.7 28193.2 28275.9 32266.0 32955.3 50432.2 50940.5 51115.2 51118.7 51213.5 305402.0 307099.0 309378.0 309921.0 310705.0 36808.4 37573.0 38832.6 42260.8 45585.8 43170.8 44259.6 44689.3 44787.1 45437.8 36733.3 37386.0 37776.2 38002.6 38665.0 37233.0 37434.6 38094.8 38178.6 38186.6 34647.8 35278.6 37143.6 41196.4 41333.8 29739.9 33726.0 34428.3 34494.0 34498.1 25400.7 25476.9 25800.6 25875.2 26336.0 01:07:58 INFO - 2015-11-26 01:07:58,328 DEBUG : BROWSER_OUTPUT: 01:07:58 INFO - 2015-11-26 01:07:58,328 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27714.44 Median:2299.48 stddev:85921.40 (3736.6%) stddev-sans-first:86137.86 01:07:58 INFO - 2015-11-26 01:07:58,328 DEBUG : BROWSER_OUTPUT: Values: 347.8 351.8 352.5 354.1 356.1 14739.8 14871.2 16899.7 17360.0 18015.5 15480.7 15548.4 15704.4 16237.4 16240.3 5318.2 5432.7 5453.2 5463.9 5466.4 4075.2 4177.6 5383.8 5437.8 5816.9 5870.2 5906.1 5919.8 5932.8 5935.4 5760.1 5903.2 5904.3 5906.9 5907.2 5269.9 5272.2 5276.9 5293.8 5301.0 19644.4 19799.0 20076.4 20127.8 20174.1 2144.3 2145.2 2154.9 2167.4 2665.6 12682.9 13117.9 13242.8 13455.6 13548.6 1808.5 1828.2 1840.4 1848.2 1870.4 58616.0 59251.0 59723.7 61385.0 63200.0 9469.0 9734.6 9823.4 9867.0 9886.5 12878.5 12881.8 12899.1 12909.7 12919.7 7186.4 7209.2 7217.6 7257.3 7257.9 6904.6 6909.2 6946.7 6964.2 6974.3 5728.2 5794.3 5812.2 5814.7 5868.1 1659.5 1701.9 1721.5 1766.3 1772.2 413.3 421.4 1007.7 1011.7 1054.5 9309.3 9499.0 10513.7 10596.2 10674.7 409.6 415.2 424.5 426.5 442.2 5770.4 5952.1 6024.9 6050.9 6107.3 510651.0 518802.0 520624.0 537290.0 539337.0 76762.8 79414.6 79507.2 79817.2 80206.6 454.3 463.1 465.7 466.0 466.1 10149.6 10277.4 14403.4 15105.3 15111.8 18584.3 29382.5 31225.7 31565.8 32068.5 43174.6 44623.6 44868.3 44963.3 44985.0 9020.4 9554.6 9572.4 9667.5 9724.5 10958.2 11008.0 11044.7 11136.3 11740.6 13436.5 13627.5 13731.5 13736.1 14684.3 13930.9 14279.0 14455.9 14525.0 15114.9 15056.6 15295.4 15333.2 15375.5 15512.8 9439.5 9641.7 9730.9 9874.4 9900.6 10216.1 11524.3 14548.5 14922.5 15038.6 01:07:58 INFO - 2015-11-26 01:07:58,329 DEBUG : BROWSER_OUTPUT: 01:07:58 INFO - 2015-11-26 01:07:58,329 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5139.34 Median:6023.17 stddev:2619.17 (43.5%) stddev-sans-first:2611.10 01:07:58 INFO - 2015-11-26 01:07:58,330 DEBUG : BROWSER_OUTPUT: Values: 1358.6 1454.3 1501.5 1632.8 1755.9 6373.9 7084.1 7102.8 7126.3 7132.9 7265.0 7310.5 7323.2 7380.6 7427.7 1915.8 1960.5 2175.1 2205.7 2236.5 2253.9 2259.2 2260.8 2262.4 2262.5 2163.0 2225.5 2230.0 2233.6 2234.9 1908.3 1948.2 2185.0 2209.5 2225.3 2196.7 2205.9 2226.8 2230.2 2252.9 7440.8 7476.2 7497.7 7505.5 7513.7 4423.5 4507.4 4525.8 4528.1 4535.6 2979.8 2985.4 2994.0 3013.2 3134.7 984.0 993.8 1009.9 1015.6 1015.8 10087.8 10093.2 10116.2 10158.2 10195.7 4105.0 4192.6 4224.9 4240.4 4262.3 8603.6 8659.0 8663.3 8670.7 8691.3 4452.2 4472.4 4497.1 4524.0 4529.3 4073.8 4114.8 4119.6 4119.8 4136.3 3565.9 3601.3 3607.1 3631.2 3640.6 1179.8 1181.5 1182.1 1191.3 1194.1 1019.1 1303.9 1306.3 1307.6 1332.4 6319.3 6829.1 6936.5 6943.9 6983.4 591.5 597.5 603.1 604.1 605.9 5533.1 5554.3 5630.4 5638.8 5639.9 8545.1 8581.4 8600.3 8636.8 8723.0 8493.2 8531.2 8534.7 8554.1 8594.0 6718.3 6850.4 6860.7 6933.3 6960.2 6609.5 6643.6 6657.1 6672.0 6700.8 7449.8 7704.6 7814.6 7825.3 7830.9 7843.6 7918.4 7925.6 7942.0 8033.4 6429.9 6500.7 6523.7 6559.4 6571.2 6962.8 6967.3 6972.9 6982.9 6986.7 6494.1 6625.4 6640.3 6643.5 6709.3 6529.7 6533.6 6587.6 6618.6 6707.4 6028.5 6324.1 6685.1 6710.4 6724.8 5957.1 6006.3 6109.0 6122.9 6137.2 5965.9 5972.9 6019.8 6023.2 6023.2 01:07:58 INFO - 2015-11-26 01:07:58,330 DEBUG : BROWSER_OUTPUT: 01:07:58 INFO - 2015-11-26 01:07:58,330 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5370.58 Median:6105.60 stddev:1635.73 (26.8%) stddev-sans-first:1595.60 01:07:58 INFO - 2015-11-26 01:07:58,331 DEBUG : BROWSER_OUTPUT: Values: 309.1 313.2 315.1 318.4 318.6 5878.6 5896.4 6022.4 6063.2 6083.4 5833.1 5966.1 5966.9 5979.7 5979.8 4594.0 4594.1 4599.1 4603.1 4606.9 4399.2 4488.0 4501.1 4605.9 4609.1 4535.0 4559.9 4564.7 4571.8 4579.0 4524.0 4555.4 4561.7 4573.2 4574.2 3997.1 4006.4 4008.7 4009.4 4012.8 5615.7 5706.0 5727.5 5776.2 5784.1 5350.9 5351.9 5352.1 5360.1 5363.1 6127.8 6428.6 6441.9 6444.2 6445.9 4337.8 4380.7 4430.8 4449.2 4450.2 6502.1 6605.8 6607.6 6608.8 6613.4 4520.9 4522.9 4535.6 4539.3 4540.7 4504.2 4588.3 4598.1 4598.6 4623.2 5306.4 5308.1 5310.1 5314.4 5314.8 6421.9 6429.4 6433.5 6438.8 6442.8 1619.7 1635.7 1637.3 1638.7 1640.8 1084.8 1086.4 1086.6 1102.7 1121.2 6229.9 6253.3 6253.6 6258.2 6266.7 6647.2 6654.9 6655.5 6657.2 6664.5 6070.2 6248.3 6248.4 6248.6 6251.5 3587.7 3618.8 3619.1 3620.8 3625.1 6890.3 6901.6 6927.2 6935.9 6939.1 6639.6 6802.1 6810.4 6812.3 6822.5 6900.7 6903.8 6923.1 6929.0 6931.3 6352.3 6487.2 6628.7 6629.2 6645.4 6366.6 6613.1 6615.5 6628.0 6635.5 6955.8 6972.6 6974.7 6976.8 6977.2 4394.9 4475.1 4478.7 4484.5 4485.9 6674.7 6688.6 6691.9 6695.1 6698.5 6482.7 6485.5 6489.8 6491.8 6500.0 6250.6 6439.8 6446.9 6475.5 6500.7 6363.7 6400.4 6412.7 6419.6 6421.5 6492.8 6516.5 6544.6 6552.3 6558.5 6232.2 6376.6 6387.3 6395.1 6405.7 01:07:58 INFO - 2015-11-26 01:07:58,331 DEBUG : BROWSER_OUTPUT: 01:07:58 INFO - 2015-11-26 01:07:58,332 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14234.90 Median:47417.14 stddev:16944.34 (35.7%) stddev-sans-first:16961.38 01:07:58 INFO - 2015-11-26 01:07:58,332 DEBUG : BROWSER_OUTPUT: Values: 698.6 798.4 807.4 824.7 829.1 13632.0 13871.6 13897.7 13914.4 13917.7 11687.7 11768.2 12822.5 12957.3 13000.9 656.6 805.4 812.9 814.1 814.4 680.4 681.4 684.0 779.2 820.5 807.6 848.0 856.5 860.3 864.4 853.6 855.6 856.1 857.5 862.1 503.8 521.2 605.4 630.3 633.5 13349.3 13466.3 13466.4 13473.7 13476.5 10215.3 10253.9 10521.3 10744.9 11076.0 10050.6 10227.5 10435.5 10504.0 10522.7 3505.5 3584.0 3584.2 3591.2 3616.3 46880.0 47333.5 47500.8 47657.0 47665.0 9373.5 9598.5 9619.3 9693.6 9721.8 16974.6 17050.1 17058.8 17081.0 17081.9 7340.3 7363.7 7388.3 7520.1 7574.8 4223.0 4246.1 4257.5 4274.3 4322.0 2842.3 2875.0 2880.8 2887.0 2893.2 502.3 509.3 512.2 516.2 528.1 614.9 619.9 639.8 643.4 643.6 8440.5 8487.3 8589.6 8689.3 8875.1 513.6 652.7 662.5 686.3 693.8 4104.9 4242.2 4258.4 4298.7 4348.0 59934.4 60851.1 63724.4 63772.7 63895.7 52942.7 53490.7 53503.7 54239.5 55042.4 48716.3 48821.3 48947.8 49607.0 50282.7 9081.6 9133.9 9368.2 9378.5 9484.9 37766.6 37837.8 37901.8 37967.6 38778.4 44699.3 48912.0 49365.5 49369.0 49491.3 10920.0 10977.0 11023.1 11215.4 11217.2 12437.4 12532.7 12645.3 12691.3 12775.3 11561.5 11574.2 11714.8 11797.1 12193.1 11003.7 11097.2 11198.2 11662.8 12082.0 11360.2 11555.4 11693.4 11803.6 12062.5 9951.4 10223.7 10323.2 10461.0 10769.8 9477.8 10244.8 10354.2 10423.2 10440.6 01:07:58 INFO - 2015-11-26 01:07:58,332 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:07:58 INFO - 2015-11-26 01:07:58,332 DEBUG : BROWSER_OUTPUT: 01:07:59 INFO - 2015-11-26 01:07:59,061 INFO : Browser exited with error code: 0 01:07:59 INFO - 2015-11-26 01:07:59,084 INFO : Completed test dromaeo_css (00:18:31) 01:07:59 INFO - 2015-11-26 01:07:59,085 INFO : Starting test kraken 01:07:59 INFO - 2015-11-26 01:07:59,085 DEBUG : operating with platform_type : linux_ 01:07:59 INFO - 2015-11-26 01:07:59,085 INFO : Initialising browser for kraken test... 01:07:59 INFO - 2015-11-26 01:07:59,091 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEDwzXY/profile http://localhost:41792/getInfo.html 01:08:02 INFO - 2015-11-26 01:08:02,722 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:08:02 INFO - 2015-11-26 01:08:02,722 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:08:02 INFO - 2015-11-26 01:08:02,722 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:08:02 INFO - 2015-11-26 01:08:02,722 DEBUG : BROWSER_OUTPUT: __metrics 01:08:02 INFO - 2015-11-26 01:08:02,863 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:08:04 INFO - 2015-11-26 01:08:04,012 INFO : Browser initialized. 01:08:04 INFO - 2015-11-26 01:08:04,012 INFO : Running cycle 1/1 for kraken test... 01:08:04 INFO - 2015-11-26 01:08:04,013 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEDwzXY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:08:15 INFO - 2015-11-26 01:08:15,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 139141120 01:08:15 INFO - 2015-11-26 01:08:15,771 DEBUG : BROWSER_OUTPUT: 01:08:18 INFO - 2015-11-26 01:08:18,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41792/tests/kraken/driver.html?testName=audio-beat-detection) 01:08:18 INFO - 2015-11-26 01:08:18,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 177881088 01:08:18 INFO - 2015-11-26 01:08:18,798 DEBUG : BROWSER_OUTPUT: 01:08:21 INFO - 2015-11-26 01:08:21,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41792/tests/kraken/driver.html?testName=audio-dft) 01:08:21 INFO - 2015-11-26 01:08:21,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 167002112 01:08:21 INFO - 2015-11-26 01:08:21,939 DEBUG : BROWSER_OUTPUT: 01:08:24 INFO - 2015-11-26 01:08:24,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41792/tests/kraken/driver.html?testName=audio-fft) 01:08:25 INFO - 2015-11-26 01:08:25,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 150126592 01:08:25 INFO - 2015-11-26 01:08:25,380 DEBUG : BROWSER_OUTPUT: 01:08:27 INFO - 2015-11-26 01:08:27,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41792/tests/kraken/driver.html?testName=audio-oscillator) 01:08:27 INFO - 2015-11-26 01:08:27,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 152150016 01:08:27 INFO - 2015-11-26 01:08:27,894 DEBUG : BROWSER_OUTPUT: 01:08:30 INFO - 2015-11-26 01:08:30,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41792/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:08:30 INFO - 2015-11-26 01:08:30,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 155320320 01:08:30 INFO - 2015-11-26 01:08:30,686 DEBUG : BROWSER_OUTPUT: 01:08:33 INFO - 2015-11-26 01:08:33,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41792/tests/kraken/driver.html?testName=imaging-darkroom) 01:08:34 INFO - 2015-11-26 01:08:34,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 155664384 01:08:34 INFO - 2015-11-26 01:08:34,131 DEBUG : BROWSER_OUTPUT: 01:08:37 INFO - 2015-11-26 01:08:37,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41792/tests/kraken/driver.html?testName=imaging-desaturate) 01:08:38 INFO - 2015-11-26 01:08:38,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 155545600 01:08:38 INFO - 2015-11-26 01:08:38,110 DEBUG : BROWSER_OUTPUT: 01:08:40 INFO - 2015-11-26 01:08:40,915 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41792/tests/kraken/driver.html?testName=json-parse-financial) 01:08:41 INFO - 2015-11-26 01:08:41,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 154476544 01:08:41 INFO - 2015-11-26 01:08:41,496 DEBUG : BROWSER_OUTPUT: 01:08:43 INFO - 2015-11-26 01:08:43,008 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41792/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:08:43 INFO - 2015-11-26 01:08:43,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 164962304 01:08:43 INFO - 2015-11-26 01:08:43,570 DEBUG : BROWSER_OUTPUT: 01:08:45 INFO - 2015-11-26 01:08:45,382 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41792/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:08:45 INFO - 2015-11-26 01:08:45,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 164601856 01:08:45 INFO - 2015-11-26 01:08:45,976 DEBUG : BROWSER_OUTPUT: 01:08:48 INFO - 2015-11-26 01:08:48,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41792/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:08:48 INFO - 2015-11-26 01:08:48,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 167759872 01:08:48 INFO - 2015-11-26 01:08:48,614 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-26 01:08:51,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:08:51 INFO - 2015-11-26 01:08:51,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 179539968 01:08:51 INFO - 2015-11-26 01:08:51,631 DEBUG : BROWSER_OUTPUT: 01:08:54 INFO - 2015-11-26 01:08:54,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:08:54 INFO - 2015-11-26 01:08:54,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 177274880 01:08:54 INFO - 2015-11-26 01:08:54,780 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41792/tests/kraken/driver.html?testName=ai-astar) 01:08:56 INFO - 2015-11-26 01:08:56,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 236830720 01:08:56 INFO - 2015-11-26 01:08:56,692 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,692 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:08:56 INFO - 2015-11-26 01:08:56,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:08:56 INFO - 2015-11-26 01:08:56,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:08:56 INFO - 2015-11-26 01:08:56,693 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:08:56 INFO - 2015-11-26 01:08:56,693 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;104;109;110;110;99;109;109;98 01:08:56 INFO - 2015-11-26 01:08:56,693 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;124;146;168;127;149;151;126;171;125 01:08:56 INFO - 2015-11-26 01:08:56,693 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;162;159;161;159;160;164;160;162 01:08:56 INFO - 2015-11-26 01:08:56,693 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;88;91;71;70;71;118;94;73 01:08:56 INFO - 2015-11-26 01:08:56,694 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;147;93;93;95;146;95;93;139 01:08:56 INFO - 2015-11-26 01:08:56,694 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;113;110;109;110;110;110;110;110 01:08:56 INFO - 2015-11-26 01:08:56,694 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;146;146;146;145;145;145;145;153 01:08:56 INFO - 2015-11-26 01:08:56,694 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;96;96;96;95;95 01:08:56 INFO - 2015-11-26 01:08:56,695 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;55;56;56;56;56;60;57;56;54 01:08:56 INFO - 2015-11-26 01:08:56,695 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;70;71;71;72;71;71;71;71 01:08:56 INFO - 2015-11-26 01:08:56,695 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;85;86;86;86;87;89;85;94;87 01:08:56 INFO - 2015-11-26 01:08:56,695 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;117;122;115;142;122;121;118;130;122 01:08:56 INFO - 2015-11-26 01:08:56,696 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;140;164;147;151;142;152;150;150;141 01:08:56 INFO - 2015-11-26 01:08:56,696 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;66;66;67;66;66;67;68;67;67 01:08:56 INFO - 2015-11-26 01:08:56,696 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:08:56 INFO - 2015-11-26 01:08:56,696 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:08:56 INFO - 2015-11-26 01:08:56,696 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,937 01:08:56 INFO - 2015-11-26 01:08:56,697 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:08:56 INFO - 2015-11-26 01:08:56,697 DEBUG : BROWSER_OUTPUT: __startTimestamp1448528936691__endTimestamp 01:08:56 INFO - 2015-11-26 01:08:56,697 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,698 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:08:56 INFO - 2015-11-26 01:08:56,699 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:08:56 INFO - 2015-11-26 01:08:56,699 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,699 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.70 Median:110.00 stddev:4.67 (4.2%) stddev-sans-first:4.88 01:08:56 INFO - 2015-11-26 01:08:56,699 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 104.0 109.0 110.0 110.0 99.0 109.0 109.0 98.0 01:08:56 INFO - 2015-11-26 01:08:56,700 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,700 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.80 Median:150.00 stddev:17.66 (11.8%) stddev-sans-first:18.53 01:08:56 INFO - 2015-11-26 01:08:56,700 DEBUG : BROWSER_OUTPUT: Values: 151.0 124.0 146.0 168.0 127.0 149.0 151.0 126.0 171.0 125.0 01:08:56 INFO - 2015-11-26 01:08:56,700 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,701 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.55 (1.0%) stddev-sans-first:1.64 01:08:56 INFO - 2015-11-26 01:08:56,701 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 162.0 159.0 161.0 159.0 160.0 164.0 160.0 162.0 01:08:56 INFO - 2015-11-26 01:08:56,701 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,701 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.80 Median:72.00 stddev:15.87 (22.0%) stddev-sans-first:16.34 01:08:56 INFO - 2015-11-26 01:08:56,702 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 88.0 91.0 71.0 70.0 71.0 118.0 94.0 73.0 01:08:56 INFO - 2015-11-26 01:08:56,702 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,702 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.50 Median:93.00 stddev:24.60 (26.5%) stddev-sans-first:25.36 01:08:56 INFO - 2015-11-26 01:08:56,702 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 147.0 93.0 93.0 95.0 146.0 95.0 93.0 139.0 01:08:56 INFO - 2015-11-26 01:08:56,703 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,703 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:1.03 (0.9%) stddev-sans-first:1.09 01:08:56 INFO - 2015-11-26 01:08:56,703 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 113.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 01:08:56 INFO - 2015-11-26 01:08:56,703 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,703 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:2.44 (1.7%) stddev-sans-first:2.55 01:08:56 INFO - 2015-11-26 01:08:56,703 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 153.0 01:08:56 INFO - 2015-11-26 01:08:56,703 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,703 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 01:08:56 INFO - 2015-11-26 01:08:56,703 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 01:08:56 INFO - 2015-11-26 01:08:56,703 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,704 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:1.65 (2.9%) stddev-sans-first:1.64 01:08:56 INFO - 2015-11-26 01:08:56,704 DEBUG : BROWSER_OUTPUT: Values: 58.0 55.0 56.0 56.0 56.0 56.0 60.0 57.0 56.0 54.0 01:08:56 INFO - 2015-11-26 01:08:56,704 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,704 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.00 stddev:0.82 (1.2%) stddev-sans-first:0.60 01:08:56 INFO - 2015-11-26 01:08:56,704 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 71.0 71.0 72.0 71.0 71.0 71.0 71.0 01:08:56 INFO - 2015-11-26 01:08:56,704 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,704 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.50 stddev:2.69 (3.1%) stddev-sans-first:2.82 01:08:56 INFO - 2015-11-26 01:08:56,704 DEBUG : BROWSER_OUTPUT: Values: 86.0 85.0 86.0 86.0 86.0 87.0 89.0 85.0 94.0 87.0 01:08:56 INFO - 2015-11-26 01:08:56,704 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,704 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:122.00 stddev:7.76 (6.4%) stddev-sans-first:8.23 01:08:56 INFO - 2015-11-26 01:08:56,705 DEBUG : BROWSER_OUTPUT: Values: 123.0 117.0 122.0 115.0 142.0 122.0 121.0 118.0 130.0 122.0 01:08:56 INFO - 2015-11-26 01:08:56,705 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,705 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:150.50 stddev:7.05 (4.7%) stddev-sans-first:7.38 01:08:56 INFO - 2015-11-26 01:08:56,705 DEBUG : BROWSER_OUTPUT: Values: 152.0 140.0 164.0 147.0 151.0 142.0 152.0 150.0 150.0 141.0 01:08:56 INFO - 2015-11-26 01:08:56,705 DEBUG : BROWSER_OUTPUT: 01:08:56 INFO - 2015-11-26 01:08:56,705 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 01:08:56 INFO - 2015-11-26 01:08:56,705 DEBUG : BROWSER_OUTPUT: Values: 68.0 66.0 66.0 67.0 66.0 66.0 67.0 68.0 67.0 67.0 01:08:56 INFO - 2015-11-26 01:08:56,705 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:08:56 INFO - 2015-11-26 01:08:56,705 DEBUG : BROWSER_OUTPUT: 01:08:57 INFO - 2015-11-26 01:08:57,453 INFO : Browser exited with error code: 0 01:08:57 INFO - 2015-11-26 01:08:57,508 INFO : Completed test kraken (00:00:58) 01:08:57 INFO - 2015-11-26 01:08:57,509 INFO : Starting test v8_7 01:08:57 INFO - 2015-11-26 01:08:57,509 DEBUG : operating with platform_type : linux_ 01:08:57 INFO - 2015-11-26 01:08:57,509 INFO : Initialising browser for v8_7 test... 01:08:57 INFO - 2015-11-26 01:08:57,515 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZrPZZJ/profile http://localhost:41792/getInfo.html 01:09:01 INFO - 2015-11-26 01:09:01,253 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:09:01 INFO - 2015-11-26 01:09:01,253 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:09:01 INFO - 2015-11-26 01:09:01,254 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:09:01 INFO - 2015-11-26 01:09:01,254 DEBUG : BROWSER_OUTPUT: __metrics 01:09:01 INFO - 2015-11-26 01:09:01,315 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:09:02 INFO - 2015-11-26 01:09:02,520 INFO : Browser initialized. 01:09:02 INFO - 2015-11-26 01:09:02,520 INFO : Running cycle 1/1 for v8_7 test... 01:09:02 INFO - 2015-11-26 01:09:02,521 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZrPZZJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:09:14 INFO - 2015-11-26 01:09:14,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 138797056 01:09:14 INFO - 2015-11-26 01:09:14,271 DEBUG : BROWSER_OUTPUT: 01:09:35 INFO - 2015-11-26 01:09:35,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41792/tests/v8_7/run.html (next: http://localhost:41792/tests/v8_7/run.html) 01:09:35 INFO - 2015-11-26 01:09:35,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 577748992 01:09:35 INFO - 2015-11-26 01:09:35,941 DEBUG : BROWSER_OUTPUT: 01:09:35 INFO - 2015-11-26 01:09:35,942 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:09:35 INFO - 2015-11-26 01:09:35,942 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:09:35 INFO - 2015-11-26 01:09:35,942 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:09:35 INFO - 2015-11-26 01:09:35,942 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:09:35 INFO - 2015-11-26 01:09:35,943 DEBUG : BROWSER_OUTPUT: |0;Richards;164.52780519907864 01:09:35 INFO - 2015-11-26 01:09:35,943 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.85580670303975 01:09:35 INFO - 2015-11-26 01:09:35,943 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.38812785388126 01:09:35 INFO - 2015-11-26 01:09:35,943 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 01:09:35 INFO - 2015-11-26 01:09:35,943 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1084.5986984815618 01:09:35 INFO - 2015-11-26 01:09:35,943 DEBUG : BROWSER_OUTPUT: |5;Earley;783.6990595611285 01:09:35 INFO - 2015-11-26 01:09:35,944 DEBUG : BROWSER_OUTPUT: |6;Boyer;12268.292682926829 01:09:35 INFO - 2015-11-26 01:09:35,944 DEBUG : BROWSER_OUTPUT: |7;RegExp;25820.51282051282 01:09:35 INFO - 2015-11-26 01:09:35,944 DEBUG : BROWSER_OUTPUT: |8;Splay;582.4111822947001 01:09:35 INFO - 2015-11-26 01:09:35,944 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 01:09:35 INFO - 2015-11-26 01:09:35,944 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:09:35 INFO - 2015-11-26 01:09:35,945 DEBUG : BROWSER_OUTPUT: __startTimestamp1448528975940__endTimestamp 01:09:35 INFO - 2015-11-26 01:09:35,945 DEBUG : BROWSER_OUTPUT: 01:09:35 INFO - 2015-11-26 01:09:35,945 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:09:35 INFO - 2015-11-26 01:09:35,945 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:09:35 INFO - 2015-11-26 01:09:35,945 DEBUG : BROWSER_OUTPUT: 01:09:35 INFO - 2015-11-26 01:09:35,946 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.53 Median:164.53 stddev:0.00 (0.0%) 01:09:35 INFO - 2015-11-26 01:09:35,946 DEBUG : BROWSER_OUTPUT: Values: 164.5 01:09:35 INFO - 2015-11-26 01:09:35,946 DEBUG : BROWSER_OUTPUT: 01:09:35 INFO - 2015-11-26 01:09:35,946 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.86 Median:194.86 stddev:0.00 (0.0%) 01:09:35 INFO - 2015-11-26 01:09:35,946 DEBUG : BROWSER_OUTPUT: Values: 194.9 01:09:35 INFO - 2015-11-26 01:09:35,947 DEBUG : BROWSER_OUTPUT: 01:09:35 INFO - 2015-11-26 01:09:35,947 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.39 Median:285.39 stddev:0.00 (0.0%) 01:09:35 INFO - 2015-11-26 01:09:35,947 DEBUG : BROWSER_OUTPUT: Values: 285.4 01:09:35 INFO - 2015-11-26 01:09:35,947 DEBUG : BROWSER_OUTPUT: 01:09:35 INFO - 2015-11-26 01:09:35,947 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 01:09:35 INFO - 2015-11-26 01:09:35,948 DEBUG : BROWSER_OUTPUT: Values: 5186.5 01:09:35 INFO - 2015-11-26 01:09:35,948 DEBUG : BROWSER_OUTPUT: 01:09:35 INFO - 2015-11-26 01:09:35,948 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1084.60 Median:1084.60 stddev:0.00 (0.0%) 01:09:35 INFO - 2015-11-26 01:09:35,948 DEBUG : BROWSER_OUTPUT: Values: 1084.6 01:09:35 INFO - 2015-11-26 01:09:35,948 DEBUG : BROWSER_OUTPUT: 01:09:35 INFO - 2015-11-26 01:09:35,950 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.70 Median:783.70 stddev:0.00 (0.0%) 01:09:35 INFO - 2015-11-26 01:09:35,950 DEBUG : BROWSER_OUTPUT: Values: 783.7 01:09:35 INFO - 2015-11-26 01:09:35,950 DEBUG : BROWSER_OUTPUT: 01:09:35 INFO - 2015-11-26 01:09:35,950 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 01:09:35 INFO - 2015-11-26 01:09:35,950 DEBUG : BROWSER_OUTPUT: Values: 12268.3 01:09:35 INFO - 2015-11-26 01:09:35,950 DEBUG : BROWSER_OUTPUT: 01:09:35 INFO - 2015-11-26 01:09:35,950 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25820.51 Median:25820.51 stddev:0.00 (0.0%) 01:09:35 INFO - 2015-11-26 01:09:35,951 DEBUG : BROWSER_OUTPUT: Values: 25820.5 01:09:35 INFO - 2015-11-26 01:09:35,951 DEBUG : BROWSER_OUTPUT: 01:09:35 INFO - 2015-11-26 01:09:35,951 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:582.41 Median:582.41 stddev:0.00 (0.0%) 01:09:35 INFO - 2015-11-26 01:09:35,951 DEBUG : BROWSER_OUTPUT: Values: 582.4 01:09:35 INFO - 2015-11-26 01:09:35,951 DEBUG : BROWSER_OUTPUT: 01:09:35 INFO - 2015-11-26 01:09:35,951 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 01:09:35 INFO - 2015-11-26 01:09:35,951 DEBUG : BROWSER_OUTPUT: Values: 4840.6 01:09:35 INFO - 2015-11-26 01:09:35,951 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:09:35 INFO - 2015-11-26 01:09:35,952 DEBUG : BROWSER_OUTPUT: 01:09:36 INFO - 2015-11-26 01:09:36,773 INFO : Browser exited with error code: 0 01:09:36 INFO - 2015-11-26 01:09:36,785 INFO : Completed test v8_7 (00:00:39) 01:09:36 INFO - 2015-11-26 01:09:36,925 INFO : Completed test suite (00:20:09) 01:09:36 INFO - 2015-11-26 01:09:36,925 DEBUG : Working with test: dromaeo_css 01:09:36 INFO - 2015-11-26 01:09:36,925 DEBUG : Generating results file: dromaeo_css 01:09:36 INFO - 2015-11-26 01:09:36,927 DEBUG : Working with test: kraken 01:09:36 INFO - 2015-11-26 01:09:36,927 DEBUG : Generating results file: kraken 01:09:36 INFO - 2015-11-26 01:09:36,927 INFO : javascript benchmark 01:09:36 INFO - 2015-11-26 01:09:36,927 DEBUG : Working with test: v8_7 01:09:36 INFO - 2015-11-26 01:09:36,927 DEBUG : Generating results file: v8_7 01:09:36 INFO - 2015-11-26 01:09:36,928 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:09:36 INFO - 2015-11-26 01:09:36,982 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 01:09:36 INFO - 2015-11-26 01:09:36,982 DEBUG : process_Request line: dromaeo_css 6911.36 graph.html#tests=[[72,201,35]] 01:09:36 INFO - 2015-11-26 01:09:36,983 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:09:37 INFO - 2015-11-26 01:09:37,024 DEBUG : process_Request line: kraken 1506.40 graph.html#tests=[[232,201,35]] 01:09:37 INFO - 2015-11-26 01:09:37,024 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:09:37 INFO - 2015-11-26 01:09:37,060 DEBUG : process_Request line: v8_7 21076.80 graph.html#tests=[[230,201,35]] 01:09:37 INFO - 2015-11-26 01:09:37,062 INFO : javascript benchmark 01:09:37 INFO - 2015-11-26 01:09:37,066 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3200.5679233303504, 3244.2700392411693, 3284.7536434767385, 3293.7529685273594, 3311.0728995881163, 5357.598180136496, 5446.319210098738, 5467.316585426822, 5475.5072043516075, 5478.7808487660495, 5323.520883120518, 5407.080796264635, 5418.783248670058, 5428.945710542894, 5468.808591699291, 4991.201407774757, 5067.695938243708, 5082.313887625179, 5086.287919691246, 5092.770825312869, 83.13478988188783, 5060.84817455477, 5123.666961647499, 5131.127708289581, 5161.406438259592, 5000.374953130859, 5010.073136469765, 5112.284280200774, 5113.207452844777, 5142.8714282143055, 5103.923441148386, 5106.361704786902, 5112.014574553105, 5115.104856650071, 5160.664556803796, 4848.393950756155, 5103.974480127613, 5109.4379618241965, 5131.435542090367, 5156.04613146569, 5165.199394093884, 5220.347456567929, 5278.0, 5286.629935904488, 5286.656367336111, 5940.821775346703, 5941.346451890288, 5942.851428714317, 5946.286445626552, 5953.345132035516, 5599.888002239933, 5801.361850196475, 5975.581709280352, 5979.2824861016525, 5981.850453738648, 5510.448955104497, 5583.0, 5588.804391846266, 5593.356763972114, 5637.661740295595, 6122.357152498924, 6165.907511387243, 6166.969165154145, 6170.876582468325, 6175.505959523317, 5742.310922689304, 5864.32560255576, 5865.35481097079, 5891.646501209942, 5984.2818861736, 5857.677827719431, 5946.940530594725, 5957.076653118686, 5957.1362152487645, 5990.5507086968655, 5831.3877042910735, 5896.823095307148, 5942.851428714317, 5957.731902064417, 5959.106134079836, 5732.283464566929, 5851.678157701367, 5866.677332746654, 5936.643801371932, 5951.613145145551, 4487.887802804956, 4532.093581283756, 4545.681802273809, 4567.931481027787, 4594.609458196091, 4076.5719599442223, 4078.5513593504693, 4083.1017176221185, 4083.509978802503, 4115.8765237042935, 5458.044842152607, 5499.780008799603, 5536.916946245809, 5683.630564013326, 5689.829305120853, 5998.0, 6015.729292181863, 6019.398060193946, 6026.216591843032, 6054.122152287893, 5672.14917762339, 5676.489115979582, 5676.744546495418, 5679.204911312419, 5685.829425117253, 5042.067217564762, 5126.4617215191865, 5135.743212839343, 5209.947900520946, 5261.789528418821, 6252.062190671436, 6253.280872699606, 6257.9687101564205, 6260.280067792171, 6266.24805023391, 5994.430529099728, 6002.579819412599, 6002.909956350571, 6007.48936340416, 6009.579329447071, 5935.436133567304, 6015.729292181775, 6032.155498230339, 6087.208662873798, 6120.294761999531, 5862.355140934579, 5915.408459154222, 5917.082852157922, 5925.9407405925385, 5950.077737950452, 5940.79207227745, 6001.819945401645, 6019.518438524995, 6024.246969128859, 6027.36712645166, 5705.885882282414, 5728.484436400744, 5773.307203135482, 5831.562632802642, 5862.237909071793, 5831.1836342912875, 5839.0, 5839.795607153729, 5842.503387212135, 5843.29880414353, 5490.533304669148, 5731.828045158652, 5741.397153299011, 5744.885102298014, 5747.08046712524, 5699.800506982236, 5728.885422291614, 5846.94153058481, 5954.10688396744, 6006.069059295816, 5678.432156784289, 5720.256366672306, 5731.254936858182, 5731.703672713066, 5778.104393818965], "unit": "ms", "name": "dojo.html", "value": 5441.838094860333}, {"lowerIsBetter": false, "replicates": [564.7402194990304, 599.289841537778, 607.1196764691198, 612.0390986151738, 612.6967151260127, 31414.68585314149, 40286.0, 41198.0, 41209.969750756245, 41254.79372603133, 43479.3478097828, 44285.114297714026, 44294.77852610732, 44307.55692443075, 44416.0, 7572.697092116308, 7665.348445382149, 8662.956685216564, 8818.470891746483, 8838.779030524223, 10130.49347532624, 10256.435896025716, 10285.794284114314, 10285.897141028569, 10287.485625718722, 10026.047525485068, 10038.84941725871, 10075.445850478221, 10085.89914100857, 10122.139618132467, 7727.806804829868, 7894.131645518988, 7912.129665736765, 10019.549120289568, 10077.647282345157, 10161.187105031653, 10212.591496340137, 10233.590656373735, 10288.588456461732, 10289.794204115875, 40431.79784101061, 40866.59133408657, 40930.9301802366, 40932.38601420981, 40935.7953210235, 3276.017194841538, 3286.556314897482, 3382.8477718502727, 3581.982090089533, 3624.5469316335457, 30478.84760576205, 30854.537181942287, 30964.0710778677, 30984.380312393852, 31003.224919377197, 3891.9610803892165, 4058.2492238935893, 4073.7555746655, 4076.266272071026, 4077.1234184650148, 286059.0, 286846.0, 287218.0, 287794.0, 288295.5585222081, 57733.711331443075, 58370.0, 60528.69735651294, 60853.69573152195, 60919.69540152271, 72284.0, 72569.2743072573, 72638.0, 72649.0, 72698.63650681713, 13675.452981880811, 13735.381907814173, 13802.240876751875, 13810.309484525733, 13907.0, 10299.794004119876, 10311.587536498457, 10311.84532232017, 10324.896751032544, 10377.0, 20588.27941022057, 20816.27143049986, 20849.270275540282, 20877.68683469749, 20900.581988360453, 7758.3017528422715, 7940.602969851484, 7976.983131952351, 7997.360211183208, 8010.5994700264755, 989.292655751127, 999.3204620857887, 1031.097789434245, 1066.9916928502646, 1071.9892801072046, 27820.304492387448, 28273.858630706716, 28464.715352846622, 28729.712702873123, 28832.567511487345, 1035.2701345551368, 1059.0362769879528, 1093.6117678224275, 1111.7331840358418, 1172.4137931034484, 14578.562643120724, 14821.629459263604, 14927.626809329853, 14970.40118395252, 14979.153960747422, 316934.0, 321114.0, 322061.0, 326802.0, 327022.0, 52132.21801672978, 52561.211581826305, 52608.21087683688, 52614.47385526172, 52736.73631631817, 1316.230005446805, 1321.0752473268751, 1322.3916998180753, 1332.4670131947105, 1337.2912356451097, 27136.72863271342, 28193.15420537387, 28275.858620706764, 32266.0, 32955.34089318248, 50432.24351634655, 50940.490595095056, 51115.233271501704, 51118.74440627773, 51213.48786512087, 305402.0, 307099.0, 309378.0, 309921.0, 310705.0, 36808.44787328139, 37573.0, 38832.6116738829, 42260.78869605633, 45585.77207113943, 43170.784146079066, 44259.55740442554, 44689.32966005577, 44787.104257915315, 45437.772811135736, 36733.26533469262, 37386.0, 37776.244475109794, 38002.61997380101, 38665.0, 37233.0, 37434.62565374311, 38094.809525952194, 38178.61821381862, 38186.618133819415, 34647.82676086603, 35278.64721352753, 37143.6285637151, 41196.38205426981, 41333.79333103315, 29739.944209484005, 33726.0, 34428.31143377168, 34494.0, 34498.13754656053, 25400.74599253984, 25476.872615636803, 25800.612990804777, 25875.22374328773, 26336.0], "unit": "ms", "name": "ext.html", "value": 19236.854764169}, {"lowerIsBetter": false, "replicates": [347.8365168370865, 351.7678332300682, 352.50649091272214, 354.0564395884967, 356.1452513966482, 14739.778903316459, 14871.182084985321, 16899.746503802453, 17360.0, 18015.45953621392, 15480.69038619227, 15548.37806487742, 15704.371825126982, 16237.431689890856, 16240.269187886544, 5318.202269659553, 5432.67403955762, 5453.182022696587, 5463.863403414906, 5466.426025267349, 4075.1849630073957, 4177.582241775814, 5383.757730902119, 5437.8368648940595, 5816.883662326751, 5870.236869206997, 5906.05503119501, 5919.763209471616, 5932.762689492415, 5935.436133567304, 5760.107183386561, 5903.2325797646245, 5904.261967254093, 5906.940930590704, 5907.202527658754, 5269.894602107936, 5272.156454967187, 5276.918231762479, 5293.841184764463, 5301.0, 19644.410667679993, 19799.0, 20076.39770806878, 20127.798722012885, 20174.092165852573, 2144.3031014920057, 2145.1848297646793, 2154.8707077575395, 2167.436466518701, 2665.586834040727, 12682.873171268262, 13117.934410327982, 13242.801357979542, 13455.596332109955, 13548.59354219375, 1808.4574627611664, 1828.1773202059126, 1840.447865640316, 1848.2052717331542, 1870.3640762140801, 58616.0, 59251.0, 59723.70138149325, 61385.0, 63200.0, 9468.952655236817, 9734.561944712505, 9823.410595364301, 9866.950665246772, 9886.505674716236, 12878.549250776177, 12881.806772898226, 12899.097063205672, 12909.677258068623, 12919.741605167845, 7186.353228209487, 7209.243029481934, 7217.603031833194, 7257.310555497219, 7257.8548429031125, 6904.585724856524, 6909.205441374206, 6946.687399066953, 6964.233934267227, 6974.337437943387, 5728.169415434739, 5794.304683438015, 5812.215350927655, 5814.738336774855, 5868.119782032729, 1659.5353301075718, 1701.9404320848957, 1721.4577408116404, 1766.311138655925, 1772.2290803500518, 413.32215167125935, 421.3700517726019, 1007.6825799873017, 1011.6797579159268, 1054.4938429553704, 9309.30180236485, 9498.95250523743, 10513.684589462327, 10596.205284603686, 10674.679759607225, 409.6129157945713, 415.15723082143296, 424.5012110769895, 426.4967338540552, 442.1996186901718, 5770.394108618619, 5952.136940143655, 6024.909626355608, 6050.878982420415, 6107.328193898667, 510651.0, 518802.0, 520624.0, 537290.0, 539337.0, 76762.84855727169, 79414.602926985, 79507.20492794998, 79817.20182798097, 80206.59896700596, 454.25728933194466, 463.1246943277209, 465.6600681502454, 465.9813607455664, 466.08879640303803, 10149.64476243328, 10277.383356998604, 14403.42386304578, 15105.32026058852, 15111.773323399937, 18584.25662973466, 29382.530873456668, 31225.68774312228, 31565.842170788997, 32068.5189722159, 43174.568254317055, 44623.553764463235, 44868.326975094744, 44963.32555011612, 44985.0, 9020.368574199743, 9554.61781528731, 9572.377795443273, 9667.516624168622, 9724.513774311397, 10958.178136639624, 11007.954244346774, 11044.668659940215, 11136.276142050741, 11740.647780566596, 13436.462541498231, 13627.454901804213, 13731.519396821463, 13736.10715303502, 14684.265786710836, 13930.930345348208, 14278.975774698172, 14455.927720361331, 14525.0, 15114.924425378242, 15056.623584410478, 15295.388184472497, 15333.233338332815, 15375.538733838002, 15512.767308490156, 9439.52802359893, 9641.662541811003, 9730.902690973, 9874.358166719141, 9900.554475048497, 10216.131628811634, 11524.308541487537, 14548.49080282185, 14922.477713279983, 15038.62403439879], "unit": "ms", "name": "jquery.html", "value": 8101.654506488722}, {"lowerIsBetter": false, "replicates": [1358.6331690443587, 1454.2510607037377, 1501.5045035138403, 1632.7550867369894, 1755.92098355574, 6373.9362606373925, 7084.114485689289, 7102.751403700871, 7126.287371262871, 7132.9286707132915, 7264.982902393669, 7310.451716121299, 7323.194448610649, 7380.55716657001, 7427.702891884318, 1915.7605299337583, 1960.5196726801883, 2175.0647221694744, 2205.746339171, 2236.507968246983, 2253.9323820285335, 2259.2318611672026, 2260.773922607734, 2262.400463877074, 2262.468319944812, 2162.9891850540803, 2225.521512874732, 2230.029936977412, 2233.564454931281, 2234.910603575863, 1908.3034692337267, 1948.162290215207, 2184.967225491611, 2209.491816882126, 2225.2990308052913, 2196.6595177747477, 2205.867647941129, 2226.7773222677765, 2230.185982116516, 2252.9211477598205, 7440.8139796504975, 7476.177620461799, 7497.737579184757, 7505.474616776828, 7513.661885215124, 4423.491298500681, 4507.368968344402, 4525.841595544173, 4528.139653465864, 4535.614472769818, 2979.8063125896747, 2985.358147998191, 2993.9700602993908, 3013.2316259353724, 3134.7492200623897, 983.9950800246024, 993.7664648807524, 1009.9495025248708, 1015.5683834370363, 1015.8019186258682, 10087.798244035079, 10093.192544596415, 10116.190704743529, 10158.187345012382, 10195.694129176063, 4104.958950410517, 4192.601702838226, 4224.852130175429, 4240.448741663564, 4262.296721041055, 8603.612837422332, 8658.95670521656, 8663.263622592025, 8670.739877803677, 8691.261242794308, 4452.1763473757455, 4472.351509031172, 4497.05561832019, 4524.0, 4529.343245229424, 4073.7759423231414, 4114.835406583763, 4119.608637179464, 4119.7940102994735, 4136.276151673445, 3565.857365705395, 3601.2797440512004, 3607.0525953730303, 3631.1829838286176, 3640.5631324241263, 1179.8053321201905, 1181.4919584578543, 1182.1134149387958, 1191.3209470601673, 1194.0566952107738, 1019.143919107938, 1303.9217646941213, 1306.3337697774205, 1307.5619667411333, 1332.380443093966, 6319.33646967071, 6829.112215411965, 6936.549124306904, 6943.930560694429, 6983.441324694012, 591.544510726738, 597.4503456819737, 603.1013789453682, 604.0606856338349, 605.8697380063307, 5533.087040638249, 5554.250176226158, 5630.352509461464, 5638.830835074954, 5639.943600564024, 8545.145485451405, 8581.35639827003, 8600.268977136888, 8636.784080397914, 8722.956385218033, 8493.150684931457, 8531.189536993976, 8534.658613655509, 8554.144585541397, 8593.95703021481, 6718.335956645567, 6850.417714494224, 6860.656967151623, 6933.3066693331275, 6960.23437421873, 6609.537332386687, 6643.601383916787, 6657.1345725055435, 6671.966640166768, 6700.798976030727, 7449.776506704808, 7704.614769261627, 7814.57019863913, 7825.295723384923, 7830.92169078302, 7843.56860372685, 7918.445708800328, 7925.564093974656, 7942.007249093864, 8033.397495187767, 6429.903551446826, 6500.707468164039, 6523.739050437929, 6559.409653131241, 6571.178602674666, 6962.825929351604, 6967.268436814062, 6972.895406569007, 6982.930170698228, 6986.685599147949, 6494.09082728409, 6625.370589793962, 6640.335966403514, 6643.534952553468, 6709.295523969913, 6529.67351632426, 6533.607983521004, 6587.604743715392, 6618.569792963634, 6707.3628005339415, 6028.5177185825905, 6324.0513922910095, 6685.064091027163, 6710.429613482908, 6724.831879202863, 5957.136215248851, 6006.309274433496, 6109.0, 6122.938770612237, 6137.202163718866, 5965.940340596539, 5972.940270597239, 6019.789307374221, 6023.1567580537885, 6023.186869772525], "unit": "ms", "name": "mootools.html", "value": 4218.461039934582}, {"lowerIsBetter": false, "replicates": [309.1082227772875, 313.1591676349003, 315.089391658108, 318.4061724883092, 318.60811202221254, 5878.559108066891, 5896.380880007597, 6022.427869352416, 6063.211782468284, 6083.3612470690605, 5833.125031245316, 5966.105084237367, 5966.940330596693, 5979.671118088514, 5979.820605381835, 4593.977030114845, 4594.0582180653055, 4599.080183963204, 4603.125406172817, 4606.930896036562, 4399.164158809832, 4487.977560112195, 4501.077279157765, 4605.861824145281, 4609.147307748078, 4535.0, 4559.908801823962, 4564.657650676196, 4571.771411429432, 4579.0, 4523.977380113111, 4555.407796986387, 4561.726296422209, 4573.199690054227, 4574.222382195035, 3997.1006523532265, 4006.419069234945, 4008.7394319369146, 4009.3985902114623, 4012.779297138656, 5615.747291371898, 5706.0, 5727.541796656257, 5776.249087618583, 5784.07454807233, 5350.892982140374, 5351.892962140774, 5352.090144675376, 5360.088784906575, 5363.115086010804, 6127.846803829895, 6428.614283143026, 6441.871162576769, 6444.162258906359, 6445.871082578369, 4337.84817531388, 4380.737155770664, 4430.800613972347, 4449.17690227309, 4450.176717307276, 6502.057201705727, 6605.834854128685, 6607.636579988099, 6608.834779130512, 6613.437857782094, 4520.932186017212, 4522.909541809146, 4535.637149028136, 4539.296409056601, 4540.682152249311, 4504.211762941472, 4588.2888152336445, 4598.057398233354, 4598.620413875824, 4623.167829790603, 5306.389765176977, 5308.124159513637, 5310.097283461821, 5314.362276526765, 5314.787408503694, 6421.8715625688155, 6429.421352078335, 6433.485321174295, 6438.776632439822, 6442.774502892376, 1619.6922584708868, 1635.7382818748943, 1637.287779815784, 1638.6722655468955, 1640.8031036275722, 1084.7559299157626, 1086.375334182848, 1086.6088208245026, 1102.6802227353978, 1121.2375584602385, 6229.875402491924, 6253.280872699698, 6253.5622506424115, 6258.155149054819, 6266.655333956676, 6647.169103862017, 6654.866902662016, 6655.500837437212, 6657.201135863727, 6664.466842652576, 6070.2108725865355, 6248.31268560458, 6248.4064013918605, 6248.562600618004, 6251.531135164881, 3587.677109060197, 3618.8371523281517, 3619.113317237294, 3620.800855952948, 3625.0756057205244, 6890.276520965327, 6901.62041087735, 6927.203371612329, 6935.930640693629, 6939.132608423947, 6639.601623902581, 6802.14973128359, 6810.387065164159, 6812.3187681232475, 6822.488313376417, 6900.689468973807, 6903.827404314832, 6923.065386172903, 6929.0299358090915, 6931.272216417305, 6352.269489008823, 6487.22153341602, 6628.734850606114, 6629.204495460575, 6645.368689974444, 6366.64983425916, 6613.14029176204, 6615.5038372123245, 6627.966860165669, 6635.502337324623, 6955.826104347432, 6972.605478904138, 6974.651267436507, 6976.825579360557, 6977.1976222733, 4394.890127746832, 4475.1273501666865, 4478.731276123443, 4484.506704262594, 4485.865424037284, 6674.666266686743, 6688.565243259172, 6691.899621505779, 6695.12963314766, 6698.497612678971, 6482.675866206765, 6485.513586481127, 6489.837754056186, 6491.805245842632, 6500.0, 6250.562460627712, 6439.8068057958335, 6446.871062578628, 6475.546711730133, 6500.7399704013205, 6363.713632886624, 6400.423961843457, 6412.743490260337, 6419.646919419477, 6421.518386121153, 6492.805215843532, 6516.478681705547, 6544.640044797582, 6552.3447655234095, 6558.540902136805, 6232.158658581215, 6376.553641245068, 6387.297397286387, 6395.104685343963, 6405.7117429714845], "unit": "ms", "name": "prototype.html", "value": 4831.4789591831795}, {"lowerIsBetter": false, "replicates": [698.5564166754116, 798.4490701416023, 807.4025221336211, 824.6824972385633, 829.067299288301, 13632.0, 13871.58385248443, 13897.722045559083, 13914.37385317662, 13917.721645567082, 11687.7078073048, 11768.176227664046, 12822.487100515968, 12957.287349195814, 13000.934995325033, 656.6421300391298, 805.4402190477606, 812.8740045292989, 814.1288820961573, 814.3932770086265, 680.4488364424807, 681.3697329969783, 684.0286792754301, 779.2246714519033, 820.4748960665179, 807.6163822184445, 848.0374774630808, 856.5460306037779, 860.290260535058, 864.3560547392202, 853.6414705823538, 855.5850412549909, 856.1310270075846, 857.4555157475017, 862.0861886400373, 503.84632687030444, 521.2207749414649, 605.446016894541, 630.3349965786094, 633.5406830048224, 13349.33253337339, 13466.25935573543, 13466.394012269471, 13473.663158421019, 13476.528321508798, 10215.336003159771, 10253.947824365176, 10521.316114452537, 10744.892551074467, 11076.0, 10050.648227312082, 10227.488625568692, 10435.47822608874, 10504.0, 10522.684319470352, 3505.474178873164, 3583.964160358389, 3584.1577229351083, 3591.1560783215923, 3616.3129005489136, 46880.0, 47333.526664733254, 47500.7624961873, 47657.04685906297, 47665.0, 9373.484458354857, 9598.520073996411, 9619.27855410847, 9693.563789629483, 9721.805563888682, 16974.575635608962, 17050.147492625318, 17058.829411705974, 17081.0, 17081.914590427215, 7340.302671246223, 7363.7422690205585, 7388.298111679382, 7520.1351844537485, 7574.810629734301, 4222.9577704223175, 4246.061441024395, 4257.489101307801, 4274.273373526508, 4321.956780432155, 2842.332051967786, 2875.0368626510353, 2880.7839412043763, 2887.0184137393385, 2893.1899068260923, 502.30430853267757, 509.320057722944, 512.1958525115607, 516.1715446708055, 528.0864105098202, 614.9453686926853, 619.891518984176, 639.8112556795757, 643.369497892059, 643.5623775832386, 8440.53577053268, 8487.321014318839, 8589.570521473901, 8689.304855611535, 8875.112488751203, 513.6199212582662, 652.6508318049915, 662.536224642752, 686.289690170671, 693.7918624412656, 4104.8768536943935, 4242.215190189763, 4258.446401967724, 4298.699091063658, 4347.978260108679, 59934.40065599288, 60851.08723369153, 63724.36275637184, 63772.68113659402, 63895.680521597096, 52942.735286323325, 53490.73254633702, 53503.73248133812, 54239.45760542423, 55042.449575503735, 48716.26925596119, 48821.26768098481, 48947.755261223465, 49607.0, 50282.748586256836, 9081.636734530544, 9133.862992054992, 9368.156865882103, 9378.531073446164, 9484.85772713396, 37766.62233377631, 37837.81081094577, 37901.81049094737, 37967.62032379641, 38778.4183237246, 44699.32951005803, 48912.0, 49365.50634493753, 49369.0, 49491.25763113484, 10920.0, 10977.0, 11023.118150548098, 11215.43922803873, 11217.158713096713, 12437.378131093228, 12532.686682833002, 12645.304508252135, 12691.301978391277, 12775.297358645365, 11561.537538498365, 11574.247673901169, 11714.76570468603, 11797.056235500968, 12193.146479746332, 11003.669889903316, 11097.167712421762, 11198.21612487118, 11662.825057623973, 12082.0, 11360.204785664924, 11555.42222888869, 11693.356865372147, 11803.645890623295, 12062.51749930028, 9951.37892555403, 10223.7444063899, 10323.225758068025, 10461.0, 10769.784604308026, 9477.763055923382, 10244.795104098026, 10354.223433242387, 10423.166146708396, 10440.63457778974], "unit": "ms", "name": "yui.html", "value": 6304.548407075842}], "name": "dromaeo_css", "value": 6911.362932378378}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 109.0, 110.0, 110.0, 99.0, 109.0, 109.0, 98.0], "unit": "ms", "name": "ai-astar", "value": 106.7}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 146.0, 168.0, 127.0, 149.0, 151.0, 126.0, 171.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.8}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 159.0, 161.0, 159.0, 160.0, 164.0, 160.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 88.0, 91.0, 71.0, 70.0, 71.0, 118.0, 94.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 147.0, 93.0, 93.0, 95.0, 146.0, 95.0, 93.0, 139.0], "unit": "ms", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 113.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 153.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [58.0, 55.0, 56.0, 56.0, 56.0, 56.0, 60.0, 57.0, 56.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 71.0, 71.0, 72.0, 71.0, 71.0, 71.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.7}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 86.0, 86.0, 86.0, 87.0, 89.0, 85.0, 94.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [123.0, 117.0, 122.0, 115.0, 142.0, 122.0, 121.0, 118.0, 130.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [152.0, 140.0, 164.0, 147.0, 151.0, 142.0, 152.0, 150.0, 150.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.9}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 68.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1506.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.52780519907864], "unit": "score", "name": "Richards", "value": 214.56555600000002}, {"lowerIsBetter": false, "replicates": [194.85580670303975], "unit": "score", "name": "DeltaBlue", "value": 339.3175759999999}, {"lowerIsBetter": false, "replicates": [285.38812785388126], "unit": "score", "name": "Encrypt", "value": 932.6982240000001}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1084.5986984815618], "unit": "score", "name": "RayTrace", "value": 682.2698579999999}, {"lowerIsBetter": false, "replicates": [783.6990595611285], "unit": "score", "name": "Earley", "value": 850.4067880000003}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [25820.51282051282], "unit": "score", "name": "RegExp", "value": 35.28144488579943}, {"lowerIsBetter": false, "replicates": [582.4111822947001], "unit": "score", "name": "Splay", "value": 139.92004699999995}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21076.79673864317}]} 01:09:37 INFO - RETURN: dromaeo_css: 6911.36 01:09:37 INFO - RETURN: kraken: 1506.40 01:09:37 INFO - RETURN: v8_7: 21076.80 01:09:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "21076.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1506.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6911.36"}}} 01:09:37 INFO - Return code: 0 01:09:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:09:37 INFO - # TBPL SUCCESS # 01:09:37 INFO - Running post-action listener: _resource_record_post_action 01:09:37 INFO - Running post-run listener: _resource_record_post_run 01:09:38 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 20480; Write bytes: 264368128; Read time: 32; Write time: 130960 01:09:38 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 552960; Read time: 0; Write time: 48 01:09:38 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 20480; Write bytes: 263815168; Read time: 32; Write time: 130912 01:09:38 INFO - Running post-run listener: _upload_blobber_files 01:09:38 INFO - Blob upload gear active. 01:09:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:09:38 INFO - Copying logs to upload dir... 01:09:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.823355 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-26 01:09:38.191393) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 01:09:38.195694) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/BQB8YiosRnOtfZq0O42qNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010209 build_url: 'https://queue.taskcluster.net/v1/task/BQB8YiosRnOtfZq0O42qNg/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-26 01:09:38.247432) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 01:09:38.247994) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1448527715.818373-1056625340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 01:09:38.299086) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 01:09:38.299439) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 01:09:38.299753) ========= ========= Total master_lag: 0.20 =========