builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1445975470.0 results: success (0) buildid: 20151027113035 builduid: 6bf3cfa58bae460e8f359fb1f45731a9 revision: 2c4b2deaf1e8b715a5f7849dfac8b0d023b96e63 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:10.000091) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:10.000644) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:10.000985) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009132 basedir: '/builds/slave/test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:10.073885) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:10.074197) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:10.125249) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:10.125663) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016206 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:10.177090) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:10.177405) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:10.177795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:10.178098) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-10-27 12:51:10-- 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% 47.2M=0s 2015-10-27 12:51:10 (47.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.254926 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:10.449049) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:10.449362) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.301645 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:10.770571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:10.771014) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 2c4b2deaf1e8b715a5f7849dfac8b0d023b96e63 --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 2c4b2deaf1e8b715a5f7849dfac8b0d023b96e63 --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=752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-27 12:51:10,913 truncating revision to first 12 chars 2015-10-27 12:51:10,913 Setting DEBUG logging. 2015-10-27 12:51:10,913 attempt 1/10 2015-10-27 12:51:10,914 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/2c4b2deaf1e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-27 12:51:11,190 unpacking tar archive at: b2g-inbound-2c4b2deaf1e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.587599 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:11.374883) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:11.375565) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:11.393497) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:11.393779) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-27 12:51:11.394227) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-10-27 12:51:11.394551) ========= /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=752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:51:11 INFO - MultiFileLogger online at 20151027 12:51:11 in /builds/slave/test-pgo 12:51:11 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 12:51:11 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:51:11 INFO - {'append_to_log': False, 12:51:11 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:51:11 INFO - 'blob_upload_branch': 'B2G-Inbound', 12:51:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:51:11 INFO - 'branch': 'B2G-Inbound', 12:51:11 INFO - 'buildbot_json_path': 'buildprops.json', 12:51:11 INFO - 'config_files': ('talos/linux_config.py',), 12:51:11 INFO - 'default_actions': ('clobber', 12:51:11 INFO - 'read-buildbot-config', 12:51:11 INFO - 'download-and-extract', 12:51:11 INFO - 'populate-webroot', 12:51:11 INFO - 'create-virtualenv', 12:51:11 INFO - 'install', 12:51:11 INFO - 'run-tests'), 12:51:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:51:11 INFO - 'download_minidump_stackwalk': True, 12:51:11 INFO - 'download_symbols': 'ondemand', 12:51:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:51:11 INFO - 'tooltool.py': '/tools/tooltool.py', 12:51:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:51:11 INFO - '/tools/misc-python/virtualenv.py')}, 12:51:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:51:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:51:11 INFO - 'installer_path': 'installer.exe', 12:51:11 INFO - 'log_level': 'info', 12:51:11 INFO - 'log_name': 'talos', 12:51:11 INFO - 'log_to_console': True, 12:51:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:51:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:51:11 INFO - 'opt_config_files': (), 12:51:11 INFO - 'pip_index': False, 12:51:11 INFO - 'sps_profile': False, 12:51:11 INFO - 'sps_profile_interval': 0, 12:51:11 INFO - 'suite': 'dromaeojs', 12:51:11 INFO - 'system_bits': '64', 12:51:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:51:11 INFO - 'title': 'talos-linux64-ix-054', 12:51:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:51:11 INFO - 'use_talos_json': True, 12:51:11 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:51:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:51:11 INFO - 'work_dir': 'build'} 12:51:11 INFO - ##### 12:51:11 INFO - ##### Running clobber step. 12:51:11 INFO - ##### 12:51:11 INFO - Running pre-action listener: _resource_record_pre_action 12:51:11 INFO - Running main action method: clobber 12:51:11 INFO - rmtree: /builds/slave/test-pgo/build 12:51:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:51:12 INFO - Running post-action listener: _resource_record_post_action 12:51:12 INFO - ##### 12:51:12 INFO - ##### Running read-buildbot-config step. 12:51:12 INFO - ##### 12:51:12 INFO - Running pre-action listener: _resource_record_pre_action 12:51:12 INFO - Running main action method: read_buildbot_config 12:51:12 INFO - Using buildbot properties: 12:51:12 INFO - { 12:51:12 INFO - "properties": { 12:51:12 INFO - "buildnumber": 895, 12:51:12 INFO - "product": "firefox", 12:51:12 INFO - "script_repo_revision": "production", 12:51:12 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 12:51:12 INFO - "repository": "", 12:51:12 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 12:51:12 INFO - "buildid": "20151027113035", 12:51:12 INFO - "slavename": "talos-linux64-ix-054", 12:51:12 INFO - "pgo_build": "True", 12:51:12 INFO - "basedir": "/builds/slave/test-pgo", 12:51:12 INFO - "project": "", 12:51:12 INFO - "platform": "ubuntu64_hw", 12:51:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:51:12 INFO - "slavebuilddir": "test", 12:51:12 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 12:51:12 INFO - "branch": "b2g-inbound", 12:51:12 INFO - "repo_path": "integration/b2g-inbound", 12:51:12 INFO - "stage_platform": "linux64-pgo", 12:51:12 INFO - "builduid": "6bf3cfa58bae460e8f359fb1f45731a9", 12:51:12 INFO - "revision": "2c4b2deaf1e8b715a5f7849dfac8b0d023b96e63" 12:51:12 INFO - }, 12:51:12 INFO - "sourcestamp": { 12:51:12 INFO - "repository": "", 12:51:12 INFO - "hasPatch": false, 12:51:12 INFO - "project": "", 12:51:12 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 12:51:12 INFO - "changes": [ 12:51:12 INFO - { 12:51:12 INFO - "category": null, 12:51:12 INFO - "files": [ 12:51:12 INFO - { 12:51:12 INFO - "url": null, 12:51:12 INFO - "name": "https://queue.taskcluster.net/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2" 12:51:12 INFO - } 12:51:12 INFO - ], 12:51:12 INFO - "repository": "", 12:51:12 INFO - "rev": "2c4b2deaf1e8b715a5f7849dfac8b0d023b96e63", 12:51:12 INFO - "who": "sendchange", 12:51:12 INFO - "when": 1445975450, 12:51:12 INFO - "number": 6581867, 12:51:12 INFO - "comments": "", 12:51:12 INFO - "project": "", 12:51:12 INFO - "at": "Tue 27 Oct 2015 12:50:50", 12:51:12 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 12:51:12 INFO - "revlink": "", 12:51:12 INFO - "properties": [ 12:51:12 INFO - [ 12:51:12 INFO - "buildid", 12:51:12 INFO - "20151027113035", 12:51:12 INFO - "Change" 12:51:12 INFO - ], 12:51:12 INFO - [ 12:51:12 INFO - "builduid", 12:51:12 INFO - "6bf3cfa58bae460e8f359fb1f45731a9", 12:51:12 INFO - "Change" 12:51:12 INFO - ], 12:51:12 INFO - [ 12:51:12 INFO - "pgo_build", 12:51:12 INFO - "True", 12:51:12 INFO - "Change" 12:51:12 INFO - ] 12:51:12 INFO - ], 12:51:12 INFO - "revision": "2c4b2deaf1e8b715a5f7849dfac8b0d023b96e63" 12:51:12 INFO - } 12:51:12 INFO - ], 12:51:12 INFO - "revision": "2c4b2deaf1e8b715a5f7849dfac8b0d023b96e63" 12:51:12 INFO - } 12:51:12 INFO - } 12:51:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2. 12:51:12 INFO - Running post-action listener: _resource_record_post_action 12:51:12 INFO - ##### 12:51:12 INFO - ##### Running download-and-extract step. 12:51:12 INFO - ##### 12:51:12 INFO - Running pre-action listener: _resource_record_pre_action 12:51:12 INFO - Running main action method: download_and_extract 12:51:12 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:51:12 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')]} 12:51:12 INFO - https://queue.taskcluster.net/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:51:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/test_packages.json 12:51:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/test_packages.json 12:51:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:51:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:51:13 INFO - Downloaded 1302 bytes. 12:51:13 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:51:13 INFO - Using the following test package requirements: 12:51:13 INFO - {u'common': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'], 12:51:13 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:13 INFO - u'firefox-44.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:51:13 INFO - u'jittest': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:13 INFO - u'jsshell-linux-x86_64.zip'], 12:51:13 INFO - u'mochitest': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:13 INFO - u'firefox-44.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:51:13 INFO - u'mozbase': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'], 12:51:13 INFO - u'reftest': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:13 INFO - u'firefox-44.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:51:13 INFO - u'talos': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:13 INFO - u'firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:51:13 INFO - u'web-platform': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:13 INFO - u'firefox-44.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:51:13 INFO - u'webapprt': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'], 12:51:13 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:13 INFO - u'firefox-44.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:51:13 INFO - Downloading packages: [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:51:13 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')]} 12:51:13 INFO - https://queue.taskcluster.net/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:51:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 12:51:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 12:51:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 12:51:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:51:16 INFO - Downloaded 23926869 bytes. 12:51:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:51:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 12:51:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:51:17 INFO - Return code: 0 12:51:17 INFO - Downloading packages: [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:51:17 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')]} 12:51:17 INFO - https://queue.taskcluster.net/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 12:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 12:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 12:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:51:20 INFO - Downloaded 23926869 bytes. 12:51:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:51:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 12:51:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:51:22 INFO - Return code: 0 12:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:22 INFO - https://queue.taskcluster.net/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:51:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip 12:51:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip 12:51:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip 12:51:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:51:24 INFO - Downloaded 11131307 bytes. 12:51:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 12:51:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip 12:51:24 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 12:51:24 INFO - Return code: 0 12:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:24 INFO - https://queue.taskcluster.net/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:51:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 12:51:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 12:51:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 12:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:51:33 INFO - Downloaded 57170074 bytes. 12:51:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 12:51:33 INFO - mkdir: /builds/slave/test-pgo/properties 12:51:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:51:33 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:51:33 INFO - Contents: 12:51:33 INFO - build_url:https://queue.taskcluster.net/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 12:51:33 INFO - Running post-action listener: _resource_record_post_action 12:51:33 INFO - Running post-action listener: set_extra_try_arguments 12:51:33 INFO - ##### 12:51:33 INFO - ##### Running populate-webroot step. 12:51:33 INFO - ##### 12:51:33 INFO - Running pre-action listener: _resource_record_pre_action 12:51:33 INFO - Running main action method: populate_webroot 12:51:33 INFO - Guessing talos json url... 12:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:33 INFO - https://queue.taskcluster.net/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt matches https://queue.taskcluster.net 12:51:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt 12:51:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt 12:51:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt to /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.txt 12:51:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.txt'}, attempt #1 12:51:34 INFO - Downloaded 107 bytes. 12:51:34 INFO - Reading from file /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.txt 12:51:34 INFO - Contents: 12:51:34 INFO - 20151027113035 12:51:34 INFO - https://hg.mozilla.org/integration/b2g-inbound/rev/2c4b2deaf1e8b715a5f7849dfac8b0d023b96e63 12:51:34 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')]} 12:51:34 INFO - trying https://hg.mozilla.org/integration/b2g-inbound/raw-file/2c4b2deaf1/testing/talos/talos.json 12:51:34 INFO - Downloading https://hg.mozilla.org/integration/b2g-inbound/raw-file/2c4b2deaf1/testing/talos/talos.json to /builds/slave/test-pgo/build/talos.json 12:51:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/b2g-inbound/raw-file/2c4b2deaf1/testing/talos/talos.json', 'file_name': '/builds/slave/test-pgo/build/talos.json'}, attempt #1 12:51:36 INFO - Downloaded 4264 bytes. 12:51:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:51:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:51:36 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:51:36 INFO - '../fennec_ids.txt'], 12:51:36 INFO - 'tests': ['tcheck2']}, 12:51:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:51:36 INFO - '--tppagecycles', 12:51:36 INFO - '7'], 12:51:36 INFO - 'tests': ['tsvgm']}}, 12:51:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:51:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:51:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:51:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:51:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:51:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:51:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:51:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:36 INFO - 'talos_options': ['--e10s'], 12:51:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:51:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:36 INFO - 'tests': ['damp', 'tps']}, 12:51:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:36 INFO - 'talos_options': ['--e10s'], 12:51:36 INFO - 'tests': ['damp', 'tps']}, 12:51:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:51:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:51:36 INFO - 'other': {'tests': ['a11yr', 12:51:36 INFO - 'ts_paint', 12:51:36 INFO - 'tpaint', 12:51:36 INFO - 'sessionrestore', 12:51:36 INFO - 'sessionrestore_no_auto_restore']}, 12:51:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:51:36 INFO - 'tests': ['a11yr', 12:51:36 INFO - 'ts_paint', 12:51:36 INFO - 'tpaint', 12:51:36 INFO - 'sessionrestore', 12:51:36 INFO - 'sessionrestore_no_auto_restore']}, 12:51:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:51:36 INFO - 'tests': ['a11yr', 12:51:36 INFO - 'ts_paint', 12:51:36 INFO - 'tpaint', 12:51:36 INFO - 'sessionrestore', 12:51:36 INFO - 'sessionrestore_no_auto_restore']}, 12:51:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:51:36 INFO - 'tests': ['a11yr', 12:51:36 INFO - 'ts_paint', 12:51:36 INFO - 'tpaint', 12:51:36 INFO - 'sessionrestore', 12:51:36 INFO - 'sessionrestore_no_auto_restore']}, 12:51:36 INFO - 'other_l64': {'tests': ['a11yr', 12:51:36 INFO - 'ts_paint', 12:51:36 INFO - 'tpaint', 12:51:36 INFO - 'sessionrestore', 12:51:36 INFO - 'sessionrestore_no_auto_restore']}, 12:51:36 INFO - 'other_nol64': {'tests': ['a11yr', 12:51:36 INFO - 'ts_paint', 12:51:36 INFO - 'tpaint', 12:51:36 INFO - 'sessionrestore', 12:51:36 INFO - 'sessionrestore_no_auto_restore']}, 12:51:36 INFO - 'svgr': {'tests': ['tsvgx', 12:51:36 INFO - 'tsvgr_opacity', 12:51:36 INFO - 'tart', 12:51:36 INFO - 'tscrollx', 12:51:36 INFO - 'cart']}, 12:51:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:51:36 INFO - 'tests': ['tsvgx', 12:51:36 INFO - 'tsvgr_opacity', 12:51:36 INFO - 'tart', 12:51:36 INFO - 'tscrollx', 12:51:36 INFO - 'cart']}, 12:51:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:36 INFO - 'tests': ['tp5o']}, 12:51:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:36 INFO - 'talos_options': ['--e10s'], 12:51:36 INFO - 'tests': ['tp5o']}, 12:51:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:36 INFO - 'talos_options': ['--xperf_path', 12:51:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:51:36 INFO - 'tests': ['tp5n']}, 12:51:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:36 INFO - 'talos_options': ['--e10s', 12:51:36 INFO - '--xperf_path', 12:51:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 12:51:36 INFO - 'C:/slave/talos-data/talos/xperf.config'], 12:51:36 INFO - 'tests': ['tp5n']}}, 12:51:36 INFO - 'talos.zip': {'path': '', 12:51:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:51:36 INFO - Running post-action listener: _resource_record_post_action 12:51:36 INFO - ##### 12:51:36 INFO - ##### Running create-virtualenv step. 12:51:36 INFO - ##### 12:51:36 INFO - Running pre-action listener: _resource_record_pre_action 12:51:36 INFO - Running main action method: create_virtualenv 12:51:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:51:36 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 12:51:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:51:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:51:36 INFO - Using real prefix '/usr' 12:51:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:51:36 INFO - Installing distribute.............................................................................................................................................................................................done. 12:51:38 INFO - Installing pip.................done. 12:51:38 INFO - Return code: 0 12:51:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:38 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 0x7f530e675c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111c7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f6c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122d230>, '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 0x127f6c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127fb70>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613', '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 12:51:38 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 12:51:38 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 12:51:38 INFO - Using env: {'DISPLAY': ':0', 12:51:38 INFO - 'HOME': '/home/cltbld', 12:51:38 INFO - 'LANG': 'en_US.UTF-8', 12:51:38 INFO - 'LANGUAGE': 'en_US:en', 12:51:38 INFO - 'LOGNAME': 'cltbld', 12:51:38 INFO - 'MAIL': '/var/mail/cltbld', 12:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:38 INFO - 'MOZ_NO_REMOTE': '1', 12:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:38 INFO - 'NO_EM_RESTART': '1', 12:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:51:38 INFO - 'PWD': '/builds/slave/test-pgo', 12:51:38 INFO - 'SHELL': '/bin/bash', 12:51:38 INFO - 'SHLVL': '1', 12:51:38 INFO - 'TERM': 'linux', 12:51:38 INFO - 'TMOUT': '86400', 12:51:38 INFO - 'USER': 'cltbld', 12:51:38 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613', 12:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:38 INFO - '_': '/tools/buildbot/bin/python'} 12:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:39 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 12:51:39 INFO - Cleaning up... 12:51:39 INFO - Return code: 0 12:51:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:51: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')]} 12:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f530e675c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111c7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f6c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122d230>, '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 0x127f6c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127fb70>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613', '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 12:51:39 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 12:51:39 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 12:51:39 INFO - Using env: {'DISPLAY': ':0', 12:51:39 INFO - 'HOME': '/home/cltbld', 12:51:39 INFO - 'LANG': 'en_US.UTF-8', 12:51:39 INFO - 'LANGUAGE': 'en_US:en', 12:51:39 INFO - 'LOGNAME': 'cltbld', 12:51:39 INFO - 'MAIL': '/var/mail/cltbld', 12:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:39 INFO - 'MOZ_NO_REMOTE': '1', 12:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:39 INFO - 'NO_EM_RESTART': '1', 12:51:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:51:39 INFO - 'PWD': '/builds/slave/test-pgo', 12:51:39 INFO - 'SHELL': '/bin/bash', 12:51:39 INFO - 'SHLVL': '1', 12:51:39 INFO - 'TERM': 'linux', 12:51:39 INFO - 'TMOUT': '86400', 12:51:39 INFO - 'USER': 'cltbld', 12:51:39 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613', 12:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:39 INFO - '_': '/tools/buildbot/bin/python'} 12:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:39 INFO - Downloading/unpacking psutil>=0.7.1 12:51:39 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 12:51:39 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 12:51:39 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 12:51:39 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 12:51:39 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 12:51:39 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 12:51:40 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:51:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:51:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:51:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:51:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:51:41 INFO - Installing collected packages: psutil 12:51:41 INFO - Running setup.py install for psutil 12:51:41 INFO - building 'psutil._psutil_linux' extension 12:51:41 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 12:51:42 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 12:51:42 INFO - building 'psutil._psutil_posix' extension 12:51:42 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 12:51:42 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 12:51:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:51:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:51:42 INFO - Successfully installed psutil 12:51:42 INFO - Cleaning up... 12:51:42 INFO - Return code: 0 12:51:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:51: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')]} 12:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:42 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 0x7f530e675c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111c7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f6c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122d230>, '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 0x127f6c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127fb70>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613', '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 12:51:42 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 12:51:42 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 12:51:42 INFO - Using env: {'DISPLAY': ':0', 12:51:42 INFO - 'HOME': '/home/cltbld', 12:51:42 INFO - 'LANG': 'en_US.UTF-8', 12:51:42 INFO - 'LANGUAGE': 'en_US:en', 12:51:42 INFO - 'LOGNAME': 'cltbld', 12:51:42 INFO - 'MAIL': '/var/mail/cltbld', 12:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:42 INFO - 'MOZ_NO_REMOTE': '1', 12:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:42 INFO - 'NO_EM_RESTART': '1', 12:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:51:42 INFO - 'PWD': '/builds/slave/test-pgo', 12:51:42 INFO - 'SHELL': '/bin/bash', 12:51:42 INFO - 'SHLVL': '1', 12:51:42 INFO - 'TERM': 'linux', 12:51:42 INFO - 'TMOUT': '86400', 12:51:42 INFO - 'USER': 'cltbld', 12:51:42 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613', 12:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:42 INFO - '_': '/tools/buildbot/bin/python'} 12:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:51:42 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 12:51:42 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 12:51:42 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 12:51:42 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 12:51:42 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 12:51:42 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 12:51:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:51:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:51:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:51:44 INFO - Installing collected packages: mozsystemmonitor 12:51:44 INFO - Running setup.py install for mozsystemmonitor 12:51:44 INFO - Successfully installed mozsystemmonitor 12:51:44 INFO - Cleaning up... 12:51:44 INFO - Return code: 0 12:51:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:44 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 0x7f530e675c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111c7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f6c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122d230>, '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 0x127f6c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127fb70>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613', '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 12:51:44 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 12:51:44 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 12:51:44 INFO - Using env: {'DISPLAY': ':0', 12:51:44 INFO - 'HOME': '/home/cltbld', 12:51:44 INFO - 'LANG': 'en_US.UTF-8', 12:51:44 INFO - 'LANGUAGE': 'en_US:en', 12:51:44 INFO - 'LOGNAME': 'cltbld', 12:51:44 INFO - 'MAIL': '/var/mail/cltbld', 12:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:44 INFO - 'MOZ_NO_REMOTE': '1', 12:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:44 INFO - 'NO_EM_RESTART': '1', 12:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:51:44 INFO - 'PWD': '/builds/slave/test-pgo', 12:51:44 INFO - 'SHELL': '/bin/bash', 12:51:44 INFO - 'SHLVL': '1', 12:51:44 INFO - 'TERM': 'linux', 12:51:44 INFO - 'TMOUT': '86400', 12:51:44 INFO - 'USER': 'cltbld', 12:51:44 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613', 12:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:44 INFO - '_': '/tools/buildbot/bin/python'} 12:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:44 INFO - Downloading/unpacking blobuploader==1.2.4 12:51:44 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 12:51:44 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 12:51:44 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 12:51:44 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 12:51:44 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 12:51:44 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 12:51:46 INFO - Downloading blobuploader-1.2.4.tar.gz 12:51:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:51:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:51:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:51:46 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 12:51:46 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 12:51:46 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 12:51:46 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 12:51:46 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 12:51:46 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 12:51:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:51:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:51:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:51:47 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 12:51:47 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 12:51:47 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 12:51:47 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 12:51:47 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 12:51:47 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 12:51:47 INFO - Downloading docopt-0.6.1.tar.gz 12:51:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:51:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:51:47 INFO - Installing collected packages: blobuploader, requests, docopt 12:51:47 INFO - Running setup.py install for blobuploader 12:51:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:51:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:51:47 INFO - Running setup.py install for requests 12:51:47 INFO - Running setup.py install for docopt 12:51:47 INFO - Successfully installed blobuploader requests docopt 12:51:47 INFO - Cleaning up... 12:51:47 INFO - Return code: 0 12:51:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:51: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')]} 12:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:47 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 0x7f530e675c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111c7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f6c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122d230>, '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 0x127f6c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127fb70>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613', '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 12:51:47 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 12:51:47 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 12:51:47 INFO - Using env: {'DISPLAY': ':0', 12:51:47 INFO - 'HOME': '/home/cltbld', 12:51:47 INFO - 'LANG': 'en_US.UTF-8', 12:51:47 INFO - 'LANGUAGE': 'en_US:en', 12:51:47 INFO - 'LOGNAME': 'cltbld', 12:51:47 INFO - 'MAIL': '/var/mail/cltbld', 12:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:47 INFO - 'MOZ_NO_REMOTE': '1', 12:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:47 INFO - 'NO_EM_RESTART': '1', 12:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:51:47 INFO - 'PWD': '/builds/slave/test-pgo', 12:51:47 INFO - 'SHELL': '/bin/bash', 12:51:47 INFO - 'SHLVL': '1', 12:51:47 INFO - 'TERM': 'linux', 12:51:47 INFO - 'TMOUT': '86400', 12:51:47 INFO - 'USER': 'cltbld', 12:51:47 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613', 12:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:47 INFO - '_': '/tools/buildbot/bin/python'} 12:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:51:48 INFO - Running setup.py (path:/tmp/pip-DF8fgM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:51:48 INFO - Running setup.py (path:/tmp/pip-vKsDit-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:51:48 INFO - Running setup.py (path:/tmp/pip-cFBwYW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:51:48 INFO - Running setup.py (path:/tmp/pip-kmARMZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:51:48 INFO - Running setup.py (path:/tmp/pip-9aC6sB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:51:48 INFO - Running setup.py (path:/tmp/pip-fC3P08-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:51:48 INFO - Running setup.py (path:/tmp/pip-gxkTnw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:51:48 INFO - Running setup.py (path:/tmp/pip-QYXE10-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:51:48 INFO - Running setup.py (path:/tmp/pip-yTjjA6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:51:48 INFO - Running setup.py (path:/tmp/pip-p0aIUX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:51:48 INFO - Running setup.py (path:/tmp/pip-UrlDWO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:51:48 INFO - Running setup.py (path:/tmp/pip-T7MdYq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:51:49 INFO - Running setup.py (path:/tmp/pip-U2NILe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:51:49 INFO - Running setup.py (path:/tmp/pip-znp3Ug-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:51:49 INFO - Running setup.py (path:/tmp/pip-i1dGSn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:51:49 INFO - Running setup.py (path:/tmp/pip-C67QXi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:51:49 INFO - Running setup.py (path:/tmp/pip-TN6eJR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:51:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:51:49 INFO - Running setup.py install for manifestparser 12:51:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:51:49 INFO - Running setup.py install for mozcrash 12:51:49 INFO - Running setup.py install for mozdebug 12:51:49 INFO - Running setup.py install for mozdevice 12:51:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:51:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:51:49 INFO - Running setup.py install for mozfile 12:51:49 INFO - Running setup.py install for mozhttpd 12:51:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:51:50 INFO - Running setup.py install for mozinfo 12:51:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:51:50 INFO - Running setup.py install for mozInstall 12:51:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:51:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:51:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:51:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:51:50 INFO - Running setup.py install for mozleak 12:51:50 INFO - Running setup.py install for mozlog 12:51:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:51:50 INFO - Running setup.py install for moznetwork 12:51:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:51:50 INFO - Running setup.py install for mozprocess 12:51:50 INFO - Running setup.py install for mozprofile 12:51:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:51:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:51:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:51:50 INFO - Running setup.py install for mozrunner 12:51:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:51:50 INFO - Running setup.py install for mozscreenshot 12:51:50 INFO - Running setup.py install for moztest 12:51:51 INFO - Running setup.py install for mozversion 12:51:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:51:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:51:51 INFO - Cleaning up... 12:51:51 INFO - Return code: 0 12:51:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f530e675c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111c7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f6c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122d230>, '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 0x127f6c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127fb70>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613', '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 12:51:51 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 12:51:51 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 12:51:51 INFO - Using env: {'DISPLAY': ':0', 12:51:51 INFO - 'HOME': '/home/cltbld', 12:51:51 INFO - 'LANG': 'en_US.UTF-8', 12:51:51 INFO - 'LANGUAGE': 'en_US:en', 12:51:51 INFO - 'LOGNAME': 'cltbld', 12:51:51 INFO - 'MAIL': '/var/mail/cltbld', 12:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:51 INFO - 'MOZ_NO_REMOTE': '1', 12:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:51 INFO - 'NO_EM_RESTART': '1', 12:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:51:51 INFO - 'PWD': '/builds/slave/test-pgo', 12:51:51 INFO - 'SHELL': '/bin/bash', 12:51:51 INFO - 'SHLVL': '1', 12:51:51 INFO - 'TERM': 'linux', 12:51:51 INFO - 'TMOUT': '86400', 12:51:51 INFO - 'USER': 'cltbld', 12:51:51 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613', 12:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:51 INFO - '_': '/tools/buildbot/bin/python'} 12:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:51:51 INFO - Running setup.py (path:/tmp/pip-0PLHl0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:51:51 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)) 12:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:51:51 INFO - Running setup.py (path:/tmp/pip-uMy30r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:51:51 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)) 12:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:51:51 INFO - Running setup.py (path:/tmp/pip-CaT52U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:51:51 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)) 12:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:51:51 INFO - Running setup.py (path:/tmp/pip-POZfBu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 12:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:51:51 INFO - Running setup.py (path:/tmp/pip-qLFVN2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:51:51 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)) 12:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:51:51 INFO - Running setup.py (path:/tmp/pip-potbeb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:51:51 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)) 12:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:51:51 INFO - Running setup.py (path:/tmp/pip-yrzGKL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 12:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:51:51 INFO - Running setup.py (path:/tmp/pip-W1qNZp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:51:51 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)) 12:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:51:51 INFO - Running setup.py (path:/tmp/pip-mw0RuB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:51:52 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)) 12:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:51:52 INFO - Running setup.py (path:/tmp/pip-WujZXq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:51:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:51:52 INFO - Running setup.py (path:/tmp/pip-6sB4IP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:51:52 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)) 12:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:51:52 INFO - Running setup.py (path:/tmp/pip-89hxSj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:51:52 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)) 12:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:51:52 INFO - Running setup.py (path:/tmp/pip-0KhrM0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:51:52 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)) 12:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:51:52 INFO - Running setup.py (path:/tmp/pip-vWaB0i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:51:52 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)) 12:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:51:52 INFO - Running setup.py (path:/tmp/pip-ruvyne-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:51:52 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)) 12:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:51:52 INFO - Running setup.py (path:/tmp/pip-n0pzM6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:51:52 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)) 12:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:51:52 INFO - Running setup.py (path:/tmp/pip-bAsXqe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:51:52 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)) 12:51:52 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)) 12:51:52 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)) 12:51:52 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)) 12:51:52 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:51:52 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:51:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:54 INFO - Downloading blessings-1.5.1.tar.gz 12:51:54 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 12:51:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:51:54 INFO - Installing collected packages: blessings 12:51:54 INFO - Running setup.py install for blessings 12:51:54 INFO - Successfully installed blessings 12:51:54 INFO - Cleaning up... 12:51:54 INFO - Return code: 0 12:51:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:51:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:51:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:51:54 INFO - Reading from file tmpfile_stdout 12:51:54 INFO - Current package versions: 12:51:54 INFO - argparse == 1.2.1 12:51:54 INFO - blessings == 1.5.1 12:51:54 INFO - blobuploader == 1.2.4 12:51:54 INFO - docopt == 0.6.1 12:51:54 INFO - manifestparser == 1.1 12:51:54 INFO - mozInstall == 1.12 12:51:54 INFO - mozcrash == 0.16 12:51:54 INFO - mozdebug == 0.1 12:51:54 INFO - mozdevice == 0.46 12:51:54 INFO - mozfile == 1.2 12:51:54 INFO - mozhttpd == 0.7 12:51:54 INFO - mozinfo == 0.8 12:51:54 INFO - mozleak == 0.1 12:51:54 INFO - mozlog == 3.0 12:51:54 INFO - moznetwork == 0.27 12:51:54 INFO - mozprocess == 0.22 12:51:54 INFO - mozprofile == 0.27 12:51:54 INFO - mozrunner == 6.11 12:51:54 INFO - mozscreenshot == 0.1 12:51:54 INFO - mozsystemmonitor == 0.0 12:51:54 INFO - moztest == 0.7 12:51:54 INFO - mozversion == 1.4 12:51:54 INFO - psutil == 3.1.1 12:51:54 INFO - requests == 1.2.3 12:51:54 INFO - wsgiref == 0.1.2 12:51:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:51: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')]} 12:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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', '-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 0x7f530e675c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111c7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f6c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122d230>, '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 0x127f6c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127fb70>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613', '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 12:51:54 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 12:51:54 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 12:51:54 INFO - Using env: {'DISPLAY': ':0', 12:51:54 INFO - 'HOME': '/home/cltbld', 12:51:54 INFO - 'LANG': 'en_US.UTF-8', 12:51:54 INFO - 'LANGUAGE': 'en_US:en', 12:51:54 INFO - 'LOGNAME': 'cltbld', 12:51:54 INFO - 'MAIL': '/var/mail/cltbld', 12:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:54 INFO - 'MOZ_NO_REMOTE': '1', 12:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:54 INFO - 'NO_EM_RESTART': '1', 12:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:51:54 INFO - 'PWD': '/builds/slave/test-pgo', 12:51:54 INFO - 'SHELL': '/bin/bash', 12:51:54 INFO - 'SHLVL': '1', 12:51:54 INFO - 'TERM': 'linux', 12:51:54 INFO - 'TMOUT': '86400', 12:51:54 INFO - 'USER': 'cltbld', 12:51:54 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613', 12:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:54 INFO - '_': '/tools/buildbot/bin/python'} 12:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:54 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)) 12:51:54 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)) 12:51:54 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)) 12:51:54 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)) 12:51:54 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)) 12:51:54 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)) 12:51:54 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)) 12:51:54 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)) 12:51:54 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)) 12:51:54 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)) 12:51:54 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)) 12:51:54 INFO - Cleaning up... 12:51:55 INFO - Return code: 0 12:51:55 INFO - Running post-action listener: _resource_record_post_action 12:51:55 INFO - Running post-action listener: _start_resource_monitoring 12:51:55 INFO - Starting resource monitoring. 12:51:55 INFO - ##### 12:51:55 INFO - ##### Running install step. 12:51:55 INFO - ##### 12:51:55 INFO - Running pre-action listener: _resource_record_pre_action 12:51:55 INFO - Running main action method: install 12:51:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:51:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:51:55 INFO - Reading from file tmpfile_stdout 12:51:55 INFO - Detecting whether we're running mozinstall >=1.0... 12:51:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:51:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:51:55 INFO - Reading from file tmpfile_stdout 12:51:55 INFO - Output received: 12:51:55 INFO - Usage: mozinstall [options] installer 12:51:55 INFO - Options: 12:51:55 INFO - -h, --help show this help message and exit 12:51:55 INFO - -d DEST, --destination=DEST 12:51:55 INFO - Directory to install application into. [default: 12:51:55 INFO - "/builds/slave/test-pgo"] 12:51:55 INFO - --app=APP Application being installed. [default: firefox] 12:51:55 INFO - mkdir: /builds/slave/test-pgo/build/application 12:51:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 12:51:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 12:52:09 INFO - Reading from file tmpfile_stdout 12:52:09 INFO - Output received: 12:52:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:52:09 INFO - Running post-action listener: _resource_record_post_action 12:52:09 INFO - ##### 12:52:09 INFO - ##### Running run-tests step. 12:52:09 INFO - ##### 12:52:09 INFO - Running pre-action listener: _resource_record_pre_action 12:52:09 INFO - Running main action method: run_tests 12:52:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:52:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:52:09 INFO - Python 2.7.3 12:52:09 INFO - Return code: 0 12:52:09 INFO - grabbing minidump binary from tooltool 12:52: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')]} 12:52:09 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 0x122d230>, '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 0x127f6c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127fb70>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:52:09 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 12:52:09 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 12:52:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:52:09 INFO - Return code: 0 12:52:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:52:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:52:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:52:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:52:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:52:09 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/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 12:52:09 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/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost 12:52:09 INFO - Using env: {'DISPLAY': ':0', 12:52:09 INFO - 'HOME': '/home/cltbld', 12:52:09 INFO - 'LANG': 'en_US.UTF-8', 12:52:09 INFO - 'LANGUAGE': 'en_US:en', 12:52:09 INFO - 'LOGNAME': 'cltbld', 12:52:09 INFO - 'MAIL': '/var/mail/cltbld', 12:52:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:52:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:09 INFO - 'MOZ_NO_REMOTE': '1', 12:52:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:09 INFO - 'NO_EM_RESTART': '1', 12:52:09 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:09 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:09 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:52:09 INFO - 'SHELL': '/bin/bash', 12:52:09 INFO - 'SHLVL': '1', 12:52:09 INFO - 'TERM': 'linux', 12:52:09 INFO - 'TMOUT': '86400', 12:52:09 INFO - 'USER': 'cltbld', 12:52:09 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613', 12:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:09 INFO - '_': '/tools/buildbot/bin/python'} 12:52:09 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/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost'] with output_timeout 3600 12:52:10 INFO - mozversion INFO | application_buildid: 20151027113035 12:52:10 INFO - mozversion INFO | application_changeset: 2c4b2deaf1e8b715a5f7849dfac8b0d023b96e63 12:52:10 INFO - mozversion INFO | application_display_name: Nightly 12:52:10 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:52:10 INFO - mozversion INFO | application_name: Firefox 12:52:10 INFO - mozversion INFO | application_remotingname: firefox 12:52:10 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 12:52:10 INFO - mozversion INFO | application_vendor: Mozilla 12:52:10 INFO - mozversion INFO | application_version: 44.0a1 12:52:10 INFO - mozversion INFO | platform_buildid: 20151027113035 12:52:10 INFO - mozversion INFO | platform_changeset: 2c4b2deaf1e8b715a5f7849dfac8b0d023b96e63 12:52:10 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 12:52:10 INFO - mozversion INFO | platform_version: 44.0a1 12:52:10 INFO - 2015-10-27 12:52:10,052 DEBUG : using testdate: 1445975530 12:52:10 INFO - 2015-10-27 12:52:10,052 DEBUG : actual date: 1445975530 12:52:10 INFO - 2015-10-27 12:52:10,060 INFO : starting webserver on 'localhost:56755' 12:52:10 INFO - 2015-10-27 12:52:10,061 INFO : Starting test suite talos-linux64-ix-054 12:52:10 INFO - 2015-10-27 12:52:10,061 INFO : Starting test dromaeo_css 12:52:10 INFO - 2015-10-27 12:52:10,061 DEBUG : operating with platform_type : linux_ 12:52:10 INFO - 2015-10-27 12:52:10,061 INFO : Initialising browser for dromaeo_css test... 12:52:10 INFO - 2015-10-27 12:52:10,093 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYthOsu/profile http://localhost:56755/getInfo.html 12:52:15 INFO - 2015-10-27 12:52:15,102 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:52:15 INFO - 2015-10-27 12:52:15,103 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:52:15 INFO - 2015-10-27 12:52:15,103 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:52:15 INFO - 2015-10-27 12:52:15,103 DEBUG : BROWSER_OUTPUT: __metrics 12:52:15 INFO - 2015-10-27 12:52:15,165 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:52:15 INFO - 2015-10-27 12:52:15,839 DEBUG : BROWSER_OUTPUT: console.error: 12:52:15 INFO - 2015-10-27 12:52:15,839 DEBUG : BROWSER_OUTPUT: Message: [Exception... "Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [mozIStorageAsyncStatement.executeAsync]" nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)" location: "JS frame :: resource://gre/modules/Sqlite.jsm :: ConnectionData.prototype<._executeStatement :: line 758" data: no] 12:52:15 INFO - 2015-10-27 12:52:15,839 DEBUG : BROWSER_OUTPUT: Stack: 12:52:15 INFO - 2015-10-27 12:52:15,839 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 12:52:15 INFO - 2015-10-27 12:52:15,839 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 12:52:15 INFO - 2015-10-27 12:52:15,839 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 12:52:15 INFO - 2015-10-27 12:52:15,840 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 12:52:15 INFO - 2015-10-27 12:52:15,840 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 12:52:15 INFO - 2015-10-27 12:52:15,840 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 12:52:15 INFO - 2015-10-27 12:52:15,840 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 12:52:15 INFO - 2015-10-27 12:52:15,840 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:791:13 12:52:15 INFO - 2015-10-27 12:52:15,840 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 12:52:15 INFO - 2015-10-27 12:52:15,840 DEBUG : BROWSER_OUTPUT: Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 12:52:15 INFO - 2015-10-27 12:52:15,840 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 12:52:15 INFO - 2015-10-27 12:52:15,841 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 12:52:15 INFO - 2015-10-27 12:52:15,841 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 12:52:15 INFO - 2015-10-27 12:52:15,841 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 12:52:15 INFO - 2015-10-27 12:52:15,841 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 12:52:15 INFO - 2015-10-27 12:52:15,841 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 12:52:15 INFO - 2015-10-27 12:52:15,841 DEBUG : BROWSER_OUTPUT: 12:52:16 INFO - 2015-10-27 12:52:16,362 INFO : Browser initialized. 12:52:16 INFO - 2015-10-27 12:52:16,363 INFO : Running cycle 1/1 for dromaeo_css test... 12:52:16 INFO - 2015-10-27 12:52:16,363 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYthOsu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:52:28 INFO - 2015-10-27 12:52:28,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 142172160 12:52:28 INFO - 2015-10-27 12:52:28,091 DEBUG : BROWSER_OUTPUT: 12:53:18 INFO - 2015-10-27 12:53:18,924 DEBUG : BROWSER_OUTPUT: 1445975598919 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] 12:55:28 INFO - 2015-10-27 12:55:28,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56755/tests/dromaeo/cssquery-ext.html) 12:55:29 INFO - 2015-10-27 12:55:29,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 232177664 12:55:29 INFO - 2015-10-27 12:55:29,462 DEBUG : BROWSER_OUTPUT: 12:58:31 INFO - 2015-10-27 12:58:31,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/dromaeo/cssquery-ext.html (next: http://localhost:56755/tests/dromaeo/cssquery-jquery.html) 12:58:32 INFO - 2015-10-27 12:58:32,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 234512384 12:58:32 INFO - 2015-10-27 12:58:32,272 DEBUG : BROWSER_OUTPUT: 13:01:34 INFO - 2015-10-27 13:01:34,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56755/tests/dromaeo/cssquery-mootools.html) 13:01:34 INFO - 2015-10-27 13:01:34,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 219561984 13:01:34 INFO - 2015-10-27 13:01:34,848 DEBUG : BROWSER_OUTPUT: 13:04:36 INFO - 2015-10-27 13:04:36,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56755/tests/dromaeo/cssquery-prototype.html) 13:04:37 INFO - 2015-10-27 13:04:37,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 217477120 13:04:37 INFO - 2015-10-27 13:04:37,274 DEBUG : BROWSER_OUTPUT: 13:07:39 INFO - 2015-10-27 13:07:39,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56755/tests/dromaeo/cssquery-yui.html) 13:07:40 INFO - 2015-10-27 13:07:40,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 210890752 13:07:40 INFO - 2015-10-27 13:07:40,328 DEBUG : BROWSER_OUTPUT: 13:10:42 INFO - 2015-10-27 13:10:42,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/dromaeo/cssquery-yui.html (next: http://localhost:56755/tests/dromaeo/cssquery-dojo.html) 13:10:43 INFO - 2015-10-27 13:10:43,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 282333184 13:10:43 INFO - 2015-10-27 13:10:43,022 DEBUG : BROWSER_OUTPUT: 13:10:43 INFO - 2015-10-27 13:10:43,023 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:10:43 INFO - 2015-10-27 13:10:43,023 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:10:43 INFO - 2015-10-27 13:10:43,023 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:10:43 INFO - 2015-10-27 13:10:43,023 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:10:43 INFO - 2015-10-27 13:10:43,025 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3207.5990501187352;3300.5874265716784;3325.617553981293;3329.633740288568;3338.6327503974558;5457.399686034543;5556.91664625031;5562.972185139074;5641.097424412095;5645.802396916109;5534.889302213954;5555.3611334696525;5614.326280846294;5620.1288800235925;5668.603197776158;5014.072396606622;5050.292958985745;5107.157319042363;5123.129068058439;5150.227465880129;4884.365032545764;5120.027194832988;5120.411152717429;5121.769520371592;5135.127028405162;4965.453800081988;5036.874078148057;5044.520770526794;5052.216906379517;5077.136886729265;5126.512981266774;5128.076946149691;5131.666441681279;5132.255822905658;5174.09453345663;4957.429895562021;5089.033083714119;5114.565261952738;5138.254953031789;5139.665921715076;5315.495027972336;5318.813841515528;5326.201069839516;5401.4868587484125;5415.458454154593;5987.461128498412;6013.308469525973;6015.669138197398;6018.127371531147;6018.8495287617725;5749.425057494217;5883.352831188566;5895.233619629464;6028.4272994065495;6049.727762250709;5478.096114141162;5536.446355364472;5540.085885828793;5540.833774986757;5593.356763972155;6000.159977603139;6006.879862402815;6018.097285407224;6018.488428483541;6022.096685497123;5555.666660000413;5656.60403771732;5818.709064546756;5821.563382746311;5822.3304320003745;5938.970305148533;5942.286925568959;5947.881042379128;5955.404459554096;5979.521638268928;5899.292084949833;5904.940950590525;5917.142014407887;5921.792737254175;5922.7927022554;5740.827775166752;5827.941720582825;5869.706514674334;5873.295204575478;5903.970480147572;4530.954690453119;4539.886502837389;4549.158405694957;4562.634989200922;4584.404027476474;4084.407760874716;4088.9182216356103;4110.712250142461;4112.794360281974;4134.441850350225;5376;5470.042742520043;5507.118860982224;5630.211770352154;5638.436156384329;5914.615549989237;6024.728887200086;6028.125921741323;6031.517478601701;6040.6979651018155;5640.435956404409;5646.068398714248;5652.689102099424;5654.123610840326;5665.688387138664;5011.774470148779;5054.7472626368535;5097.057044446789;5106.080905437057;5164.561012313995;6114.296855861544;6193.84515387119;6195.1636529068;6195.31851496335;6203.47270482005;5967.7016149191495;5976.372480889444;5977.043673012297;5977.910331344946;5982.700864956648;5896.6756828374855;6008.339082700987;6015.759369625166;6063;6126.811919960783;5887.1757953887345;5910.113482977587;5920.496757775637;5920.526357891445;5928.525717942641;5988.401159883977;5990.730417131327;5998.9100163496705;6001.219841420588;6003.729832157476;5527.668339899619;5630.549556035589;5633.746481408264;5734.885302294014;5759.65442073477;5793.15999180125;5822.388649191774;5833.4749872511675;5836.533077353716;5847.181394604674;5435.701036443033;5738.254026976467;5748;5748.741306641127;5751.281089863767;5645.322561292671;5695.658260504383;5811.360750317377;5813.854653633693;5816.505597024131;5646.322441307069;5677.489025987681;5683.431656834449;5685.857853553694;5696.715164241854 13:10:43 INFO - 2015-10-27 13:10:43,028 DEBUG : BROWSER_OUTPUT: |1;ext.html;617.2192176896226;618.9969050154749;619.8760247950411;623.0747340199805;624.547203277624;32777.50833737493;39219;39516.2096758065;39545.802270988606;39837.402438963436;40686.593134068724;41254.79372603133;41276.38085428721;41281.38077928834;41288;7849.882251766228;7973.800654983614;8738.868916966234;8921.910780892205;8960;10473.73815654611;10782.838257426105;10792.244542882001;10795.352278863254;10807.351558906452;10483.790324193511;10572.947135264312;10614.469276536181;10627.84058239127;10652.041316281533;8039.5176289422825;8193.8361232775;10483.21375896807;10643.042126208678;10940.343579385262;10391.168706503462;10510.947445262802;10518.631847885288;10528.052475277185;10534.631287904964;40416.39375409342;40696.18607627831;40776.79611601953;40789.79605101985;40851;3216.790908590934;3221.4040402525607;3324.6010478742464;3464.6188919218866;4052.189562087565;30375.392492150033;30707.2323191922;30729;30785.846070769727;31025.379492410026;3068.125584208512;3079.825892500598;3129.9827556044374;3136.670649581784;3159.57345758322;250130;250434;251354;251596;252162;56539.71730141405;57626.135607965916;58440;58772.4122758767;64531;59484.7025764877;59577.40422595719;59662.10506842401;59735;59833;14313.212773297568;14374.712505749827;14459.421623135167;14465.78301325481;14467.348969296196;10955.671329860117;11026.889731102587;11029.83455248172;11030.613928512625;11032;19125.139368728163;19310.32413865508;19323.227070917004;19327.420177394702;19335.12991915367;8697.652093916298;8913.910860891438;8947.507887066144;8959.41763785352;8968.820623587491;914.346242436661;914.6204325205099;937.5827756648363;964.3876138652007;1001.1940387987594;27346.863265683543;27648;28069.43861122807;28071.71928280691;28111.57832632512;980.4901451245313;982.9557669904729;1009.4750729620703;1024.2215915903819;1029.4801125431609;13706.109102908278;13913.304334783423;13974.301284935713;14029.649258768408;14097.436102555783;772019;773805;780075;780099;781012;57697.4230257692;58465.12302315469;58472.41527584755;58477;58538.4146158533;1330.7272009238084;1333.1534475607864;1338.6385675867461;1340.383423625124;1344.7243315120377;29648.258793530335;30608;30642;30738.077857664306;30980.84509577528;47490.28764568465;47946.5205347942;48104.759476202395;48105.278420823015;48123.5187648119;306171;308248;308665;309326;398929;29759;33307.50038749469;33423;33797.155071123416;33896.830515847265;41383.172336553704;42218.36672449854;42558.36162457504;42565;43135;35083.64916350804;35531.64468355283;35760;36568.63431365759;41968.370474442294;30612.163390013317;37984.62015379922;41069.1786164281;41416.79291603523;41962.37056444095;37197;37608.247835042595;37868.2426351477;38051.80974095112;38052.42921356126;33853.66146338505;35104.12239694028;35312;35366;35705.46441803323;26169.345766355993;26205.737942621094;26335.473290534464;26395.472090558465;26431.471370572865 13:10:43 INFO - 2015-10-27 13:10:43,030 DEBUG : BROWSER_OUTPUT: |2;jquery.html;360.398135114359;361.54625944439726;365.6909911125099;367.3791292715311;368.4638850472562;14730.63173420665;15379.307931143097;17134.48596542104;17166.22751976161;17695.64608707825;16862.409815656454;17028.233729482174;17180.656386872255;17182.054986975712;17221.483355499324;5222.399424066233;5336.546393556552;5393.973030134864;5398.379186393556;5400.837974860741;3990.580988996157;4099.0777075158;5388.622796404254;5902.173695682608;6066.211392518989;5957.791477298296;5992.5505587080925;5995.13070604762;6011.939880601181;6015.278166620012;4854.732989685566;4915;4952.034353301107;4959.181735013754;4962.1812400953795;4155.044339801832;4203.201391735591;4273.081287523167;4275.123599662093;4277.144571085795;13760.449582016707;13786.103903246258;13948.372323245478;14007.229602371866;14120.36458359366;2009.5578972626;2036.9592608147755;2065.2461851424273;2075.8443116766302;2111.693804398369;10016.599336026551;10220.89779102207;10344.79310413795;10487.423191724452;10522;1717.4761697682202;1792.57874399516;1816.0375001249358;1829.9085045747793;1839.7516335294697;61417;61670;61954;62145;62526;7101.183363913113;7177.6770045348085;7265.745698900619;7300.4159667226495;7322.340989310987;8711.172438618321;8719.215270625675;8723.738287851374;8724.956375218084;8732.170443807956;5566.638168519034;5631.605787594911;5667.716614169275;5677.602567820296;5679.432056794288;5690.800821971211;5692.57305702074;5713.171590119409;5726.799562015392;5730.255066841284;3312.9171770705925;3350.0787283497234;3366.3267346530793;3371.4100032494216;3374.7806392584403;1188.506769690586;1214.1500949335325;1217.7077501399776;1220.0605533738972;1261.8044203148527;465.2997239155118;472.43072098121684;474.5136235358716;474.5207340586033;479.1806011719998;11385.316880987168;11822.34977076252;12077.214981026205;12092.334921579222;12114.757704845853;493.1099365645045;501.285667923208;504.3191691216828;515.569499467941;522.4227228912074;6465.4827613790785;6634.834129146713;6669.099671544376;6706.5640733352175;6754.425873800782;518977;524485;550690;551642;557911;78455.60772196103;81451;82035.17964820395;82638.17361826425;83344.16655833364;551.1952549278099;563.7209581257385;564.6922427277144;564.9180868774087;565.0563558856719;11406.372649504357;11462.4268786562;11686.766264674829;11687.76624467523;11772.117091218022;37267.62732372642;37521.24957500889;37583.43624845684;38049.2390152201;38300.42549361706;49359.259611105146;58141;58154.418455816594;58543;58546.12180817376;14049.157050576998;14167.291635418394;14782.852171478147;14817.481388151364;14837;18437.72343414823;18848;19006;19425.320113796515;19607.803921961167;9086.772830679285;12629;12683.619491415273;13797.862021379658;16079.35682572684;9498.477583732685;9799.657012004545;9940.304178707422;9943.552540135855;10267.12729417978;8113.553754543556;9404.952975235354;10064.245181611263;10308.536115874653;10458.895411045793;14941.402343906122;15213.847861521243;15260;15455.381784728936;15518.534443966699;15840.28718707638;16166.110863902599;16283.844094019356;16466.83533164653;16661.833381666514 13:10:43 INFO - 2015-10-27 13:10:43,031 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1496.4537943650557;1532.7854100425939;1643.1948345310798;1750.553608829749;1876.3526583328746;6838.58968461892;7300.6349682515865;7411.4070874330055;7417.332440080391;7427.851442971138;7136.714531418737;7217.386522145611;7225.674844631991;7231.096112985877;7234.421246300297;1979.2676709617463;2017.6368253714325;2244.9102035918545;2252.1892118837245;2274.692916456274;2285.42864283929;2302.5855346037706;2305.07796881248;2306.7693230676964;2308.9191878284264;2234;2295.162265772989;2295.678604995302;2297;2299.5630830142304;2004.8295894848955;2026.4427282497356;2216.2353987874158;2285.8857057147075;2290.484640955788;2248.449129963153;2259.7853203945597;2273.7612550682106;2280.8403411761183;2286.8856557172076;7570.659320330598;7620.847583048308;7627.466077374586;7628;7634.244123851489;4654.2785868190485;4720.480747117815;4725.645576581735;4726.125666751627;4733.479317275097;3021.5165573508352;3102.8448577571257;3116.8285744284053;3141.5287706844156;3145.795523290979;995.144176008632;1007.5566750629699;1024.9692509224735;1032.690192942122;1047.6804574604741;10313.432761198132;10403;10403.791924161475;10406.42764647944;10415.94792026035;4042.636162745367;4088.6524645405475;4137.958620413818;4157.875263742093;4169.958300416957;8256.8348633027;8307.958460207781;8353.498790072616;8375.036870759941;8378.748637540884;4657.813687452532;4658.301254811805;4662.53374662531;4664.323673067454;4678.6491013174145;4302.333138363559;4309.052008558112;4312.5903039211225;4312.870613881589;4319.870403887889;3360.1431634932937;3414.8463319150696;3433.1073920780777;3434.845431955568;3435.793852368866;1088.3361149698678;1121.4000509727257;1125.6341688951125;1127.9548818047185;1129.971750706239;1221.3587866370049;1334.6730051137533;1343.6909510812568;1343.8387393512646;1355.3562058022558;7035.366816986393;7042.894356584656;7058.858822823515;7076.4692648051605;7316.926830731731;1151.1423989127986;1153.5904753812445;1159.6984783956063;1162.6221478019677;1183;5928.170056192136;5939;5957.195778569924;5964.194833697396;5965.3139888912465;9002.729918102468;9411.529423528933;9412;9413.529323533796;9419.293552983554;9371.859422108673;9378.577963991636;9380.530973451436;9399.57701903416;9406.482643454676;7083.433325333961;7165.3551180394015;7193.820154496179;7205.927940720526;7223.061002069802;7016.929830701832;7036.261192574911;7038.472114591528;7044.753433629799;7056.082709247765;8118.431709780495;8214.178582141738;8405.49567025956;8407.53758543286;8422.199891010345;8488.533130677624;8490.23587877094;8512.616932237941;8529.232369086812;8536.061033286209;6705.932940670726;6869.244383117953;6879.89680154788;6888.484533402643;6899.310068993061;7485.4385921055045;7497.3252407281425;7509.812254693677;7565.8108547284555;7584.393248540214;6905.1713794345;6927.861442771015;7016.824579385556;7163.3552980232025;7163.7492687755675;6491;6701.966490167518;6932.549384290005;6983.895241571482;7046.084009078787;7150.928490715234;7161.892571611325;7174.1032370953635;7193.892091618525;7195.136583609791;6603.570767900071;6617.735290588323;6633.2040155181685;6637.1703537057865;6646.102776125162;6627.23786764509;6630.83422914431;6644.568103073285;6655.334466553306;6662.133922590032 13:10:43 INFO - 2015-10-27 13:10:43,031 DEBUG : BROWSER_OUTPUT: |4;prototype.html;331.7395844262254;336.3189541179113;342.09515830627987;344.8586079707317;350.58455729959985;5863.824085277443;5868.677222752757;5877.118432235166;5877.265341832271;5878.647281163133;5778.133280007991;5779.335376431712;5787.797427090053;5792.971035144818;5798.10129429939;4553.521880202581;4560.042391097865;4566.063956888846;4567.703099298552;4568.611668008207;4448.154850578396;4515.796789144496;4518;4528.094381123772;4534.523874993128;4503.234450143467;4505.279155335131;4507.256302710065;4508.954910450902;4513.864584062483;4329.7618630975285;4395.428594282723;4502.392177056088;4506.076254367847;4516;3912.8826135215704;3932.8820135395986;3950.585188555218;3971.7815520146382;3973.562908080109;5462.071447853875;5507.284053073075;5507.7246137692955;5517.310336207974;5525.281713377275;4902.068606964665;4982.800687972477;5037.143685573461;5081.110805609003;5127.9230811537855;5948.048312270016;5951.137085122633;5956.642601443884;5964.493018093467;5972.701364931736;4312.63342615878;4312.849050283225;4314.223439780838;4314.805833737458;4315.956840431619;6014.669193194372;6169.321374648785;6170.784022559189;6171.290301615327;6175.907361389583;4483.730976141442;4484;4485.0805584855025;4485.708428952108;4491.214037543416;4540.818367265339;4543.1822271990695;4545.250033744395;4548.249538826123;4553.408056952575;5155.329807125125;5156.432792392834;5158.587313014949;5158.8968220636125;5163.483651634807;5940.61386009908;6049.243844519435;6114.266288045463;6121.051237058263;6123.540734444934;1560.1107368799676;1585.1281795012696;1585.191552308331;1586.3813112885985;1586.6192113892582;1063.3938654966594;1065.5471424644495;1081.6971248050559;1081.853949716794;1081.967540973772;5845.035569131131;5857.414258574108;5861.648301101947;5861.677607731615;5866.208061911588;6187.071939209155;6282.308946015934;6284.905726414107;6287.717052732546;6290.779822706183;5903.557233207526;5922;5937.406259374115;5939.821805345847;5951.970240148771;3352.3295340931913;3460.6366331534828;3460.8961731148106;3461.7922924624604;3463.8960831175104;6536.215654121535;6537.607743535308;6541.6402097885075;6542.6401547914365;6549.901751473732;6258.3741625837965;6455.064015717789;6456.418922297016;6458.773942911976;6466.902996455057;6429.807105786834;6445.548811583238;6470.288268290485;6519.054737063099;6529.444997175198;6208.50331973432;6227.688615569294;6228.56400051992;6231.096491008688;6233.5636505446;6010.398960103955;6152.969235153795;6165.106059621419;6169.81490555284;6172.907406388818;6465.77369792055;6483.319251478527;6484.773032943825;6486.54594178403;6572.309907459648;4315.050688848449;4322.438083049184;4323.156984388014;4325.134973005349;4325.84859529915;6271.717772700148;6277.18396608438;6279.183706118358;6279.623222606659;6293.150424692791;5952.255968003999;6112.541559382975;6114.113453549299;6116.174316467398;6120.296165940796;6054.3340232575265;6058.545609079425;6068.908966365596;6115.84710382244;6125.509959203164;5965.403459654;5965.970170149295;5971;5971.4327138921735;5973.641581505123;5945.583809133492;6044.637321760709;6046.27444706638;6071.332153463204;6105.48103411215;5962.07587823888;5972.611780234444;5976.19321391624;5976.432238937294;5979.641221526722 13:10:43 INFO - 2015-10-27 13:10:43,032 DEBUG : BROWSER_OUTPUT: |5;yui.html;718.3104219948849;742.4060751398883;796.5300472721095;838.5974732128582;875.2691502595333;11201.047910927571;11395.658130256084;11421.600243991463;11424.485898134582;11427.942860285697;13577.253251071186;13676.65808354789;13677.042607017513;13678.863211367909;13682.794758078637;674.6323253826677;683.9521233513656;827.3174630929477;829.3075282139406;847.4449235750593;836.602613758466;843.9029511606152;846.5724808971461;850.1498501498502;850.3537311643134;720.7297263526177;883.041899539001;888.3159966825541;893.7542175901647;895.2614093372961;723.6164832638683;866.3026263857593;887.7691800131947;887.7691800131947;887.8313120507147;654.4960380507031;654.6661202786613;658.1181217168969;658.2331583704978;658.2758965138357;13876.58370248894;13993.090449120775;14015.579532614038;14018.929905350407;14033.368498417596;12485.563005294862;12885.613431597067;13109.147905386119;13153.73692526144;13257.734845303039;10442.269041167121;10533.210009249337;10576.206784491116;10583.100436462833;10611.78776424475;3584.444411116255;3594.6225646307284;3596.9280614387826;3610.584782749991;3658.1769101952113;49311.50688493105;49419.50580494221;49432.25851612229;49463.25805112926;49535;9328.860067098998;9474.289428292906;9607.855882161773;9654.082862128087;9713.90286097144;18551.16519756614;18921.7161742574;18953.905230474036;18966.71549926752;18984.62030759377;7566.432517561205;7571.924280757232;7702.191269916578;7847.450678452454;7895.486793358528;4303.634191093792;4403.294021758091;4428.357888106207;4457.375967364572;4540.772961351985;3071.4778487657154;3109.2848644811365;3112.0197137901487;3122.2194451387154;3123.8594263257755;471.85372534513726;474.8836535048866;480.88699155698384;481.838584074339;482.3680977918937;606.848287928018;624.7844493649684;633.5343522510951;661.2825084783065;701.4283359062348;8004.679812807422;8342.708005219789;8343;8424.873626895602;8557.914420855712;612.3845535237148;619.7644894939893;649.3344322069822;673.2358772792916;678.9796306110825;3829.1384438501113;4041.4948131483566;4094.815733292009;4101.46680931477;4129.566395528486;66436.33563664398;67718;67748.6612566934;67776.32223677798;67882.66058669773;56434;58066.70966645224;58235.41764582384;58308.41691583115;59548.70225648844;51549.74225128925;51635.48364516382;52115.21827172596;53043.734781325846;53130.73434632802;7706.499077559941;7778.688852445839;7938.483998540077;8121;8166.7958301042945;38440;38926.4161037579;39496.60503395044;39707.80146099251;40522.79738601406;51672.48327516827;51832.48167518427;52143.73928130335;52445.47554524559;53087.46912530825;8791.780205494913;9047.411918225294;9101.317401195069;9137.817243655223;9205.217556507772;12767.361631918182;12824.358782061046;12944.919467090649;12963.675908102374;12967.092303538662;11302.717432064264;11303.434828258718;11479.827802583135;11722;12088.818667719815;11777.470013849568;11842.82235766447;12195.146339756488;12228.082893782825;12418;11244.55021799119;11492.425378730863;11577.363245021268;11691.649250522498;11875.40654746255;9581.808363832824;10134.847977280198;10286.691399258034;10395.220358472994;10835.02484776374;9635.662751803653;10156.89843101589;10181.185505159718;10203.28576999603;10207.081362677394 13:10:43 INFO - 2015-10-27 13:10:43,032 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:10:43 INFO - 2015-10-27 13:10:43,032 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:10:43 INFO - 2015-10-27 13:10:43,032 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,798 13:10:43 INFO - 2015-10-27 13:10:43,032 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:10:43 INFO - 2015-10-27 13:10:43,033 DEBUG : BROWSER_OUTPUT: __startTimestamp1445976643021__endTimestamp 13:10:43 INFO - 2015-10-27 13:10:43,033 DEBUG : BROWSER_OUTPUT: 13:10:43 INFO - 2015-10-27 13:10:43,033 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:10:43 INFO - 2015-10-27 13:10:43,033 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:10:43 INFO - 2015-10-27 13:10:43,033 DEBUG : BROWSER_OUTPUT: 13:10:43 INFO - 2015-10-27 13:10:43,033 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5509.19 Median:5668.60 stddev:605.64 (10.7%) stddev-sans-first:579.96 13:10:43 INFO - 2015-10-27 13:10:43,033 DEBUG : BROWSER_OUTPUT: Values: 3207.6 3300.6 3325.6 3329.6 3338.6 5457.4 5556.9 5563.0 5641.1 5645.8 5534.9 5555.4 5614.3 5620.1 5668.6 5014.1 5050.3 5107.2 5123.1 5150.2 4884.4 5120.0 5120.4 5121.8 5135.1 4965.5 5036.9 5044.5 5052.2 5077.1 5126.5 5128.1 5131.7 5132.3 5174.1 4957.4 5089.0 5114.6 5138.3 5139.7 5315.5 5318.8 5326.2 5401.5 5415.5 5987.5 6013.3 6015.7 6018.1 6018.8 5749.4 5883.4 5895.2 6028.4 6049.7 5478.1 5536.4 5540.1 5540.8 5593.4 6000.2 6006.9 6018.1 6018.5 6022.1 5555.7 5656.6 5818.7 5821.6 5822.3 5939.0 5942.3 5947.9 5955.4 5979.5 5899.3 5904.9 5917.1 5921.8 5922.8 5740.8 5827.9 5869.7 5873.3 5904.0 4531.0 4539.9 4549.2 4562.6 4584.4 4084.4 4088.9 4110.7 4112.8 4134.4 5376.0 5470.0 5507.1 5630.2 5638.4 5914.6 6024.7 6028.1 6031.5 6040.7 5640.4 5646.1 5652.7 5654.1 5665.7 5011.8 5054.7 5097.1 5106.1 5164.6 6114.3 6193.8 6195.2 6195.3 6203.5 5967.7 5976.4 5977.0 5977.9 5982.7 5896.7 6008.3 6015.8 6063.0 6126.8 5887.2 5910.1 5920.5 5920.5 5928.5 5988.4 5990.7 5998.9 6001.2 6003.7 5527.7 5630.5 5633.7 5734.9 5759.7 5793.2 5822.4 5833.5 5836.5 5847.2 5435.7 5738.3 5748.0 5748.7 5751.3 5645.3 5695.7 5811.4 5813.9 5816.5 5646.3 5677.5 5683.4 5685.9 5696.7 13:10:43 INFO - 2015-10-27 13:10:43,033 DEBUG : BROWSER_OUTPUT: 13:10:43 INFO - 2015-10-27 13:10:43,034 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:60194.58 Median:33875.25 stddev:137375.46 (405.5%) stddev-sans-first:137688.01 13:10:43 INFO - 2015-10-27 13:10:43,034 DEBUG : BROWSER_OUTPUT: Values: 617.2 619.0 619.9 623.1 624.5 32777.5 39219.0 39516.2 39545.8 39837.4 40686.6 41254.8 41276.4 41281.4 41288.0 7849.9 7973.8 8738.9 8921.9 8960.0 10473.7 10782.8 10792.2 10795.4 10807.4 10483.8 10572.9 10614.5 10627.8 10652.0 8039.5 8193.8 10483.2 10643.0 10940.3 10391.2 10510.9 10518.6 10528.1 10534.6 40416.4 40696.2 40776.8 40789.8 40851.0 3216.8 3221.4 3324.6 3464.6 4052.2 30375.4 30707.2 30729.0 30785.8 31025.4 3068.1 3079.8 3130.0 3136.7 3159.6 250130.0 250434.0 251354.0 251596.0 252162.0 56539.7 57626.1 58440.0 58772.4 64531.0 59484.7 59577.4 59662.1 59735.0 59833.0 14313.2 14374.7 14459.4 14465.8 14467.3 10955.7 11026.9 11029.8 11030.6 11032.0 19125.1 19310.3 19323.2 19327.4 19335.1 8697.7 8913.9 8947.5 8959.4 8968.8 914.3 914.6 937.6 964.4 1001.2 27346.9 27648.0 28069.4 28071.7 28111.6 980.5 983.0 1009.5 1024.2 1029.5 13706.1 13913.3 13974.3 14029.6 14097.4 772019.0 773805.0 780075.0 780099.0 781012.0 57697.4 58465.1 58472.4 58477.0 58538.4 1330.7 1333.2 1338.6 1340.4 1344.7 29648.3 30608.0 30642.0 30738.1 30980.8 47490.3 47946.5 48104.8 48105.3 48123.5 306171.0 308248.0 308665.0 309326.0 398929.0 29759.0 33307.5 33423.0 33797.2 33896.8 41383.2 42218.4 42558.4 42565.0 43135.0 35083.6 35531.6 35760.0 36568.6 41968.4 30612.2 37984.6 41069.2 41416.8 41962.4 37197.0 37608.2 37868.2 38051.8 38052.4 33853.7 35104.1 35312.0 35366.0 35705.5 26169.3 26205.7 26335.5 26395.5 26431.5 13:10:43 INFO - 2015-10-27 13:10:43,034 DEBUG : BROWSER_OUTPUT: 13:10:43 INFO - 2015-10-27 13:10:43,034 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28535.91 Median:4179.12 stddev:88664.11 (2121.6%) stddev-sans-first:88887.59 13:10:43 INFO - 2015-10-27 13:10:43,035 DEBUG : BROWSER_OUTPUT: Values: 360.4 361.5 365.7 367.4 368.5 14730.6 15379.3 17134.5 17166.2 17695.6 16862.4 17028.2 17180.7 17182.1 17221.5 5222.4 5336.5 5394.0 5398.4 5400.8 3990.6 4099.1 5388.6 5902.2 6066.2 5957.8 5992.6 5995.1 6011.9 6015.3 4854.7 4915.0 4952.0 4959.2 4962.2 4155.0 4203.2 4273.1 4275.1 4277.1 13760.4 13786.1 13948.4 14007.2 14120.4 2009.6 2037.0 2065.2 2075.8 2111.7 10016.6 10220.9 10344.8 10487.4 10522.0 1717.5 1792.6 1816.0 1829.9 1839.8 61417.0 61670.0 61954.0 62145.0 62526.0 7101.2 7177.7 7265.7 7300.4 7322.3 8711.2 8719.2 8723.7 8725.0 8732.2 5566.6 5631.6 5667.7 5677.6 5679.4 5690.8 5692.6 5713.2 5726.8 5730.3 3312.9 3350.1 3366.3 3371.4 3374.8 1188.5 1214.2 1217.7 1220.1 1261.8 465.3 472.4 474.5 474.5 479.2 11385.3 11822.3 12077.2 12092.3 12114.8 493.1 501.3 504.3 515.6 522.4 6465.5 6634.8 6669.1 6706.6 6754.4 518977.0 524485.0 550690.0 551642.0 557911.0 78455.6 81451.0 82035.2 82638.2 83344.2 551.2 563.7 564.7 564.9 565.1 11406.4 11462.4 11686.8 11687.8 11772.1 37267.6 37521.2 37583.4 38049.2 38300.4 49359.3 58141.0 58154.4 58543.0 58546.1 14049.2 14167.3 14782.9 14817.5 14837.0 18437.7 18848.0 19006.0 19425.3 19607.8 9086.8 12629.0 12683.6 13797.9 16079.4 9498.5 9799.7 9940.3 9943.6 10267.1 8113.6 9405.0 10064.2 10308.5 10458.9 14941.4 15213.8 15260.0 15455.4 15518.5 15840.3 16166.1 16283.8 16466.8 16661.8 13:10:43 INFO - 2015-10-27 13:10:43,035 DEBUG : BROWSER_OUTPUT: 13:10:43 INFO - 2015-10-27 13:10:43,036 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5392.13 Median:6610.65 stddev:2750.45 (41.6%) stddev-sans-first:2742.58 13:10:43 INFO - 2015-10-27 13:10:43,036 DEBUG : BROWSER_OUTPUT: Values: 1496.5 1532.8 1643.2 1750.6 1876.4 6838.6 7300.6 7411.4 7417.3 7427.9 7136.7 7217.4 7225.7 7231.1 7234.4 1979.3 2017.6 2244.9 2252.2 2274.7 2285.4 2302.6 2305.1 2306.8 2308.9 2234.0 2295.2 2295.7 2297.0 2299.6 2004.8 2026.4 2216.2 2285.9 2290.5 2248.4 2259.8 2273.8 2280.8 2286.9 7570.7 7620.8 7627.5 7628.0 7634.2 4654.3 4720.5 4725.6 4726.1 4733.5 3021.5 3102.8 3116.8 3141.5 3145.8 995.1 1007.6 1025.0 1032.7 1047.7 10313.4 10403.0 10403.8 10406.4 10415.9 4042.6 4088.7 4138.0 4157.9 4170.0 8256.8 8308.0 8353.5 8375.0 8378.7 4657.8 4658.3 4662.5 4664.3 4678.6 4302.3 4309.1 4312.6 4312.9 4319.9 3360.1 3414.8 3433.1 3434.8 3435.8 1088.3 1121.4 1125.6 1128.0 1130.0 1221.4 1334.7 1343.7 1343.8 1355.4 7035.4 7042.9 7058.9 7076.5 7316.9 1151.1 1153.6 1159.7 1162.6 1183.0 5928.2 5939.0 5957.2 5964.2 5965.3 9002.7 9411.5 9412.0 9413.5 9419.3 9371.9 9378.6 9380.5 9399.6 9406.5 7083.4 7165.4 7193.8 7205.9 7223.1 7016.9 7036.3 7038.5 7044.8 7056.1 8118.4 8214.2 8405.5 8407.5 8422.2 8488.5 8490.2 8512.6 8529.2 8536.1 6705.9 6869.2 6879.9 6888.5 6899.3 7485.4 7497.3 7509.8 7565.8 7584.4 6905.2 6927.9 7016.8 7163.4 7163.7 6491.0 6702.0 6932.5 6983.9 7046.1 7150.9 7161.9 7174.1 7193.9 7195.1 6603.6 6617.7 6633.2 6637.2 6646.1 6627.2 6630.8 6644.6 6655.3 6662.1 13:10:43 INFO - 2015-10-27 13:10:43,036 DEBUG : BROWSER_OUTPUT: 13:10:43 INFO - 2015-10-27 13:10:43,037 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5121.91 Median:5867.44 stddev:1504.57 (25.6%) stddev-sans-first:1465.21 13:10:43 INFO - 2015-10-27 13:10:43,037 DEBUG : BROWSER_OUTPUT: Values: 331.7 336.3 342.1 344.9 350.6 5863.8 5868.7 5877.1 5877.3 5878.6 5778.1 5779.3 5787.8 5793.0 5798.1 4553.5 4560.0 4566.1 4567.7 4568.6 4448.2 4515.8 4518.0 4528.1 4534.5 4503.2 4505.3 4507.3 4509.0 4513.9 4329.8 4395.4 4502.4 4506.1 4516.0 3912.9 3932.9 3950.6 3971.8 3973.6 5462.1 5507.3 5507.7 5517.3 5525.3 4902.1 4982.8 5037.1 5081.1 5127.9 5948.0 5951.1 5956.6 5964.5 5972.7 4312.6 4312.8 4314.2 4314.8 4316.0 6014.7 6169.3 6170.8 6171.3 6175.9 4483.7 4484.0 4485.1 4485.7 4491.2 4540.8 4543.2 4545.3 4548.2 4553.4 5155.3 5156.4 5158.6 5158.9 5163.5 5940.6 6049.2 6114.3 6121.1 6123.5 1560.1 1585.1 1585.2 1586.4 1586.6 1063.4 1065.5 1081.7 1081.9 1082.0 5845.0 5857.4 5861.6 5861.7 5866.2 6187.1 6282.3 6284.9 6287.7 6290.8 5903.6 5922.0 5937.4 5939.8 5952.0 3352.3 3460.6 3460.9 3461.8 3463.9 6536.2 6537.6 6541.6 6542.6 6549.9 6258.4 6455.1 6456.4 6458.8 6466.9 6429.8 6445.5 6470.3 6519.1 6529.4 6208.5 6227.7 6228.6 6231.1 6233.6 6010.4 6153.0 6165.1 6169.8 6172.9 6465.8 6483.3 6484.8 6486.5 6572.3 4315.1 4322.4 4323.2 4325.1 4325.8 6271.7 6277.2 6279.2 6279.6 6293.2 5952.3 6112.5 6114.1 6116.2 6120.3 6054.3 6058.5 6068.9 6115.8 6125.5 5965.4 5966.0 5971.0 5971.4 5973.6 5945.6 6044.6 6046.3 6071.3 6105.5 5962.1 5972.6 5976.2 5976.4 5979.6 13:10:43 INFO - 2015-10-27 13:10:43,037 DEBUG : BROWSER_OUTPUT: 13:10:43 INFO - 2015-10-27 13:10:43,037 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14812.15 Median:49447.76 stddev:18204.99 (36.8%) stddev-sans-first:18225.30 13:10:43 INFO - 2015-10-27 13:10:43,037 DEBUG : BROWSER_OUTPUT: Values: 718.3 742.4 796.5 838.6 875.3 11201.0 11395.7 11421.6 11424.5 11427.9 13577.3 13676.7 13677.0 13678.9 13682.8 674.6 684.0 827.3 829.3 847.4 836.6 843.9 846.6 850.1 850.4 720.7 883.0 888.3 893.8 895.3 723.6 866.3 887.8 887.8 887.8 654.5 654.7 658.1 658.2 658.3 13876.6 13993.1 14015.6 14018.9 14033.4 12485.6 12885.6 13109.1 13153.7 13257.7 10442.3 10533.2 10576.2 10583.1 10611.8 3584.4 3594.6 3596.9 3610.6 3658.2 49311.5 49419.5 49432.3 49463.3 49535.0 9328.9 9474.3 9607.9 9654.1 9713.9 18551.2 18921.7 18953.9 18966.7 18984.6 7566.4 7571.9 7702.2 7847.5 7895.5 4303.6 4403.3 4428.4 4457.4 4540.8 3071.5 3109.3 3112.0 3122.2 3123.9 471.9 474.9 480.9 481.8 482.4 606.8 624.8 633.5 661.3 701.4 8004.7 8342.7 8343.0 8424.9 8557.9 612.4 619.8 649.3 673.2 679.0 3829.1 4041.5 4094.8 4101.5 4129.6 66436.3 67718.0 67748.7 67776.3 67882.7 56434.0 58066.7 58235.4 58308.4 59548.7 51549.7 51635.5 52115.2 53043.7 53130.7 7706.5 7778.7 7938.5 8121.0 8166.8 38440.0 38926.4 39496.6 39707.8 40522.8 51672.5 51832.5 52143.7 52445.5 53087.5 8791.8 9047.4 9101.3 9137.8 9205.2 12767.4 12824.4 12944.9 12963.7 12967.1 11302.7 11303.4 11479.8 11722.0 12088.8 11777.5 11842.8 12195.1 12228.1 12418.0 11244.6 11492.4 11577.4 11691.6 11875.4 9581.8 10134.8 10286.7 10395.2 10835.0 9635.7 10156.9 10181.2 10203.3 10207.1 13:10:43 INFO - 2015-10-27 13:10:43,037 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:10:43 INFO - 2015-10-27 13:10:43,038 DEBUG : BROWSER_OUTPUT: 13:10:43 INFO - 2015-10-27 13:10:43,653 INFO : Browser exited with error code: 0 13:10:43 INFO - 2015-10-27 13:10:43,672 INFO : Completed test dromaeo_css (00:18:33) 13:10:43 INFO - 2015-10-27 13:10:43,672 INFO : Starting test kraken 13:10:43 INFO - 2015-10-27 13:10:43,672 DEBUG : operating with platform_type : linux_ 13:10:43 INFO - 2015-10-27 13:10:43,672 INFO : Initialising browser for kraken test... 13:10:43 INFO - 2015-10-27 13:10:43,678 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJAvD7n/profile http://localhost:56755/getInfo.html 13:10:47 INFO - 2015-10-27 13:10:47,360 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:10:47 INFO - 2015-10-27 13:10:47,360 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:10:47 INFO - 2015-10-27 13:10:47,360 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:10:47 INFO - 2015-10-27 13:10:47,360 DEBUG : BROWSER_OUTPUT: __metrics 13:10:47 INFO - 2015-10-27 13:10:47,462 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:10:48 INFO - 2015-10-27 13:10:48,683 INFO : Browser initialized. 13:10:48 INFO - 2015-10-27 13:10:48,684 INFO : Running cycle 1/1 for kraken test... 13:10:48 INFO - 2015-10-27 13:10:48,684 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJAvD7n/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:11:00 INFO - 2015-10-27 13:11:00,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 142163968 13:11:00 INFO - 2015-10-27 13:11:00,450 DEBUG : BROWSER_OUTPUT: 13:11:02 INFO - 2015-10-27 13:11:02,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56755/tests/kraken/driver.html?testName=audio-beat-detection) 13:11:03 INFO - 2015-10-27 13:11:03,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 177377280 13:11:03 INFO - 2015-10-27 13:11:03,499 DEBUG : BROWSER_OUTPUT: 13:11:05 INFO - 2015-10-27 13:11:05,915 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56755/tests/kraken/driver.html?testName=audio-dft) 13:11:06 INFO - 2015-10-27 13:11:06,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 163938304 13:11:06 INFO - 2015-10-27 13:11:06,477 DEBUG : BROWSER_OUTPUT: 13:11:09 INFO - 2015-10-27 13:11:09,276 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56755/tests/kraken/driver.html?testName=audio-fft) 13:11:09 INFO - 2015-10-27 13:11:09,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 152240128 13:11:09 INFO - 2015-10-27 13:11:09,882 DEBUG : BROWSER_OUTPUT: 13:11:11 INFO - 2015-10-27 13:11:11,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56755/tests/kraken/driver.html?testName=audio-oscillator) 13:11:12 INFO - 2015-10-27 13:11:12,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 151658496 13:11:12 INFO - 2015-10-27 13:11:12,267 DEBUG : BROWSER_OUTPUT: 13:11:14 INFO - 2015-10-27 13:11:14,433 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56755/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:11:14 INFO - 2015-10-27 13:11:14,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 154087424 13:11:14 INFO - 2015-10-27 13:11:14,986 DEBUG : BROWSER_OUTPUT: 13:11:17 INFO - 2015-10-27 13:11:17,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56755/tests/kraken/driver.html?testName=imaging-darkroom) 13:11:18 INFO - 2015-10-27 13:11:18,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 150241280 13:11:18 INFO - 2015-10-27 13:11:18,423 DEBUG : BROWSER_OUTPUT: 13:11:21 INFO - 2015-10-27 13:11:21,724 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56755/tests/kraken/driver.html?testName=imaging-desaturate) 13:11:22 INFO - 2015-10-27 13:11:22,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 158121984 13:11:22 INFO - 2015-10-27 13:11:22,292 DEBUG : BROWSER_OUTPUT: 13:11:25 INFO - 2015-10-27 13:11:25,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56755/tests/kraken/driver.html?testName=json-parse-financial) 13:11:25 INFO - 2015-10-27 13:11:25,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 158547968 13:11:25 INFO - 2015-10-27 13:11:25,590 DEBUG : BROWSER_OUTPUT: 13:11:27 INFO - 2015-10-27 13:11:27,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56755/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:11:27 INFO - 2015-10-27 13:11:27,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 160522240 13:11:27 INFO - 2015-10-27 13:11:27,660 DEBUG : BROWSER_OUTPUT: 13:11:29 INFO - 2015-10-27 13:11:29,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56755/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:11:30 INFO - 2015-10-27 13:11:30,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 161746944 13:11:30 INFO - 2015-10-27 13:11:30,008 DEBUG : BROWSER_OUTPUT: 13:11:32 INFO - 2015-10-27 13:11:32,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56755/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:11:32 INFO - 2015-10-27 13:11:32,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 172441600 13:11:32 INFO - 2015-10-27 13:11:32,594 DEBUG : BROWSER_OUTPUT: 13:11:35 INFO - 2015-10-27 13:11:35,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:11:35 INFO - 2015-10-27 13:11:35,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 177881088 13:11:35 INFO - 2015-10-27 13:11:35,737 DEBUG : BROWSER_OUTPUT: 13:11:38 INFO - 2015-10-27 13:11:38,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:11:38 INFO - 2015-10-27 13:11:38,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 174985216 13:11:38 INFO - 2015-10-27 13:11:38,814 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,463 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56755/tests/kraken/driver.html?testName=ai-astar) 13:11:40 INFO - 2015-10-27 13:11:40,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 228495360 13:11:40 INFO - 2015-10-27 13:11:40,721 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,721 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:11:40 INFO - 2015-10-27 13:11:40,722 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:11:40 INFO - 2015-10-27 13:11:40,722 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:11:40 INFO - 2015-10-27 13:11:40,722 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:11:40 INFO - 2015-10-27 13:11:40,722 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;104;109;111;110;99;111;103;109 13:11:40 INFO - 2015-10-27 13:11:40,722 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;122;119;128;143;132;122;128;122;136;121 13:11:40 INFO - 2015-10-27 13:11:40,722 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;159;157;160;159;157;159;161;156;158 13:11:40 INFO - 2015-10-27 13:11:40,722 DEBUG : BROWSER_OUTPUT: |3;audio-fft;68;73;72;77;70;73;69;69;76;69 13:11:40 INFO - 2015-10-27 13:11:40,723 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;135;91;92;91;144;91;91;126 13:11:40 INFO - 2015-10-27 13:11:40,723 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;109;110;109;110;110;110 13:11:40 INFO - 2015-10-27 13:11:40,723 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;144;145;145;145;145;145;145;145 13:11:40 INFO - 2015-10-27 13:11:40,723 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;102;95;95;96;95;96;95 13:11:40 INFO - 2015-10-27 13:11:40,723 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;54;56;56;55;56;55;65;53;54 13:11:40 INFO - 2015-10-27 13:11:40,724 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;66;66;67;67;67;68;67;72;68 13:11:40 INFO - 2015-10-27 13:11:40,724 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;82;84;85;83;83;82;84;82 13:11:40 INFO - 2015-10-27 13:11:40,724 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;109;116;123;118;113;114;120;111;121 13:11:40 INFO - 2015-10-27 13:11:40,724 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;144;154;142;142;137;148;141;145;145 13:11:40 INFO - 2015-10-27 13:11:40,724 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;67;66;68;66;64;66;66;65 13:11:40 INFO - 2015-10-27 13:11:40,725 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:11:40 INFO - 2015-10-27 13:11:40,725 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:11:40 INFO - 2015-10-27 13:11:40,725 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,824 13:11:40 INFO - 2015-10-27 13:11:40,725 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:11:40 INFO - 2015-10-27 13:11:40,725 DEBUG : BROWSER_OUTPUT: __startTimestamp1445976700716__endTimestamp 13:11:40 INFO - 2015-10-27 13:11:40,725 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,725 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:11:40 INFO - 2015-10-27 13:11:40,725 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:11:40 INFO - 2015-10-27 13:11:40,725 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,725 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.50 Median:110.00 stddev:4.06 (3.7%) stddev-sans-first:4.27 13:11:40 INFO - 2015-10-27 13:11:40,726 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 104.0 109.0 111.0 110.0 99.0 111.0 103.0 109.0 13:11:40 INFO - 2015-10-27 13:11:40,726 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,726 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:127.30 Median:128.00 stddev:7.73 (6.0%) stddev-sans-first:7.96 13:11:40 INFO - 2015-10-27 13:11:40,726 DEBUG : BROWSER_OUTPUT: Values: 122.0 119.0 128.0 143.0 132.0 122.0 128.0 122.0 136.0 121.0 13:11:40 INFO - 2015-10-27 13:11:40,726 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,726 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:158.90 Median:159.00 stddev:2.08 (1.3%) stddev-sans-first:1.59 13:11:40 INFO - 2015-10-27 13:11:40,726 DEBUG : BROWSER_OUTPUT: Values: 163.0 159.0 157.0 160.0 159.0 157.0 159.0 161.0 156.0 158.0 13:11:40 INFO - 2015-10-27 13:11:40,726 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,726 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:71.60 Median:72.50 stddev:3.13 (4.3%) stddev-sans-first:3.04 13:11:40 INFO - 2015-10-27 13:11:40,726 DEBUG : BROWSER_OUTPUT: Values: 68.0 73.0 72.0 77.0 70.0 73.0 69.0 69.0 76.0 69.0 13:11:40 INFO - 2015-10-27 13:11:40,726 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,727 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.40 Median:91.00 stddev:21.54 (23.7%) stddev-sans-first:22.30 13:11:40 INFO - 2015-10-27 13:11:40,727 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 135.0 91.0 92.0 91.0 144.0 91.0 91.0 126.0 13:11:40 INFO - 2015-10-27 13:11:40,727 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,727 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:11:40 INFO - 2015-10-27 13:11:40,727 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 109.0 110.0 109.0 110.0 110.0 110.0 13:11:40 INFO - 2015-10-27 13:11:40,727 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,727 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 13:11:40 INFO - 2015-10-27 13:11:40,727 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 144.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 13:11:40 INFO - 2015-10-27 13:11:40,728 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,728 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.00 stddev:2.16 (2.3%) stddev-sans-first:2.26 13:11:40 INFO - 2015-10-27 13:11:40,728 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 102.0 95.0 95.0 96.0 95.0 96.0 95.0 13:11:40 INFO - 2015-10-27 13:11:40,728 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,728 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:3.35 (6.0%) stddev-sans-first:3.54 13:11:40 INFO - 2015-10-27 13:11:40,728 DEBUG : BROWSER_OUTPUT: Values: 57.0 54.0 56.0 56.0 55.0 56.0 55.0 65.0 53.0 54.0 13:11:40 INFO - 2015-10-27 13:11:40,728 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,728 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:1.78 (2.7%) stddev-sans-first:1.81 13:11:40 INFO - 2015-10-27 13:11:40,729 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 66.0 67.0 67.0 67.0 68.0 67.0 72.0 68.0 13:11:40 INFO - 2015-10-27 13:11:40,729 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,729 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:1.05 (1.3%) stddev-sans-first:1.05 13:11:40 INFO - 2015-10-27 13:11:40,729 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 82.0 84.0 85.0 83.0 83.0 82.0 84.0 82.0 13:11:40 INFO - 2015-10-27 13:11:40,729 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,729 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:117.50 stddev:4.49 (3.8%) stddev-sans-first:4.76 13:11:40 INFO - 2015-10-27 13:11:40,729 DEBUG : BROWSER_OUTPUT: Values: 117.0 109.0 116.0 123.0 118.0 113.0 114.0 120.0 111.0 121.0 13:11:40 INFO - 2015-10-27 13:11:40,729 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,729 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:145.00 stddev:4.67 (3.2%) stddev-sans-first:4.79 13:11:40 INFO - 2015-10-27 13:11:40,729 DEBUG : BROWSER_OUTPUT: Values: 148.0 144.0 154.0 142.0 142.0 137.0 148.0 141.0 145.0 145.0 13:11:40 INFO - 2015-10-27 13:11:40,729 DEBUG : BROWSER_OUTPUT: 13:11:40 INFO - 2015-10-27 13:11:40,729 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 13:11:40 INFO - 2015-10-27 13:11:40,729 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 67.0 66.0 68.0 66.0 64.0 66.0 66.0 65.0 13:11:40 INFO - 2015-10-27 13:11:40,730 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:11:40 INFO - 2015-10-27 13:11:40,730 DEBUG : BROWSER_OUTPUT: 13:11:41 INFO - 2015-10-27 13:11:41,445 INFO : Browser exited with error code: 0 13:11:41 INFO - 2015-10-27 13:11:41,493 INFO : Completed test kraken (00:00:57) 13:11:41 INFO - 2015-10-27 13:11:41,493 INFO : Starting test v8_7 13:11:41 INFO - 2015-10-27 13:11:41,493 DEBUG : operating with platform_type : linux_ 13:11:41 INFO - 2015-10-27 13:11:41,494 INFO : Initialising browser for v8_7 test... 13:11:41 INFO - 2015-10-27 13:11:41,500 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA2WSY_/profile http://localhost:56755/getInfo.html 13:11:45 INFO - 2015-10-27 13:11:45,320 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:11:45 INFO - 2015-10-27 13:11:45,320 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:11:45 INFO - 2015-10-27 13:11:45,321 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:11:45 INFO - 2015-10-27 13:11:45,321 DEBUG : BROWSER_OUTPUT: __metrics 13:11:45 INFO - 2015-10-27 13:11:45,449 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:11:46 INFO - 2015-10-27 13:11:46,769 INFO : Browser initialized. 13:11:46 INFO - 2015-10-27 13:11:46,769 INFO : Running cycle 1/1 for v8_7 test... 13:11:46 INFO - 2015-10-27 13:11:46,770 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA2WSY_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:11:58 INFO - 2015-10-27 13:11:58,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 141426688 13:11:58 INFO - 2015-10-27 13:11:58,562 DEBUG : BROWSER_OUTPUT: 13:12:20 INFO - 2015-10-27 13:12:20,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56755/tests/v8_7/run.html (next: http://localhost:56755/tests/v8_7/run.html) 13:12:20 INFO - 2015-10-27 13:12:20,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 555466752 13:12:20 INFO - 2015-10-27 13:12:20,266 DEBUG : BROWSER_OUTPUT: 13:12:20 INFO - 2015-10-27 13:12:20,266 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:12:20 INFO - 2015-10-27 13:12:20,266 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:12:20 INFO - 2015-10-27 13:12:20,266 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:12:20 INFO - 2015-10-27 13:12:20,267 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:12:20 INFO - 2015-10-27 13:12:20,267 DEBUG : BROWSER_OUTPUT: |0;Richards;169.9524133242692 13:12:20 INFO - 2015-10-27 13:12:20,267 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.57250612860645 13:12:20 INFO - 2015-10-27 13:12:20,267 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.61081385525205 13:12:20 INFO - 2015-10-27 13:12:20,267 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 13:12:20 INFO - 2015-10-27 13:12:20,267 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1982.1782178217823 13:12:20 INFO - 2015-10-27 13:12:20,268 DEBUG : BROWSER_OUTPUT: |5;Earley;808.4074373484236 13:12:20 INFO - 2015-10-27 13:12:20,268 DEBUG : BROWSER_OUTPUT: |6;Boyer;11764.70588235294 13:12:20 INFO - 2015-10-27 13:12:20,268 DEBUG : BROWSER_OUTPUT: |7;RegExp;25525 13:12:20 INFO - 2015-10-27 13:12:20,268 DEBUG : BROWSER_OUTPUT: |8;Splay;572.4098454493417 13:12:20 INFO - 2015-10-27 13:12:20,268 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 13:12:20 INFO - 2015-10-27 13:12:20,268 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:12:20 INFO - 2015-10-27 13:12:20,269 DEBUG : BROWSER_OUTPUT: __startTimestamp1445976740265__endTimestamp 13:12:20 INFO - 2015-10-27 13:12:20,269 DEBUG : BROWSER_OUTPUT: 13:12:20 INFO - 2015-10-27 13:12:20,269 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:12:20 INFO - 2015-10-27 13:12:20,269 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:12:20 INFO - 2015-10-27 13:12:20,269 DEBUG : BROWSER_OUTPUT: 13:12:20 INFO - 2015-10-27 13:12:20,270 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:169.95 Median:169.95 stddev:0.00 (0.0%) 13:12:20 INFO - 2015-10-27 13:12:20,270 DEBUG : BROWSER_OUTPUT: Values: 170.0 13:12:20 INFO - 2015-10-27 13:12:20,270 DEBUG : BROWSER_OUTPUT: 13:12:20 INFO - 2015-10-27 13:12:20,270 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.57 Median:188.57 stddev:0.00 (0.0%) 13:12:20 INFO - 2015-10-27 13:12:20,270 DEBUG : BROWSER_OUTPUT: Values: 188.6 13:12:20 INFO - 2015-10-27 13:12:20,271 DEBUG : BROWSER_OUTPUT: 13:12:20 INFO - 2015-10-27 13:12:20,271 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.61 Median:281.61 stddev:0.00 (0.0%) 13:12:20 INFO - 2015-10-27 13:12:20,271 DEBUG : BROWSER_OUTPUT: Values: 281.6 13:12:20 INFO - 2015-10-27 13:12:20,271 DEBUG : BROWSER_OUTPUT: 13:12:20 INFO - 2015-10-27 13:12:20,271 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 13:12:20 INFO - 2015-10-27 13:12:20,271 DEBUG : BROWSER_OUTPUT: Values: 5040.2 13:12:20 INFO - 2015-10-27 13:12:20,272 DEBUG : BROWSER_OUTPUT: 13:12:20 INFO - 2015-10-27 13:12:20,272 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1982.18 Median:1982.18 stddev:0.00 (0.0%) 13:12:20 INFO - 2015-10-27 13:12:20,272 DEBUG : BROWSER_OUTPUT: Values: 1982.2 13:12:20 INFO - 2015-10-27 13:12:20,273 DEBUG : BROWSER_OUTPUT: 13:12:20 INFO - 2015-10-27 13:12:20,273 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:808.41 Median:808.41 stddev:0.00 (0.0%) 13:12:20 INFO - 2015-10-27 13:12:20,273 DEBUG : BROWSER_OUTPUT: Values: 808.4 13:12:20 INFO - 2015-10-27 13:12:20,274 DEBUG : BROWSER_OUTPUT: 13:12:20 INFO - 2015-10-27 13:12:20,274 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11764.71 Median:11764.71 stddev:0.00 (0.0%) 13:12:20 INFO - 2015-10-27 13:12:20,274 DEBUG : BROWSER_OUTPUT: Values: 11764.7 13:12:20 INFO - 2015-10-27 13:12:20,274 DEBUG : BROWSER_OUTPUT: 13:12:20 INFO - 2015-10-27 13:12:20,274 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25525.00 Median:25525.00 stddev:0.00 (0.0%) 13:12:20 INFO - 2015-10-27 13:12:20,274 DEBUG : BROWSER_OUTPUT: Values: 25525.0 13:12:20 INFO - 2015-10-27 13:12:20,274 DEBUG : BROWSER_OUTPUT: 13:12:20 INFO - 2015-10-27 13:12:20,274 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:572.41 Median:572.41 stddev:0.00 (0.0%) 13:12:20 INFO - 2015-10-27 13:12:20,275 DEBUG : BROWSER_OUTPUT: Values: 572.4 13:12:20 INFO - 2015-10-27 13:12:20,275 DEBUG : BROWSER_OUTPUT: 13:12:20 INFO - 2015-10-27 13:12:20,275 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 13:12:20 INFO - 2015-10-27 13:12:20,275 DEBUG : BROWSER_OUTPUT: Values: 4822.1 13:12:20 INFO - 2015-10-27 13:12:20,275 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:12:20 INFO - 2015-10-27 13:12:20,275 DEBUG : BROWSER_OUTPUT: 13:12:21 INFO - 2015-10-27 13:12:21,049 INFO : Browser exited with error code: 0 13:12:21 INFO - 2015-10-27 13:12:21,062 INFO : Completed test v8_7 (00:00:39) 13:12:21 INFO - 2015-10-27 13:12:21,258 INFO : Completed test suite (00:20:11) 13:12:21 INFO - 2015-10-27 13:12:21,258 DEBUG : Working with test: dromaeo_css 13:12:21 INFO - 2015-10-27 13:12:21,258 DEBUG : Generating results file: dromaeo_css 13:12:21 INFO - 2015-10-27 13:12:21,259 DEBUG : Working with test: kraken 13:12:21 INFO - 2015-10-27 13:12:21,260 DEBUG : Generating results file: kraken 13:12:21 INFO - 2015-10-27 13:12:21,260 INFO : javascript benchmark 13:12:21 INFO - 2015-10-27 13:12:21,260 DEBUG : Working with test: v8_7 13:12:21 INFO - 2015-10-27 13:12:21,260 DEBUG : Generating results file: v8_7 13:12:21 INFO - 2015-10-27 13:12:21,260 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:12:21 INFO - 2015-10-27 13:12:21,428 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 13:12:21 INFO - 2015-10-27 13:12:21,428 DEBUG : process_Request line: dromaeo_css 6910.77 graph.html#tests=[[72,201,35]] 13:12:21 INFO - 2015-10-27 13:12:21,428 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:12:21 INFO - 2015-10-27 13:12:21,461 DEBUG : process_Request line: kraken 1453.70 graph.html#tests=[[232,201,35]] 13:12:21 INFO - 2015-10-27 13:12:21,462 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:12:21 INFO - 2015-10-27 13:12:21,497 DEBUG : process_Request line: v8_7 20008.53 graph.html#tests=[[230,201,35]] 13:12:21 INFO - 2015-10-27 13:12:21,499 INFO : javascript benchmark 13:12:21 INFO - 2015-10-27 13:12:21,501 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [360.398135114359, 361.54625944439726, 365.6909911125099, 367.3791292715311, 368.4638850472562, 14730.63173420665, 15379.307931143097, 17134.48596542104, 17166.22751976161, 17695.64608707825, 16862.409815656454, 17028.233729482174, 17180.656386872255, 17182.054986975712, 17221.483355499324, 5222.399424066233, 5336.546393556552, 5393.973030134864, 5398.379186393556, 5400.837974860741, 3990.580988996157, 4099.0777075158, 5388.622796404254, 5902.173695682608, 6066.211392518989, 5957.791477298296, 5992.5505587080925, 5995.13070604762, 6011.939880601181, 6015.278166620012, 4854.732989685566, 4915.0, 4952.034353301107, 4959.181735013754, 4962.1812400953795, 4155.044339801832, 4203.201391735591, 4273.081287523167, 4275.123599662093, 4277.144571085795, 13760.449582016707, 13786.103903246258, 13948.372323245478, 14007.229602371866, 14120.36458359366, 2009.5578972626, 2036.9592608147755, 2065.2461851424273, 2075.8443116766302, 2111.693804398369, 10016.599336026551, 10220.89779102207, 10344.79310413795, 10487.423191724452, 10522.0, 1717.4761697682202, 1792.57874399516, 1816.0375001249358, 1829.9085045747793, 1839.7516335294697, 61417.0, 61670.0, 61954.0, 62145.0, 62526.0, 7101.183363913113, 7177.6770045348085, 7265.745698900619, 7300.4159667226495, 7322.340989310987, 8711.172438618321, 8719.215270625675, 8723.738287851374, 8724.956375218084, 8732.170443807956, 5566.638168519034, 5631.605787594911, 5667.716614169275, 5677.602567820296, 5679.432056794288, 5690.800821971211, 5692.57305702074, 5713.171590119409, 5726.799562015392, 5730.255066841284, 3312.9171770705925, 3350.0787283497234, 3366.3267346530793, 3371.4100032494216, 3374.7806392584403, 1188.506769690586, 1214.1500949335325, 1217.7077501399776, 1220.0605533738972, 1261.8044203148527, 465.2997239155118, 472.43072098121684, 474.5136235358716, 474.5207340586033, 479.1806011719998, 11385.316880987168, 11822.34977076252, 12077.214981026205, 12092.334921579222, 12114.757704845853, 493.1099365645045, 501.285667923208, 504.3191691216828, 515.569499467941, 522.4227228912074, 6465.4827613790785, 6634.834129146713, 6669.099671544376, 6706.5640733352175, 6754.425873800782, 518977.0, 524485.0, 550690.0, 551642.0, 557911.0, 78455.60772196103, 81451.0, 82035.17964820395, 82638.17361826425, 83344.16655833364, 551.1952549278099, 563.7209581257385, 564.6922427277144, 564.9180868774087, 565.0563558856719, 11406.372649504357, 11462.4268786562, 11686.766264674829, 11687.76624467523, 11772.117091218022, 37267.62732372642, 37521.24957500889, 37583.43624845684, 38049.2390152201, 38300.42549361706, 49359.259611105146, 58141.0, 58154.418455816594, 58543.0, 58546.12180817376, 14049.157050576998, 14167.291635418394, 14782.852171478147, 14817.481388151364, 14837.0, 18437.72343414823, 18848.0, 19006.0, 19425.320113796515, 19607.803921961167, 9086.772830679285, 12629.0, 12683.619491415273, 13797.862021379658, 16079.35682572684, 9498.477583732685, 9799.657012004545, 9940.304178707422, 9943.552540135855, 10267.12729417978, 8113.553754543556, 9404.952975235354, 10064.245181611263, 10308.536115874653, 10458.895411045793, 14941.402343906122, 15213.847861521243, 15260.0, 15455.381784728936, 15518.534443966699, 15840.28718707638, 16166.110863902599, 16283.844094019356, 16466.83533164653, 16661.833381666514], "dojo.html": [3207.5990501187352, 3300.5874265716784, 3325.617553981293, 3329.633740288568, 3338.6327503974558, 5457.399686034543, 5556.91664625031, 5562.972185139074, 5641.097424412095, 5645.802396916109, 5534.889302213954, 5555.3611334696525, 5614.326280846294, 5620.1288800235925, 5668.603197776158, 5014.072396606622, 5050.292958985745, 5107.157319042363, 5123.129068058439, 5150.227465880129, 4884.365032545764, 5120.027194832988, 5120.411152717429, 5121.769520371592, 5135.127028405162, 4965.453800081988, 5036.874078148057, 5044.520770526794, 5052.216906379517, 5077.136886729265, 5126.512981266774, 5128.076946149691, 5131.666441681279, 5132.255822905658, 5174.09453345663, 4957.429895562021, 5089.033083714119, 5114.565261952738, 5138.254953031789, 5139.665921715076, 5315.495027972336, 5318.813841515528, 5326.201069839516, 5401.4868587484125, 5415.458454154593, 5987.461128498412, 6013.308469525973, 6015.669138197398, 6018.127371531147, 6018.8495287617725, 5749.425057494217, 5883.352831188566, 5895.233619629464, 6028.4272994065495, 6049.727762250709, 5478.096114141162, 5536.446355364472, 5540.085885828793, 5540.833774986757, 5593.356763972155, 6000.159977603139, 6006.879862402815, 6018.097285407224, 6018.488428483541, 6022.096685497123, 5555.666660000413, 5656.60403771732, 5818.709064546756, 5821.563382746311, 5822.3304320003745, 5938.970305148533, 5942.286925568959, 5947.881042379128, 5955.404459554096, 5979.521638268928, 5899.292084949833, 5904.940950590525, 5917.142014407887, 5921.792737254175, 5922.7927022554, 5740.827775166752, 5827.941720582825, 5869.706514674334, 5873.295204575478, 5903.970480147572, 4530.954690453119, 4539.886502837389, 4549.158405694957, 4562.634989200922, 4584.404027476474, 4084.407760874716, 4088.9182216356103, 4110.712250142461, 4112.794360281974, 4134.441850350225, 5376.0, 5470.042742520043, 5507.118860982224, 5630.211770352154, 5638.436156384329, 5914.615549989237, 6024.728887200086, 6028.125921741323, 6031.517478601701, 6040.6979651018155, 5640.435956404409, 5646.068398714248, 5652.689102099424, 5654.123610840326, 5665.688387138664, 5011.774470148779, 5054.7472626368535, 5097.057044446789, 5106.080905437057, 5164.561012313995, 6114.296855861544, 6193.84515387119, 6195.1636529068, 6195.31851496335, 6203.47270482005, 5967.7016149191495, 5976.372480889444, 5977.043673012297, 5977.910331344946, 5982.700864956648, 5896.6756828374855, 6008.339082700987, 6015.759369625166, 6063.0, 6126.811919960783, 5887.1757953887345, 5910.113482977587, 5920.496757775637, 5920.526357891445, 5928.525717942641, 5988.401159883977, 5990.730417131327, 5998.9100163496705, 6001.219841420588, 6003.729832157476, 5527.668339899619, 5630.549556035589, 5633.746481408264, 5734.885302294014, 5759.65442073477, 5793.15999180125, 5822.388649191774, 5833.4749872511675, 5836.533077353716, 5847.181394604674, 5435.701036443033, 5738.254026976467, 5748.0, 5748.741306641127, 5751.281089863767, 5645.322561292671, 5695.658260504383, 5811.360750317377, 5813.854653633693, 5816.505597024131, 5646.322441307069, 5677.489025987681, 5683.431656834449, 5685.857853553694, 5696.715164241854], "mootools.html": [1496.4537943650557, 1532.7854100425939, 1643.1948345310798, 1750.553608829749, 1876.3526583328746, 6838.58968461892, 7300.6349682515865, 7411.4070874330055, 7417.332440080391, 7427.851442971138, 7136.714531418737, 7217.386522145611, 7225.674844631991, 7231.096112985877, 7234.421246300297, 1979.2676709617463, 2017.6368253714325, 2244.9102035918545, 2252.1892118837245, 2274.692916456274, 2285.42864283929, 2302.5855346037706, 2305.07796881248, 2306.7693230676964, 2308.9191878284264, 2234.0, 2295.162265772989, 2295.678604995302, 2297.0, 2299.5630830142304, 2004.8295894848955, 2026.4427282497356, 2216.2353987874158, 2285.8857057147075, 2290.484640955788, 2248.449129963153, 2259.7853203945597, 2273.7612550682106, 2280.8403411761183, 2286.8856557172076, 7570.659320330598, 7620.847583048308, 7627.466077374586, 7628.0, 7634.244123851489, 4654.2785868190485, 4720.480747117815, 4725.645576581735, 4726.125666751627, 4733.479317275097, 3021.5165573508352, 3102.8448577571257, 3116.8285744284053, 3141.5287706844156, 3145.795523290979, 995.144176008632, 1007.5566750629699, 1024.9692509224735, 1032.690192942122, 1047.6804574604741, 10313.432761198132, 10403.0, 10403.791924161475, 10406.42764647944, 10415.94792026035, 4042.636162745367, 4088.6524645405475, 4137.958620413818, 4157.875263742093, 4169.958300416957, 8256.8348633027, 8307.958460207781, 8353.498790072616, 8375.036870759941, 8378.748637540884, 4657.813687452532, 4658.301254811805, 4662.53374662531, 4664.323673067454, 4678.6491013174145, 4302.333138363559, 4309.052008558112, 4312.5903039211225, 4312.870613881589, 4319.870403887889, 3360.1431634932937, 3414.8463319150696, 3433.1073920780777, 3434.845431955568, 3435.793852368866, 1088.3361149698678, 1121.4000509727257, 1125.6341688951125, 1127.9548818047185, 1129.971750706239, 1221.3587866370049, 1334.6730051137533, 1343.6909510812568, 1343.8387393512646, 1355.3562058022558, 7035.366816986393, 7042.894356584656, 7058.858822823515, 7076.4692648051605, 7316.926830731731, 1151.1423989127986, 1153.5904753812445, 1159.6984783956063, 1162.6221478019677, 1183.0, 5928.170056192136, 5939.0, 5957.195778569924, 5964.194833697396, 5965.3139888912465, 9002.729918102468, 9411.529423528933, 9412.0, 9413.529323533796, 9419.293552983554, 9371.859422108673, 9378.577963991636, 9380.530973451436, 9399.57701903416, 9406.482643454676, 7083.433325333961, 7165.3551180394015, 7193.820154496179, 7205.927940720526, 7223.061002069802, 7016.929830701832, 7036.261192574911, 7038.472114591528, 7044.753433629799, 7056.082709247765, 8118.431709780495, 8214.178582141738, 8405.49567025956, 8407.53758543286, 8422.199891010345, 8488.533130677624, 8490.23587877094, 8512.616932237941, 8529.232369086812, 8536.061033286209, 6705.932940670726, 6869.244383117953, 6879.89680154788, 6888.484533402643, 6899.310068993061, 7485.4385921055045, 7497.3252407281425, 7509.812254693677, 7565.8108547284555, 7584.393248540214, 6905.1713794345, 6927.861442771015, 7016.824579385556, 7163.3552980232025, 7163.7492687755675, 6491.0, 6701.966490167518, 6932.549384290005, 6983.895241571482, 7046.084009078787, 7150.928490715234, 7161.892571611325, 7174.1032370953635, 7193.892091618525, 7195.136583609791, 6603.570767900071, 6617.735290588323, 6633.2040155181685, 6637.1703537057865, 6646.102776125162, 6627.23786764509, 6630.83422914431, 6644.568103073285, 6655.334466553306, 6662.133922590032], "ext.html": [617.2192176896226, 618.9969050154749, 619.8760247950411, 623.0747340199805, 624.547203277624, 32777.50833737493, 39219.0, 39516.2096758065, 39545.802270988606, 39837.402438963436, 40686.593134068724, 41254.79372603133, 41276.38085428721, 41281.38077928834, 41288.0, 7849.882251766228, 7973.800654983614, 8738.868916966234, 8921.910780892205, 8960.0, 10473.73815654611, 10782.838257426105, 10792.244542882001, 10795.352278863254, 10807.351558906452, 10483.790324193511, 10572.947135264312, 10614.469276536181, 10627.84058239127, 10652.041316281533, 8039.5176289422825, 8193.8361232775, 10483.21375896807, 10643.042126208678, 10940.343579385262, 10391.168706503462, 10510.947445262802, 10518.631847885288, 10528.052475277185, 10534.631287904964, 40416.39375409342, 40696.18607627831, 40776.79611601953, 40789.79605101985, 40851.0, 3216.790908590934, 3221.4040402525607, 3324.6010478742464, 3464.6188919218866, 4052.189562087565, 30375.392492150033, 30707.2323191922, 30729.0, 30785.846070769727, 31025.379492410026, 3068.125584208512, 3079.825892500598, 3129.9827556044374, 3136.670649581784, 3159.57345758322, 250130.0, 250434.0, 251354.0, 251596.0, 252162.0, 56539.71730141405, 57626.135607965916, 58440.0, 58772.4122758767, 64531.0, 59484.7025764877, 59577.40422595719, 59662.10506842401, 59735.0, 59833.0, 14313.212773297568, 14374.712505749827, 14459.421623135167, 14465.78301325481, 14467.348969296196, 10955.671329860117, 11026.889731102587, 11029.83455248172, 11030.613928512625, 11032.0, 19125.139368728163, 19310.32413865508, 19323.227070917004, 19327.420177394702, 19335.12991915367, 8697.652093916298, 8913.910860891438, 8947.507887066144, 8959.41763785352, 8968.820623587491, 914.346242436661, 914.6204325205099, 937.5827756648363, 964.3876138652007, 1001.1940387987594, 27346.863265683543, 27648.0, 28069.43861122807, 28071.71928280691, 28111.57832632512, 980.4901451245313, 982.9557669904729, 1009.4750729620703, 1024.2215915903819, 1029.4801125431609, 13706.109102908278, 13913.304334783423, 13974.301284935713, 14029.649258768408, 14097.436102555783, 772019.0, 773805.0, 780075.0, 780099.0, 781012.0, 57697.4230257692, 58465.12302315469, 58472.41527584755, 58477.0, 58538.4146158533, 1330.7272009238084, 1333.1534475607864, 1338.6385675867461, 1340.383423625124, 1344.7243315120377, 29648.258793530335, 30608.0, 30642.0, 30738.077857664306, 30980.84509577528, 47490.28764568465, 47946.5205347942, 48104.759476202395, 48105.278420823015, 48123.5187648119, 306171.0, 308248.0, 308665.0, 309326.0, 398929.0, 29759.0, 33307.50038749469, 33423.0, 33797.155071123416, 33896.830515847265, 41383.172336553704, 42218.36672449854, 42558.36162457504, 42565.0, 43135.0, 35083.64916350804, 35531.64468355283, 35760.0, 36568.63431365759, 41968.370474442294, 30612.163390013317, 37984.62015379922, 41069.1786164281, 41416.79291603523, 41962.37056444095, 37197.0, 37608.247835042595, 37868.2426351477, 38051.80974095112, 38052.42921356126, 33853.66146338505, 35104.12239694028, 35312.0, 35366.0, 35705.46441803323, 26169.345766355993, 26205.737942621094, 26335.473290534464, 26395.472090558465, 26431.471370572865], "prototype.html": [331.7395844262254, 336.3189541179113, 342.09515830627987, 344.8586079707317, 350.58455729959985, 5863.824085277443, 5868.677222752757, 5877.118432235166, 5877.265341832271, 5878.647281163133, 5778.133280007991, 5779.335376431712, 5787.797427090053, 5792.971035144818, 5798.10129429939, 4553.521880202581, 4560.042391097865, 4566.063956888846, 4567.703099298552, 4568.611668008207, 4448.154850578396, 4515.796789144496, 4518.0, 4528.094381123772, 4534.523874993128, 4503.234450143467, 4505.279155335131, 4507.256302710065, 4508.954910450902, 4513.864584062483, 4329.7618630975285, 4395.428594282723, 4502.392177056088, 4506.076254367847, 4516.0, 3912.8826135215704, 3932.8820135395986, 3950.585188555218, 3971.7815520146382, 3973.562908080109, 5462.071447853875, 5507.284053073075, 5507.7246137692955, 5517.310336207974, 5525.281713377275, 4902.068606964665, 4982.800687972477, 5037.143685573461, 5081.110805609003, 5127.9230811537855, 5948.048312270016, 5951.137085122633, 5956.642601443884, 5964.493018093467, 5972.701364931736, 4312.63342615878, 4312.849050283225, 4314.223439780838, 4314.805833737458, 4315.956840431619, 6014.669193194372, 6169.321374648785, 6170.784022559189, 6171.290301615327, 6175.907361389583, 4483.730976141442, 4484.0, 4485.0805584855025, 4485.708428952108, 4491.214037543416, 4540.818367265339, 4543.1822271990695, 4545.250033744395, 4548.249538826123, 4553.408056952575, 5155.329807125125, 5156.432792392834, 5158.587313014949, 5158.8968220636125, 5163.483651634807, 5940.61386009908, 6049.243844519435, 6114.266288045463, 6121.051237058263, 6123.540734444934, 1560.1107368799676, 1585.1281795012696, 1585.191552308331, 1586.3813112885985, 1586.6192113892582, 1063.3938654966594, 1065.5471424644495, 1081.6971248050559, 1081.853949716794, 1081.967540973772, 5845.035569131131, 5857.414258574108, 5861.648301101947, 5861.677607731615, 5866.208061911588, 6187.071939209155, 6282.308946015934, 6284.905726414107, 6287.717052732546, 6290.779822706183, 5903.557233207526, 5922.0, 5937.406259374115, 5939.821805345847, 5951.970240148771, 3352.3295340931913, 3460.6366331534828, 3460.8961731148106, 3461.7922924624604, 3463.8960831175104, 6536.215654121535, 6537.607743535308, 6541.6402097885075, 6542.6401547914365, 6549.901751473732, 6258.3741625837965, 6455.064015717789, 6456.418922297016, 6458.773942911976, 6466.902996455057, 6429.807105786834, 6445.548811583238, 6470.288268290485, 6519.054737063099, 6529.444997175198, 6208.50331973432, 6227.688615569294, 6228.56400051992, 6231.096491008688, 6233.5636505446, 6010.398960103955, 6152.969235153795, 6165.106059621419, 6169.81490555284, 6172.907406388818, 6465.77369792055, 6483.319251478527, 6484.773032943825, 6486.54594178403, 6572.309907459648, 4315.050688848449, 4322.438083049184, 4323.156984388014, 4325.134973005349, 4325.84859529915, 6271.717772700148, 6277.18396608438, 6279.183706118358, 6279.623222606659, 6293.150424692791, 5952.255968003999, 6112.541559382975, 6114.113453549299, 6116.174316467398, 6120.296165940796, 6054.3340232575265, 6058.545609079425, 6068.908966365596, 6115.84710382244, 6125.509959203164, 5965.403459654, 5965.970170149295, 5971.0, 5971.4327138921735, 5973.641581505123, 5945.583809133492, 6044.637321760709, 6046.27444706638, 6071.332153463204, 6105.48103411215, 5962.07587823888, 5972.611780234444, 5976.19321391624, 5976.432238937294, 5979.641221526722], "yui.html": [718.3104219948849, 742.4060751398883, 796.5300472721095, 838.5974732128582, 875.2691502595333, 11201.047910927571, 11395.658130256084, 11421.600243991463, 11424.485898134582, 11427.942860285697, 13577.253251071186, 13676.65808354789, 13677.042607017513, 13678.863211367909, 13682.794758078637, 674.6323253826677, 683.9521233513656, 827.3174630929477, 829.3075282139406, 847.4449235750593, 836.602613758466, 843.9029511606152, 846.5724808971461, 850.1498501498502, 850.3537311643134, 720.7297263526177, 883.041899539001, 888.3159966825541, 893.7542175901647, 895.2614093372961, 723.6164832638683, 866.3026263857593, 887.7691800131947, 887.7691800131947, 887.8313120507147, 654.4960380507031, 654.6661202786613, 658.1181217168969, 658.2331583704978, 658.2758965138357, 13876.58370248894, 13993.090449120775, 14015.579532614038, 14018.929905350407, 14033.368498417596, 12485.563005294862, 12885.613431597067, 13109.147905386119, 13153.73692526144, 13257.734845303039, 10442.269041167121, 10533.210009249337, 10576.206784491116, 10583.100436462833, 10611.78776424475, 3584.444411116255, 3594.6225646307284, 3596.9280614387826, 3610.584782749991, 3658.1769101952113, 49311.50688493105, 49419.50580494221, 49432.25851612229, 49463.25805112926, 49535.0, 9328.860067098998, 9474.289428292906, 9607.855882161773, 9654.082862128087, 9713.90286097144, 18551.16519756614, 18921.7161742574, 18953.905230474036, 18966.71549926752, 18984.62030759377, 7566.432517561205, 7571.924280757232, 7702.191269916578, 7847.450678452454, 7895.486793358528, 4303.634191093792, 4403.294021758091, 4428.357888106207, 4457.375967364572, 4540.772961351985, 3071.4778487657154, 3109.2848644811365, 3112.0197137901487, 3122.2194451387154, 3123.8594263257755, 471.85372534513726, 474.8836535048866, 480.88699155698384, 481.838584074339, 482.3680977918937, 606.848287928018, 624.7844493649684, 633.5343522510951, 661.2825084783065, 701.4283359062348, 8004.679812807422, 8342.708005219789, 8343.0, 8424.873626895602, 8557.914420855712, 612.3845535237148, 619.7644894939893, 649.3344322069822, 673.2358772792916, 678.9796306110825, 3829.1384438501113, 4041.4948131483566, 4094.815733292009, 4101.46680931477, 4129.566395528486, 66436.33563664398, 67718.0, 67748.6612566934, 67776.32223677798, 67882.66058669773, 56434.0, 58066.70966645224, 58235.41764582384, 58308.41691583115, 59548.70225648844, 51549.74225128925, 51635.48364516382, 52115.21827172596, 53043.734781325846, 53130.73434632802, 7706.499077559941, 7778.688852445839, 7938.483998540077, 8121.0, 8166.7958301042945, 38440.0, 38926.4161037579, 39496.60503395044, 39707.80146099251, 40522.79738601406, 51672.48327516827, 51832.48167518427, 52143.73928130335, 52445.47554524559, 53087.46912530825, 8791.780205494913, 9047.411918225294, 9101.317401195069, 9137.817243655223, 9205.217556507772, 12767.361631918182, 12824.358782061046, 12944.919467090649, 12963.675908102374, 12967.092303538662, 11302.717432064264, 11303.434828258718, 11479.827802583135, 11722.0, 12088.818667719815, 11777.470013849568, 11842.82235766447, 12195.146339756488, 12228.082893782825, 12418.0, 11244.55021799119, 11492.425378730863, 11577.363245021268, 11691.649250522498, 11875.40654746255, 9581.808363832824, 10134.847977280198, 10286.691399258034, 10395.220358472994, 10835.02484776374, 9635.662751803653, 10156.89843101589, 10181.185505159718, 10203.28576999603, 10207.081362677394]}, "summary": {"suite": 6910.769609865356, "subtests": {"jquery.html": {"filtered": 7732.73413357088, "value": 7732.73413357088}, "dojo.html": {"filtered": 5470.1754217127, "value": 5470.1754217127}, "mootools.html": {"filtered": 4461.682740416428, "value": 4461.682740416428}, "ext.html": {"filtered": 19403.065334906136, "value": 19403.065334906136}, "prototype.html": {"filtered": 4639.35505163115, "value": 4639.35505163115}, "yui.html": {"filtered": 6411.47506796709, "value": 6411.47506796709}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-054"}, "testrun": {"date": 1445975530, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151027113035", "branch": "B2G-Inbound", "revision": "2c4b2deaf1e8b715a5f7849dfac8b0d023b96e63"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 159.0, 157.0, 160.0, 159.0, 157.0, 159.0, 161.0, 156.0, 158.0], "ai-astar": [109.0, 110.0, 104.0, 109.0, 111.0, 110.0, 99.0, 111.0, 103.0, 109.0], "imaging-gaussian-blur": [110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0], "audio-beat-detection": [122.0, 119.0, 128.0, 143.0, 132.0, 122.0, 128.0, 122.0, 136.0, 121.0], "json-stringify-tinderbox": [66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 68.0, 67.0, 72.0, 68.0], "stanford-crypto-pbkdf2": [148.0, 144.0, 154.0, 142.0, 142.0, 137.0, 148.0, 141.0, 145.0, 145.0], "json-parse-financial": [57.0, 54.0, 56.0, 56.0, 55.0, 56.0, 55.0, 65.0, 53.0, 54.0], "stanford-crypto-sha256-iterative": [66.0, 66.0, 67.0, 66.0, 68.0, 66.0, 64.0, 66.0, 66.0, 65.0], "audio-fft": [68.0, 73.0, 72.0, 77.0, 70.0, 73.0, 69.0, 69.0, 76.0, 69.0], "imaging-darkroom": [146.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "stanford-crypto-ccm": [117.0, 109.0, 116.0, 123.0, 118.0, 113.0, 114.0, 120.0, 111.0, 121.0], "audio-oscillator": [91.0, 92.0, 135.0, 91.0, 92.0, 91.0, 144.0, 91.0, 91.0, 126.0], "stanford-crypto-aes": [82.0, 83.0, 82.0, 84.0, 85.0, 83.0, 83.0, 82.0, 84.0, 82.0], "imaging-desaturate": [95.0, 95.0, 96.0, 102.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0]}, "summary": {"suite": 1453.7, "subtests": {"audio-fft": {"filtered": 71.6, "value": 71.6}, "stanford-crypto-pbkdf2": {"filtered": 144.6, "value": 144.6}, "audio-beat-detection": {"filtered": 127.3, "value": 127.3}, "stanford-crypto-ccm": {"filtered": 116.2, "value": 116.2}, "imaging-darkroom": {"filtered": 145.0, "value": 145.0}, "json-parse-financial": {"filtered": 56.1, "value": 56.1}, "audio-oscillator": {"filtered": 104.4, "value": 104.4}, "ai-astar": {"filtered": 107.5, "value": 107.5}, "audio-dft": {"filtered": 158.9, "value": 158.9}, "stanford-crypto-sha256-iterative": {"filtered": 66.0, "value": 66.0}, "json-stringify-tinderbox": {"filtered": 67.4, "value": 67.4}, "imaging-gaussian-blur": {"filtered": 109.7, "value": 109.7}, "stanford-crypto-aes": {"filtered": 83.0, "value": 83.0}, "imaging-desaturate": {"filtered": 96.0, "value": 96.0}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-054"}, "testrun": {"date": 1445975530, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151027113035", "branch": "B2G-Inbound", "revision": "2c4b2deaf1e8b715a5f7849dfac8b0d023b96e63"}}, {"talos_counters": {}, "results": {"DeltaBlue": [188.57250612860645], "Encrypt": [281.61081385525205], "NavierStokes": [4822.115384615385], "Decrypt": [5040.201005025126], "Splay": [572.4098454493417], "Richards": [169.9524133242692], "RegExp": [25525.0], "Earley": [808.4074373484236], "Boyer": [11764.70588235294], "RayTrace": [1982.1782178217823]}, "summary": {"suite": 20008.533741052106, "subtests": {"DeltaBlue": {"filtered": 350.62375399999996, "value": 350.62375399999996}, "Encrypt": {"filtered": 945.2087309999996, "value": 945.2087309999996}, "NavierStokes": {"filtered": 307.7487537387835, "value": 307.7487537387835}, "Decrypt": {"filtered": 52.81158424725827, "value": 52.81158424725827}, "Splay": {"filtered": 142.36477700000003, "value": 142.36477700000003}, "RegExp": {"filtered": 35.689911851126354, "value": 35.689911851126354}, "Richards": {"filtered": 207.7169679999999, "value": 207.7169679999999}, "Earley": {"filtered": 824.4147309999997, "value": 824.4147309999997}, "Boyer": {"filtered": 56.64935499999997, "value": 56.64935499999997}, "RayTrace": {"filtered": 373.32112387612375, "value": 373.32112387612375}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-054"}, "testrun": {"date": 1445975530, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151027113035", "branch": "B2G-Inbound", "revision": "2c4b2deaf1e8b715a5f7849dfac8b0d023b96e63"}}] 13:12:21 INFO - RETURN: dromaeo_css: 6910.77 13:12:21 INFO - RETURN: kraken: 1453.70 13:12:21 INFO - RETURN: v8_7: 20008.53 13:12:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20008.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1453.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6910.77"}}} 13:12:21 INFO - Return code: 0 13:12:21 INFO - # TBPL SUCCESS # 13:12:21 INFO - Running post-action listener: _resource_record_post_action 13:12:21 INFO - Running post-run listener: _resource_record_post_run 13:12:22 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 8019968; Write bytes: 465346560; Read time: 1728; Write time: 421960 13:12:22 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 68136960; Read time: 0; Write time: 40064 13:12:22 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 5865472; Write bytes: 397209600; Read time: 1596; Write time: 381896 13:12:22 INFO - Running post-run listener: _upload_blobber_files 13:12:22 INFO - Blob upload gear active. 13:12:22 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:12:22 INFO - Copying logs to upload dir... 13:12:22 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.233335 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-10-27 13:12:22.638342) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-27 13:12:22.642346) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010059 build_url: 'https://queue.taskcluster.net/v1/task/llq7LQvkReSyNQvkTpZvZw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-27 13:12:22.694347) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 13:12:22.694672) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1445973701.408559-962723613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004379 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 13:12:22.744782) ========= ========= Started reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-27 13:12:22.745108) ========= ========= Finished reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-27 13:12:26.879887) =========