builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1448009542.75 results: success (0) buildid: 20151119223034 builduid: 9c993d68588d47dbbed489abf9fe8ada revision: 3835b568092ae3b71adc931d24928670ad7141a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:22.754628) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:22.755094) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:22.755686) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006637 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:22.776622) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:22.776937) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:22.789663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:22.790061) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004662 ========= master_lag: 0.21 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.007874) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.008201) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.008608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.008878) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 00:52:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 77.8M=0s 2015-11-20 00:52:23 (77.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.413728 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.437165) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.437446) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013955 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.486944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.487276) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3835b568092ae3b71adc931d24928670ad7141a7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3835b568092ae3b71adc931d24928670ad7141a7 --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=447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 00:52:23,991 truncating revision to first 12 chars 2015-11-20 00:52:23,991 Setting DEBUG logging. 2015-11-20 00:52:23,991 attempt 1/10 2015-11-20 00:52:23,991 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3835b568092a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 00:52:24,447 unpacking tar archive at: mozilla-central-3835b568092a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.714008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:24.213298) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:24.213594) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:24.227095) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:24.227353) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:24.227714) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-20 00:52:24.227997) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:52:24 INFO - MultiFileLogger online at 20151120 00:52:24 in /builds/slave/test-pgo 00:52:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 00:52:24 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:52:24 INFO - {'append_to_log': False, 00:52:24 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:52:24 INFO - 'blob_upload_branch': 'Firefox', 00:52:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:52:24 INFO - 'branch': 'Firefox', 00:52:24 INFO - 'buildbot_json_path': 'buildprops.json', 00:52:24 INFO - 'config_files': ('talos/linux_config.py',), 00:52:24 INFO - 'default_actions': ('clobber', 00:52:24 INFO - 'read-buildbot-config', 00:52:24 INFO - 'download-and-extract', 00:52:24 INFO - 'populate-webroot', 00:52:24 INFO - 'create-virtualenv', 00:52:24 INFO - 'install', 00:52:24 INFO - 'run-tests'), 00:52:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:52:24 INFO - 'download_minidump_stackwalk': True, 00:52:24 INFO - 'download_symbols': 'ondemand', 00:52:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:52:24 INFO - 'tooltool.py': '/tools/tooltool.py', 00:52:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:52:24 INFO - '/tools/misc-python/virtualenv.py')}, 00:52:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:52:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:52:24 INFO - 'installer_path': 'installer.exe', 00:52:24 INFO - 'log_level': 'info', 00:52:24 INFO - 'log_name': 'talos', 00:52:24 INFO - 'log_to_console': True, 00:52:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:52:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:52:24 INFO - 'opt_config_files': (), 00:52:24 INFO - 'pip_index': False, 00:52:24 INFO - 'sps_profile': False, 00:52:24 INFO - 'sps_profile_interval': 0, 00:52:24 INFO - 'suite': 'dromaeojs', 00:52:24 INFO - 'system_bits': '64', 00:52:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:52:24 INFO - 'title': 'talos-linux64-ix-027', 00:52:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:52:24 INFO - 'use_talos_json': True, 00:52:24 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:52:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:52:24 INFO - 'work_dir': 'build'} 00:52:24 INFO - ##### 00:52:24 INFO - ##### Running clobber step. 00:52:24 INFO - ##### 00:52:24 INFO - Running pre-action listener: _resource_record_pre_action 00:52:24 INFO - Running main action method: clobber 00:52:24 INFO - rmtree: /builds/slave/test-pgo/build 00:52:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:52:25 INFO - Running post-action listener: _resource_record_post_action 00:52:25 INFO - ##### 00:52:25 INFO - ##### Running read-buildbot-config step. 00:52:25 INFO - ##### 00:52:25 INFO - Running pre-action listener: _resource_record_pre_action 00:52:25 INFO - Running main action method: read_buildbot_config 00:52:25 INFO - Using buildbot properties: 00:52:25 INFO - { 00:52:25 INFO - "properties": { 00:52:25 INFO - "buildnumber": 569, 00:52:25 INFO - "product": "firefox", 00:52:25 INFO - "script_repo_revision": "production", 00:52:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 00:52:25 INFO - "repository": "", 00:52:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 00:52:25 INFO - "buildid": "20151119223034", 00:52:25 INFO - "slavename": "talos-linux64-ix-027", 00:52:25 INFO - "pgo_build": "True", 00:52:25 INFO - "basedir": "/builds/slave/test-pgo", 00:52:25 INFO - "project": "", 00:52:25 INFO - "platform": "ubuntu64_hw", 00:52:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:52:25 INFO - "slavebuilddir": "test", 00:52:25 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 00:52:25 INFO - "branch": "mozilla-central", 00:52:25 INFO - "repo_path": "mozilla-central", 00:52:25 INFO - "stage_platform": "linux64-pgo", 00:52:25 INFO - "builduid": "9c993d68588d47dbbed489abf9fe8ada", 00:52:25 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 00:52:25 INFO - }, 00:52:25 INFO - "sourcestamp": { 00:52:25 INFO - "repository": "", 00:52:25 INFO - "hasPatch": false, 00:52:25 INFO - "project": "", 00:52:25 INFO - "branch": "mozilla-central-linux64-pgo-talos", 00:52:25 INFO - "changes": [ 00:52:25 INFO - { 00:52:25 INFO - "category": null, 00:52:25 INFO - "files": [ 00:52:25 INFO - { 00:52:25 INFO - "url": null, 00:52:25 INFO - "name": "https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:52:25 INFO - } 00:52:25 INFO - ], 00:52:25 INFO - "repository": "", 00:52:25 INFO - "rev": "3835b568092ae3b71adc931d24928670ad7141a7", 00:52:25 INFO - "who": "sendchange", 00:52:25 INFO - "when": 1448009500, 00:52:25 INFO - "number": 6687459, 00:52:25 INFO - "comments": "", 00:52:25 INFO - "project": "", 00:52:25 INFO - "at": "Fri 20 Nov 2015 00:51:40", 00:52:25 INFO - "branch": "mozilla-central-linux64-pgo-talos", 00:52:25 INFO - "revlink": "", 00:52:25 INFO - "properties": [ 00:52:25 INFO - [ 00:52:25 INFO - "buildid", 00:52:25 INFO - "20151119223034", 00:52:25 INFO - "Change" 00:52:25 INFO - ], 00:52:25 INFO - [ 00:52:25 INFO - "builduid", 00:52:25 INFO - "9c993d68588d47dbbed489abf9fe8ada", 00:52:25 INFO - "Change" 00:52:25 INFO - ], 00:52:25 INFO - [ 00:52:25 INFO - "pgo_build", 00:52:25 INFO - "True", 00:52:25 INFO - "Change" 00:52:25 INFO - ] 00:52:25 INFO - ], 00:52:25 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 00:52:25 INFO - } 00:52:25 INFO - ], 00:52:25 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 00:52:25 INFO - } 00:52:25 INFO - } 00:52:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:52:25 INFO - Running post-action listener: _resource_record_post_action 00:52:25 INFO - ##### 00:52:25 INFO - ##### Running download-and-extract step. 00:52:25 INFO - ##### 00:52:25 INFO - Running pre-action listener: _resource_record_pre_action 00:52:25 INFO - Running main action method: download_and_extract 00:52:25 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:25 INFO - https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:52:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/test_packages.json 00:52:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/test_packages.json 00:52:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:52:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:52:30 INFO - Downloaded 1302 bytes. 00:52:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:52:30 INFO - Using the following test package requirements: 00:52:30 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:52:30 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:52:30 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:30 INFO - u'jsshell-linux-x86_64.zip'], 00:52:30 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:52:30 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:52:30 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:52:30 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:52:30 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:52:30 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:52:30 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:52:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:30 INFO - https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:52:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:52:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:52:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:52:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:52:42 INFO - Downloaded 22521768 bytes. 00:52:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 00:52:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:52:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:52:43 INFO - Return code: 0 00:52:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:43 INFO - https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:52:51 INFO - Downloaded 22521768 bytes. 00:52:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 00:52:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:52:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:52:52 INFO - Return code: 0 00:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:52 INFO - https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:52:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:52:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:52:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:52:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:52:54 INFO - Downloaded 11130997 bytes. 00:52:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 00:52:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:52:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 00:52:54 INFO - Return code: 0 00:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:54 INFO - https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:52:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:52:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:52:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:52:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:52:57 INFO - Downloaded 57337938 bytes. 00:52:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:52:57 INFO - mkdir: /builds/slave/test-pgo/properties 00:52:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:52:57 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:52:57 INFO - Contents: 00:52:57 INFO - build_url:https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:52:57 INFO - Running post-action listener: _resource_record_post_action 00:52:57 INFO - Running post-action listener: set_extra_try_arguments 00:52:57 INFO - ##### 00:52:57 INFO - ##### Running populate-webroot step. 00:52:57 INFO - ##### 00:52:57 INFO - Running pre-action listener: _resource_record_pre_action 00:52:57 INFO - Running main action method: populate_webroot 00:52:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:52:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:52:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:52:57 INFO - '../fennec_ids.txt'], 00:52:57 INFO - 'tests': ['tcheck2']}, 00:52:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:52:57 INFO - '--tppagecycles', 00:52:57 INFO - '7'], 00:52:57 INFO - 'tests': ['tsvgm']}}, 00:52:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:52:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:52:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:52:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:52:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:52:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:52:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:52:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:57 INFO - 'talos_options': ['--e10s'], 00:52:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:52:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:57 INFO - 'tests': ['damp', 'tps']}, 00:52:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:57 INFO - 'talos_options': ['--e10s'], 00:52:57 INFO - 'tests': ['damp', 'tps']}, 00:52:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:52:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:52:57 INFO - 'other': {'tests': ['a11yr', 00:52:57 INFO - 'ts_paint', 00:52:57 INFO - 'tpaint', 00:52:57 INFO - 'sessionrestore', 00:52:57 INFO - 'sessionrestore_no_auto_restore']}, 00:52:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:52:57 INFO - 'tests': ['a11yr', 00:52:57 INFO - 'ts_paint', 00:52:57 INFO - 'tpaint', 00:52:57 INFO - 'sessionrestore', 00:52:57 INFO - 'sessionrestore_no_auto_restore']}, 00:52:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:52:57 INFO - 'tests': ['a11yr', 00:52:57 INFO - 'ts_paint', 00:52:57 INFO - 'tpaint', 00:52:57 INFO - 'sessionrestore', 00:52:57 INFO - 'sessionrestore_no_auto_restore']}, 00:52:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:52:57 INFO - 'tests': ['a11yr', 00:52:57 INFO - 'ts_paint', 00:52:57 INFO - 'tpaint', 00:52:57 INFO - 'sessionrestore', 00:52:57 INFO - 'sessionrestore_no_auto_restore']}, 00:52:57 INFO - 'other_l64': {'tests': ['a11yr', 00:52:57 INFO - 'ts_paint', 00:52:57 INFO - 'tpaint', 00:52:57 INFO - 'sessionrestore', 00:52:57 INFO - 'sessionrestore_no_auto_restore']}, 00:52:57 INFO - 'other_nol64': {'tests': ['a11yr', 00:52:57 INFO - 'ts_paint', 00:52:57 INFO - 'tpaint', 00:52:57 INFO - 'sessionrestore', 00:52:57 INFO - 'sessionrestore_no_auto_restore']}, 00:52:57 INFO - 'svgr': {'tests': ['tsvgx', 00:52:57 INFO - 'tsvgr_opacity', 00:52:57 INFO - 'tart', 00:52:57 INFO - 'tscrollx', 00:52:57 INFO - 'cart']}, 00:52:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:52:57 INFO - 'tests': ['tsvgx', 00:52:57 INFO - 'tsvgr_opacity', 00:52:57 INFO - 'tart', 00:52:57 INFO - 'tscrollx', 00:52:57 INFO - 'cart']}, 00:52:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:57 INFO - 'tests': ['tp5o']}, 00:52:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:57 INFO - 'talos_options': ['--e10s'], 00:52:57 INFO - 'tests': ['tp5o']}, 00:52:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:57 INFO - 'talos_options': ['--xperf_path', 00:52:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:52:57 INFO - 'tests': ['tp5n']}, 00:52:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:57 INFO - 'talos_options': ['--e10s', 00:52:57 INFO - '--xperf_path', 00:52:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:52:57 INFO - 'tests': ['tp5n']}}, 00:52:57 INFO - 'talos.zip': {'path': '', 00:52:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:52:57 INFO - Running post-action listener: _resource_record_post_action 00:52:57 INFO - ##### 00:52:57 INFO - ##### Running create-virtualenv step. 00:52:57 INFO - ##### 00:52:57 INFO - Running pre-action listener: _resource_record_pre_action 00:52:57 INFO - Running main action method: create_virtualenv 00:52:57 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:52:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 00:52:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:52:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:52:57 INFO - Using real prefix '/usr' 00:52:57 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:52:58 INFO - Installing distribute.............................................................................................................................................................................................done. 00:53:00 INFO - Installing pip.................done. 00:53:00 INFO - Return code: 0 00:53:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fac48157c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22637c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d70>, '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 0x22a8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a8fb0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:53:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 00:53:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:53:00 INFO - Using env: {'DISPLAY': ':0', 00:53:00 INFO - 'HOME': '/home/cltbld', 00:53:00 INFO - 'LANG': 'en_US.UTF-8', 00:53:00 INFO - 'LANGUAGE': 'en_US:en', 00:53:00 INFO - 'LOGNAME': 'cltbld', 00:53:00 INFO - 'MAIL': '/var/mail/cltbld', 00:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:00 INFO - 'MOZ_NO_REMOTE': '1', 00:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:00 INFO - 'NO_EM_RESTART': '1', 00:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:00 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:00 INFO - 'SHELL': '/bin/bash', 00:53:00 INFO - 'SHLVL': '1', 00:53:00 INFO - 'TERM': 'linux', 00:53:00 INFO - 'TMOUT': '86400', 00:53:00 INFO - 'USER': 'cltbld', 00:53:00 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605', 00:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:00 INFO - '_': '/tools/buildbot/bin/python'} 00:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:53:00 INFO - Cleaning up... 00:53:00 INFO - Return code: 0 00:53:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fac48157c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22637c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d70>, '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 0x22a8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a8fb0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:53:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 00:53:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:53:00 INFO - Using env: {'DISPLAY': ':0', 00:53:00 INFO - 'HOME': '/home/cltbld', 00:53:00 INFO - 'LANG': 'en_US.UTF-8', 00:53:00 INFO - 'LANGUAGE': 'en_US:en', 00:53:00 INFO - 'LOGNAME': 'cltbld', 00:53:00 INFO - 'MAIL': '/var/mail/cltbld', 00:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:00 INFO - 'MOZ_NO_REMOTE': '1', 00:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:00 INFO - 'NO_EM_RESTART': '1', 00:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:00 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:00 INFO - 'SHELL': '/bin/bash', 00:53:00 INFO - 'SHLVL': '1', 00:53:00 INFO - 'TERM': 'linux', 00:53:00 INFO - 'TMOUT': '86400', 00:53:00 INFO - 'USER': 'cltbld', 00:53:00 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605', 00:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:00 INFO - '_': '/tools/buildbot/bin/python'} 00:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:00 INFO - Downloading/unpacking psutil>=0.7.1 00:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:02 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:53:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:53:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:53:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:53:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:53:02 INFO - Installing collected packages: psutil 00:53:02 INFO - Running setup.py install for psutil 00:53:02 INFO - building 'psutil._psutil_linux' extension 00:53:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:53:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:53:02 INFO - building 'psutil._psutil_posix' extension 00:53:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:53:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:53:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:53:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:53:02 INFO - Successfully installed psutil 00:53:02 INFO - Cleaning up... 00:53:03 INFO - Return code: 0 00:53:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fac48157c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22637c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d70>, '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 0x22a8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a8fb0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:53:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 00:53:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 00:53:03 INFO - Using env: {'DISPLAY': ':0', 00:53:03 INFO - 'HOME': '/home/cltbld', 00:53:03 INFO - 'LANG': 'en_US.UTF-8', 00:53:03 INFO - 'LANGUAGE': 'en_US:en', 00:53:03 INFO - 'LOGNAME': 'cltbld', 00:53:03 INFO - 'MAIL': '/var/mail/cltbld', 00:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:03 INFO - 'MOZ_NO_REMOTE': '1', 00:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:03 INFO - 'NO_EM_RESTART': '1', 00:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:03 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:03 INFO - 'SHELL': '/bin/bash', 00:53:03 INFO - 'SHLVL': '1', 00:53:03 INFO - 'TERM': 'linux', 00:53:03 INFO - 'TMOUT': '86400', 00:53:03 INFO - 'USER': 'cltbld', 00:53:03 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605', 00:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:03 INFO - '_': '/tools/buildbot/bin/python'} 00:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:53:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:53:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:53:04 INFO - Installing collected packages: mozsystemmonitor 00:53:04 INFO - Running setup.py install for mozsystemmonitor 00:53:05 INFO - Successfully installed mozsystemmonitor 00:53:05 INFO - Cleaning up... 00:53:05 INFO - Return code: 0 00:53:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fac48157c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22637c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d70>, '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 0x22a8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a8fb0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:53:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 00:53:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:53:05 INFO - Using env: {'DISPLAY': ':0', 00:53:05 INFO - 'HOME': '/home/cltbld', 00:53:05 INFO - 'LANG': 'en_US.UTF-8', 00:53:05 INFO - 'LANGUAGE': 'en_US:en', 00:53:05 INFO - 'LOGNAME': 'cltbld', 00:53:05 INFO - 'MAIL': '/var/mail/cltbld', 00:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:05 INFO - 'MOZ_NO_REMOTE': '1', 00:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:05 INFO - 'NO_EM_RESTART': '1', 00:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:05 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:05 INFO - 'SHELL': '/bin/bash', 00:53:05 INFO - 'SHLVL': '1', 00:53:05 INFO - 'TERM': 'linux', 00:53:05 INFO - 'TMOUT': '86400', 00:53:05 INFO - 'USER': 'cltbld', 00:53:05 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605', 00:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:05 INFO - '_': '/tools/buildbot/bin/python'} 00:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:05 INFO - Downloading/unpacking blobuploader==1.2.4 00:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:06 INFO - Downloading blobuploader-1.2.4.tar.gz 00:53:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:53:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:53:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:53:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:53:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:07 INFO - Downloading docopt-0.6.1.tar.gz 00:53:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:53:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:53:07 INFO - Installing collected packages: blobuploader, requests, docopt 00:53:07 INFO - Running setup.py install for blobuploader 00:53:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:53:07 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:53:07 INFO - Running setup.py install for requests 00:53:08 INFO - Running setup.py install for docopt 00:53:08 INFO - Successfully installed blobuploader requests docopt 00:53:08 INFO - Cleaning up... 00:53:08 INFO - Return code: 0 00:53:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:08 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 0x7fac48157c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22637c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d70>, '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 0x22a8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a8fb0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:53:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 00:53:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:53:08 INFO - Using env: {'DISPLAY': ':0', 00:53:08 INFO - 'HOME': '/home/cltbld', 00:53:08 INFO - 'LANG': 'en_US.UTF-8', 00:53:08 INFO - 'LANGUAGE': 'en_US:en', 00:53:08 INFO - 'LOGNAME': 'cltbld', 00:53:08 INFO - 'MAIL': '/var/mail/cltbld', 00:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:08 INFO - 'MOZ_NO_REMOTE': '1', 00:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:08 INFO - 'NO_EM_RESTART': '1', 00:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:08 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:08 INFO - 'SHELL': '/bin/bash', 00:53:08 INFO - 'SHLVL': '1', 00:53:08 INFO - 'TERM': 'linux', 00:53:08 INFO - 'TMOUT': '86400', 00:53:08 INFO - 'USER': 'cltbld', 00:53:08 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605', 00:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:08 INFO - '_': '/tools/buildbot/bin/python'} 00:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:53:08 INFO - Running setup.py (path:/tmp/pip-VjXf2c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:53:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:53:08 INFO - Running setup.py (path:/tmp/pip-bOU2ci-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:53:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:53:08 INFO - Running setup.py (path:/tmp/pip-FK3XuK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:53:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:53:08 INFO - Running setup.py (path:/tmp/pip-hVSZu6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:53:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:53:08 INFO - Running setup.py (path:/tmp/pip-_XybFV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:53:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:53:08 INFO - Running setup.py (path:/tmp/pip-Zmk6Fn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:53:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:53:08 INFO - Running setup.py (path:/tmp/pip-i_tFFs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:53:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:53:08 INFO - Running setup.py (path:/tmp/pip-PNWgta-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:53:09 INFO - Running setup.py (path:/tmp/pip-9dnlZG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:53:09 INFO - Running setup.py (path:/tmp/pip-kMAUlA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:53:09 INFO - Running setup.py (path:/tmp/pip-qLDChr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:53:09 INFO - Running setup.py (path:/tmp/pip-fvWZNm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:53:09 INFO - Running setup.py (path:/tmp/pip-HBhAeO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:53:09 INFO - Running setup.py (path:/tmp/pip-7e5qSF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:53:09 INFO - Running setup.py (path:/tmp/pip-LLHizd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:53:09 INFO - Running setup.py (path:/tmp/pip-BQvOB9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:53:09 INFO - Running setup.py (path:/tmp/pip-3sCE8m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:53:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:53:09 INFO - Running setup.py install for manifestparser 00:53:09 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:53:09 INFO - Running setup.py install for mozcrash 00:53:09 INFO - Running setup.py install for mozdebug 00:53:09 INFO - Running setup.py install for mozdevice 00:53:10 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:53:10 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:53:10 INFO - Running setup.py install for mozfile 00:53:10 INFO - Running setup.py install for mozhttpd 00:53:10 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:53:10 INFO - Running setup.py install for mozinfo 00:53:10 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:53:10 INFO - Running setup.py install for mozInstall 00:53:10 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:53:10 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:53:10 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:53:10 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:53:10 INFO - Running setup.py install for mozleak 00:53:10 INFO - Running setup.py install for mozlog 00:53:10 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:53:10 INFO - Running setup.py install for moznetwork 00:53:10 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:53:10 INFO - Running setup.py install for mozprocess 00:53:10 INFO - Running setup.py install for mozprofile 00:53:11 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:53:11 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:53:11 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:53:11 INFO - Running setup.py install for mozrunner 00:53:11 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:53:11 INFO - Running setup.py install for mozscreenshot 00:53:11 INFO - Running setup.py install for moztest 00:53:11 INFO - Running setup.py install for mozversion 00:53:11 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:53:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:53:11 INFO - Cleaning up... 00:53:11 INFO - Return code: 0 00:53:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:11 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 0x7fac48157c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22637c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d70>, '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 0x22a8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a8fb0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:53:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 00:53:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:53:11 INFO - Using env: {'DISPLAY': ':0', 00:53:11 INFO - 'HOME': '/home/cltbld', 00:53:11 INFO - 'LANG': 'en_US.UTF-8', 00:53:11 INFO - 'LANGUAGE': 'en_US:en', 00:53:11 INFO - 'LOGNAME': 'cltbld', 00:53:11 INFO - 'MAIL': '/var/mail/cltbld', 00:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:11 INFO - 'MOZ_NO_REMOTE': '1', 00:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:11 INFO - 'NO_EM_RESTART': '1', 00:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:11 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:11 INFO - 'SHELL': '/bin/bash', 00:53:11 INFO - 'SHLVL': '1', 00:53:11 INFO - 'TERM': 'linux', 00:53:11 INFO - 'TMOUT': '86400', 00:53:11 INFO - 'USER': 'cltbld', 00:53:11 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605', 00:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:11 INFO - '_': '/tools/buildbot/bin/python'} 00:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:53:11 INFO - Running setup.py (path:/tmp/pip-k2f9qF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:53:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 00:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:53:11 INFO - Running setup.py (path:/tmp/pip-4LlI7C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:53:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:53:11 INFO - Running setup.py (path:/tmp/pip-Ey1spB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:53:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 00:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:53:11 INFO - Running setup.py (path:/tmp/pip-01tH_1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:53:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:53:11 INFO - Running setup.py (path:/tmp/pip-L451eK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 00:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:53:12 INFO - Running setup.py (path:/tmp/pip-sdlK0x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 00:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:53:12 INFO - Running setup.py (path:/tmp/pip-AdIPRH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 00:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:53:12 INFO - Running setup.py (path:/tmp/pip-7QAG7I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 00:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:53:12 INFO - Running setup.py (path:/tmp/pip-FFdE0j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 00:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:53:12 INFO - Running setup.py (path:/tmp/pip-51xOVh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:53:12 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)) 00:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:53:12 INFO - Running setup.py (path:/tmp/pip-_Sm8qY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 00:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:53:12 INFO - Running setup.py (path:/tmp/pip-Djc5MJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 00:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:53:12 INFO - Running setup.py (path:/tmp/pip-6zqjKT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 00:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:53:12 INFO - Running setup.py (path:/tmp/pip-xpgG43-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 00:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:53:12 INFO - Running setup.py (path:/tmp/pip-CtIuAs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 00:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:53:12 INFO - Running setup.py (path:/tmp/pip-oNIWwY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 00:53:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:53:12 INFO - Running setup.py (path:/tmp/pip-WYDqtl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:53:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:14 INFO - Downloading blessings-1.5.1.tar.gz 00:53:14 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 00:53:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:53:14 INFO - Installing collected packages: blessings 00:53:14 INFO - Running setup.py install for blessings 00:53:14 INFO - Successfully installed blessings 00:53:14 INFO - Cleaning up... 00:53:14 INFO - Return code: 0 00:53:14 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:53:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:53:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:53:15 INFO - Reading from file tmpfile_stdout 00:53:15 INFO - Current package versions: 00:53:15 INFO - argparse == 1.2.1 00:53:15 INFO - blessings == 1.5.1 00:53:15 INFO - blobuploader == 1.2.4 00:53:15 INFO - docopt == 0.6.1 00:53:15 INFO - manifestparser == 1.1 00:53:15 INFO - mozInstall == 1.12 00:53:15 INFO - mozcrash == 0.16 00:53:15 INFO - mozdebug == 0.1 00:53:15 INFO - mozdevice == 0.47 00:53:15 INFO - mozfile == 1.2 00:53:15 INFO - mozhttpd == 0.7 00:53:15 INFO - mozinfo == 0.9 00:53:15 INFO - mozleak == 0.1 00:53:15 INFO - mozlog == 3.0 00:53:15 INFO - moznetwork == 0.27 00:53:15 INFO - mozprocess == 0.22 00:53:15 INFO - mozprofile == 0.27 00:53:15 INFO - mozrunner == 6.11 00:53:15 INFO - mozscreenshot == 0.1 00:53:15 INFO - mozsystemmonitor == 0.0 00:53:15 INFO - moztest == 0.7 00:53:15 INFO - mozversion == 1.4 00:53:15 INFO - psutil == 3.1.1 00:53:15 INFO - requests == 1.2.3 00:53:15 INFO - wsgiref == 0.1.2 00:53:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fac48157c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22637c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d70>, '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 0x22a8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a8fb0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:53:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 00:53:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:53:15 INFO - Using env: {'DISPLAY': ':0', 00:53:15 INFO - 'HOME': '/home/cltbld', 00:53:15 INFO - 'LANG': 'en_US.UTF-8', 00:53:15 INFO - 'LANGUAGE': 'en_US:en', 00:53:15 INFO - 'LOGNAME': 'cltbld', 00:53:15 INFO - 'MAIL': '/var/mail/cltbld', 00:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:15 INFO - 'MOZ_NO_REMOTE': '1', 00:53:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:15 INFO - 'NO_EM_RESTART': '1', 00:53:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:15 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:15 INFO - 'SHELL': '/bin/bash', 00:53:15 INFO - 'SHLVL': '1', 00:53:15 INFO - 'TERM': 'linux', 00:53:15 INFO - 'TMOUT': '86400', 00:53:15 INFO - 'USER': 'cltbld', 00:53:15 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605', 00:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:15 INFO - '_': '/tools/buildbot/bin/python'} 00:53:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:53:15 INFO - Cleaning up... 00:53:15 INFO - Return code: 0 00:53:15 INFO - Running post-action listener: _resource_record_post_action 00:53:15 INFO - Running post-action listener: _start_resource_monitoring 00:53:15 INFO - Starting resource monitoring. 00:53:15 INFO - ##### 00:53:15 INFO - ##### Running install step. 00:53:15 INFO - ##### 00:53:15 INFO - Running pre-action listener: _resource_record_pre_action 00:53:15 INFO - Running main action method: install 00:53:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:53:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:53:15 INFO - Reading from file tmpfile_stdout 00:53:15 INFO - Detecting whether we're running mozinstall >=1.0... 00:53:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:53:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:53:15 INFO - Reading from file tmpfile_stdout 00:53:15 INFO - Output received: 00:53:15 INFO - Usage: mozinstall [options] installer 00:53:15 INFO - Options: 00:53:15 INFO - -h, --help show this help message and exit 00:53:15 INFO - -d DEST, --destination=DEST 00:53:15 INFO - Directory to install application into. [default: 00:53:15 INFO - "/builds/slave/test-pgo"] 00:53:15 INFO - --app=APP Application being installed. [default: firefox] 00:53:15 INFO - mkdir: /builds/slave/test-pgo/build/application 00:53:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 00:53:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 00:53:29 INFO - Reading from file tmpfile_stdout 00:53:29 INFO - Output received: 00:53:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:53:29 INFO - Running post-action listener: _resource_record_post_action 00:53:29 INFO - ##### 00:53:29 INFO - ##### Running run-tests step. 00:53:29 INFO - ##### 00:53:29 INFO - Running pre-action listener: _resource_record_pre_action 00:53:29 INFO - Running main action method: run_tests 00:53:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:53:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:53:29 INFO - Python 2.7.3 00:53:29 INFO - Return code: 0 00:53:29 INFO - grabbing minidump binary from tooltool 00:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:29 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 0x22a7d70>, '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 0x22a8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a8fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:53:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 00:53:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:53:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:53:30 INFO - Return code: 0 00:53:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:53:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:53:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:53:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:53:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:53:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 00:53:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost 00:53:30 INFO - Using env: {'DISPLAY': ':0', 00:53:30 INFO - 'HOME': '/home/cltbld', 00:53:30 INFO - 'LANG': 'en_US.UTF-8', 00:53:30 INFO - 'LANGUAGE': 'en_US:en', 00:53:30 INFO - 'LOGNAME': 'cltbld', 00:53:30 INFO - 'MAIL': '/var/mail/cltbld', 00:53:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:53:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:30 INFO - 'MOZ_NO_REMOTE': '1', 00:53:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:53:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:30 INFO - 'NO_EM_RESTART': '1', 00:53:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:30 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:53:30 INFO - 'SHELL': '/bin/bash', 00:53:30 INFO - 'SHLVL': '1', 00:53:30 INFO - 'TERM': 'linux', 00:53:30 INFO - 'TMOUT': '86400', 00:53:30 INFO - 'USER': 'cltbld', 00:53:30 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605', 00:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:30 INFO - '_': '/tools/buildbot/bin/python'} 00:53:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] with output_timeout 3600 00:53:30 INFO - mozversion INFO | application_buildid: 20151119223034 00:53:30 INFO - mozversion INFO | application_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 00:53:30 INFO - mozversion INFO | application_display_name: Nightly 00:53:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:53:30 INFO - mozversion INFO | application_name: Firefox 00:53:30 INFO - mozversion INFO | application_remotingname: firefox 00:53:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 00:53:30 INFO - mozversion INFO | application_vendor: Mozilla 00:53:30 INFO - mozversion INFO | application_version: 45.0a1 00:53:30 INFO - mozversion INFO | platform_buildid: 20151119223034 00:53:30 INFO - mozversion INFO | platform_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 00:53:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 00:53:30 INFO - mozversion INFO | platform_version: 45.0a1 00:53:30 INFO - 2015-11-20 00:53:30,259 DEBUG : using testdate: 1448009610 00:53:30 INFO - 2015-11-20 00:53:30,259 DEBUG : actual date: 1448009610 00:53:30 INFO - 2015-11-20 00:53:30,268 INFO : starting webserver on 'localhost:39026' 00:53:30 INFO - 2015-11-20 00:53:30,269 INFO : Starting test suite talos-linux64-ix-027 00:53:30 INFO - 2015-11-20 00:53:30,269 INFO : Starting test dromaeo_css 00:53:30 INFO - 2015-11-20 00:53:30,269 DEBUG : operating with platform_type : linux_ 00:53:30 INFO - 2015-11-20 00:53:30,270 INFO : Initialising browser for dromaeo_css test... 00:53:30 INFO - 2015-11-20 00:53:30,283 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpis2tZ4/profile http://localhost:39026/getInfo.html 00:53:34 INFO - 2015-11-20 00:53:34,251 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:53:34 INFO - 2015-11-20 00:53:34,251 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:53:34 INFO - 2015-11-20 00:53:34,251 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:53:34 INFO - 2015-11-20 00:53:34,251 DEBUG : BROWSER_OUTPUT: __metrics 00:53:34 INFO - 2015-11-20 00:53:34,501 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:53:35 INFO - 2015-11-20 00:53:35,753 INFO : Browser initialized. 00:53:35 INFO - 2015-11-20 00:53:35,754 INFO : Running cycle 1/1 for dromaeo_css test... 00:53:35 INFO - 2015-11-20 00:53:35,754 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpis2tZ4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:53:47 INFO - 2015-11-20 00:53:47,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 141180928 00:53:47 INFO - 2015-11-20 00:53:47,508 DEBUG : BROWSER_OUTPUT: 00:54:38 INFO - 2015-11-20 00:54:38,900 DEBUG : BROWSER_OUTPUT: 1448009678898 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 00:56:48 INFO - 2015-11-20 00:56:48,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39026/tests/dromaeo/cssquery-ext.html) 00:56:49 INFO - 2015-11-20 00:56:49,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 265420800 00:56:49 INFO - 2015-11-20 00:56:49,349 DEBUG : BROWSER_OUTPUT: 00:59:51 INFO - 2015-11-20 00:59:51,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/dromaeo/cssquery-ext.html (next: http://localhost:39026/tests/dromaeo/cssquery-jquery.html) 00:59:52 INFO - 2015-11-20 00:59:52,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 223735808 00:59:52 INFO - 2015-11-20 00:59:52,269 DEBUG : BROWSER_OUTPUT: 01:02:54 INFO - 2015-11-20 01:02:54,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39026/tests/dromaeo/cssquery-mootools.html) 01:02:54 INFO - 2015-11-20 01:02:54,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 217751552 01:02:54 INFO - 2015-11-20 01:02:54,798 DEBUG : BROWSER_OUTPUT: 01:05:56 INFO - 2015-11-20 01:05:56,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39026/tests/dromaeo/cssquery-prototype.html) 01:05:57 INFO - 2015-11-20 01:05:57,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 201666560 01:05:57 INFO - 2015-11-20 01:05:57,220 DEBUG : BROWSER_OUTPUT: 01:08:59 INFO - 2015-11-20 01:08:59,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39026/tests/dromaeo/cssquery-yui.html) 01:09:00 INFO - 2015-11-20 01:09:00,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 204378112 01:09:00 INFO - 2015-11-20 01:09:00,319 DEBUG : BROWSER_OUTPUT: 01:12:02 INFO - 2015-11-20 01:12:02,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/dromaeo/cssquery-yui.html (next: http://localhost:39026/tests/dromaeo/cssquery-dojo.html) 01:12:03 INFO - 2015-11-20 01:12:03,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 461299712 01:12:03 INFO - 2015-11-20 01:12:03,028 DEBUG : BROWSER_OUTPUT: 01:12:03 INFO - 2015-11-20 01:12:03,029 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:12:03 INFO - 2015-11-20 01:12:03,029 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:12:03 INFO - 2015-11-20 01:12:03,029 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:12:03 INFO - 2015-11-20 01:12:03,030 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:12:03 INFO - 2015-11-20 01:12:03,031 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3180.9681903180967;3221.9838900805494;3262.3149138680874;3267.8692852285926;3284.967150328496;5279.815206467774;5310.867228319294;5315;5403.21653360263;5415.323084614423;5430.185472179165;5482.91775623366;5580.581456390767;5589.552835773138;5589.888202235953;5007.974960125203;5081.517255860687;5085.644004919657;5113.923291150636;5164.251183578379;5043.974780126113;5126.436092029874;5151.793928242866;5157.664751791141;5168.8707782305555;4915.361003069578;5024.572911302544;5061.114304996611;5123.257127716498;5127.743612819363;4979.30289759434;4997.375328083989;4999.400071991348;5002.124628190052;5020.246962955549;4924.679895806761;4954.628402869799;4979.2282196259275;4983.8504844854715;4984.426790919055;5291.550218231455;5322.813701520467;5323.041852466555;5324.281222035014;5423.376311724123;5908.438698323653;5916.763329466816;5927.37762534932;5977.521798256129;5979.252593425822;5965.8806823863715;5970.164177015221;5971.581989260753;5995.880082398371;6025.578209525335;5418.078926582491;5496.560275177976;5523.4200408956485;5526.281583394173;5582.665040097567;5802.506786923074;5833.125031245348;5836.474717275466;5862.472377485961;5865;5816.82549523515;5823.970880145572;5829.329627092854;5839.708014599253;5841.269841269841;5851.765929362778;5857.355690874086;5857.531397488191;5861.794837180678;5901.940980590225;5820.30156381237;5841.591088623755;5846.532277417797;5849.122631605208;5849.590528663038;5657.915131273035;5762.049261871828;5836;5932.169496270526;5932.2584676915385;4596.609288210473;4602.838900638529;4608.88477788058;4619.491855895849;4620.4686461056735;4047.7571345719352;4076.735012224255;4086.264472394938;4116.073883376216;4122.381642753611;5440.646357986719;5549.694766787785;5665.688387138664;5668.716564171775;5671.262735844314;5749.108888122348;5798.9420105799245;5825.126231065289;5840.912386314209;5898.64608123514;5652.349979752381;5653.123765816305;5654.180143879114;5654.4062873398525;5658.971705141448;4965.478624744422;5066.392032956069;5238.7904483820985;5241.764120614582;5257.237700533401;5916.556258280646;5963.821085367446;6039.7282122304605;6042.244719410074;6097.268327800603;6000.729967151401;6027.758889644365;6060.90908636362;6081.966065768742;6116.66358350295;5985.311689155628;6054.212952316171;6072.4264395709915;6297.905531417124;6324.557280990287;5790.855228619318;5858.94141058584;5863.941360586339;5906.468417842415;5911.852203694942;5937.673427961504;5943.52451803846;5950.821475355746;5969.791057312973;6051.364606716232;5670.971645141748;5785.913211301918;5807.593468457337;5810.331811841692;5813.505852002627;5768.2501274834;5768.567357448124;5880.176775251553;5883.823485295448;5932.110183472341;5711.514521265739;5718.428157184248;5757.222774925499;5759.798407055733;5763.135529670583;5616.382197958303;5799.101139323411;5816.563757718103;5859.179714840011;5887.58786884931;5659.179418984307;5738.799142030009;5760.337561180518;5763.7982670606325;5812.68030258323 01:12:03 INFO - 2015-11-20 01:12:03,032 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.2324257660564;582.4641329976424;591.3554225893774;593.1606776411378;603.7645318325854;32225;32908.34183316332;32951.34097318055;32952.17619559512;33013.33973320532;41559;41859.372109418386;41908.74273771784;41966.790166049206;42127.157456850844;8684.088170742076;8820.823583528325;8821.911780882174;8832.425892317011;8836.602352894102;7729.072511298652;7910.208979102102;7913.723019694312;8481.660733570681;8579.399442039059;10403.37579745214;10576.576936922515;10593.788124237512;10615.946920265387;10621.25651204416;10294.794104117913;10394.220433467444;10452.477376131163;10461.320014199053;10476.371417714961;7766.262205090564;7970.960145199237;10282;10417.947910260476;10508.2644214905;40152;40581.39127913084;40596.79701601503;40661.59338406608;40689.186216275804;3260.4131256373844;3327.317899830529;3327.467605183159;3626.709863210937;4049.2711311963835;30319.848400758077;30524;31198.37603247945;31300.217494562592;31767.364652706816;3964.623360780721;4026.6376026157786;4036.091879327157;4044.292248856438;4044.292248856438;273314;273782;274332.999999998;274358;275643;61719;62309;62349;62403;62415;65208;65489;65546.68906621936;65726;65780.6710966442;16370.508884733477;16549.50351489457;16625.833741662427;16781.24484398205;16791.832081679273;12765.872341276654;12781.680457988625;12827.743445131046;12845.614631561068;12852.228866268053;20593.485162870747;20961;21013.474663133544;21051.68422473664;21095.68356474654;7681.423893208032;7692.423068269902;7769.223077692185;7861.371090312761;7870.252326029018;960.2174228004154;969.8157350103457;1004.929654924163;1017.7710015246511;1062.9742298681808;28701.712982869903;28780.856095719806;28823.423531529254;28973.56539651907;29230.85384573106;1007.8840933292765;1021.6373187518473;1026.861373714539;1026.9435181065114;1108.3239224073309;14193.361298741582;14208.360623771749;14496.275186240646;14504.129752214902;14506.492272770402;257722;300929;304112;336169;340776;48936.75531622319;49145.50854491409;49540.50459495431;49619;49637.25544116841;1289.7162624222656;1325.9933700331437;1335.585968349834;1341.5774031180147;1349.480450026727;23194;27682.584761229;27821;28186.43627127405;28377.43245135127;47212.7639361801;47450.52549474461;47559;47640;47745.28382074341;290361;290852;291425;291587;291962;32676.183095422806;32678.183045424055;32833.343333132725;33033.339333213684;45499.317510238034;44805;44904.550954490034;45238.54761452475;45470.31794523151;45862.77068614635;37424.25151497009;37846.62153378431;38381.6161838378;39080.21839563136;39145;37467;37625.811870941565;38246.80876595599;38503.807480962416;38760.6123938757;37158.628413715516;37333.81333093317;37379.81310093432;37438;37488.25023499569;32440;34457.82771086128;34482.20887015626;34929;35034.64965350314;25939.74060259373;26331.605025924244;26625.334366640214;26641;27450.862745686143 01:12:03 INFO - 2015-11-20 01:12:03,034 DEBUG : BROWSER_OUTPUT: |2;jquery.html;350.89297764181913;351.8451881172286;357.0644910334923;357.6227080430146;358.06544917764637;14230.928845355758;14592.41630334788;16353.672926541461;16540.172991350428;17140.48578542644;15904.920475397636;16348.427805026826;16850.494485165465;17413.30346786127;17431;5257.421683614799;5346.091164502024;5351.839444816662;5353.411124776271;5357.276767636377;4034.677225821942;4136.420901073852;5342.732863356836;5727.742251598688;5908.379620139888;5782.797602083928;5791.826245212629;5811.883762324751;5833.241678581779;5848.093545500433;5733.627314224583;5925.466707996301;5925.881482370329;5929.525637948976;5932.555058370639;5206.76569554371;5208.505192006791;5209.348831396075;5212.452692467312;5222.529972302473;10907.454627268684;11315.434228288552;11396;11406.144539159597;11412;2098.7376577927757;2102.8212601928853;2136.3484137338105;2345.3667509772267;2481.3424442522746;8865.955670221672;8949.552522373855;9051;9136.314776391797;9230.953845230732;1793.4261036468336;1864.3102052240622;1867.7478540397144;1880.3982725527837;1898.411492437349;60004;61856;62539.37460625381;63910.68044659794;64836.3516364835;9952.552135153936;10027.247956403298;10282.537285822156;10324.896751032544;10327.74180645475;13181.604551863267;13212.942964562812;13298.135621184592;13299.069065165346;13311.46754129824;7530.322270995636;7579.317861392391;7951.721689740832;8002.5598592077995;8009.038915330081;7954.244346787046;7977.641006154621;7983.441159118806;8028.197180282042;8040.035195776544;4422.204003279377;4451.421315229064;4461.933071003938;4465.441819772528;4482;1708.1117818734187;1743.2504023269862;1756.200928577494;1798.0829776813919;1834.9449516514526;959.4483172176027;984.9162821160138;1034.591336422109;1043.2853495355705;1067.546292825546;13774.793378099337;15596.142212178213;15722.606934826721;15741.921290393475;16143.757843632355;892.3040028777564;912.1653686876566;916.2898753465984;921.6543796076471;970.9757256068655;7770.850817248145;9473;9634.421934683942;9695.127438530566;9759.121679048778;517590;522188;534618;552951;555600.997955093;71753.6412317935;71970;72923;78309;81901;1156.4160099149876;1156.4969238381332;1174.9706257343635;1198.0714945916984;1214.1318956945827;14480.493182738554;14736.852631473977;14746.557603271918;14963;15192;34718.82640586781;34793;35677.46483802797;36504.26991460103;36507.81746091253;46144.769276153405;46534.06931861276;46998.06003879835;49276;49826;8878.200961913459;9134.5432728362;9588.137067663944;9635.181009614262;9643;16162.838371616133;16223;16513.256903439134;17003.14984250807;17092.230849611547;14150;14183.361748721538;14257.786133207803;14548.563543093724;14779.778303325675;13831.170129792245;14144.363503642566;14374.209418482083;14377.56867293983;14820.333085011416;11762.176647634584;12884.48462061507;13645.317734113452;13911.304434778018;14151.150930944177;8849.823003540021;9011.909880901369;9245.907540924505;9544.188743956563;9587.712368628952;9422.858657120012;10828.350298982086;14366.353514091681;14448.494302699355;15279.465218717292 01:12:03 INFO - 2015-11-20 01:12:03,035 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1438.6762978329873;1450.2023886862225;1480.6520467690098;1569.7252980728376;1744.1976690722274;6732.326767323271;7316.5975871327055;7465.029546159005;7484.663190156442;7495.063117110361;7553.660085296161;7684.308412242897;7691.192424795386;7691.307782299592;7710.884336734954;1959.5101224693826;2009.5076706207;2009.9899500502477;2181.1166477576608;2209.812165965895;2023.6053969475959;2191.824654027674;2204.669299605064;2227.654713519407;2227.6881236626887;2101.8108370246673;2121.490842197869;2127.7233959585233;2168.8481806273567;2168.9240876569324;1920.2990908318363;1973.1219607274768;2216.9358707820174;2248.1119957616734;2249.3364457485;2205.977940220593;2257.7516473188102;2265.456290490287;2282.1784157703214;2284.3489605462364;7551.848963020709;7556.962215188943;7621.466497345188;7639.618019099078;7644.197359277251;4517.9774101129615;4562.931556026662;4582.381378513925;4598.402207713009;4614.30785382192;3028.4700177468853;3178.5550022996567;3180.6501284858646;3195.6964088411564;3207.5028370602595;971.0677749360623;979.8481235408523;995.8008398320293;998.1066945084182;1031.2471895516314;10314.535845886878;10321.122704570196;10324.690259292232;10334;10354.79290414195;4048.21059893318;4089;4117.958820411757;4118.9588104118575;4168.458100446923;8944.776380590538;8957.14907083826;8958.417702849294;8961.551922403854;8987.101289870961;4574.725516469022;4580.839670611579;4581.175388430114;4589.770511474413;4589.931151032737;4149.481314835645;4164.437800896901;4166.375043743402;4174.937375939363;4187.706860519735;3668.137987572918;3669.376206044979;3671.210689701727;3671.549737853533;3715.628437156263;1179.5046080645977;1202.6331968749616;1208.383724300613;1209.5947857467847;1216.045404357575;1292.8190053392532;1293.5537239652306;1313.441787240438;1341.7249463859885;1346.7777816660337;7226.819329516699;7246.891296630555;7340.11918569775;7341.265873412616;7345.273860642745;1077.6443773554709;1095.7479779650726;1097.780443911221;1118.5246270335076;1131.5360702112096;5439.619226654176;5516.91724624131;5523.337199536081;5526.557875369961;5655.688937108499;8557.743267701979;8685.522296273639;8790.384673072951;8841.425307355;8950.507722075217;9042.276617870555;9068;9085.409448385833;9147.085291470932;9154.038825923182;6984.126984127086;7025.508214424941;7077.752278670325;7130.393916517154;7165.104361954755;7218.314260145278;7246.130464344313;7280.96359518199;7282.927170728225;7288.016117824238;8074;8117.8376432472205;8186.918130818615;8328.458650187718;8334.374921880762;8332;8345.666173352998;8368.288695460955;8511.659533618833;8545.188207120314;6495.772647957298;6534.235756345665;6551.770688025897;6631.303713110054;6634.701438435185;7295;7331.1569169544055;7335.376492998155;7335.889961650686;7343.118825740945;7007.054047703495;7046.823829404306;7072.045273888165;7136.857262854817;7166.641667916688;6934.16789985205;6955.304469553004;6972.6862291196;7016.1580610325045;7116.46626503004;6853.691583878638;6860.759873404407;6872.278410766798;6872.45020398357;6987.406070483862;6391.648459334781;6433.806985790434;6437.356264373712;6442.742290308335;6446.065320528591;6484.351564843478;6484.383983521558;6509.349065093453;6537.607743535403;6541.116949211795 01:12:03 INFO - 2015-11-20 01:12:03,038 DEBUG : BROWSER_OUTPUT: |4;prototype.html;312.30200501878306;317.0946946467834;318.724303477492;324.68019001283716;326.2414885391464;5980.43185897339;6053.57624966252;6085.786997455084;6102.633841969485;6181.3200547939805;5921.407859214077;6066.332703402633;6090.482309003729;6096.26844778626;6101.871153836543;4642.234031384817;4646.279826626878;4654.534546545336;4656.976715116437;4660.300954856764;4431.556844315559;4517.751523666197;4521.480029796566;4523.8642840714665;4647.419072615923;4487.169873573399;4576.656750743691;4619.56793394049;4629.8148074077;4632.698874573159;4618.237990731542;4621.052684199731;4635.976820115911;4636.235021221528;4639.930401043987;4031.8992025199314;4033.2941735196223;4035.0315924177985;4035.1324465239823;4054.432379466877;5683.54531637468;5782.768689252425;5798.043322851724;5805.651660900359;5809.796657116981;5397.109476936301;5402.91895621566;5405.783768649249;5416.837494875121;5422.8915421691345;6253.062040693887;6503.414692677635;6521.021846722982;6524.445422139124;6527.118838956775;4334.9783251083545;4405.405270288502;4434.2905135178535;4438.4451943507065;4449.466064072332;6702.229243636946;6726.697298621574;6741.696623651997;6753.45972322213;6758.391744742997;4544.568266014723;4546.318052292183;4546.840860569864;4548.590626843534;4550.0217453247715;4424.358468022118;4541.341505481687;4562.270036794097;4605.4933957264675;4612.262038073892;5335.86660333487;5337.332833395825;5337.706426146521;5338.546223570962;5343.305370301836;6576.276609572943;6578.868422631521;6584;6585.703643336062;6588.374104460068;1575.5667191522423;1579.5261421573482;1580.146720770794;1586.1038513240212;1586.6905953338987;1046.0585473074293;1048.4548035021746;1049.2497864027257;1057.6879820452984;1076.208986394999;6281.371862813682;6288.842778930563;6292.433680968643;6294.464970477469;6295.401936815995;6755.425788807908;6759.256481787;6766.6278354689985;6769.221539523018;6769.695363708645;6136.7852125175405;6286.49708023357;6288.213973253343;6296.307406185316;6303.464205542488;3649.489071529988;3677.099110717838;3682.9447558286647;3684.1894783147663;3684.521012268388;7008.754693585802;7012.649367531603;7015.614141222281;7020.297970203041;7026.473014523931;6871.484638652121;6949.826254343682;6952.582845029315;6955.339242771928;6959.686814093277;7070.469714771412;7135.322144396378;7136.536125151849;7137.714491420389;7141.214466408691;6556.2788093308745;6672.633005184762;6675.532712710258;6840.452763778985;6862.862742745017;6735.932640673726;6752.953292239711;6753.797386078426;6757.594544327356;6765.729370825112;7057.929420705727;7060.117485314336;7069;7078.929210707827;7102.076730025064;4540.636749060133;4605.125026245003;4614.676972611885;4622.607078398374;4633.443986721615;6774.898376524257;6783;6785;6786.423154031962;6795.354441328263;6564.212294524687;6575.309592492719;6591.373819487141;6601.768938087144;6613.537052406477;6446.323136070832;6565.113709649328;6576.112224849775;6587.571807832667;6595.043718660863;6471;6471.320511346241;6478.676066196577;6484.610923344426;6486.091947127312;6616.239132499824;6618.569792963442;6624.56940298879;6626.370494802986;6628.171478565179;6329.968350158219;6434.871302573829;6468.8059358219325;6478.125453063776;6485.6108633482145 01:12:03 INFO - 2015-11-20 01:12:03,039 DEBUG : BROWSER_OUTPUT: |5;yui.html;754.7999780058282;771.8572064168128;850.047946300144;867.9305655547553;869.8651708985108;13308.667283317922;13430.529931452389;13453.66365840852;13462.596122116327;13486.393112309945;13104.34478276087;13212.273324967124;13220.206787592751;13226.669333266673;13239.205647661147;668.7191379620547;677.3666621708694;796.8685166947475;811.2455416462687;813.5281536708695;813.9796505087361;816.4733746733383;818.5866137600503;821.4783612406135;823.3495538524559;850.2262940723942;856.04550925718;857.4512312120248;857.8412993596173;858.1804376820153;683.9794806155799;688.9242183359827;837.1084794693662;853.7524118005771;855.1576696953496;624.8781487609917;629.1003864473801;629.3297638015499;629.8236493781749;630.3948209718676;13412.396442160127;13547.729045419135;13561.864381356258;13574.253416062113;13583.932080339633;11686.824697629543;12425.31660758658;12709.17390369623;12960;13168.341582920912;9914.25643076765;9974.700758977242;10060.547275372626;10140.430441182361;10166.440845753481;3498.6501349865066;3587.892363229107;3628.5282913221376;3708.9443658345144;3709.3137769512455;48649.51350486485;49476.257856132186;49719.751401242764;49762.25356619654;49832;9709.009094401186;9816.607335706634;9883.950580247052;10017.29878908484;10186.694399168036;18690.439286821143;18698;18698.81301186998;18729.344472943652;18732.719009214874;6212.4696404534925;6322.747090116436;6958;7044.788656340318;7316.304951029751;3924.038610540436;3968;4052.3313653247474;4120.567340429212;4152.335626299838;3115.9844200778853;3125.1249650098007;3130.3269796993754;3142.9528557071662;3143.9685603144135;558.6536347464516;563.3549585724322;576.4408523731973;579.1717843483858;590.630855715178;532.2840779152111;597.4801922327516;610.8289678889829;659.8650321447103;682.0791930893255;8608;8622.61198246068;8755.693550725695;8777.473351598925;8802;564.340778810048;570.5264630356794;689.4484412470105;699.7061234281614;706.1455638677259;3863.4204869269834;3969.994801079349;3991.1818077294083;4089.9386509202386;4312.439382880206;55065.1740223897;55505;55607.443925561034;55698;55743;53000.73499632477;53183.20225196625;53297.2005419919;54021.45978540243;54033;48743;48773.26840097401;48866.02267954692;49109.50890491121;49896.251556226685;9040;9099.727008189764;9207.815843683224;9243.168114869424;9362.251019918254;35854;36054.8197259012;36639.45040824443;36779.26441471209;36886.446703298934;42054.7897260524;45540.31689524594;47298;47809.52190478051;47874.521254787;11126.554937802397;11195.88804111981;11262.549498020315;11403.885961140615;11490.942545287555;12090.214136081127;12230.816537751763;12593.496260149857;12621.495140194289;12740;11521.942390287995;11567.190296679151;11674.824877627012;11977.64067077989;12081.879181208076;11176.329420234812;11670;11892.844870090134;11902.166848320534;11943.820842687193;7760.45676802641;10162.949185254027;11129.888701112885;11500.137489688139;11615.361155136548;9943.651972180938;10045.949770251102;10171.84742228882;10191.337563058378;10386.272960892666;8747.125287471203;9234.307426942873;9492.288078394286;9628.422294662343;10206.336588121749 01:12:03 INFO - 2015-11-20 01:12:03,039 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:12:03 INFO - 2015-11-20 01:12:03,039 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:12:03 INFO - 2015-11-20 01:12:03,039 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1029 01:12:03 INFO - 2015-11-20 01:12:03,039 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:12:03 INFO - 2015-11-20 01:12:03,039 DEBUG : BROWSER_OUTPUT: __startTimestamp1448010723028__endTimestamp 01:12:03 INFO - 2015-11-20 01:12:03,039 DEBUG : BROWSER_OUTPUT: 01:12:03 INFO - 2015-11-20 01:12:03,039 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:12:03 INFO - 2015-11-20 01:12:03,039 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:12:03 INFO - 2015-11-20 01:12:03,039 DEBUG : BROWSER_OUTPUT: 01:12:03 INFO - 2015-11-20 01:12:03,041 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5491.73 Median:5749.11 stddev:607.30 (10.6%) stddev-sans-first:581.48 01:12:03 INFO - 2015-11-20 01:12:03,041 DEBUG : BROWSER_OUTPUT: Values: 3181.0 3222.0 3262.3 3267.9 3285.0 5279.8 5310.9 5315.0 5403.2 5415.3 5430.2 5482.9 5580.6 5589.6 5589.9 5008.0 5081.5 5085.6 5113.9 5164.3 5044.0 5126.4 5151.8 5157.7 5168.9 4915.4 5024.6 5061.1 5123.3 5127.7 4979.3 4997.4 4999.4 5002.1 5020.2 4924.7 4954.6 4979.2 4983.9 4984.4 5291.6 5322.8 5323.0 5324.3 5423.4 5908.4 5916.8 5927.4 5977.5 5979.3 5965.9 5970.2 5971.6 5995.9 6025.6 5418.1 5496.6 5523.4 5526.3 5582.7 5802.5 5833.1 5836.5 5862.5 5865.0 5816.8 5824.0 5829.3 5839.7 5841.3 5851.8 5857.4 5857.5 5861.8 5901.9 5820.3 5841.6 5846.5 5849.1 5849.6 5657.9 5762.0 5836.0 5932.2 5932.3 4596.6 4602.8 4608.9 4619.5 4620.5 4047.8 4076.7 4086.3 4116.1 4122.4 5440.6 5549.7 5665.7 5668.7 5671.3 5749.1 5798.9 5825.1 5840.9 5898.6 5652.3 5653.1 5654.2 5654.4 5659.0 4965.5 5066.4 5238.8 5241.8 5257.2 5916.6 5963.8 6039.7 6042.2 6097.3 6000.7 6027.8 6060.9 6082.0 6116.7 5985.3 6054.2 6072.4 6297.9 6324.6 5790.9 5858.9 5863.9 5906.5 5911.9 5937.7 5943.5 5950.8 5969.8 6051.4 5671.0 5785.9 5807.6 5810.3 5813.5 5768.3 5768.6 5880.2 5883.8 5932.1 5711.5 5718.4 5757.2 5759.8 5763.1 5616.4 5799.1 5816.6 5859.2 5887.6 5659.2 5738.8 5760.3 5763.8 5812.7 01:12:03 INFO - 2015-11-20 01:12:03,041 DEBUG : BROWSER_OUTPUT: 01:12:03 INFO - 2015-11-20 01:12:03,041 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46861.22 Median:3327.39 stddev:76178.64 (2289.4%) stddev-sans-first:76312.99 01:12:03 INFO - 2015-11-20 01:12:03,041 DEBUG : BROWSER_OUTPUT: Values: 550.2 582.5 591.4 593.2 603.8 32225.0 32908.3 32951.3 32952.2 33013.3 41559.0 41859.4 41908.7 41966.8 42127.2 8684.1 8820.8 8821.9 8832.4 8836.6 7729.1 7910.2 7913.7 8481.7 8579.4 10403.4 10576.6 10593.8 10615.9 10621.3 10294.8 10394.2 10452.5 10461.3 10476.4 7766.3 7971.0 10282.0 10417.9 10508.3 40152.0 40581.4 40596.8 40661.6 40689.2 3260.4 3327.3 3327.5 3626.7 4049.3 30319.8 30524.0 31198.4 31300.2 31767.4 3964.6 4026.6 4036.1 4044.3 4044.3 273314.0 273782.0 274333.0 274358.0 275643.0 61719.0 62309.0 62349.0 62403.0 62415.0 65208.0 65489.0 65546.7 65726.0 65780.7 16370.5 16549.5 16625.8 16781.2 16791.8 12765.9 12781.7 12827.7 12845.6 12852.2 20593.5 20961.0 21013.5 21051.7 21095.7 7681.4 7692.4 7769.2 7861.4 7870.3 960.2 969.8 1004.9 1017.8 1063.0 28701.7 28780.9 28823.4 28973.6 29230.9 1007.9 1021.6 1026.9 1026.9 1108.3 14193.4 14208.4 14496.3 14504.1 14506.5 257722.0 300929.0 304112.0 336169.0 340776.0 48936.8 49145.5 49540.5 49619.0 49637.3 1289.7 1326.0 1335.6 1341.6 1349.5 23194.0 27682.6 27821.0 28186.4 28377.4 47212.8 47450.5 47559.0 47640.0 47745.3 290361.0 290852.0 291425.0 291587.0 291962.0 32676.2 32678.2 32833.3 33033.3 45499.3 44805.0 44904.6 45238.5 45470.3 45862.8 37424.3 37846.6 38381.6 39080.2 39145.0 37467.0 37625.8 38246.8 38503.8 38760.6 37158.6 37333.8 37379.8 37438.0 37488.3 32440.0 34457.8 34482.2 34929.0 35034.6 25939.7 26331.6 26625.3 26641.0 27450.9 01:12:03 INFO - 2015-11-20 01:12:03,041 DEBUG : BROWSER_OUTPUT: 01:12:03 INFO - 2015-11-20 01:12:03,041 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28354.20 Median:20271.25 stddev:87721.99 (432.7%) stddev-sans-first:87942.87 01:12:03 INFO - 2015-11-20 01:12:03,042 DEBUG : BROWSER_OUTPUT: Values: 350.9 351.8 357.1 357.6 358.1 14230.9 14592.4 16353.7 16540.2 17140.5 15904.9 16348.4 16850.5 17413.3 17431.0 5257.4 5346.1 5351.8 5353.4 5357.3 4034.7 4136.4 5342.7 5727.7 5908.4 5782.8 5791.8 5811.9 5833.2 5848.1 5733.6 5925.5 5925.9 5929.5 5932.6 5206.8 5208.5 5209.3 5212.5 5222.5 10907.5 11315.4 11396.0 11406.1 11412.0 2098.7 2102.8 2136.3 2345.4 2481.3 8866.0 8949.6 9051.0 9136.3 9231.0 1793.4 1864.3 1867.7 1880.4 1898.4 60004.0 61856.0 62539.4 63910.7 64836.4 9952.6 10027.2 10282.5 10324.9 10327.7 13181.6 13212.9 13298.1 13299.1 13311.5 7530.3 7579.3 7951.7 8002.6 8009.0 7954.2 7977.6 7983.4 8028.2 8040.0 4422.2 4451.4 4461.9 4465.4 4482.0 1708.1 1743.3 1756.2 1798.1 1834.9 959.4 984.9 1034.6 1043.3 1067.5 13774.8 15596.1 15722.6 15741.9 16143.8 892.3 912.2 916.3 921.7 971.0 7770.9 9473.0 9634.4 9695.1 9759.1 517590.0 522188.0 534618.0 552951.0 555601.0 71753.6 71970.0 72923.0 78309.0 81901.0 1156.4 1156.5 1175.0 1198.1 1214.1 14480.5 14736.9 14746.6 14963.0 15192.0 34718.8 34793.0 35677.5 36504.3 36507.8 46144.8 46534.1 46998.1 49276.0 49826.0 8878.2 9134.5 9588.1 9635.2 9643.0 16162.8 16223.0 16513.3 17003.1 17092.2 14150.0 14183.4 14257.8 14548.6 14779.8 13831.2 14144.4 14374.2 14377.6 14820.3 11762.2 12884.5 13645.3 13911.3 14151.2 8849.8 9011.9 9245.9 9544.2 9587.7 9422.9 10828.4 14366.4 14448.5 15279.5 01:12:03 INFO - 2015-11-20 01:12:03,043 DEBUG : BROWSER_OUTPUT: 01:12:03 INFO - 2015-11-20 01:12:03,043 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5348.23 Median:6465.21 stddev:2745.89 (42.5%) stddev-sans-first:2737.86 01:12:03 INFO - 2015-11-20 01:12:03,044 DEBUG : BROWSER_OUTPUT: Values: 1438.7 1450.2 1480.7 1569.7 1744.2 6732.3 7316.6 7465.0 7484.7 7495.1 7553.7 7684.3 7691.2 7691.3 7710.9 1959.5 2009.5 2010.0 2181.1 2209.8 2023.6 2191.8 2204.7 2227.7 2227.7 2101.8 2121.5 2127.7 2168.8 2168.9 1920.3 1973.1 2216.9 2248.1 2249.3 2206.0 2257.8 2265.5 2282.2 2284.3 7551.8 7557.0 7621.5 7639.6 7644.2 4518.0 4562.9 4582.4 4598.4 4614.3 3028.5 3178.6 3180.7 3195.7 3207.5 971.1 979.8 995.8 998.1 1031.2 10314.5 10321.1 10324.7 10334.0 10354.8 4048.2 4089.0 4118.0 4119.0 4168.5 8944.8 8957.1 8958.4 8961.6 8987.1 4574.7 4580.8 4581.2 4589.8 4589.9 4149.5 4164.4 4166.4 4174.9 4187.7 3668.1 3669.4 3671.2 3671.5 3715.6 1179.5 1202.6 1208.4 1209.6 1216.0 1292.8 1293.6 1313.4 1341.7 1346.8 7226.8 7246.9 7340.1 7341.3 7345.3 1077.6 1095.7 1097.8 1118.5 1131.5 5439.6 5516.9 5523.3 5526.6 5655.7 8557.7 8685.5 8790.4 8841.4 8950.5 9042.3 9068.0 9085.4 9147.1 9154.0 6984.1 7025.5 7077.8 7130.4 7165.1 7218.3 7246.1 7281.0 7282.9 7288.0 8074.0 8117.8 8186.9 8328.5 8334.4 8332.0 8345.7 8368.3 8511.7 8545.2 6495.8 6534.2 6551.8 6631.3 6634.7 7295.0 7331.2 7335.4 7335.9 7343.1 7007.1 7046.8 7072.0 7136.9 7166.6 6934.2 6955.3 6972.7 7016.2 7116.5 6853.7 6860.8 6872.3 6872.5 6987.4 6391.6 6433.8 6437.4 6442.7 6446.1 6484.4 6484.4 6509.3 6537.6 6541.1 01:12:03 INFO - 2015-11-20 01:12:03,044 DEBUG : BROWSER_OUTPUT: 01:12:03 INFO - 2015-11-20 01:12:03,044 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5445.56 Median:6217.19 stddev:1681.32 (27.0%) stddev-sans-first:1641.29 01:12:03 INFO - 2015-11-20 01:12:03,046 DEBUG : BROWSER_OUTPUT: Values: 312.3 317.1 318.7 324.7 326.2 5980.4 6053.6 6085.8 6102.6 6181.3 5921.4 6066.3 6090.5 6096.3 6101.9 4642.2 4646.3 4654.5 4657.0 4660.3 4431.6 4517.8 4521.5 4523.9 4647.4 4487.2 4576.7 4619.6 4629.8 4632.7 4618.2 4621.1 4636.0 4636.2 4639.9 4031.9 4033.3 4035.0 4035.1 4054.4 5683.5 5782.8 5798.0 5805.7 5809.8 5397.1 5402.9 5405.8 5416.8 5422.9 6253.1 6503.4 6521.0 6524.4 6527.1 4335.0 4405.4 4434.3 4438.4 4449.5 6702.2 6726.7 6741.7 6753.5 6758.4 4544.6 4546.3 4546.8 4548.6 4550.0 4424.4 4541.3 4562.3 4605.5 4612.3 5335.9 5337.3 5337.7 5338.5 5343.3 6576.3 6578.9 6584.0 6585.7 6588.4 1575.6 1579.5 1580.1 1586.1 1586.7 1046.1 1048.5 1049.2 1057.7 1076.2 6281.4 6288.8 6292.4 6294.5 6295.4 6755.4 6759.3 6766.6 6769.2 6769.7 6136.8 6286.5 6288.2 6296.3 6303.5 3649.5 3677.1 3682.9 3684.2 3684.5 7008.8 7012.6 7015.6 7020.3 7026.5 6871.5 6949.8 6952.6 6955.3 6959.7 7070.5 7135.3 7136.5 7137.7 7141.2 6556.3 6672.6 6675.5 6840.5 6862.9 6735.9 6753.0 6753.8 6757.6 6765.7 7057.9 7060.1 7069.0 7078.9 7102.1 4540.6 4605.1 4614.7 4622.6 4633.4 6774.9 6783.0 6785.0 6786.4 6795.4 6564.2 6575.3 6591.4 6601.8 6613.5 6446.3 6565.1 6576.1 6587.6 6595.0 6471.0 6471.3 6478.7 6484.6 6486.1 6616.2 6618.6 6624.6 6626.4 6628.2 6330.0 6434.9 6468.8 6478.1 6485.6 01:12:03 INFO - 2015-11-20 01:12:03,046 DEBUG : BROWSER_OUTPUT: 01:12:03 INFO - 2015-11-20 01:12:03,046 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14024.75 Median:48758.13 stddev:16339.92 (33.5%) stddev-sans-first:16355.37 01:12:03 INFO - 2015-11-20 01:12:03,046 DEBUG : BROWSER_OUTPUT: Values: 754.8 771.9 850.0 867.9 869.9 13308.7 13430.5 13453.7 13462.6 13486.4 13104.3 13212.3 13220.2 13226.7 13239.2 668.7 677.4 796.9 811.2 813.5 814.0 816.5 818.6 821.5 823.3 850.2 856.0 857.5 857.8 858.2 684.0 688.9 837.1 853.8 855.2 624.9 629.1 629.3 629.8 630.4 13412.4 13547.7 13561.9 13574.3 13583.9 11686.8 12425.3 12709.2 12960.0 13168.3 9914.3 9974.7 10060.5 10140.4 10166.4 3498.7 3587.9 3628.5 3708.9 3709.3 48649.5 49476.3 49719.8 49762.3 49832.0 9709.0 9816.6 9884.0 10017.3 10186.7 18690.4 18698.0 18698.8 18729.3 18732.7 6212.5 6322.7 6958.0 7044.8 7316.3 3924.0 3968.0 4052.3 4120.6 4152.3 3116.0 3125.1 3130.3 3143.0 3144.0 558.7 563.4 576.4 579.2 590.6 532.3 597.5 610.8 659.9 682.1 8608.0 8622.6 8755.7 8777.5 8802.0 564.3 570.5 689.4 699.7 706.1 3863.4 3970.0 3991.2 4089.9 4312.4 55065.2 55505.0 55607.4 55698.0 55743.0 53000.7 53183.2 53297.2 54021.5 54033.0 48743.0 48773.3 48866.0 49109.5 49896.3 9040.0 9099.7 9207.8 9243.2 9362.3 35854.0 36054.8 36639.5 36779.3 36886.4 42054.8 45540.3 47298.0 47809.5 47874.5 11126.6 11195.9 11262.5 11403.9 11490.9 12090.2 12230.8 12593.5 12621.5 12740.0 11521.9 11567.2 11674.8 11977.6 12081.9 11176.3 11670.0 11892.8 11902.2 11943.8 7760.5 10162.9 11129.9 11500.1 11615.4 9943.7 10045.9 10171.8 10191.3 10386.3 8747.1 9234.3 9492.3 9628.4 10206.3 01:12:03 INFO - 2015-11-20 01:12:03,046 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:12:03 INFO - 2015-11-20 01:12:03,046 DEBUG : BROWSER_OUTPUT: 01:12:03 INFO - 2015-11-20 01:12:03,777 INFO : Browser exited with error code: 0 01:12:03 INFO - 2015-11-20 01:12:03,794 INFO : Completed test dromaeo_css (00:18:33) 01:12:03 INFO - 2015-11-20 01:12:03,794 INFO : Starting test kraken 01:12:03 INFO - 2015-11-20 01:12:03,794 DEBUG : operating with platform_type : linux_ 01:12:03 INFO - 2015-11-20 01:12:03,794 INFO : Initialising browser for kraken test... 01:12:03 INFO - 2015-11-20 01:12:03,800 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAonI5u/profile http://localhost:39026/getInfo.html 01:12:07 INFO - 2015-11-20 01:12:07,748 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:12:07 INFO - 2015-11-20 01:12:07,748 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:12:07 INFO - 2015-11-20 01:12:07,748 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:12:07 INFO - 2015-11-20 01:12:07,748 DEBUG : BROWSER_OUTPUT: __metrics 01:12:07 INFO - 2015-11-20 01:12:07,837 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:12:09 INFO - 2015-11-20 01:12:09,269 INFO : Browser initialized. 01:12:09 INFO - 2015-11-20 01:12:09,270 INFO : Running cycle 1/1 for kraken test... 01:12:09 INFO - 2015-11-20 01:12:09,270 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAonI5u/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:12:21 INFO - 2015-11-20 01:12:21,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 141230080 01:12:21 INFO - 2015-11-20 01:12:21,064 DEBUG : BROWSER_OUTPUT: 01:12:23 INFO - 2015-11-20 01:12:23,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39026/tests/kraken/driver.html?testName=audio-beat-detection) 01:12:24 INFO - 2015-11-20 01:12:24,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 179322880 01:12:24 INFO - 2015-11-20 01:12:24,086 DEBUG : BROWSER_OUTPUT: 01:12:26 INFO - 2015-11-20 01:12:26,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39026/tests/kraken/driver.html?testName=audio-dft) 01:12:27 INFO - 2015-11-20 01:12:27,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 168763392 01:12:27 INFO - 2015-11-20 01:12:27,281 DEBUG : BROWSER_OUTPUT: 01:12:30 INFO - 2015-11-20 01:12:30,180 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39026/tests/kraken/driver.html?testName=audio-fft) 01:12:30 INFO - 2015-11-20 01:12:30,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 151699456 01:12:30 INFO - 2015-11-20 01:12:30,741 DEBUG : BROWSER_OUTPUT: 01:12:32 INFO - 2015-11-20 01:12:32,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39026/tests/kraken/driver.html?testName=audio-oscillator) 01:12:33 INFO - 2015-11-20 01:12:33,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 154148864 01:12:33 INFO - 2015-11-20 01:12:33,294 DEBUG : BROWSER_OUTPUT: 01:12:35 INFO - 2015-11-20 01:12:35,459 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39026/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:12:36 INFO - 2015-11-20 01:12:36,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 155009024 01:12:36 INFO - 2015-11-20 01:12:36,020 DEBUG : BROWSER_OUTPUT: 01:12:38 INFO - 2015-11-20 01:12:38,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39026/tests/kraken/driver.html?testName=imaging-darkroom) 01:12:39 INFO - 2015-11-20 01:12:39,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 155291648 01:12:39 INFO - 2015-11-20 01:12:39,473 DEBUG : BROWSER_OUTPUT: 01:12:42 INFO - 2015-11-20 01:12:42,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39026/tests/kraken/driver.html?testName=imaging-desaturate) 01:12:43 INFO - 2015-11-20 01:12:43,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 158461952 01:12:43 INFO - 2015-11-20 01:12:43,453 DEBUG : BROWSER_OUTPUT: 01:12:46 INFO - 2015-11-20 01:12:46,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39026/tests/kraken/driver.html?testName=json-parse-financial) 01:12:46 INFO - 2015-11-20 01:12:46,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 156430336 01:12:46 INFO - 2015-11-20 01:12:46,795 DEBUG : BROWSER_OUTPUT: 01:12:48 INFO - 2015-11-20 01:12:48,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39026/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:12:48 INFO - 2015-11-20 01:12:48,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 164532224 01:12:48 INFO - 2015-11-20 01:12:48,925 DEBUG : BROWSER_OUTPUT: 01:12:50 INFO - 2015-11-20 01:12:50,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39026/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:12:51 INFO - 2015-11-20 01:12:51,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 162197504 01:12:51 INFO - 2015-11-20 01:12:51,303 DEBUG : BROWSER_OUTPUT: 01:12:53 INFO - 2015-11-20 01:12:53,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39026/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:12:53 INFO - 2015-11-20 01:12:53,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 169181184 01:12:53 INFO - 2015-11-20 01:12:53,969 DEBUG : BROWSER_OUTPUT: 01:12:56 INFO - 2015-11-20 01:12:56,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39026/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:12:56 INFO - 2015-11-20 01:12:56,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 180604928 01:12:56 INFO - 2015-11-20 01:12:56,946 DEBUG : BROWSER_OUTPUT: 01:12:59 INFO - 2015-11-20 01:12:59,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39026/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:13:00 INFO - 2015-11-20 01:13:00,088 DEBUG : BROWSER_OUTPUT: RSS: Main: 179036160 01:13:00 INFO - 2015-11-20 01:13:00,088 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-11-20 01:13:01,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39026/tests/kraken/driver.html?testName=ai-astar) 01:13:01 INFO - 2015-11-20 01:13:01,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 237645824 01:13:01 INFO - 2015-11-20 01:13:01,998 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:01,999 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:13:02 INFO - 2015-11-20 01:13:02,000 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:13:02 INFO - 2015-11-20 01:13:02,000 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:13:02 INFO - 2015-11-20 01:13:02,000 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:13:02 INFO - 2015-11-20 01:13:02,001 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;104;109;110;110;99;111;113;109 01:13:02 INFO - 2015-11-20 01:13:02,001 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;123;150;177;132;150;155;132;168;125 01:13:02 INFO - 2015-11-20 01:13:02,001 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;162;160;160;160;160;163;161;163 01:13:02 INFO - 2015-11-20 01:13:02,002 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;84;98;72;72;71;107;91;72 01:13:02 INFO - 2015-11-20 01:13:02,002 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;91;135;90;90;90;137;89;91;144 01:13:02 INFO - 2015-11-20 01:13:02,002 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;110;109;109;109;110;109 01:13:02 INFO - 2015-11-20 01:13:02,002 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;146;145;145;146;145;144;147 01:13:02 INFO - 2015-11-20 01:13:02,002 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;97;96;96;96;95 01:13:02 INFO - 2015-11-20 01:13:02,003 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;59;60;60;60;59;59;67;58;59 01:13:02 INFO - 2015-11-20 01:13:02,003 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;68;69;70;69;69;69;69;69 01:13:02 INFO - 2015-11-20 01:13:02,003 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;92;84;84;92;85;86;86;87;85 01:13:02 INFO - 2015-11-20 01:13:02,003 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;124;119;117;119;117;124;120;123;117 01:13:02 INFO - 2015-11-20 01:13:02,003 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;153;151;151;157;139;151;149;151;141 01:13:02 INFO - 2015-11-20 01:13:02,004 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;68;68;66;69;66;68;68;66;66 01:13:02 INFO - 2015-11-20 01:13:02,004 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:13:02 INFO - 2015-11-20 01:13:02,004 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:13:02 INFO - 2015-11-20 01:13:02,004 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,920 01:13:02 INFO - 2015-11-20 01:13:02,004 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:13:02 INFO - 2015-11-20 01:13:02,005 DEBUG : BROWSER_OUTPUT: __startTimestamp1448010781999__endTimestamp 01:13:02 INFO - 2015-11-20 01:13:02,005 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,008 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:13:02 INFO - 2015-11-20 01:13:02,008 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:13:02 INFO - 2015-11-20 01:13:02,008 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,009 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:4.01 (3.6%) stddev-sans-first:4.24 01:13:02 INFO - 2015-11-20 01:13:02,009 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 104.0 109.0 110.0 110.0 99.0 111.0 113.0 109.0 01:13:02 INFO - 2015-11-20 01:13:02,009 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,009 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.90 Median:152.50 stddev:18.36 (12.0%) stddev-sans-first:19.10 01:13:02 INFO - 2015-11-20 01:13:02,009 DEBUG : BROWSER_OUTPUT: Values: 157.0 123.0 150.0 177.0 132.0 150.0 155.0 132.0 168.0 125.0 01:13:02 INFO - 2015-11-20 01:13:02,009 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,009 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.90 Median:160.50 stddev:1.29 (0.8%) stddev-sans-first:1.32 01:13:02 INFO - 2015-11-20 01:13:02,010 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 162.0 160.0 160.0 160.0 160.0 163.0 161.0 163.0 01:13:02 INFO - 2015-11-20 01:13:02,010 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,010 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.20 Median:72.50 stddev:13.17 (18.2%) stddev-sans-first:13.63 01:13:02 INFO - 2015-11-20 01:13:02,010 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 84.0 98.0 72.0 72.0 71.0 107.0 91.0 72.0 01:13:02 INFO - 2015-11-20 01:13:02,010 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,010 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.60 Median:90.00 stddev:23.62 (26.2%) stddev-sans-first:24.37 01:13:02 INFO - 2015-11-20 01:13:02,010 DEBUG : BROWSER_OUTPUT: Values: 89.0 91.0 135.0 90.0 90.0 90.0 137.0 89.0 91.0 144.0 01:13:02 INFO - 2015-11-20 01:13:02,010 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,010 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:13:02 INFO - 2015-11-20 01:13:02,010 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 110.0 109.0 109.0 109.0 110.0 109.0 01:13:02 INFO - 2015-11-20 01:13:02,010 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,011 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 01:13:02 INFO - 2015-11-20 01:13:02,011 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 146.0 145.0 145.0 146.0 145.0 144.0 147.0 01:13:02 INFO - 2015-11-20 01:13:02,011 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,011 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 01:13:02 INFO - 2015-11-20 01:13:02,011 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 97.0 96.0 96.0 96.0 95.0 01:13:02 INFO - 2015-11-20 01:13:02,011 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,012 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.10 Median:60.00 stddev:2.51 (4.2%) stddev-sans-first:2.67 01:13:02 INFO - 2015-11-20 01:13:02,012 DEBUG : BROWSER_OUTPUT: Values: 60.0 59.0 60.0 60.0 60.0 59.0 59.0 67.0 58.0 59.0 01:13:02 INFO - 2015-11-20 01:13:02,012 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,012 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 01:13:02 INFO - 2015-11-20 01:13:02,012 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 68.0 69.0 70.0 69.0 69.0 69.0 69.0 69.0 01:13:02 INFO - 2015-11-20 01:13:02,012 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,013 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.00 stddev:3.30 (3.8%) stddev-sans-first:3.11 01:13:02 INFO - 2015-11-20 01:13:02,013 DEBUG : BROWSER_OUTPUT: Values: 82.0 92.0 84.0 84.0 92.0 85.0 86.0 86.0 87.0 85.0 01:13:02 INFO - 2015-11-20 01:13:02,013 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,013 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:120.00 stddev:2.79 (2.3%) stddev-sans-first:2.96 01:13:02 INFO - 2015-11-20 01:13:02,013 DEBUG : BROWSER_OUTPUT: Values: 120.0 124.0 119.0 117.0 119.0 117.0 124.0 120.0 123.0 117.0 01:13:02 INFO - 2015-11-20 01:13:02,013 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,013 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.50 Median:151.00 stddev:5.84 (3.9%) stddev-sans-first:5.70 01:13:02 INFO - 2015-11-20 01:13:02,013 DEBUG : BROWSER_OUTPUT: Values: 142.0 153.0 151.0 151.0 157.0 139.0 151.0 149.0 151.0 141.0 01:13:02 INFO - 2015-11-20 01:13:02,013 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,013 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 01:13:02 INFO - 2015-11-20 01:13:02,014 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 66.0 69.0 66.0 68.0 68.0 66.0 66.0 01:13:02 INFO - 2015-11-20 01:13:02,014 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:13:02 INFO - 2015-11-20 01:13:02,014 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,881 INFO : Browser exited with error code: 0 01:13:02 INFO - 2015-11-20 01:13:02,936 INFO : Completed test kraken (00:00:59) 01:13:02 INFO - 2015-11-20 01:13:02,936 INFO : Starting test v8_7 01:13:02 INFO - 2015-11-20 01:13:02,936 DEBUG : operating with platform_type : linux_ 01:13:02 INFO - 2015-11-20 01:13:02,936 INFO : Initialising browser for v8_7 test... 01:13:02 INFO - 2015-11-20 01:13:02,942 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbXkBgO/profile http://localhost:39026/getInfo.html 01:13:07 INFO - 2015-11-20 01:13:07,021 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:13:07 INFO - 2015-11-20 01:13:07,021 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:13:07 INFO - 2015-11-20 01:13:07,021 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:13:07 INFO - 2015-11-20 01:13:07,021 DEBUG : BROWSER_OUTPUT: __metrics 01:13:07 INFO - 2015-11-20 01:13:07,190 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:13:08 INFO - 2015-11-20 01:13:08,412 INFO : Browser initialized. 01:13:08 INFO - 2015-11-20 01:13:08,413 INFO : Running cycle 1/1 for v8_7 test... 01:13:08 INFO - 2015-11-20 01:13:08,413 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbXkBgO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:13:20 INFO - 2015-11-20 01:13:20,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 142311424 01:13:20 INFO - 2015-11-20 01:13:20,210 DEBUG : BROWSER_OUTPUT: 01:13:41 INFO - 2015-11-20 01:13:41,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39026/tests/v8_7/run.html (next: http://localhost:39026/tests/v8_7/run.html) 01:13:41 INFO - 2015-11-20 01:13:41,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 538124288 01:13:41 INFO - 2015-11-20 01:13:41,859 DEBUG : BROWSER_OUTPUT: 01:13:41 INFO - 2015-11-20 01:13:41,859 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:13:41 INFO - 2015-11-20 01:13:41,859 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:13:41 INFO - 2015-11-20 01:13:41,859 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:13:41 INFO - 2015-11-20 01:13:41,860 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:13:41 INFO - 2015-11-20 01:13:41,860 DEBUG : BROWSER_OUTPUT: |0;Richards;163.1321370309951 01:13:41 INFO - 2015-11-20 01:13:41,860 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.5014137606032 01:13:41 INFO - 2015-11-20 01:13:41,860 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.45229383619477 01:13:41 INFO - 2015-11-20 01:13:41,860 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 01:13:41 INFO - 2015-11-20 01:13:41,860 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1984.126984126984 01:13:41 INFO - 2015-11-20 01:13:41,861 DEBUG : BROWSER_OUTPUT: |5;Earley;777.000777000777 01:13:41 INFO - 2015-11-20 01:13:41,861 DEBUG : BROWSER_OUTPUT: |6;Boyer;12365.853658536585 01:13:41 INFO - 2015-11-20 01:13:41,861 DEBUG : BROWSER_OUTPUT: |7;RegExp;26128.20512820513 01:13:41 INFO - 2015-11-20 01:13:41,861 DEBUG : BROWSER_OUTPUT: |8;Splay;586.1664712778429 01:13:41 INFO - 2015-11-20 01:13:41,861 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 01:13:41 INFO - 2015-11-20 01:13:41,861 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:13:41 INFO - 2015-11-20 01:13:41,861 DEBUG : BROWSER_OUTPUT: __startTimestamp1448010821856__endTimestamp 01:13:41 INFO - 2015-11-20 01:13:41,861 DEBUG : BROWSER_OUTPUT: 01:13:41 INFO - 2015-11-20 01:13:41,861 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:13:41 INFO - 2015-11-20 01:13:41,861 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:13:41 INFO - 2015-11-20 01:13:41,862 DEBUG : BROWSER_OUTPUT: 01:13:41 INFO - 2015-11-20 01:13:41,862 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.13 Median:163.13 stddev:0.00 (0.0%) 01:13:41 INFO - 2015-11-20 01:13:41,862 DEBUG : BROWSER_OUTPUT: Values: 163.1 01:13:41 INFO - 2015-11-20 01:13:41,862 DEBUG : BROWSER_OUTPUT: 01:13:41 INFO - 2015-11-20 01:13:41,862 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.50 Median:188.50 stddev:0.00 (0.0%) 01:13:41 INFO - 2015-11-20 01:13:41,862 DEBUG : BROWSER_OUTPUT: Values: 188.5 01:13:41 INFO - 2015-11-20 01:13:41,862 DEBUG : BROWSER_OUTPUT: 01:13:41 INFO - 2015-11-20 01:13:41,862 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.45 Median:281.45 stddev:0.00 (0.0%) 01:13:41 INFO - 2015-11-20 01:13:41,862 DEBUG : BROWSER_OUTPUT: Values: 281.5 01:13:41 INFO - 2015-11-20 01:13:41,862 DEBUG : BROWSER_OUTPUT: 01:13:41 INFO - 2015-11-20 01:13:41,862 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 01:13:41 INFO - 2015-11-20 01:13:41,862 DEBUG : BROWSER_OUTPUT: Values: 5035.2 01:13:41 INFO - 2015-11-20 01:13:41,863 DEBUG : BROWSER_OUTPUT: 01:13:41 INFO - 2015-11-20 01:13:41,863 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1984.13 Median:1984.13 stddev:0.00 (0.0%) 01:13:41 INFO - 2015-11-20 01:13:41,863 DEBUG : BROWSER_OUTPUT: Values: 1984.1 01:13:41 INFO - 2015-11-20 01:13:41,863 DEBUG : BROWSER_OUTPUT: 01:13:41 INFO - 2015-11-20 01:13:41,863 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:777.00 Median:777.00 stddev:0.00 (0.0%) 01:13:41 INFO - 2015-11-20 01:13:41,863 DEBUG : BROWSER_OUTPUT: Values: 777.0 01:13:41 INFO - 2015-11-20 01:13:41,863 DEBUG : BROWSER_OUTPUT: 01:13:41 INFO - 2015-11-20 01:13:41,863 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12365.85 Median:12365.85 stddev:0.00 (0.0%) 01:13:41 INFO - 2015-11-20 01:13:41,864 DEBUG : BROWSER_OUTPUT: Values: 12365.9 01:13:41 INFO - 2015-11-20 01:13:41,864 DEBUG : BROWSER_OUTPUT: 01:13:41 INFO - 2015-11-20 01:13:41,864 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26128.21 Median:26128.21 stddev:0.00 (0.0%) 01:13:41 INFO - 2015-11-20 01:13:41,864 DEBUG : BROWSER_OUTPUT: Values: 26128.2 01:13:41 INFO - 2015-11-20 01:13:41,864 DEBUG : BROWSER_OUTPUT: 01:13:41 INFO - 2015-11-20 01:13:41,864 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:586.17 Median:586.17 stddev:0.00 (0.0%) 01:13:41 INFO - 2015-11-20 01:13:41,864 DEBUG : BROWSER_OUTPUT: Values: 586.2 01:13:41 INFO - 2015-11-20 01:13:41,864 DEBUG : BROWSER_OUTPUT: 01:13:41 INFO - 2015-11-20 01:13:41,864 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 01:13:41 INFO - 2015-11-20 01:13:41,864 DEBUG : BROWSER_OUTPUT: Values: 4822.1 01:13:41 INFO - 2015-11-20 01:13:41,864 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:13:41 INFO - 2015-11-20 01:13:41,864 DEBUG : BROWSER_OUTPUT: 01:13:42 INFO - 2015-11-20 01:13:42,721 INFO : Browser exited with error code: 0 01:13:42 INFO - 2015-11-20 01:13:42,738 INFO : Completed test v8_7 (00:00:39) 01:13:42 INFO - 2015-11-20 01:13:42,883 INFO : Completed test suite (00:20:12) 01:13:42 INFO - 2015-11-20 01:13:42,883 DEBUG : Working with test: dromaeo_css 01:13:42 INFO - 2015-11-20 01:13:42,883 DEBUG : Generating results file: dromaeo_css 01:13:42 INFO - 2015-11-20 01:13:42,884 DEBUG : Working with test: kraken 01:13:42 INFO - 2015-11-20 01:13:42,885 DEBUG : Generating results file: kraken 01:13:42 INFO - 2015-11-20 01:13:42,885 INFO : javascript benchmark 01:13:42 INFO - 2015-11-20 01:13:42,885 DEBUG : Working with test: v8_7 01:13:42 INFO - 2015-11-20 01:13:42,885 DEBUG : Generating results file: v8_7 01:13:42 INFO - 2015-11-20 01:13:42,886 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:13:42 INFO - 2015-11-20 01:13:42,931 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 01:13:42 INFO - 2015-11-20 01:13:42,931 DEBUG : process_Request line: dromaeo_css 7048.62 graph.html#tests=[[72,1,35]] 01:13:42 INFO - 2015-11-20 01:13:42,932 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:13:42 INFO - 2015-11-20 01:13:42,960 DEBUG : process_Request line: kraken 1503.80 graph.html#tests=[[232,1,35]] 01:13:42 INFO - 2015-11-20 01:13:42,960 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:13:43 INFO - 2015-11-20 01:13:43,009 DEBUG : process_Request line: v8_7 19980.48 graph.html#tests=[[230,1,35]] 01:13:43 INFO - 2015-11-20 01:13:43,011 INFO : javascript benchmark 01:13:43 INFO - 2015-11-20 01:13:43,014 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3180.9681903180967, 3221.9838900805494, 3262.3149138680874, 3267.8692852285926, 3284.967150328496, 5279.815206467774, 5310.867228319294, 5315.0, 5403.21653360263, 5415.323084614423, 5430.185472179165, 5482.91775623366, 5580.581456390767, 5589.552835773138, 5589.888202235953, 5007.974960125203, 5081.517255860687, 5085.644004919657, 5113.923291150636, 5164.251183578379, 5043.974780126113, 5126.436092029874, 5151.793928242866, 5157.664751791141, 5168.8707782305555, 4915.361003069578, 5024.572911302544, 5061.114304996611, 5123.257127716498, 5127.743612819363, 4979.30289759434, 4997.375328083989, 4999.400071991348, 5002.124628190052, 5020.246962955549, 4924.679895806761, 4954.628402869799, 4979.2282196259275, 4983.8504844854715, 4984.426790919055, 5291.550218231455, 5322.813701520467, 5323.041852466555, 5324.281222035014, 5423.376311724123, 5908.438698323653, 5916.763329466816, 5927.37762534932, 5977.521798256129, 5979.252593425822, 5965.8806823863715, 5970.164177015221, 5971.581989260753, 5995.880082398371, 6025.578209525335, 5418.078926582491, 5496.560275177976, 5523.4200408956485, 5526.281583394173, 5582.665040097567, 5802.506786923074, 5833.125031245348, 5836.474717275466, 5862.472377485961, 5865.0, 5816.82549523515, 5823.970880145572, 5829.329627092854, 5839.708014599253, 5841.269841269841, 5851.765929362778, 5857.355690874086, 5857.531397488191, 5861.794837180678, 5901.940980590225, 5820.30156381237, 5841.591088623755, 5846.532277417797, 5849.122631605208, 5849.590528663038, 5657.915131273035, 5762.049261871828, 5836.0, 5932.169496270526, 5932.2584676915385, 4596.609288210473, 4602.838900638529, 4608.88477788058, 4619.491855895849, 4620.4686461056735, 4047.7571345719352, 4076.735012224255, 4086.264472394938, 4116.073883376216, 4122.381642753611, 5440.646357986719, 5549.694766787785, 5665.688387138664, 5668.716564171775, 5671.262735844314, 5749.108888122348, 5798.9420105799245, 5825.126231065289, 5840.912386314209, 5898.64608123514, 5652.349979752381, 5653.123765816305, 5654.180143879114, 5654.4062873398525, 5658.971705141448, 4965.478624744422, 5066.392032956069, 5238.7904483820985, 5241.764120614582, 5257.237700533401, 5916.556258280646, 5963.821085367446, 6039.7282122304605, 6042.244719410074, 6097.268327800603, 6000.729967151401, 6027.758889644365, 6060.90908636362, 6081.966065768742, 6116.66358350295, 5985.311689155628, 6054.212952316171, 6072.4264395709915, 6297.905531417124, 6324.557280990287, 5790.855228619318, 5858.94141058584, 5863.941360586339, 5906.468417842415, 5911.852203694942, 5937.673427961504, 5943.52451803846, 5950.821475355746, 5969.791057312973, 6051.364606716232, 5670.971645141748, 5785.913211301918, 5807.593468457337, 5810.331811841692, 5813.505852002627, 5768.2501274834, 5768.567357448124, 5880.176775251553, 5883.823485295448, 5932.110183472341, 5711.514521265739, 5718.428157184248, 5757.222774925499, 5759.798407055733, 5763.135529670583, 5616.382197958303, 5799.101139323411, 5816.563757718103, 5859.179714840011, 5887.58786884931, 5659.179418984307, 5738.799142030009, 5760.337561180518, 5763.7982670606325, 5812.68030258323], "unit": "ms", "name": "dojo.html", "value": 5452.093462081099}, {"lowerIsBetter": false, "replicates": [550.2324257660564, 582.4641329976424, 591.3554225893774, 593.1606776411378, 603.7645318325854, 32225.0, 32908.34183316332, 32951.34097318055, 32952.17619559512, 33013.33973320532, 41559.0, 41859.372109418386, 41908.74273771784, 41966.790166049206, 42127.157456850844, 8684.088170742076, 8820.823583528325, 8821.911780882174, 8832.425892317011, 8836.602352894102, 7729.072511298652, 7910.208979102102, 7913.723019694312, 8481.660733570681, 8579.399442039059, 10403.37579745214, 10576.576936922515, 10593.788124237512, 10615.946920265387, 10621.25651204416, 10294.794104117913, 10394.220433467444, 10452.477376131163, 10461.320014199053, 10476.371417714961, 7766.262205090564, 7970.960145199237, 10282.0, 10417.947910260476, 10508.2644214905, 40152.0, 40581.39127913084, 40596.79701601503, 40661.59338406608, 40689.186216275804, 3260.4131256373844, 3327.317899830529, 3327.467605183159, 3626.709863210937, 4049.2711311963835, 30319.848400758077, 30524.0, 31198.37603247945, 31300.217494562592, 31767.364652706816, 3964.623360780721, 4026.6376026157786, 4036.091879327157, 4044.292248856438, 4044.292248856438, 273314.0, 273782.0, 274332.999999998, 274358.0, 275643.0, 61719.0, 62309.0, 62349.0, 62403.0, 62415.0, 65208.0, 65489.0, 65546.68906621936, 65726.0, 65780.6710966442, 16370.508884733477, 16549.50351489457, 16625.833741662427, 16781.24484398205, 16791.832081679273, 12765.872341276654, 12781.680457988625, 12827.743445131046, 12845.614631561068, 12852.228866268053, 20593.485162870747, 20961.0, 21013.474663133544, 21051.68422473664, 21095.68356474654, 7681.423893208032, 7692.423068269902, 7769.223077692185, 7861.371090312761, 7870.252326029018, 960.2174228004154, 969.8157350103457, 1004.929654924163, 1017.7710015246511, 1062.9742298681808, 28701.712982869903, 28780.856095719806, 28823.423531529254, 28973.56539651907, 29230.85384573106, 1007.8840933292765, 1021.6373187518473, 1026.861373714539, 1026.9435181065114, 1108.3239224073309, 14193.361298741582, 14208.360623771749, 14496.275186240646, 14504.129752214902, 14506.492272770402, 257722.0, 300929.0, 304112.0, 336169.0, 340776.0, 48936.75531622319, 49145.50854491409, 49540.50459495431, 49619.0, 49637.25544116841, 1289.7162624222656, 1325.9933700331437, 1335.585968349834, 1341.5774031180147, 1349.480450026727, 23194.0, 27682.584761229, 27821.0, 28186.43627127405, 28377.43245135127, 47212.7639361801, 47450.52549474461, 47559.0, 47640.0, 47745.28382074341, 290361.0, 290852.0, 291425.0, 291587.0, 291962.0, 32676.183095422806, 32678.183045424055, 32833.343333132725, 33033.339333213684, 45499.317510238034, 44805.0, 44904.550954490034, 45238.54761452475, 45470.31794523151, 45862.77068614635, 37424.25151497009, 37846.62153378431, 38381.6161838378, 39080.21839563136, 39145.0, 37467.0, 37625.811870941565, 38246.80876595599, 38503.807480962416, 38760.6123938757, 37158.628413715516, 37333.81333093317, 37379.81310093432, 37438.0, 37488.25023499569, 32440.0, 34457.82771086128, 34482.20887015626, 34929.0, 35034.64965350314, 25939.74060259373, 26331.605025924244, 26625.334366640214, 26641.0, 27450.862745686143], "unit": "ms", "name": "ext.html", "value": 18994.561672318523}, {"lowerIsBetter": false, "replicates": [350.89297764181913, 351.8451881172286, 357.0644910334923, 357.6227080430146, 358.06544917764637, 14230.928845355758, 14592.41630334788, 16353.672926541461, 16540.172991350428, 17140.48578542644, 15904.920475397636, 16348.427805026826, 16850.494485165465, 17413.30346786127, 17431.0, 5257.421683614799, 5346.091164502024, 5351.839444816662, 5353.411124776271, 5357.276767636377, 4034.677225821942, 4136.420901073852, 5342.732863356836, 5727.742251598688, 5908.379620139888, 5782.797602083928, 5791.826245212629, 5811.883762324751, 5833.241678581779, 5848.093545500433, 5733.627314224583, 5925.466707996301, 5925.881482370329, 5929.525637948976, 5932.555058370639, 5206.76569554371, 5208.505192006791, 5209.348831396075, 5212.452692467312, 5222.529972302473, 10907.454627268684, 11315.434228288552, 11396.0, 11406.144539159597, 11412.0, 2098.7376577927757, 2102.8212601928853, 2136.3484137338105, 2345.3667509772267, 2481.3424442522746, 8865.955670221672, 8949.552522373855, 9051.0, 9136.314776391797, 9230.953845230732, 1793.4261036468336, 1864.3102052240622, 1867.7478540397144, 1880.3982725527837, 1898.411492437349, 60004.0, 61856.0, 62539.37460625381, 63910.68044659794, 64836.3516364835, 9952.552135153936, 10027.247956403298, 10282.537285822156, 10324.896751032544, 10327.74180645475, 13181.604551863267, 13212.942964562812, 13298.135621184592, 13299.069065165346, 13311.46754129824, 7530.322270995636, 7579.317861392391, 7951.721689740832, 8002.5598592077995, 8009.038915330081, 7954.244346787046, 7977.641006154621, 7983.441159118806, 8028.197180282042, 8040.035195776544, 4422.204003279377, 4451.421315229064, 4461.933071003938, 4465.441819772528, 4482.0, 1708.1117818734187, 1743.2504023269862, 1756.200928577494, 1798.0829776813919, 1834.9449516514526, 959.4483172176027, 984.9162821160138, 1034.591336422109, 1043.2853495355705, 1067.546292825546, 13774.793378099337, 15596.142212178213, 15722.606934826721, 15741.921290393475, 16143.757843632355, 892.3040028777564, 912.1653686876566, 916.2898753465984, 921.6543796076471, 970.9757256068655, 7770.850817248145, 9473.0, 9634.421934683942, 9695.127438530566, 9759.121679048778, 517590.0, 522188.0, 534618.0, 552951.0, 555600.997955093, 71753.6412317935, 71970.0, 72923.0, 78309.0, 81901.0, 1156.4160099149876, 1156.4969238381332, 1174.9706257343635, 1198.0714945916984, 1214.1318956945827, 14480.493182738554, 14736.852631473977, 14746.557603271918, 14963.0, 15192.0, 34718.82640586781, 34793.0, 35677.46483802797, 36504.26991460103, 36507.81746091253, 46144.769276153405, 46534.06931861276, 46998.06003879835, 49276.0, 49826.0, 8878.200961913459, 9134.5432728362, 9588.137067663944, 9635.181009614262, 9643.0, 16162.838371616133, 16223.0, 16513.256903439134, 17003.14984250807, 17092.230849611547, 14150.0, 14183.361748721538, 14257.786133207803, 14548.563543093724, 14779.778303325675, 13831.170129792245, 14144.363503642566, 14374.209418482083, 14377.56867293983, 14820.333085011416, 11762.176647634584, 12884.48462061507, 13645.317734113452, 13911.304434778018, 14151.150930944177, 8849.823003540021, 9011.909880901369, 9245.907540924505, 9544.188743956563, 9587.712368628952, 9422.858657120012, 10828.350298982086, 14366.353514091681, 14448.494302699355, 15279.465218717292], "unit": "ms", "name": "jquery.html", "value": 8695.703060432916}, {"lowerIsBetter": false, "replicates": [1438.6762978329873, 1450.2023886862225, 1480.6520467690098, 1569.7252980728376, 1744.1976690722274, 6732.326767323271, 7316.5975871327055, 7465.029546159005, 7484.663190156442, 7495.063117110361, 7553.660085296161, 7684.308412242897, 7691.192424795386, 7691.307782299592, 7710.884336734954, 1959.5101224693826, 2009.5076706207, 2009.9899500502477, 2181.1166477576608, 2209.812165965895, 2023.6053969475959, 2191.824654027674, 2204.669299605064, 2227.654713519407, 2227.6881236626887, 2101.8108370246673, 2121.490842197869, 2127.7233959585233, 2168.8481806273567, 2168.9240876569324, 1920.2990908318363, 1973.1219607274768, 2216.9358707820174, 2248.1119957616734, 2249.3364457485, 2205.977940220593, 2257.7516473188102, 2265.456290490287, 2282.1784157703214, 2284.3489605462364, 7551.848963020709, 7556.962215188943, 7621.466497345188, 7639.618019099078, 7644.197359277251, 4517.9774101129615, 4562.931556026662, 4582.381378513925, 4598.402207713009, 4614.30785382192, 3028.4700177468853, 3178.5550022996567, 3180.6501284858646, 3195.6964088411564, 3207.5028370602595, 971.0677749360623, 979.8481235408523, 995.8008398320293, 998.1066945084182, 1031.2471895516314, 10314.535845886878, 10321.122704570196, 10324.690259292232, 10334.0, 10354.79290414195, 4048.21059893318, 4089.0, 4117.958820411757, 4118.9588104118575, 4168.458100446923, 8944.776380590538, 8957.14907083826, 8958.417702849294, 8961.551922403854, 8987.101289870961, 4574.725516469022, 4580.839670611579, 4581.175388430114, 4589.770511474413, 4589.931151032737, 4149.481314835645, 4164.437800896901, 4166.375043743402, 4174.937375939363, 4187.706860519735, 3668.137987572918, 3669.376206044979, 3671.210689701727, 3671.549737853533, 3715.628437156263, 1179.5046080645977, 1202.6331968749616, 1208.383724300613, 1209.5947857467847, 1216.045404357575, 1292.8190053392532, 1293.5537239652306, 1313.441787240438, 1341.7249463859885, 1346.7777816660337, 7226.819329516699, 7246.891296630555, 7340.11918569775, 7341.265873412616, 7345.273860642745, 1077.6443773554709, 1095.7479779650726, 1097.780443911221, 1118.5246270335076, 1131.5360702112096, 5439.619226654176, 5516.91724624131, 5523.337199536081, 5526.557875369961, 5655.688937108499, 8557.743267701979, 8685.522296273639, 8790.384673072951, 8841.425307355, 8950.507722075217, 9042.276617870555, 9068.0, 9085.409448385833, 9147.085291470932, 9154.038825923182, 6984.126984127086, 7025.508214424941, 7077.752278670325, 7130.393916517154, 7165.104361954755, 7218.314260145278, 7246.130464344313, 7280.96359518199, 7282.927170728225, 7288.016117824238, 8074.0, 8117.8376432472205, 8186.918130818615, 8328.458650187718, 8334.374921880762, 8332.0, 8345.666173352998, 8368.288695460955, 8511.659533618833, 8545.188207120314, 6495.772647957298, 6534.235756345665, 6551.770688025897, 6631.303713110054, 6634.701438435185, 7295.0, 7331.1569169544055, 7335.376492998155, 7335.889961650686, 7343.118825740945, 7007.054047703495, 7046.823829404306, 7072.045273888165, 7136.857262854817, 7166.641667916688, 6934.16789985205, 6955.304469553004, 6972.6862291196, 7016.1580610325045, 7116.46626503004, 6853.691583878638, 6860.759873404407, 6872.278410766798, 6872.45020398357, 6987.406070483862, 6391.648459334781, 6433.806985790434, 6437.356264373712, 6442.742290308335, 6446.065320528591, 6484.351564843478, 6484.383983521558, 6509.349065093453, 6537.607743535403, 6541.116949211795], "unit": "ms", "name": "mootools.html", "value": 4411.751888810195}, {"lowerIsBetter": false, "replicates": [312.30200501878306, 317.0946946467834, 318.724303477492, 324.68019001283716, 326.2414885391464, 5980.43185897339, 6053.57624966252, 6085.786997455084, 6102.633841969485, 6181.3200547939805, 5921.407859214077, 6066.332703402633, 6090.482309003729, 6096.26844778626, 6101.871153836543, 4642.234031384817, 4646.279826626878, 4654.534546545336, 4656.976715116437, 4660.300954856764, 4431.556844315559, 4517.751523666197, 4521.480029796566, 4523.8642840714665, 4647.419072615923, 4487.169873573399, 4576.656750743691, 4619.56793394049, 4629.8148074077, 4632.698874573159, 4618.237990731542, 4621.052684199731, 4635.976820115911, 4636.235021221528, 4639.930401043987, 4031.8992025199314, 4033.2941735196223, 4035.0315924177985, 4035.1324465239823, 4054.432379466877, 5683.54531637468, 5782.768689252425, 5798.043322851724, 5805.651660900359, 5809.796657116981, 5397.109476936301, 5402.91895621566, 5405.783768649249, 5416.837494875121, 5422.8915421691345, 6253.062040693887, 6503.414692677635, 6521.021846722982, 6524.445422139124, 6527.118838956775, 4334.9783251083545, 4405.405270288502, 4434.2905135178535, 4438.4451943507065, 4449.466064072332, 6702.229243636946, 6726.697298621574, 6741.696623651997, 6753.45972322213, 6758.391744742997, 4544.568266014723, 4546.318052292183, 4546.840860569864, 4548.590626843534, 4550.0217453247715, 4424.358468022118, 4541.341505481687, 4562.270036794097, 4605.4933957264675, 4612.262038073892, 5335.86660333487, 5337.332833395825, 5337.706426146521, 5338.546223570962, 5343.305370301836, 6576.276609572943, 6578.868422631521, 6584.0, 6585.703643336062, 6588.374104460068, 1575.5667191522423, 1579.5261421573482, 1580.146720770794, 1586.1038513240212, 1586.6905953338987, 1046.0585473074293, 1048.4548035021746, 1049.2497864027257, 1057.6879820452984, 1076.208986394999, 6281.371862813682, 6288.842778930563, 6292.433680968643, 6294.464970477469, 6295.401936815995, 6755.425788807908, 6759.256481787, 6766.6278354689985, 6769.221539523018, 6769.695363708645, 6136.7852125175405, 6286.49708023357, 6288.213973253343, 6296.307406185316, 6303.464205542488, 3649.489071529988, 3677.099110717838, 3682.9447558286647, 3684.1894783147663, 3684.521012268388, 7008.754693585802, 7012.649367531603, 7015.614141222281, 7020.297970203041, 7026.473014523931, 6871.484638652121, 6949.826254343682, 6952.582845029315, 6955.339242771928, 6959.686814093277, 7070.469714771412, 7135.322144396378, 7136.536125151849, 7137.714491420389, 7141.214466408691, 6556.2788093308745, 6672.633005184762, 6675.532712710258, 6840.452763778985, 6862.862742745017, 6735.932640673726, 6752.953292239711, 6753.797386078426, 6757.594544327356, 6765.729370825112, 7057.929420705727, 7060.117485314336, 7069.0, 7078.929210707827, 7102.076730025064, 4540.636749060133, 4605.125026245003, 4614.676972611885, 4622.607078398374, 4633.443986721615, 6774.898376524257, 6783.0, 6785.0, 6786.423154031962, 6795.354441328263, 6564.212294524687, 6575.309592492719, 6591.373819487141, 6601.768938087144, 6613.537052406477, 6446.323136070832, 6565.113709649328, 6576.112224849775, 6587.571807832667, 6595.043718660863, 6471.0, 6471.320511346241, 6478.676066196577, 6484.610923344426, 6486.091947127312, 6616.239132499824, 6618.569792963442, 6624.56940298879, 6626.370494802986, 6628.171478565179, 6329.968350158219, 6434.871302573829, 6468.8059358219325, 6478.125453063776, 6485.6108633482145], "unit": "ms", "name": "prototype.html", "value": 4885.590191249387}, {"lowerIsBetter": false, "replicates": [754.7999780058282, 771.8572064168128, 850.047946300144, 867.9305655547553, 869.8651708985108, 13308.667283317922, 13430.529931452389, 13453.66365840852, 13462.596122116327, 13486.393112309945, 13104.34478276087, 13212.273324967124, 13220.206787592751, 13226.669333266673, 13239.205647661147, 668.7191379620547, 677.3666621708694, 796.8685166947475, 811.2455416462687, 813.5281536708695, 813.9796505087361, 816.4733746733383, 818.5866137600503, 821.4783612406135, 823.3495538524559, 850.2262940723942, 856.04550925718, 857.4512312120248, 857.8412993596173, 858.1804376820153, 683.9794806155799, 688.9242183359827, 837.1084794693662, 853.7524118005771, 855.1576696953496, 624.8781487609917, 629.1003864473801, 629.3297638015499, 629.8236493781749, 630.3948209718676, 13412.396442160127, 13547.729045419135, 13561.864381356258, 13574.253416062113, 13583.932080339633, 11686.824697629543, 12425.31660758658, 12709.17390369623, 12960.0, 13168.341582920912, 9914.25643076765, 9974.700758977242, 10060.547275372626, 10140.430441182361, 10166.440845753481, 3498.6501349865066, 3587.892363229107, 3628.5282913221376, 3708.9443658345144, 3709.3137769512455, 48649.51350486485, 49476.257856132186, 49719.751401242764, 49762.25356619654, 49832.0, 9709.009094401186, 9816.607335706634, 9883.950580247052, 10017.29878908484, 10186.694399168036, 18690.439286821143, 18698.0, 18698.81301186998, 18729.344472943652, 18732.719009214874, 6212.4696404534925, 6322.747090116436, 6958.0, 7044.788656340318, 7316.304951029751, 3924.038610540436, 3968.0, 4052.3313653247474, 4120.567340429212, 4152.335626299838, 3115.9844200778853, 3125.1249650098007, 3130.3269796993754, 3142.9528557071662, 3143.9685603144135, 558.6536347464516, 563.3549585724322, 576.4408523731973, 579.1717843483858, 590.630855715178, 532.2840779152111, 597.4801922327516, 610.8289678889829, 659.8650321447103, 682.0791930893255, 8608.0, 8622.61198246068, 8755.693550725695, 8777.473351598925, 8802.0, 564.340778810048, 570.5264630356794, 689.4484412470105, 699.7061234281614, 706.1455638677259, 3863.4204869269834, 3969.994801079349, 3991.1818077294083, 4089.9386509202386, 4312.439382880206, 55065.1740223897, 55505.0, 55607.443925561034, 55698.0, 55743.0, 53000.73499632477, 53183.20225196625, 53297.2005419919, 54021.45978540243, 54033.0, 48743.0, 48773.26840097401, 48866.02267954692, 49109.50890491121, 49896.251556226685, 9040.0, 9099.727008189764, 9207.815843683224, 9243.168114869424, 9362.251019918254, 35854.0, 36054.8197259012, 36639.45040824443, 36779.26441471209, 36886.446703298934, 42054.7897260524, 45540.31689524594, 47298.0, 47809.52190478051, 47874.521254787, 11126.554937802397, 11195.88804111981, 11262.549498020315, 11403.885961140615, 11490.942545287555, 12090.214136081127, 12230.816537751763, 12593.496260149857, 12621.495140194289, 12740.0, 11521.942390287995, 11567.190296679151, 11674.824877627012, 11977.64067077989, 12081.879181208076, 11176.329420234812, 11670.0, 11892.844870090134, 11902.166848320534, 11943.820842687193, 7760.45676802641, 10162.949185254027, 11129.888701112885, 11500.137489688139, 11615.361155136548, 9943.651972180938, 10045.949770251102, 10171.84742228882, 10191.337563058378, 10386.272960892666, 8747.125287471203, 9234.307426942873, 9492.288078394286, 9628.422294662343, 10206.336588121749], "unit": "ms", "name": "yui.html", "value": 6317.731378566952}], "name": "dromaeo_css", "value": 7048.622160573129}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 109.0, 110.0, 110.0, 99.0, 111.0, 113.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [157.0, 123.0, 150.0, 177.0, 132.0, 150.0, 155.0, 132.0, 168.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 162.0, 160.0, 160.0, 160.0, 160.0, 163.0, 161.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 84.0, 98.0, 72.0, 72.0, 71.0, 107.0, 91.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [89.0, 91.0, 135.0, 90.0, 90.0, 90.0, 137.0, 89.0, 91.0, 144.0], "unit": "ms", "name": "audio-oscillator", "value": 104.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 144.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 60.0, 60.0, 60.0, 59.0, 59.0, 67.0, 58.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 60.1}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [82.0, 92.0, 84.0, 84.0, 92.0, 85.0, 86.0, 86.0, 87.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [120.0, 124.0, 119.0, 117.0, 119.0, 117.0, 124.0, 120.0, 123.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.0}, {"lowerIsBetter": true, "replicates": [142.0, 153.0, 151.0, 151.0, 157.0, 139.0, 151.0, 149.0, 151.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 66.0, 69.0, 66.0, 68.0, 68.0, 66.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1503.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.1321370309951], "unit": "score", "name": "Richards", "value": 216.40126}, {"lowerIsBetter": false, "replicates": [188.5014137606032], "unit": "score", "name": "DeltaBlue", "value": 350.7559900000001}, {"lowerIsBetter": false, "replicates": [281.45229383619477], "unit": "score", "name": "Encrypt", "value": 945.7410929999998}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [1984.126984126984], "unit": "score", "name": "RayTrace", "value": 372.9544560000001}, {"lowerIsBetter": false, "replicates": [777.000777000777], "unit": "score", "name": "Earley", "value": 857.737881}, {"lowerIsBetter": false, "replicates": [12365.853658536585], "unit": "score", "name": "Boyer", "value": 53.89542998027611}, {"lowerIsBetter": false, "replicates": [26128.20512820513], "unit": "score", "name": "RegExp", "value": 34.86596172718352}, {"lowerIsBetter": false, "replicates": [586.1664712778429], "unit": "score", "name": "Splay", "value": 139.02364600000004}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19980.477370081262}]} 01:13:43 INFO - RETURN: dromaeo_css: 7048.62 01:13:43 INFO - RETURN: kraken: 1503.80 01:13:43 INFO - RETURN: v8_7: 19980.48 01:13:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19980.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1503.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "7048.62"}}} 01:13:43 INFO - Return code: 0 01:13:43 INFO - # TBPL SUCCESS # 01:13:43 INFO - Running post-action listener: _resource_record_post_action 01:13:43 INFO - Running post-run listener: _resource_record_post_run 01:13:44 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 508428288; Read time: 8; Write time: 422160 01:13:44 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 190537728; Read time: 0; Write time: 154112 01:13:44 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278032384; Read time: 8; Write time: 205608 01:13:44 INFO - Running post-run listener: _upload_blobber_files 01:13:44 INFO - Blob upload gear active. 01:13:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:13:44 INFO - Copying logs to upload dir... 01:13:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.530749 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-20 01:13:43.779547) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 01:13:43.783795) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009986 build_url: 'https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 01:13:43.835309) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:13:43.835635) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448008141.812785-1636550605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004780 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:13:43.885110) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 01:13:43.885442) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 01:13:43.885740) ========= ========= Total master_lag: 0.40 =========