builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1447223957.62 results: success (0) buildid: 20151110205821 builduid: b62c496024fd4ca0a839c1bcba0855c6 revision: 5ce07357c5f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:17.615745) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:17.616426) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:17.616892) ========= 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=5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004867 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:17.633841) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:17.634167) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:17.642826) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:17.643107) ========= 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=5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003960 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:17.691321) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:17.691710) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:17.692167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:17.692467) ========= 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=5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-10 22:39:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 207M=0s 2015-11-10 22:39:18 (207 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193484 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:17.898465) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:17.898776) ========= 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=5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019283 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:17.948078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:17.948435) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5ce07357c5f7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5ce07357c5f7 --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=5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-10 22:39:18,783 Setting DEBUG logging. 2015-11-10 22:39:18,783 attempt 1/10 2015-11-10 22:39:18,783 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5ce07357c5f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-10 22:39:19,135 unpacking tar archive at: mozilla-inbound-5ce07357c5f7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678817 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:18.640375) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:18.640806) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:18.648575) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:18.648871) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-10 22:39:18.649468) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2015-11-10 22:39:18.649761) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:39:19 INFO - MultiFileLogger online at 20151110 22:39:19 in /builds/slave/test-pgo 22:39:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:39:19 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:39:19 INFO - {'append_to_log': False, 22:39:19 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:39:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:39:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:39:19 INFO - 'branch': 'Mozilla-Inbound', 22:39:19 INFO - 'buildbot_json_path': 'buildprops.json', 22:39:19 INFO - 'config_files': ('talos/linux_config.py',), 22:39:19 INFO - 'default_actions': ('clobber', 22:39:19 INFO - 'read-buildbot-config', 22:39:19 INFO - 'download-and-extract', 22:39:19 INFO - 'populate-webroot', 22:39:19 INFO - 'create-virtualenv', 22:39:19 INFO - 'install', 22:39:19 INFO - 'run-tests'), 22:39:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:39:19 INFO - 'download_minidump_stackwalk': True, 22:39:19 INFO - 'download_symbols': 'ondemand', 22:39:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:39:19 INFO - 'tooltool.py': '/tools/tooltool.py', 22:39:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:39:19 INFO - '/tools/misc-python/virtualenv.py')}, 22:39:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:39:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:39:19 INFO - 'installer_path': 'installer.exe', 22:39:19 INFO - 'log_level': 'info', 22:39:19 INFO - 'log_name': 'talos', 22:39:19 INFO - 'log_to_console': True, 22:39:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:39:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:39:19 INFO - 'opt_config_files': (), 22:39:19 INFO - 'pip_index': False, 22:39:19 INFO - 'sps_profile': False, 22:39:19 INFO - 'sps_profile_interval': 0, 22:39:19 INFO - 'suite': 'dromaeojs', 22:39:19 INFO - 'system_bits': '64', 22:39:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:39:19 INFO - 'title': 'talos-linux64-ix-061', 22:39:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:39:19 INFO - 'use_talos_json': True, 22:39:19 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:39:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:39:19 INFO - 'work_dir': 'build'} 22:39:19 INFO - ##### 22:39:19 INFO - ##### Running clobber step. 22:39:19 INFO - ##### 22:39:19 INFO - Running pre-action listener: _resource_record_pre_action 22:39:19 INFO - Running main action method: clobber 22:39:19 INFO - rmtree: /builds/slave/test-pgo/build 22:39:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:39:20 INFO - Running post-action listener: _resource_record_post_action 22:39:20 INFO - ##### 22:39:20 INFO - ##### Running read-buildbot-config step. 22:39:20 INFO - ##### 22:39:20 INFO - Running pre-action listener: _resource_record_pre_action 22:39:20 INFO - Running main action method: read_buildbot_config 22:39:20 INFO - Using buildbot properties: 22:39:20 INFO - { 22:39:20 INFO - "properties": { 22:39:20 INFO - "buildnumber": 543, 22:39:20 INFO - "product": "firefox", 22:39:20 INFO - "script_repo_revision": "production", 22:39:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 22:39:20 INFO - "repository": "", 22:39:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 22:39:20 INFO - "buildid": "20151110205821", 22:39:20 INFO - "slavename": "talos-linux64-ix-061", 22:39:20 INFO - "pgo_build": "True", 22:39:20 INFO - "basedir": "/builds/slave/test-pgo", 22:39:20 INFO - "project": "", 22:39:20 INFO - "platform": "ubuntu64_hw", 22:39:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:39:20 INFO - "slavebuilddir": "test", 22:39:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:39:20 INFO - "branch": "mozilla-inbound", 22:39:20 INFO - "repo_path": "integration/mozilla-inbound", 22:39:20 INFO - "stage_platform": "linux64-pgo", 22:39:20 INFO - "builduid": "b62c496024fd4ca0a839c1bcba0855c6", 22:39:20 INFO - "revision": "5ce07357c5f7" 22:39:20 INFO - }, 22:39:20 INFO - "sourcestamp": { 22:39:20 INFO - "repository": "", 22:39:20 INFO - "hasPatch": false, 22:39:20 INFO - "project": "", 22:39:20 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 22:39:20 INFO - "changes": [ 22:39:20 INFO - { 22:39:20 INFO - "category": null, 22:39:20 INFO - "files": [ 22:39:20 INFO - { 22:39:20 INFO - "url": null, 22:39:20 INFO - "name": "https://queue.taskcluster.net/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:39:20 INFO - } 22:39:20 INFO - ], 22:39:20 INFO - "repository": "", 22:39:20 INFO - "rev": "5ce07357c5f7", 22:39:20 INFO - "who": "sendchange", 22:39:20 INFO - "when": 1447223674, 22:39:20 INFO - "number": 6646485, 22:39:20 INFO - "comments": "", 22:39:20 INFO - "project": "", 22:39:20 INFO - "at": "Tue 10 Nov 2015 22:34:34", 22:39:20 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 22:39:20 INFO - "revlink": "", 22:39:20 INFO - "properties": [ 22:39:20 INFO - [ 22:39:20 INFO - "buildid", 22:39:20 INFO - "20151110205821", 22:39:20 INFO - "Change" 22:39:20 INFO - ], 22:39:20 INFO - [ 22:39:20 INFO - "builduid", 22:39:20 INFO - "b62c496024fd4ca0a839c1bcba0855c6", 22:39:20 INFO - "Change" 22:39:20 INFO - ], 22:39:20 INFO - [ 22:39:20 INFO - "pgo_build", 22:39:20 INFO - "True", 22:39:20 INFO - "Change" 22:39:20 INFO - ] 22:39:20 INFO - ], 22:39:20 INFO - "revision": "5ce07357c5f7" 22:39:20 INFO - } 22:39:20 INFO - ], 22:39:20 INFO - "revision": "5ce07357c5f7" 22:39:20 INFO - } 22:39:20 INFO - } 22:39:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:39:20 INFO - Running post-action listener: _resource_record_post_action 22:39:20 INFO - ##### 22:39:20 INFO - ##### Running download-and-extract step. 22:39:20 INFO - ##### 22:39:20 INFO - Running pre-action listener: _resource_record_pre_action 22:39:20 INFO - Running main action method: download_and_extract 22:39:20 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:39:20 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')]} 22:39:20 INFO - https://queue.taskcluster.net/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:39:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/test_packages.json 22:39:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/test_packages.json 22:39:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:39:20 INFO - Downloaded 1302 bytes. 22:39:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:39:20 INFO - Using the following test package requirements: 22:39:20 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:39:20 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:39:20 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:20 INFO - u'jsshell-linux-x86_64.zip'], 22:39:20 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:39:20 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:39:20 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:39:20 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:39:20 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:39:20 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:39:20 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:39:20 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:39:20 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')]} 22:39:20 INFO - https://queue.taskcluster.net/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:39:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:39:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:39:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/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 22:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/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 22:39:21 INFO - Downloaded 22427456 bytes. 22:39:21 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 22:39:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:39:21 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 22:39:22 INFO - Return code: 0 22:39:22 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 22:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:22 INFO - https://queue.taskcluster.net/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:39:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:39:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:39:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/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 22:39:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/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 22:39:23 INFO - Downloaded 22427456 bytes. 22:39:23 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 22:39:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:39:23 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 22:39:24 INFO - Return code: 0 22:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:24 INFO - https://queue.taskcluster.net/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:39:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:39:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:39:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/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 22:39:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/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 22:39:25 INFO - Downloaded 11131693 bytes. 22:39:25 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 22:39:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:39:25 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 22:39:26 INFO - Return code: 0 22:39:26 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')]} 22:39:26 INFO - https://queue.taskcluster.net/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:39:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:39:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:39:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/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 22:39:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zVvxPWjFTCWG4Knti7IPQw/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 22:39:27 INFO - Downloaded 57142322 bytes. 22:39:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:39:27 INFO - mkdir: /builds/slave/test-pgo/properties 22:39:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:39:27 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:39:27 INFO - Contents: 22:39:27 INFO - build_url:https://queue.taskcluster.net/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:39:27 INFO - Running post-action listener: _resource_record_post_action 22:39:27 INFO - Running post-action listener: set_extra_try_arguments 22:39:27 INFO - ##### 22:39:27 INFO - ##### Running populate-webroot step. 22:39:27 INFO - ##### 22:39:27 INFO - Running pre-action listener: _resource_record_pre_action 22:39:27 INFO - Running main action method: populate_webroot 22:39:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:39:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:39:27 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:39:27 INFO - '../fennec_ids.txt'], 22:39:27 INFO - 'tests': ['tcheck2']}, 22:39:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:39:27 INFO - '--tppagecycles', 22:39:27 INFO - '7'], 22:39:27 INFO - 'tests': ['tsvgm']}}, 22:39:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:39:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:39:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:39:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:39:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:39:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:39:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:39:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:39:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:39:27 INFO - 'talos_options': ['--e10s'], 22:39:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:39:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:39:27 INFO - 'tests': ['damp', 'tps']}, 22:39:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:39:27 INFO - 'talos_options': ['--e10s'], 22:39:27 INFO - 'tests': ['damp', 'tps']}, 22:39:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:39:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:39:27 INFO - 'other': {'tests': ['a11yr', 22:39:27 INFO - 'ts_paint', 22:39:27 INFO - 'tpaint', 22:39:27 INFO - 'sessionrestore', 22:39:27 INFO - 'sessionrestore_no_auto_restore']}, 22:39:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:39:27 INFO - 'tests': ['a11yr', 22:39:27 INFO - 'ts_paint', 22:39:27 INFO - 'tpaint', 22:39:27 INFO - 'sessionrestore', 22:39:27 INFO - 'sessionrestore_no_auto_restore']}, 22:39:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:39:27 INFO - 'tests': ['a11yr', 22:39:27 INFO - 'ts_paint', 22:39:27 INFO - 'tpaint', 22:39:27 INFO - 'sessionrestore', 22:39:27 INFO - 'sessionrestore_no_auto_restore']}, 22:39:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:39:27 INFO - 'tests': ['a11yr', 22:39:27 INFO - 'ts_paint', 22:39:27 INFO - 'tpaint', 22:39:27 INFO - 'sessionrestore', 22:39:27 INFO - 'sessionrestore_no_auto_restore']}, 22:39:27 INFO - 'other_l64': {'tests': ['a11yr', 22:39:27 INFO - 'ts_paint', 22:39:27 INFO - 'tpaint', 22:39:27 INFO - 'sessionrestore', 22:39:27 INFO - 'sessionrestore_no_auto_restore']}, 22:39:27 INFO - 'other_nol64': {'tests': ['a11yr', 22:39:27 INFO - 'ts_paint', 22:39:27 INFO - 'tpaint', 22:39:27 INFO - 'sessionrestore', 22:39:27 INFO - 'sessionrestore_no_auto_restore']}, 22:39:27 INFO - 'svgr': {'tests': ['tsvgx', 22:39:27 INFO - 'tsvgr_opacity', 22:39:27 INFO - 'tart', 22:39:27 INFO - 'tscrollx', 22:39:27 INFO - 'cart']}, 22:39:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:39:27 INFO - 'tests': ['tsvgx', 22:39:27 INFO - 'tsvgr_opacity', 22:39:27 INFO - 'tart', 22:39:27 INFO - 'tscrollx', 22:39:27 INFO - 'cart']}, 22:39:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:39:27 INFO - 'tests': ['tp5o']}, 22:39:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:39:27 INFO - 'talos_options': ['--e10s'], 22:39:27 INFO - 'tests': ['tp5o']}, 22:39:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:39:27 INFO - 'talos_options': ['--xperf_path', 22:39:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:39:27 INFO - 'tests': ['tp5n']}, 22:39:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:39:27 INFO - 'talos_options': ['--e10s', 22:39:27 INFO - '--xperf_path', 22:39:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:39:27 INFO - 'tests': ['tp5n']}}, 22:39:27 INFO - 'talos.zip': {'path': '', 22:39:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:39:27 INFO - Running post-action listener: _resource_record_post_action 22:39:27 INFO - ##### 22:39:27 INFO - ##### Running create-virtualenv step. 22:39:27 INFO - ##### 22:39:27 INFO - Running pre-action listener: _resource_record_pre_action 22:39:27 INFO - Running main action method: create_virtualenv 22:39:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:39:27 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 22:39:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:39:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:39:27 INFO - Using real prefix '/usr' 22:39:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:39:27 INFO - Installing distribute.............................................................................................................................................................................................done. 22:39:29 INFO - Installing pip.................done. 22:39:29 INFO - Return code: 0 22:39:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:39: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')]} 22:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39: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')]} 22:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:29 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 0x7f203b0acc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19036c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c46e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19faa90>, '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 0x1a4cf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d2e0>, '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': '5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616', '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 22:39:29 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 22:39:29 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 22:39:29 INFO - Using env: {'DISPLAY': ':0', 22:39:29 INFO - 'HOME': '/home/cltbld', 22:39:29 INFO - 'LANG': 'en_US.UTF-8', 22:39:29 INFO - 'LANGUAGE': 'en_US:en', 22:39:29 INFO - 'LOGNAME': 'cltbld', 22:39:29 INFO - 'MAIL': '/var/mail/cltbld', 22:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:29 INFO - 'MOZ_NO_REMOTE': '1', 22:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:29 INFO - 'NO_EM_RESTART': '1', 22:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:39:29 INFO - 'PWD': '/builds/slave/test-pgo', 22:39:29 INFO - 'SHELL': '/bin/bash', 22:39:29 INFO - 'SHLVL': '1', 22:39:29 INFO - 'TERM': 'linux', 22:39:29 INFO - 'TMOUT': '86400', 22:39:29 INFO - 'USER': 'cltbld', 22:39:29 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616', 22:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:29 INFO - '_': '/tools/buildbot/bin/python'} 22:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:30 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 22:39:30 INFO - Cleaning up... 22:39:30 INFO - Return code: 0 22:39:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:39: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')]} 22:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39: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')]} 22:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:30 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 0x7f203b0acc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19036c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c46e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19faa90>, '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 0x1a4cf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d2e0>, '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': '5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616', '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 22:39:30 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 22:39:30 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 22:39:30 INFO - Using env: {'DISPLAY': ':0', 22:39:30 INFO - 'HOME': '/home/cltbld', 22:39:30 INFO - 'LANG': 'en_US.UTF-8', 22:39:30 INFO - 'LANGUAGE': 'en_US:en', 22:39:30 INFO - 'LOGNAME': 'cltbld', 22:39:30 INFO - 'MAIL': '/var/mail/cltbld', 22:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:30 INFO - 'MOZ_NO_REMOTE': '1', 22:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:30 INFO - 'NO_EM_RESTART': '1', 22:39:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:39:30 INFO - 'PWD': '/builds/slave/test-pgo', 22:39:30 INFO - 'SHELL': '/bin/bash', 22:39:30 INFO - 'SHLVL': '1', 22:39:30 INFO - 'TERM': 'linux', 22:39:30 INFO - 'TMOUT': '86400', 22:39:30 INFO - 'USER': 'cltbld', 22:39:30 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616', 22:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:30 INFO - '_': '/tools/buildbot/bin/python'} 22:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:30 INFO - Downloading/unpacking psutil>=0.7.1 22:39:30 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 22:39:30 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 22:39:30 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 22:39:30 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 22:39:30 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 22:39:30 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 22:39:31 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:39:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:39:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:39:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:39:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:39:32 INFO - Installing collected packages: psutil 22:39:32 INFO - Running setup.py install for psutil 22:39:32 INFO - building 'psutil._psutil_linux' extension 22:39:32 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 22:39:32 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 22:39:32 INFO - building 'psutil._psutil_posix' extension 22:39:32 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 22:39:32 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 22:39:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:39:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:39:32 INFO - Successfully installed psutil 22:39:32 INFO - Cleaning up... 22:39:32 INFO - Return code: 0 22:39:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:39:32 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')]} 22:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:32 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')]} 22:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:32 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 0x7f203b0acc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19036c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c46e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19faa90>, '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 0x1a4cf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d2e0>, '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': '5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616', '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 22:39:32 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 22:39:32 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 22:39:32 INFO - Using env: {'DISPLAY': ':0', 22:39:32 INFO - 'HOME': '/home/cltbld', 22:39:32 INFO - 'LANG': 'en_US.UTF-8', 22:39:32 INFO - 'LANGUAGE': 'en_US:en', 22:39:32 INFO - 'LOGNAME': 'cltbld', 22:39:32 INFO - 'MAIL': '/var/mail/cltbld', 22:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:32 INFO - 'MOZ_NO_REMOTE': '1', 22:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:32 INFO - 'NO_EM_RESTART': '1', 22:39:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:39:32 INFO - 'PWD': '/builds/slave/test-pgo', 22:39:32 INFO - 'SHELL': '/bin/bash', 22:39:32 INFO - 'SHLVL': '1', 22:39:32 INFO - 'TERM': 'linux', 22:39:32 INFO - 'TMOUT': '86400', 22:39:32 INFO - 'USER': 'cltbld', 22:39:32 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616', 22:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:32 INFO - '_': '/tools/buildbot/bin/python'} 22:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:39:32 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 22:39:32 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 22:39:32 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 22:39:32 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 22:39:32 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 22:39:32 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 22:39:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:39:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:39:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:39:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:39:34 INFO - Installing collected packages: mozsystemmonitor 22:39:34 INFO - Running setup.py install for mozsystemmonitor 22:39:34 INFO - Successfully installed mozsystemmonitor 22:39:34 INFO - Cleaning up... 22:39:34 INFO - Return code: 0 22:39:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:34 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 0x7f203b0acc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19036c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c46e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19faa90>, '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 0x1a4cf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d2e0>, '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': '5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616', '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 22:39:34 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 22:39:34 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 22:39:34 INFO - Using env: {'DISPLAY': ':0', 22:39:34 INFO - 'HOME': '/home/cltbld', 22:39:34 INFO - 'LANG': 'en_US.UTF-8', 22:39:34 INFO - 'LANGUAGE': 'en_US:en', 22:39:34 INFO - 'LOGNAME': 'cltbld', 22:39:34 INFO - 'MAIL': '/var/mail/cltbld', 22:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:34 INFO - 'MOZ_NO_REMOTE': '1', 22:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:34 INFO - 'NO_EM_RESTART': '1', 22:39:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:39:34 INFO - 'PWD': '/builds/slave/test-pgo', 22:39:34 INFO - 'SHELL': '/bin/bash', 22:39:34 INFO - 'SHLVL': '1', 22:39:34 INFO - 'TERM': 'linux', 22:39:34 INFO - 'TMOUT': '86400', 22:39:34 INFO - 'USER': 'cltbld', 22:39:34 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616', 22:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:34 INFO - '_': '/tools/buildbot/bin/python'} 22:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:34 INFO - Downloading/unpacking blobuploader==1.2.4 22:39:34 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 22:39:34 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 22:39:34 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 22:39:34 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 22:39:34 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 22:39:34 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 22:39:36 INFO - Downloading blobuploader-1.2.4.tar.gz 22:39:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:39:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:39:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:39:36 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 22:39:36 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 22:39:36 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 22:39:36 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 22:39:36 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 22:39:36 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 22:39:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:39:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:39:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:39:36 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 22:39:36 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 22:39:36 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 22:39:36 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 22:39:36 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 22:39:36 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 22:39:37 INFO - Downloading docopt-0.6.1.tar.gz 22:39:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:39:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:39:37 INFO - Installing collected packages: blobuploader, requests, docopt 22:39:37 INFO - Running setup.py install for blobuploader 22:39:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:39:37 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:39:37 INFO - Running setup.py install for requests 22:39:37 INFO - Running setup.py install for docopt 22:39:37 INFO - Successfully installed blobuploader requests docopt 22:39:37 INFO - Cleaning up... 22:39:37 INFO - Return code: 0 22:39:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:37 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 0x7f203b0acc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19036c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c46e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19faa90>, '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 0x1a4cf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d2e0>, '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': '5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616', '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 22:39:37 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 22:39:37 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 22:39:37 INFO - Using env: {'DISPLAY': ':0', 22:39:37 INFO - 'HOME': '/home/cltbld', 22:39:37 INFO - 'LANG': 'en_US.UTF-8', 22:39:37 INFO - 'LANGUAGE': 'en_US:en', 22:39:37 INFO - 'LOGNAME': 'cltbld', 22:39:37 INFO - 'MAIL': '/var/mail/cltbld', 22:39:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:37 INFO - 'MOZ_NO_REMOTE': '1', 22:39:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:37 INFO - 'NO_EM_RESTART': '1', 22:39:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:39:37 INFO - 'PWD': '/builds/slave/test-pgo', 22:39:37 INFO - 'SHELL': '/bin/bash', 22:39:37 INFO - 'SHLVL': '1', 22:39:37 INFO - 'TERM': 'linux', 22:39:37 INFO - 'TMOUT': '86400', 22:39:37 INFO - 'USER': 'cltbld', 22:39:37 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616', 22:39:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:37 INFO - '_': '/tools/buildbot/bin/python'} 22:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:39:38 INFO - Running setup.py (path:/tmp/pip-embj4P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:39:38 INFO - Running setup.py (path:/tmp/pip-uNkOqF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:39:38 INFO - Running setup.py (path:/tmp/pip-sTDQW_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:39:38 INFO - Running setup.py (path:/tmp/pip-jKGUcG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:39:38 INFO - Running setup.py (path:/tmp/pip-bA3Npp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:39:38 INFO - Running setup.py (path:/tmp/pip-AfQxue-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:39:38 INFO - Running setup.py (path:/tmp/pip-6iczL5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:39:38 INFO - Running setup.py (path:/tmp/pip-oRLft5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:39:38 INFO - Running setup.py (path:/tmp/pip-ASf984-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:39:38 INFO - Running setup.py (path:/tmp/pip-oPQ7_F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:39:38 INFO - Running setup.py (path:/tmp/pip-2Hx3z0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:39:38 INFO - Running setup.py (path:/tmp/pip-wlRROO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:39:38 INFO - Running setup.py (path:/tmp/pip-Lmq8Vs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:39:38 INFO - Running setup.py (path:/tmp/pip-NQ2YCI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:39:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:39:39 INFO - Running setup.py (path:/tmp/pip-tyLrej-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:39:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:39:39 INFO - Running setup.py (path:/tmp/pip-zId3YO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:39:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:39:39 INFO - Running setup.py (path:/tmp/pip-czFZ4i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:39:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:39:39 INFO - Running setup.py install for manifestparser 22:39:39 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:39:39 INFO - Running setup.py install for mozcrash 22:39:39 INFO - Running setup.py install for mozdebug 22:39:39 INFO - Running setup.py install for mozdevice 22:39:39 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:39:39 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:39:39 INFO - Running setup.py install for mozfile 22:39:39 INFO - Running setup.py install for mozhttpd 22:39:39 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:39:39 INFO - Running setup.py install for mozinfo 22:39:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:39:39 INFO - Running setup.py install for mozInstall 22:39:40 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:39:40 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:39:40 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:39:40 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:39:40 INFO - Running setup.py install for mozleak 22:39:40 INFO - Running setup.py install for mozlog 22:39:40 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:39:40 INFO - Running setup.py install for moznetwork 22:39:40 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:39:40 INFO - Running setup.py install for mozprocess 22:39:40 INFO - Running setup.py install for mozprofile 22:39:40 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:39:40 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:39:40 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:39:40 INFO - Running setup.py install for mozrunner 22:39:40 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:39:40 INFO - Running setup.py install for mozscreenshot 22:39:40 INFO - Running setup.py install for moztest 22:39:40 INFO - Running setup.py install for mozversion 22:39:41 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:39:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:39:41 INFO - Cleaning up... 22:39:41 INFO - Return code: 0 22:39:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:41 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 0x7f203b0acc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19036c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c46e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19faa90>, '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 0x1a4cf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d2e0>, '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': '5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616', '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 22:39:41 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 22:39:41 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 22:39:41 INFO - Using env: {'DISPLAY': ':0', 22:39:41 INFO - 'HOME': '/home/cltbld', 22:39:41 INFO - 'LANG': 'en_US.UTF-8', 22:39:41 INFO - 'LANGUAGE': 'en_US:en', 22:39:41 INFO - 'LOGNAME': 'cltbld', 22:39:41 INFO - 'MAIL': '/var/mail/cltbld', 22:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:41 INFO - 'MOZ_NO_REMOTE': '1', 22:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:41 INFO - 'NO_EM_RESTART': '1', 22:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:39:41 INFO - 'PWD': '/builds/slave/test-pgo', 22:39:41 INFO - 'SHELL': '/bin/bash', 22:39:41 INFO - 'SHLVL': '1', 22:39:41 INFO - 'TERM': 'linux', 22:39:41 INFO - 'TMOUT': '86400', 22:39:41 INFO - 'USER': 'cltbld', 22:39:41 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616', 22:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:41 INFO - '_': '/tools/buildbot/bin/python'} 22:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:39:41 INFO - Running setup.py (path:/tmp/pip-d8XX_i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:39:41 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)) 22:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:39:41 INFO - Running setup.py (path:/tmp/pip-7NPeiQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:39:41 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)) 22:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:39:41 INFO - Running setup.py (path:/tmp/pip-NeE4f3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:39:41 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)) 22:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:39:41 INFO - Running setup.py (path:/tmp/pip-DqRDb3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:39:41 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)) 22:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:39:41 INFO - Running setup.py (path:/tmp/pip-s_qP_d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:39:41 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)) 22:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:39:41 INFO - Running setup.py (path:/tmp/pip-FFLCaV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:39:41 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)) 22:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:39:41 INFO - Running setup.py (path:/tmp/pip-CS6LEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:39:41 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)) 22:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:39:41 INFO - Running setup.py (path:/tmp/pip-HtxhiX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:39:41 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)) 22:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:39:41 INFO - Running setup.py (path:/tmp/pip-fFd09g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:39:41 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)) 22:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:39:41 INFO - Running setup.py (path:/tmp/pip-ACat0y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:39:41 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)) 22:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:39:41 INFO - Running setup.py (path:/tmp/pip-frZxQH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:39:42 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)) 22:39:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:39:42 INFO - Running setup.py (path:/tmp/pip-UxBAZD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:39:42 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)) 22:39:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:39:42 INFO - Running setup.py (path:/tmp/pip-Uj6ZQm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:39:42 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)) 22:39:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:39:42 INFO - Running setup.py (path:/tmp/pip-dlvblC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:39:42 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)) 22:39:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:39:42 INFO - Running setup.py (path:/tmp/pip-pegpUU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:39:42 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)) 22:39:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:39:42 INFO - Running setup.py (path:/tmp/pip-UD_Ype-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:39:42 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)) 22:39:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:39:42 INFO - Running setup.py (path:/tmp/pip-4ViRXC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:39:42 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)) 22:39:42 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)) 22:39:42 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)) 22:39:42 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)) 22:39:42 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)) 22:39:42 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)) 22:39:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:44 INFO - Downloading blessings-1.5.1.tar.gz 22:39:44 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 22:39:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:39:44 INFO - Installing collected packages: blessings 22:39:44 INFO - Running setup.py install for blessings 22:39:44 INFO - Successfully installed blessings 22:39:44 INFO - Cleaning up... 22:39:44 INFO - Return code: 0 22:39:44 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:39:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:39:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:39:44 INFO - Reading from file tmpfile_stdout 22:39:44 INFO - Current package versions: 22:39:44 INFO - argparse == 1.2.1 22:39:44 INFO - blessings == 1.5.1 22:39:44 INFO - blobuploader == 1.2.4 22:39:44 INFO - docopt == 0.6.1 22:39:44 INFO - manifestparser == 1.1 22:39:44 INFO - mozInstall == 1.12 22:39:44 INFO - mozcrash == 0.16 22:39:44 INFO - mozdebug == 0.1 22:39:44 INFO - mozdevice == 0.47 22:39:44 INFO - mozfile == 1.2 22:39:44 INFO - mozhttpd == 0.7 22:39:44 INFO - mozinfo == 0.9 22:39:44 INFO - mozleak == 0.1 22:39:44 INFO - mozlog == 3.0 22:39:44 INFO - moznetwork == 0.27 22:39:44 INFO - mozprocess == 0.22 22:39:44 INFO - mozprofile == 0.27 22:39:44 INFO - mozrunner == 6.11 22:39:44 INFO - mozscreenshot == 0.1 22:39:44 INFO - mozsystemmonitor == 0.0 22:39:44 INFO - moztest == 0.7 22:39:44 INFO - mozversion == 1.4 22:39:44 INFO - psutil == 3.1.1 22:39:44 INFO - requests == 1.2.3 22:39:44 INFO - wsgiref == 0.1.2 22:39:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f203b0acc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19036c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c46e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19faa90>, '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 0x1a4cf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d2e0>, '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': '5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616', '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 22:39:44 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 22:39:44 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 22:39:44 INFO - Using env: {'DISPLAY': ':0', 22:39:44 INFO - 'HOME': '/home/cltbld', 22:39:44 INFO - 'LANG': 'en_US.UTF-8', 22:39:44 INFO - 'LANGUAGE': 'en_US:en', 22:39:44 INFO - 'LOGNAME': 'cltbld', 22:39:44 INFO - 'MAIL': '/var/mail/cltbld', 22:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:44 INFO - 'MOZ_NO_REMOTE': '1', 22:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:44 INFO - 'NO_EM_RESTART': '1', 22:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:39:44 INFO - 'PWD': '/builds/slave/test-pgo', 22:39:44 INFO - 'SHELL': '/bin/bash', 22:39:44 INFO - 'SHLVL': '1', 22:39:44 INFO - 'TERM': 'linux', 22:39:44 INFO - 'TMOUT': '86400', 22:39:44 INFO - 'USER': 'cltbld', 22:39:44 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616', 22:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:44 INFO - '_': '/tools/buildbot/bin/python'} 22:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:44 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)) 22:39:44 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)) 22:39:44 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)) 22:39:44 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)) 22:39:44 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)) 22:39:44 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)) 22:39:44 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)) 22:39:44 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)) 22:39:44 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)) 22:39:44 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)) 22:39:44 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)) 22:39:44 INFO - Cleaning up... 22:39:44 INFO - Return code: 0 22:39:44 INFO - Running post-action listener: _resource_record_post_action 22:39:44 INFO - Running post-action listener: _start_resource_monitoring 22:39:44 INFO - Starting resource monitoring. 22:39:44 INFO - ##### 22:39:44 INFO - ##### Running install step. 22:39:44 INFO - ##### 22:39:44 INFO - Running pre-action listener: _resource_record_pre_action 22:39:44 INFO - Running main action method: install 22:39:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:39:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:39:45 INFO - Reading from file tmpfile_stdout 22:39:45 INFO - Detecting whether we're running mozinstall >=1.0... 22:39:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:39:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:39:45 INFO - Reading from file tmpfile_stdout 22:39:45 INFO - Output received: 22:39:45 INFO - Usage: mozinstall [options] installer 22:39:45 INFO - Options: 22:39:45 INFO - -h, --help show this help message and exit 22:39:45 INFO - -d DEST, --destination=DEST 22:39:45 INFO - Directory to install application into. [default: 22:39:45 INFO - "/builds/slave/test-pgo"] 22:39:45 INFO - --app=APP Application being installed. [default: firefox] 22:39:45 INFO - mkdir: /builds/slave/test-pgo/build/application 22:39:45 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'] 22:39:45 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 22:39:59 INFO - Reading from file tmpfile_stdout 22:39:59 INFO - Output received: 22:39:59 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:39:59 INFO - Running post-action listener: _resource_record_post_action 22:39:59 INFO - ##### 22:39:59 INFO - ##### Running run-tests step. 22:39:59 INFO - ##### 22:39:59 INFO - Running pre-action listener: _resource_record_pre_action 22:39:59 INFO - Running main action method: run_tests 22:39:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:39:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:39:59 INFO - Python 2.7.3 22:39:59 INFO - Return code: 0 22:39:59 INFO - grabbing minidump binary from tooltool 22:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:59 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 0x19faa90>, '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 0x1a4cf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:39:59 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 22:39:59 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 22:39:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:39:59 INFO - Return code: 0 22:39:59 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:39:59 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:39:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:39:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:39:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:39:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 22:39:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost 22:39:59 INFO - Using env: {'DISPLAY': ':0', 22:39:59 INFO - 'HOME': '/home/cltbld', 22:39:59 INFO - 'LANG': 'en_US.UTF-8', 22:39:59 INFO - 'LANGUAGE': 'en_US:en', 22:39:59 INFO - 'LOGNAME': 'cltbld', 22:39:59 INFO - 'MAIL': '/var/mail/cltbld', 22:39:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:39:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:59 INFO - 'MOZ_NO_REMOTE': '1', 22:39:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:59 INFO - 'NO_EM_RESTART': '1', 22:39:59 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:39:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:39:59 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:39:59 INFO - 'SHELL': '/bin/bash', 22:39:59 INFO - 'SHLVL': '1', 22:39:59 INFO - 'TERM': 'linux', 22:39:59 INFO - 'TMOUT': '86400', 22:39:59 INFO - 'USER': 'cltbld', 22:39:59 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616', 22:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:59 INFO - '_': '/tools/buildbot/bin/python'} 22:39:59 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] with output_timeout 3600 22:39:59 INFO - mozversion INFO | application_buildid: 20151110205821 22:39:59 INFO - mozversion INFO | application_changeset: 5ce07357c5f7e458b0b5cfe1daad8e8eb772f765 22:39:59 INFO - mozversion INFO | application_display_name: Nightly 22:39:59 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:39:59 INFO - mozversion INFO | application_name: Firefox 22:39:59 INFO - mozversion INFO | application_remotingname: firefox 22:39:59 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:39:59 INFO - mozversion INFO | application_vendor: Mozilla 22:39:59 INFO - mozversion INFO | application_version: 45.0a1 22:39:59 INFO - mozversion INFO | platform_buildid: 20151110205821 22:39:59 INFO - mozversion INFO | platform_changeset: 5ce07357c5f7e458b0b5cfe1daad8e8eb772f765 22:39:59 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:39:59 INFO - mozversion INFO | platform_version: 45.0a1 22:39:59 INFO - 2015-11-10 22:39:59,790 DEBUG : using testdate: 1447223999 22:39:59 INFO - 2015-11-10 22:39:59,790 DEBUG : actual date: 1447223999 22:39:59 INFO - 2015-11-10 22:39:59,798 INFO : starting webserver on 'localhost:35287' 22:39:59 INFO - 2015-11-10 22:39:59,799 INFO : Starting test suite talos-linux64-ix-061 22:39:59 INFO - 2015-11-10 22:39:59,799 INFO : Starting test dromaeo_css 22:39:59 INFO - 2015-11-10 22:39:59,799 DEBUG : operating with platform_type : linux_ 22:39:59 INFO - 2015-11-10 22:39:59,800 INFO : Initialising browser for dromaeo_css test... 22:39:59 INFO - 2015-11-10 22:39:59,817 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_4Cyd4/profile http://localhost:35287/getInfo.html 22:40:04 INFO - 2015-11-10 22:40:04,245 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:40:04 INFO - 2015-11-10 22:40:04,245 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:40:04 INFO - 2015-11-10 22:40:04,245 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:40:04 INFO - 2015-11-10 22:40:04,245 DEBUG : BROWSER_OUTPUT: __metrics 22:40:04 INFO - 2015-11-10 22:40:04,341 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:40:05 INFO - 2015-11-10 22:40:05,637 INFO : Browser initialized. 22:40:05 INFO - 2015-11-10 22:40:05,637 INFO : Running cycle 1/1 for dromaeo_css test... 22:40:05 INFO - 2015-11-10 22:40:05,638 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_4Cyd4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:40:17 INFO - 2015-11-10 22:40:17,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 139186176 22:40:17 INFO - 2015-11-10 22:40:17,431 DEBUG : BROWSER_OUTPUT: 22:41:09 INFO - 2015-11-10 22:41:08,999 DEBUG : BROWSER_OUTPUT: 1447224068994 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:43:17 INFO - 2015-11-10 22:43:17,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35287/tests/dromaeo/cssquery-ext.html) 22:43:18 INFO - 2015-11-10 22:43:18,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 227946496 22:43:18 INFO - 2015-11-10 22:43:18,327 DEBUG : BROWSER_OUTPUT: 22:46:20 INFO - 2015-11-10 22:46:20,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/dromaeo/cssquery-ext.html (next: http://localhost:35287/tests/dromaeo/cssquery-jquery.html) 22:46:21 INFO - 2015-11-10 22:46:21,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 213688320 22:46:21 INFO - 2015-11-10 22:46:21,204 DEBUG : BROWSER_OUTPUT: 22:49:22 INFO - 2015-11-10 22:49:22,972 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35287/tests/dromaeo/cssquery-mootools.html) 22:49:23 INFO - 2015-11-10 22:49:23,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 224698368 22:49:23 INFO - 2015-11-10 22:49:23,552 DEBUG : BROWSER_OUTPUT: 22:52:25 INFO - 2015-11-10 22:52:25,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35287/tests/dromaeo/cssquery-prototype.html) 22:52:26 INFO - 2015-11-10 22:52:26,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 197005312 22:52:26 INFO - 2015-11-10 22:52:26,036 DEBUG : BROWSER_OUTPUT: 22:55:28 INFO - 2015-11-10 22:55:28,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35287/tests/dromaeo/cssquery-yui.html) 22:55:29 INFO - 2015-11-10 22:55:29,031 DEBUG : BROWSER_OUTPUT: RSS: Main: 199458816 22:55:29 INFO - 2015-11-10 22:55:29,031 DEBUG : BROWSER_OUTPUT: 22:58:31 INFO - 2015-11-10 22:58:31,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/dromaeo/cssquery-yui.html (next: http://localhost:35287/tests/dromaeo/cssquery-dojo.html) 22:58:31 INFO - 2015-11-10 22:58:31,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 361897984 22:58:31 INFO - 2015-11-10 22:58:31,729 DEBUG : BROWSER_OUTPUT: 22:58:31 INFO - 2015-11-10 22:58:31,729 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:58:31 INFO - 2015-11-10 22:58:31,729 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:58:31 INFO - 2015-11-10 22:58:31,729 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:58:31 INFO - 2015-11-10 22:58:31,729 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:58:31 INFO - 2015-11-10 22:58:31,731 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3125.421796967561;3232.48280275156;3270.8201048942296;3277.213468767495;3290.3912776136417;5093.923591146136;5251.028559716446;5423.457654234579;5450.182472629108;5480.342358916931;5292.708901010443;5306.204069389593;5362.865928351784;5375.543078838304;5403.945960540394;4852.854414367557;4854.077725232203;4871.805127794884;4905.533974272438;4958.231474121517;4853.320535125085;5046.268291097788;5067.163917953533;5104.795808167669;5134.537891589756;4880.292357608145;4913.926291105637;4974.9751251243515;4978.9751051244875;4980.252962055684;4887.633427492917;4895.339129217546;4900.093482705711;4918.926216106761;4930.876728081791;4734.786934587952;4849.127157111719;4879.097366987084;4896.338994235768;4930.260460930889;5129.12804823181;5217.139172036609;5217.5565076968505;5221.765020574046;5239.895202095937;5775.682337471438;5797;5797.333306669702;5799.536037117063;5800.187973683687;5653.23681303027;5711.742971566289;5791.623544469596;5823.126531020339;5837.737301821428;5475.616706830563;5509.256250406184;5522.392536820947;5525.944740552583;5527.170924361338;5938.406159384027;5952.107183922446;5964.105384192406;5974.40255974399;5977.163197152402;5529.917051244234;5619.971900140473;5642.520385767174;5699.145128230715;5778.479936805707;5771.422857714279;5775.913361299584;5790.565707571949;5791.507721843691;5813.331466881363;5728.656280623092;5742.942570574241;5748.166515855178;5751.9424805751405;5756.884862302731;5633.774649014075;5696.857578560569;5718.085106382959;5801.216835727208;5808.07070868659;4352.956470435255;4364.148990946798;4392.626626736699;4412.801423935931;4507.256302710081;3925;3926.155876486569;3941.034446560611;3952.2885880541203;3960.960390396059;5252.763625636779;5352.437994010573;5357.7589008494715;5365.7585408656705;5460.563154947595;5785.768569257182;5853.64878107315;5855.151003104526;5867.530597552186;5879.029960056543;5501.669899806025;5512.007838589093;5527.723613819293;5533.253010843565;5533.418991005967;4905.460399356068;4919.803207871717;4953.6037117030555;5008.949910500921;5025.195968644999;5875.236219291465;5926.644401335848;5932.940670593239;5942.7920022799;5953.3451320354725;5655.293088363955;5852.06366981298;5861.238039054895;5866.090755932837;5890.852728681817;5747.051736463437;5754.798582049608;5862.032764593965;5948.226730525004;5996.370381110095;5716.857078573069;5727.198192253005;5728.598998070095;5737.569682273763;5744.253247077853;5437.3747019091725;5796.21751063601;5824.504917082096;5831.650100993954;5838.708064596668;5465.9726701366235;5502.312210973629;5540.168974653673;5552.722363881709;5586.888262234814;5649.830505084854;5666.886662266814;5683.488486036111;5689.34572524165;5700.828975130753;5333.359996800409;5442.782288708408;5567.63810352342;5585.720713964367;5604.439556044363;5598.524125449382;5678;5698.800541981011;5736.827895163152;5739.512141467855;5507.862303442446;5509.807156749494;5513.2005859151;5515.61390702663;5635.9436405635415 22:58:31 INFO - 2015-11-10 22:58:31,734 DEBUG : BROWSER_OUTPUT: |1;ext.html;580.7909152705026;581.7469400810647;590.1914377303094;596.5972968246433;606.7451670298474;31072.378552428938;31728.841355793218;31762.68237317626;39538.60461395385;40164.598354016525;42454.363184552254;42676;42797.144057118836;42879.78560107203;43026.13947721051;7529.47293689442;8483.236508714215;8617.698380556682;8741.082186370435;8769.649214031462;7657.617119144048;10343.431111288914;10559.260851740342;10616.04455598996;10640.361578305326;10276.537555810006;10429.269951103426;10433.686989390293;10433.947830260839;10441.216908731876;7785.026871641073;7984.880226796603;10298.897011029907;10433.113185379214;10457.79084418315;10175.13511351536;10318.793624127551;10320.380777153396;10320.432376219305;10321.225908056926;38763.612363876564;38956.61043389587;39079;39255.607443925765;39289.607103929164;3190.1546090286092;3373.8987830365127;3924.548676902136;3950.940735888964;4008.939865902014;29794;29823.10530684083;30036;30945.535816962765;31270.218244544067;3299.554560134375;3354.4297469430257;3391.4573668213216;3433.7424693148114;3459.7924124552355;281484;283265.0040997547;283640;284465;285224;55110.448895511334;55782.44217557772;56203.43796561982;56822.147667785015;62387.37612623906;58692.83725208791;58889.41110588925;58894.41105588889;59296;59355.703221483614;12694.746105077847;12809.871901281054;12833.101682882296;12872.935635321763;12879.613611591667;9958.651447199314;10053.899461005443;10066.144377727975;10066.949665251626;10069;18987.905060474885;19024.71462928057;19189.808101919083;19200.71198932017;19211.32760353409;7285;7475.081402411672;7537.133229678548;7539.170691223961;7625.504342217738;935.1443429262149;983.955721992512;993.6373223773415;1004.8241557727368;1041.0786453988276;28457.288567785556;28543;28747.28131796722;28953.565696514568;29136.562951555745;1043.212374657129;1054.3884546962743;1070.978580428387;1121.3103941076342;1121.3496172220093;15408.691826163638;16254.43109491162;16283.511494655178;16427.123180950945;16440.917795410947;330582;335011;336164;337242;337724;52502.47497525052;52815.47184528183;52906.735466322425;53042;53095.46904530982;1313.507434711983;1325.0658285908412;1331.54061848664;1336.1782503760312;1342.8321459817523;23914.55097856255;25221.621675674513;27941;28569.857150714113;29169.270768230115;43512.56487435085;43540;43718;43759;43959.78020110007;229779;230606;230657;230974;401485;28558.857205713837;30656.386872262876;32131.822863027657;32158.356832862744;32523.512147317335;37424.43863341997;37696.43455348117;37932.81033594815;38082.61917380791;38482.6151738479;32045.359092817547;32708.34583308368;32732.836335818167;33258.83370583132;33271.50092748659;28840.278993025342;29390.412191756473;30130.246743830703;30265.394692105594;34712;32800;33225.833870830495;33327.83336083304;33609.327813444084;33756;29421.26446838846;29952.25119372033;30550.541741873447;30597.694023059485;30656.386872261985;24619.753802462463;25271;25379.746202538478;25830.933525318305;26614.866925665247 22:58:31 INFO - 2015-11-10 22:58:31,734 DEBUG : BROWSER_OUTPUT: |2;jquery.html;356.5543071161049;356.8715262505499;357.23016898583563;357.5227071859068;359.10582649203485;14319.284035798195;14334.71330573388;16772.41296554621;16978.320867165316;17608.2076306566;15639.374425023014;15728.685426291497;16030.198490075509;16101.83898161018;16132;5256.474352564742;5432.538234250073;5435.864103397407;5437.102878025121;5439.048166570854;4003.539592946819;4093.549709531964;5359.812406565771;5400.675959442446;5806.651600903938;5783.334916484616;5878.970605146968;5923.526117910578;5936.88126237475;5940.079287710412;5731.684757338345;5799.8690255400215;5920.79277225295;5927.110933359987;5935.970320148414;5178.430372659042;5211.166213405875;5221.112410890158;5238.266642670029;5245.10833158364;15243.847561524353;15321.080735155814;16500.009999400074;17402.564935876577;20288.898555507276;2075.8443116766302;2130.4886827161527;2192.495725983017;2268.956280111134;2344.3553022918663;13244.337783110903;13407.262600556965;13512.797308040388;13590.456381744718;13665.658358541017;1704.8891822031528;1713.049257661997;1776.1563257452735;1821.6538857617143;1897.8291953724092;58169.70915145397;59075.704621476616;59270;59953.700231498566;60810;9124.635014599342;9164.450132992042;9286.349955503185;9396.436213827192;9451.149396554343;11952.40237988097;11987.400629968466;11994.880051199376;12001.699957501132;12036.39818009096;6829.282925292872;6888.690008949609;6894.586324820527;6902.413294869993;6963.268856770068;6461.224653041571;6557.868842623121;6587.703553340111;6657.667116644148;6687.966560167168;5664.6034777566;5748.338941021836;5760.107183386582;5767.106098554731;5793.565482588822;1619.7408414653598;1679.4289941419977;1687.9915600422164;1707.3170731707417;1757.8593712502968;927.9304052195977;939.3612343606413;964.9758756031156;970.0590427285522;1005.6982905128432;11299.830502542469;12406.81389779154;12532.624021279376;16927.238274277443;17608.647827043387;500.2671086857771;500.57201093065635;501.5586284069995;514.531776083762;523.7643060622659;6597.175353080865;6753.696083676246;6761.898571521431;6856.24581296057;6879.2432832389395;558009;559780;571953;591145;595950.0809983776;73953.26046739571;76029.61985190038;77929.83105253425;78924.60537697274;78961.60519197483;568.1591244957486;570.9143628455682;572.9484346408843;573.3292048303495;573.3549756523911;11103.111751059734;11255.437228138724;11348.489317980546;11390.715232119263;11515.884841151481;35968.460473092404;36202.09494762652;36232.63767362293;36322.09194770152;36439.63560364363;46987.295190572855;47085.52914470811;48784.75607621939;49196.508034920626;49405.50594494153;6696.899546506709;6970.895436568557;6979.581225126306;6981.441484681111;6982.650867456506;12278.693032674255;12445.697545954028;12664.493420263087;12673.55642552543;12737.98096152324;10991.175661825555;10996.560137594406;11040.5031773572;11086.833697494705;11170.162237832032;10502.579896804042;10624.734381640521;10656.520456579317;10747;10894.291871028357;10881.455927203766;11102.777944441228;11255.718607034889;11265;11316.660500185008;6755.952827311775;6825.931740682529;6861.931380686129;6879.89680154788;6901.275366086488;10544.472776361305;10549.736256593647;10594.629187978384;11067.778644427228;11183.608573699881 22:58:31 INFO - 2015-11-10 22:58:31,738 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1323.2523624152348;1687.974680379794;1728.636986232891;1760.1375326090215;1774.5918438759093;6546.247181574115;7490.9250907490905;7574.09110906692;7582.165961744217;7586.544807311565;7417.925820741791;7521.811954701136;7532.322091011808;7534;7535.773926782205;2010.4069299556593;2053.722747429093;2276.465030717788;2294.7590502997236;2319.0491898321693;2243.921462748804;2276.46503071778;2277.339571524256;2278.783515566027;2280.2019293247313;2246.8988895499742;2311.861288322706;2315.143396943133;2316.177756896303;2316.9884150579223;1989.9900500497477;2017.6973453981873;2247.112390605718;2275.3174047785596;2278.9886050569808;2300.413394584387;2309.1802410144323;2332.428555004035;2341.2273949596593;2344.859308441499;7130.322619351154;7136.3220494052985;7160.140783106009;7165;7182.604956727378;4502.41468609082;4564.383808185886;4578.542145785428;4586.7477288749105;4595.586397224266;2983.418233444479;2996.2659148508537;3020.1241639924397;3030.757539396865;3104.984475077633;886.1670030171618;890.7505898348472;906.3927168796922;925.7963248085478;926.9860952085725;10039.34744241622;10149.289549731522;10166.034226748447;10183.89816101837;10205.336653117598;4282.336237883133;4324.762138082373;4367.781610919441;4429.756363400044;4432.069265454226;8738.912610873937;8741.082186370466;8742.519161446182;8750.64997400097;8776.16626420489;4502.729836209773;4507.18870603288;4521;4536.092781443725;4536.61438777701;4024.3762216856435;4040.595940405936;4044.292248856438;4050.6354428101613;4057.8173982170874;3523.5947865995226;3561.44797556374;3565.625609310985;3570.1610121621397;3590.820458977093;1137.6928229378186;1169.1114752787773;1190.660661711408;1195.5994741761608;1218.5856808684912;926.5969303353063;1302.6808431934048;1304.373900527752;1319.5381616434363;1331.73365326935;6300.369963003663;6766.323367663194;6932.306769323028;6939.930600693929;6941.583504989717;673.3636713305879;684.6029303004245;687.9724811007503;693.5977133262695;696.7596179318127;5529.889402211933;5560.7488315129585;5566.721663916788;5568.9443105568425;5570.470805273492;8700.216980471789;8765.737027889174;8941.552922353856;8999.730008099637;9087.954560227157;8992.505412202261;8994.460332379947;9000.36997410175;9003.36976411658;9006.954965225132;6478.740850365933;6584;7000.894986575104;7022.438204943593;7066.3640272374705;6657.533972622064;6751.628660423724;6762.222344430454;6767.35710107539;6771.356721111487;7759.107702614272;7866;7920.366370690446;7969.043714754266;7992.36061115121;8064.314533264738;8153.266206041485;8230.794230144294;8235.588220588827;8309.916900831156;6706.262311145672;6721.831954201184;6756.223034351113;6838.897416538855;6857.485688573477;7107;7142.214356420894;7202.567845929261;7203;7205.747798827016;6632.668366581748;6673.866522669617;6691.888271953565;6725.461963042847;6738.764143254963;6418;6696.59820410777;6818.897716534157;6840.623765692934;6957.060796792368;6035.939640603538;6212.161358216583;6354.618722876642;6829.317068293131;6874.587524748331;6337.081123237197;6360.332165122595;6375.74497020114;6380.617162970237;6382.808515744535;6247.562670613195;6368.949123394588;6373.776917807854;6406.327335629691;6418.101465794699 22:58:31 INFO - 2015-11-10 22:58:31,738 DEBUG : BROWSER_OUTPUT: |4;prototype.html;311.8440779610195;315.3566723883278;322.81438173050503;324.6428928179005;331.6401704150996;5756.971215143929;5825.621334613247;5871.060630299153;5888.676122813249;5903.940960590398;5669.6314739542;5707.942920570793;5740.827775166741;5779.971100144504;5791.160281759142;4408.3167109097985;4416.381706561076;4416.889577760549;4416.955830441687;4422.071365013335;4284.935725964113;4332.198543269489;4360.781960901958;4414.02891363901;4432.645388368923;4393.340998850166;4395.692301538894;4402.25161722508;4402.669799765014;4414.249577571821;4392.780360981938;4395.164918665443;4395.428594282739;4402.295632698785;4403.581659742319;3819.5607505136986;3834.9808250958845;3838.1556057667267;3841.154945911895;3842.3083844907906;5424;5508.944910550883;5533;5598.888022239533;5605.775768969236;5146.614003949719;5151.278820965068;5151.536361727425;5151.7681704323395;5161.993411284801;6163.599366041193;6169.167162433059;6169.29053158888;6170.691465426711;6178.135061091451;4294.141171765659;4296.849610263625;4296.935545966813;4298.183345164409;4299.247631664446;6271.153394291758;6353.777617783356;6373.107764912916;6378.170837791104;6380.425761681471;4286.721363111388;4311.741295522279;4314.71954322968;4314.978425107917;4315.287977483743;4355.956440435619;4360.345948107746;4365.585269399402;4369.541198174209;4369.825206991684;5055.241713742968;5060.544550990428;5067.619928505377;5073.949260507347;5074.340335756402;6116.724747386378;6232.968835155886;6239.438450539473;6241.875162496724;6245.531585131042;1570.685862827439;1589.0703938196284;1589.276879020043;1589.3404237241646;1589.737693280619;1027.5273374247781;1036.1969473657975;1041.9791604167874;1050.6637875879644;1061.0397590180899;6038.758449662052;6039.184710064085;6063.454289114001;6069.36271691466;6070.726817293233;6214.223222097238;6289.8742025159245;6308.0537919311555;6394.904076438857;6398.8080357588415;5958.314793798769;5999.730012149464;6008.609440386361;6011.759529618854;6040.7583696651645;3497.5802903651725;3522.9823850881094;3525.259695463981;3530.117470632342;3532.911677208039;6377.5216858735785;6439.839004024843;6469.288378278386;6489.1888513935755;6490.610563366213;6468.126802881551;6473.06140609609;6489.156409666807;6566.540342176002;6568.047633093175;6585.769498067544;6588.439982601532;6594.70323835419;6599.340065993362;6602.504812139109;6276.246850377984;6424.357564243538;6450.193725784277;6467.320931302145;6472.385123413268;6300.936990630218;6309.873802523832;6324.4940404766585;6349.841253968688;6351.110844481684;6462.256840463218;6513.739450422119;6517.674116294261;6524.706388212637;6528.934710652833;4357.760323182255;4391.429114215131;4391.692581519263;4392;4393.978030109829;6266.185395898504;6339.429451349401;6378.77674281398;6422;6449.193850768654;6272.466840318624;6283;6286.277078136073;6289.433950944437;6293.905591416041;6258.280297765815;6269.12232287471;6269.404406581368;6274.372562743689;6277.027060805583;6045.758169673164;6179.258488981351;6181.196444462191;6183.721732522137;6185.597936134137;6321.273053598711;6321.905171422524;6322.399372059647;6325.4939604832425;6326;5917.289925209003;6158.076288556573;6159.876802463836;6160.568760186744;6163.7842675506145 22:58:31 INFO - 2015-11-10 22:58:31,738 DEBUG : BROWSER_OUTPUT: |5;yui.html;780.6409051836155;821.9958900205498;832.7543374704461;836.5942517878829;850.07766573268;12425.875741242586;12700.110992230524;12721.618351449448;12723.936380318097;12739.171953822995;12782.169159004658;13029.478820847178;13062.804057939138;13117.540886068966;13134.343282835844;680.2415306932784;687.821166496712;812.7927378518469;813;828.4739190613973;819.8647223208163;820.8727647214691;824.286991752136;825.455199568285;826.0747962282252;859.8108416148438;865.4374656473279;867.7960679240374;867.9522626255554;867.9522626255554;704.5631708340836;711.6263961420244;846.8645016797313;857.1300130367682;859.2910848549909;627.3694936588745;628.6856571714143;629.2637613991641;629.4523764325066;629.8582818865718;13188.142770719873;13517.729645407135;13529.797053044213;13532.188068715908;13543.187408755506;11570.305781653044;12010;12493.312867792269;12605;12857.742845143139;10239.948800255952;10258.1022510835;10428.530716117717;10436.895631043744;10453.05922466974;3529.4529347951107;3576.517170182044;3581.3732596795458;3589.4436362363876;3749.062734316421;44479;44668.3299750504;44761;44964;44984.3252351215;9662.903370966342;9707;9769;9812.116909478038;9931.702048938543;17673.469795906145;17718.734218986727;17721.556961075818;17723.911380443016;17925.28298868031;6877.89683154753;6934.791956241321;7277.89083163753;7457.7016919323705;7575.6969721211635;4095.8566450174103;4285.185814695198;4314.245007123741;4329.675274354436;4356.6514678825615;2644.6165306030903;2665.5068812269405;2669.8131130820657;2675.317793962527;2677.54481738105;407.7920260667081;413.1344832575749;413.59880915511906;415.167588984085;415.3292432721134;658.9406953374123;662.4998126414526;663.0617675988518;663.598522893652;685.9931400686029;8122.959385203036;8163.632636531371;8290.792730181673;8425.536595487307;8476.194761497647;648.9351064893567;654.5418207254941;661.4278648968608;662.3707477896018;676.0839063069568;4269.167512335065;4348.804303806336;4361.672874534423;4375.321825117112;4536.342230376643;52581;53174.468255317726;53616.73191634017;58280.41719582835;58456.70771646115;48984.75507622439;49916.75041624841;50456.495435045916;50637.74681126571;50978.490215098114;46407;46752.2987155193;47532.5246747535;47635.285470717965;47887.76056119697;8678.349123815613;8809.955950220208;9077.500737459502;9146.588403521724;9370.969193388859;34196.48705269473;35525.82237088798;35918.10204744902;36376;36490.270194595425;42295.36556951587;42990.35514467348;43265.567344326155;44102;44263.55736442594;7583.582902940391;8184.181581841768;8188.222118898695;8225.054118776177;8249.711260105867;12184.51261949512;12213.633590992284;12238.265704057785;12564.87435125637;12752.553660621834;10862.185336099667;11018.173636977099;11128;11229.550817967516;11407.201495895208;11392.316461012366;11397.772044559228;11523.423828808358;12049.33728644898;12149.453274602487;8572.142785721628;10451.895481045092;11268.549258029587;11342.489587968395;11837.053035756946;9875.40747555149;9917.404955702392;10121.190304775748;10123.595056197964;10298.485075746332;8214.301784348398;9562.952185239308;10081.44552049615;10215.846762298721;10286.331388459726 22:58:31 INFO - 2015-11-10 22:58:31,738 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:58:31 INFO - 2015-11-10 22:58:31,738 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:58:31 INFO - 2015-11-10 22:58:31,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,707 22:58:31 INFO - 2015-11-10 22:58:31,738 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:58:31 INFO - 2015-11-10 22:58:31,739 DEBUG : BROWSER_OUTPUT: __startTimestamp1447225111727__endTimestamp 22:58:31 INFO - 2015-11-10 22:58:31,739 DEBUG : BROWSER_OUTPUT: 22:58:31 INFO - 2015-11-10 22:58:31,739 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:58:31 INFO - 2015-11-10 22:58:31,739 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:58:31 INFO - 2015-11-10 22:58:31,739 DEBUG : BROWSER_OUTPUT: 22:58:31 INFO - 2015-11-10 22:58:31,739 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5357.31 Median:5529.92 stddev:595.07 (10.8%) stddev-sans-first:570.55 22:58:31 INFO - 2015-11-10 22:58:31,740 DEBUG : BROWSER_OUTPUT: Values: 3125.4 3232.5 3270.8 3277.2 3290.4 5093.9 5251.0 5423.5 5450.2 5480.3 5292.7 5306.2 5362.9 5375.5 5403.9 4852.9 4854.1 4871.8 4905.5 4958.2 4853.3 5046.3 5067.2 5104.8 5134.5 4880.3 4913.9 4975.0 4979.0 4980.3 4887.6 4895.3 4900.1 4918.9 4930.9 4734.8 4849.1 4879.1 4896.3 4930.3 5129.1 5217.1 5217.6 5221.8 5239.9 5775.7 5797.0 5797.3 5799.5 5800.2 5653.2 5711.7 5791.6 5823.1 5837.7 5475.6 5509.3 5522.4 5525.9 5527.2 5938.4 5952.1 5964.1 5974.4 5977.2 5529.9 5620.0 5642.5 5699.1 5778.5 5771.4 5775.9 5790.6 5791.5 5813.3 5728.7 5742.9 5748.2 5751.9 5756.9 5633.8 5696.9 5718.1 5801.2 5808.1 4353.0 4364.1 4392.6 4412.8 4507.3 3925.0 3926.2 3941.0 3952.3 3961.0 5252.8 5352.4 5357.8 5365.8 5460.6 5785.8 5853.6 5855.2 5867.5 5879.0 5501.7 5512.0 5527.7 5533.3 5533.4 4905.5 4919.8 4953.6 5008.9 5025.2 5875.2 5926.6 5932.9 5942.8 5953.3 5655.3 5852.1 5861.2 5866.1 5890.9 5747.1 5754.8 5862.0 5948.2 5996.4 5716.9 5727.2 5728.6 5737.6 5744.3 5437.4 5796.2 5824.5 5831.7 5838.7 5466.0 5502.3 5540.2 5552.7 5586.9 5649.8 5666.9 5683.5 5689.3 5700.8 5333.4 5442.8 5567.6 5585.7 5604.4 5598.5 5678.0 5698.8 5736.8 5739.5 5507.9 5509.8 5513.2 5515.6 5635.9 22:58:31 INFO - 2015-11-10 22:58:31,740 DEBUG : BROWSER_OUTPUT: 22:58:31 INFO - 2015-11-10 22:58:31,740 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45728.44 Median:17476.42 stddev:78298.68 (448.0%) stddev-sans-first:78444.95 22:58:31 INFO - 2015-11-10 22:58:31,740 DEBUG : BROWSER_OUTPUT: Values: 580.8 581.7 590.2 596.6 606.7 31072.4 31728.8 31762.7 39538.6 40164.6 42454.4 42676.0 42797.1 42879.8 43026.1 7529.5 8483.2 8617.7 8741.1 8769.6 7657.6 10343.4 10559.3 10616.0 10640.4 10276.5 10429.3 10433.7 10433.9 10441.2 7785.0 7984.9 10298.9 10433.1 10457.8 10175.1 10318.8 10320.4 10320.4 10321.2 38763.6 38956.6 39079.0 39255.6 39289.6 3190.2 3373.9 3924.5 3950.9 4008.9 29794.0 29823.1 30036.0 30945.5 31270.2 3299.6 3354.4 3391.5 3433.7 3459.8 281484.0 283265.0 283640.0 284465.0 285224.0 55110.4 55782.4 56203.4 56822.1 62387.4 58692.8 58889.4 58894.4 59296.0 59355.7 12694.7 12809.9 12833.1 12872.9 12879.6 9958.7 10053.9 10066.1 10066.9 10069.0 18987.9 19024.7 19189.8 19200.7 19211.3 7285.0 7475.1 7537.1 7539.2 7625.5 935.1 984.0 993.6 1004.8 1041.1 28457.3 28543.0 28747.3 28953.6 29136.6 1043.2 1054.4 1071.0 1121.3 1121.3 15408.7 16254.4 16283.5 16427.1 16440.9 330582.0 335011.0 336164.0 337242.0 337724.0 52502.5 52815.5 52906.7 53042.0 53095.5 1313.5 1325.1 1331.5 1336.2 1342.8 23914.6 25221.6 27941.0 28569.9 29169.3 43512.6 43540.0 43718.0 43759.0 43959.8 229779.0 230606.0 230657.0 230974.0 401485.0 28558.9 30656.4 32131.8 32158.4 32523.5 37424.4 37696.4 37932.8 38082.6 38482.6 32045.4 32708.3 32732.8 33258.8 33271.5 28840.3 29390.4 30130.2 30265.4 34712.0 32800.0 33225.8 33327.8 33609.3 33756.0 29421.3 29952.3 30550.5 30597.7 30656.4 24619.8 25271.0 25379.7 25830.9 26614.9 22:58:31 INFO - 2015-11-10 22:58:31,741 DEBUG : BROWSER_OUTPUT: 22:58:31 INFO - 2015-11-10 22:58:31,741 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28806.55 Median:48990.63 stddev:94125.16 (192.1%) stddev-sans-first:94364.96 22:58:31 INFO - 2015-11-10 22:58:31,742 DEBUG : BROWSER_OUTPUT: Values: 356.6 356.9 357.2 357.5 359.1 14319.3 14334.7 16772.4 16978.3 17608.2 15639.4 15728.7 16030.2 16101.8 16132.0 5256.5 5432.5 5435.9 5437.1 5439.0 4003.5 4093.5 5359.8 5400.7 5806.7 5783.3 5879.0 5923.5 5936.9 5940.1 5731.7 5799.9 5920.8 5927.1 5936.0 5178.4 5211.2 5221.1 5238.3 5245.1 15243.8 15321.1 16500.0 17402.6 20288.9 2075.8 2130.5 2192.5 2269.0 2344.4 13244.3 13407.3 13512.8 13590.5 13665.7 1704.9 1713.0 1776.2 1821.7 1897.8 58169.7 59075.7 59270.0 59953.7 60810.0 9124.6 9164.5 9286.3 9396.4 9451.1 11952.4 11987.4 11994.9 12001.7 12036.4 6829.3 6888.7 6894.6 6902.4 6963.3 6461.2 6557.9 6587.7 6657.7 6688.0 5664.6 5748.3 5760.1 5767.1 5793.6 1619.7 1679.4 1688.0 1707.3 1757.9 927.9 939.4 965.0 970.1 1005.7 11299.8 12406.8 12532.6 16927.2 17608.6 500.3 500.6 501.6 514.5 523.8 6597.2 6753.7 6761.9 6856.2 6879.2 558009.0 559780.0 571953.0 591145.0 595950.1 73953.3 76029.6 77929.8 78924.6 78961.6 568.2 570.9 572.9 573.3 573.4 11103.1 11255.4 11348.5 11390.7 11515.9 35968.5 36202.1 36232.6 36322.1 36439.6 46987.3 47085.5 48784.8 49196.5 49405.5 6696.9 6970.9 6979.6 6981.4 6982.7 12278.7 12445.7 12664.5 12673.6 12738.0 10991.2 10996.6 11040.5 11086.8 11170.2 10502.6 10624.7 10656.5 10747.0 10894.3 10881.5 11102.8 11255.7 11265.0 11316.7 6756.0 6825.9 6861.9 6879.9 6901.3 10544.5 10549.7 10594.6 11067.8 11183.6 22:58:31 INFO - 2015-11-10 22:58:31,742 DEBUG : BROWSER_OUTPUT: 22:58:31 INFO - 2015-11-10 22:58:31,742 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5233.60 Median:6394.57 stddev:2673.17 (41.8%) stddev-sans-first:2664.51 22:58:31 INFO - 2015-11-10 22:58:31,742 DEBUG : BROWSER_OUTPUT: Values: 1323.3 1688.0 1728.6 1760.1 1774.6 6546.2 7490.9 7574.1 7582.2 7586.5 7417.9 7521.8 7532.3 7534.0 7535.8 2010.4 2053.7 2276.5 2294.8 2319.0 2243.9 2276.5 2277.3 2278.8 2280.2 2246.9 2311.9 2315.1 2316.2 2317.0 1990.0 2017.7 2247.1 2275.3 2279.0 2300.4 2309.2 2332.4 2341.2 2344.9 7130.3 7136.3 7160.1 7165.0 7182.6 4502.4 4564.4 4578.5 4586.7 4595.6 2983.4 2996.3 3020.1 3030.8 3105.0 886.2 890.8 906.4 925.8 927.0 10039.3 10149.3 10166.0 10183.9 10205.3 4282.3 4324.8 4367.8 4429.8 4432.1 8738.9 8741.1 8742.5 8750.6 8776.2 4502.7 4507.2 4521.0 4536.1 4536.6 4024.4 4040.6 4044.3 4050.6 4057.8 3523.6 3561.4 3565.6 3570.2 3590.8 1137.7 1169.1 1190.7 1195.6 1218.6 926.6 1302.7 1304.4 1319.5 1331.7 6300.4 6766.3 6932.3 6939.9 6941.6 673.4 684.6 688.0 693.6 696.8 5529.9 5560.7 5566.7 5568.9 5570.5 8700.2 8765.7 8941.6 8999.7 9088.0 8992.5 8994.5 9000.4 9003.4 9007.0 6478.7 6584.0 7000.9 7022.4 7066.4 6657.5 6751.6 6762.2 6767.4 6771.4 7759.1 7866.0 7920.4 7969.0 7992.4 8064.3 8153.3 8230.8 8235.6 8309.9 6706.3 6721.8 6756.2 6838.9 6857.5 7107.0 7142.2 7202.6 7203.0 7205.7 6632.7 6673.9 6691.9 6725.5 6738.8 6418.0 6696.6 6818.9 6840.6 6957.1 6035.9 6212.2 6354.6 6829.3 6874.6 6337.1 6360.3 6375.7 6380.6 6382.8 6247.6 6368.9 6373.8 6406.3 6418.1 22:58:31 INFO - 2015-11-10 22:58:31,742 DEBUG : BROWSER_OUTPUT: 22:58:31 INFO - 2015-11-10 22:58:31,744 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5167.59 Median:5937.80 stddev:1564.10 (26.3%) stddev-sans-first:1525.43 22:58:31 INFO - 2015-11-10 22:58:31,744 DEBUG : BROWSER_OUTPUT: Values: 311.8 315.4 322.8 324.6 331.6 5757.0 5825.6 5871.1 5888.7 5903.9 5669.6 5707.9 5740.8 5780.0 5791.2 4408.3 4416.4 4416.9 4417.0 4422.1 4284.9 4332.2 4360.8 4414.0 4432.6 4393.3 4395.7 4402.3 4402.7 4414.2 4392.8 4395.2 4395.4 4402.3 4403.6 3819.6 3835.0 3838.2 3841.2 3842.3 5424.0 5508.9 5533.0 5598.9 5605.8 5146.6 5151.3 5151.5 5151.8 5162.0 6163.6 6169.2 6169.3 6170.7 6178.1 4294.1 4296.8 4296.9 4298.2 4299.2 6271.2 6353.8 6373.1 6378.2 6380.4 4286.7 4311.7 4314.7 4315.0 4315.3 4356.0 4360.3 4365.6 4369.5 4369.8 5055.2 5060.5 5067.6 5073.9 5074.3 6116.7 6233.0 6239.4 6241.9 6245.5 1570.7 1589.1 1589.3 1589.3 1589.7 1027.5 1036.2 1042.0 1050.7 1061.0 6038.8 6039.2 6063.5 6069.4 6070.7 6214.2 6289.9 6308.1 6394.9 6398.8 5958.3 5999.7 6008.6 6011.8 6040.8 3497.6 3523.0 3525.3 3530.1 3532.9 6377.5 6439.8 6469.3 6489.2 6490.6 6468.1 6473.1 6489.2 6566.5 6568.0 6585.8 6588.4 6594.7 6599.3 6602.5 6276.2 6424.4 6450.2 6467.3 6472.4 6300.9 6309.9 6324.5 6349.8 6351.1 6462.3 6513.7 6517.7 6524.7 6528.9 4357.8 4391.4 4391.7 4392.0 4394.0 6266.2 6339.4 6378.8 6422.0 6449.2 6272.5 6283.0 6286.3 6289.4 6293.9 6258.3 6269.1 6269.4 6274.4 6277.0 6045.8 6179.3 6181.2 6183.7 6185.6 6321.3 6321.9 6322.4 6325.5 6326.0 5917.3 6158.1 6159.9 6160.6 6163.8 22:58:31 INFO - 2015-11-10 22:58:31,744 DEBUG : BROWSER_OUTPUT: 22:58:31 INFO - 2015-11-10 22:58:31,744 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13486.50 Median:44714.66 stddev:15553.18 (34.8%) stddev-sans-first:15567.54 22:58:31 INFO - 2015-11-10 22:58:31,744 DEBUG : BROWSER_OUTPUT: Values: 780.6 822.0 832.8 836.6 850.1 12425.9 12700.1 12721.6 12723.9 12739.2 12782.2 13029.5 13062.8 13117.5 13134.3 680.2 687.8 812.8 813.0 828.5 819.9 820.9 824.3 825.5 826.1 859.8 865.4 867.8 868.0 868.0 704.6 711.6 846.9 857.1 859.3 627.4 628.7 629.3 629.5 629.9 13188.1 13517.7 13529.8 13532.2 13543.2 11570.3 12010.0 12493.3 12605.0 12857.7 10239.9 10258.1 10428.5 10436.9 10453.1 3529.5 3576.5 3581.4 3589.4 3749.1 44479.0 44668.3 44761.0 44964.0 44984.3 9662.9 9707.0 9769.0 9812.1 9931.7 17673.5 17718.7 17721.6 17723.9 17925.3 6877.9 6934.8 7277.9 7457.7 7575.7 4095.9 4285.2 4314.2 4329.7 4356.7 2644.6 2665.5 2669.8 2675.3 2677.5 407.8 413.1 413.6 415.2 415.3 658.9 662.5 663.1 663.6 686.0 8123.0 8163.6 8290.8 8425.5 8476.2 648.9 654.5 661.4 662.4 676.1 4269.2 4348.8 4361.7 4375.3 4536.3 52581.0 53174.5 53616.7 58280.4 58456.7 48984.8 49916.8 50456.5 50637.7 50978.5 46407.0 46752.3 47532.5 47635.3 47887.8 8678.3 8810.0 9077.5 9146.6 9371.0 34196.5 35525.8 35918.1 36376.0 36490.3 42295.4 42990.4 43265.6 44102.0 44263.6 7583.6 8184.2 8188.2 8225.1 8249.7 12184.5 12213.6 12238.3 12564.9 12752.6 10862.2 11018.2 11128.0 11229.6 11407.2 11392.3 11397.8 11523.4 12049.3 12149.5 8572.1 10451.9 11268.5 11342.5 11837.1 9875.4 9917.4 10121.2 10123.6 10298.5 8214.3 9563.0 10081.4 10215.8 10286.3 22:58:31 INFO - 2015-11-10 22:58:31,744 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:58:31 INFO - 2015-11-10 22:58:31,744 DEBUG : BROWSER_OUTPUT: 22:58:32 INFO - 2015-11-10 22:58:32,449 INFO : Browser exited with error code: 0 22:58:32 INFO - 2015-11-10 22:58:32,467 INFO : Completed test dromaeo_css (00:18:32) 22:58:32 INFO - 2015-11-10 22:58:32,468 INFO : Starting test kraken 22:58:32 INFO - 2015-11-10 22:58:32,468 DEBUG : operating with platform_type : linux_ 22:58:32 INFO - 2015-11-10 22:58:32,468 INFO : Initialising browser for kraken test... 22:58:32 INFO - 2015-11-10 22:58:32,474 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGBymig/profile http://localhost:35287/getInfo.html 22:58:36 INFO - 2015-11-10 22:58:36,151 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:58:36 INFO - 2015-11-10 22:58:36,152 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:58:36 INFO - 2015-11-10 22:58:36,152 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:58:36 INFO - 2015-11-10 22:58:36,153 DEBUG : BROWSER_OUTPUT: __metrics 22:58:36 INFO - 2015-11-10 22:58:36,270 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:58:37 INFO - 2015-11-10 22:58:37,445 INFO : Browser initialized. 22:58:37 INFO - 2015-11-10 22:58:37,445 INFO : Running cycle 1/1 for kraken test... 22:58:37 INFO - 2015-11-10 22:58:37,445 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGBymig/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:58:49 INFO - 2015-11-10 22:58:49,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 139526144 22:58:49 INFO - 2015-11-10 22:58:49,195 DEBUG : BROWSER_OUTPUT: 22:58:51 INFO - 2015-11-10 22:58:51,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35287/tests/kraken/driver.html?testName=audio-beat-detection) 22:58:52 INFO - 2015-11-10 22:58:52,261 DEBUG : BROWSER_OUTPUT: RSS: Main: 181354496 22:58:52 INFO - 2015-11-10 22:58:52,261 DEBUG : BROWSER_OUTPUT: 22:58:54 INFO - 2015-11-10 22:58:54,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35287/tests/kraken/driver.html?testName=audio-dft) 22:58:55 INFO - 2015-11-10 22:58:55,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 170475520 22:58:55 INFO - 2015-11-10 22:58:55,440 DEBUG : BROWSER_OUTPUT: 22:58:58 INFO - 2015-11-10 22:58:58,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35287/tests/kraken/driver.html?testName=audio-fft) 22:58:58 INFO - 2015-11-10 22:58:58,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 151347200 22:58:58 INFO - 2015-11-10 22:58:58,818 DEBUG : BROWSER_OUTPUT: 22:59:00 INFO - 2015-11-10 22:59:00,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35287/tests/kraken/driver.html?testName=audio-oscillator) 22:59:01 INFO - 2015-11-10 22:59:01,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 154234880 22:59:01 INFO - 2015-11-10 22:59:01,351 DEBUG : BROWSER_OUTPUT: 22:59:03 INFO - 2015-11-10 22:59:03,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35287/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:59:04 INFO - 2015-11-10 22:59:04,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 155193344 22:59:04 INFO - 2015-11-10 22:59:04,090 DEBUG : BROWSER_OUTPUT: 22:59:06 INFO - 2015-11-10 22:59:06,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35287/tests/kraken/driver.html?testName=imaging-darkroom) 22:59:07 INFO - 2015-11-10 22:59:07,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 156516352 22:59:07 INFO - 2015-11-10 22:59:07,553 DEBUG : BROWSER_OUTPUT: 22:59:10 INFO - 2015-11-10 22:59:10,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35287/tests/kraken/driver.html?testName=imaging-desaturate) 22:59:11 INFO - 2015-11-10 22:59:11,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 155832320 22:59:11 INFO - 2015-11-10 22:59:11,522 DEBUG : BROWSER_OUTPUT: 22:59:14 INFO - 2015-11-10 22:59:14,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35287/tests/kraken/driver.html?testName=json-parse-financial) 22:59:14 INFO - 2015-11-10 22:59:14,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 156995584 22:59:14 INFO - 2015-11-10 22:59:14,853 DEBUG : BROWSER_OUTPUT: 22:59:16 INFO - 2015-11-10 22:59:16,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35287/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:59:17 INFO - 2015-11-10 22:59:17,027 DEBUG : BROWSER_OUTPUT: RSS: Main: 174432256 22:59:17 INFO - 2015-11-10 22:59:17,027 DEBUG : BROWSER_OUTPUT: 22:59:18 INFO - 2015-11-10 22:59:18,795 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35287/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:59:19 INFO - 2015-11-10 22:59:19,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 166903808 22:59:19 INFO - 2015-11-10 22:59:19,397 DEBUG : BROWSER_OUTPUT: 22:59:21 INFO - 2015-11-10 22:59:21,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35287/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:59:22 INFO - 2015-11-10 22:59:22,015 DEBUG : BROWSER_OUTPUT: RSS: Main: 177254400 22:59:22 INFO - 2015-11-10 22:59:22,015 DEBUG : BROWSER_OUTPUT: 22:59:24 INFO - 2015-11-10 22:59:24,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35287/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:59:24 INFO - 2015-11-10 22:59:24,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 180416512 22:59:24 INFO - 2015-11-10 22:59:24,994 DEBUG : BROWSER_OUTPUT: 22:59:27 INFO - 2015-11-10 22:59:27,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35287/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:59:28 INFO - 2015-11-10 22:59:28,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 180723712 22:59:28 INFO - 2015-11-10 22:59:28,109 DEBUG : BROWSER_OUTPUT: 22:59:29 INFO - 2015-11-10 22:59:29,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35287/tests/kraken/driver.html?testName=ai-astar) 22:59:30 INFO - 2015-11-10 22:59:30,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 240197632 22:59:30 INFO - 2015-11-10 22:59:30,026 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,028 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:59:30 INFO - 2015-11-10 22:59:30,028 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:59:30 INFO - 2015-11-10 22:59:30,028 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:59:30 INFO - 2015-11-10 22:59:30,028 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:59:30 INFO - 2015-11-10 22:59:30,028 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;103;110;110;111;101;109;108;111 22:59:30 INFO - 2015-11-10 22:59:30,029 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;124;149;164;128;148;158;124;166;126 22:59:30 INFO - 2015-11-10 22:59:30,029 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;160;160;161;163;160;165;163;164 22:59:30 INFO - 2015-11-10 22:59:30,029 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;85;92;71;73;71;96;90;77 22:59:30 INFO - 2015-11-10 22:59:30,029 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;142;92;93;93;147;91;91;133 22:59:30 INFO - 2015-11-10 22:59:30,029 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;110;109;110;109;110 22:59:30 INFO - 2015-11-10 22:59:30,029 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;145;144;145;145;146;146;146 22:59:30 INFO - 2015-11-10 22:59:30,030 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;95;96;96;95;95;96 22:59:30 INFO - 2015-11-10 22:59:30,030 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;57;57;68;61;58;59;74;56;61 22:59:30 INFO - 2015-11-10 22:59:30,030 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;66;66;67;66;67;67;66;66;66 22:59:30 INFO - 2015-11-10 22:59:30,030 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;85;84;86;85;85;85;87;86 22:59:30 INFO - 2015-11-10 22:59:30,030 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;122;122;115;128;112;118;116;135;116 22:59:30 INFO - 2015-11-10 22:59:30,030 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;151;149;151;151;136;152;148;148;139 22:59:30 INFO - 2015-11-10 22:59:30,030 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;65;66;65;68;66;69;68;69 22:59:30 INFO - 2015-11-10 22:59:30,031 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:59:30 INFO - 2015-11-10 22:59:30,031 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:59:30 INFO - 2015-11-10 22:59:30,031 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,917 22:59:30 INFO - 2015-11-10 22:59:30,031 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:59:30 INFO - 2015-11-10 22:59:30,031 DEBUG : BROWSER_OUTPUT: __startTimestamp1447225170026__endTimestamp 22:59:30 INFO - 2015-11-10 22:59:30,031 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,035 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:59:30 INFO - 2015-11-10 22:59:30,035 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:59:30 INFO - 2015-11-10 22:59:30,035 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,035 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.00 Median:109.50 stddev:3.37 (3.1%) stddev-sans-first:3.57 22:59:30 INFO - 2015-11-10 22:59:30,035 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 103.0 110.0 110.0 111.0 101.0 109.0 108.0 111.0 22:59:30 INFO - 2015-11-10 22:59:30,035 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,035 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.60 Median:149.00 stddev:16.75 (11.2%) stddev-sans-first:17.65 22:59:30 INFO - 2015-11-10 22:59:30,035 DEBUG : BROWSER_OUTPUT: Values: 149.0 124.0 149.0 164.0 128.0 148.0 158.0 124.0 166.0 126.0 22:59:30 INFO - 2015-11-10 22:59:30,035 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,035 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.96 (1.2%) stddev-sans-first:1.99 22:59:30 INFO - 2015-11-10 22:59:30,035 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 160.0 160.0 161.0 163.0 160.0 165.0 163.0 164.0 22:59:30 INFO - 2015-11-10 22:59:30,035 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,035 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.90 Median:81.00 stddev:9.86 (12.2%) stddev-sans-first:10.14 22:59:30 INFO - 2015-11-10 22:59:30,035 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 85.0 92.0 71.0 73.0 71.0 96.0 90.0 77.0 22:59:30 INFO - 2015-11-10 22:59:30,035 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,036 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:91.50 stddev:23.82 (26.0%) stddev-sans-first:24.69 22:59:30 INFO - 2015-11-10 22:59:30,036 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 142.0 92.0 93.0 93.0 147.0 91.0 91.0 133.0 22:59:30 INFO - 2015-11-10 22:59:30,036 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,036 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 22:59:30 INFO - 2015-11-10 22:59:30,036 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 110.0 109.0 110.0 109.0 110.0 22:59:30 INFO - 2015-11-10 22:59:30,036 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,036 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 22:59:30 INFO - 2015-11-10 22:59:30,036 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 145.0 144.0 145.0 145.0 146.0 146.0 146.0 22:59:30 INFO - 2015-11-10 22:59:30,036 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,036 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 22:59:30 INFO - 2015-11-10 22:59:30,036 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 22:59:30 INFO - 2015-11-10 22:59:30,036 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,036 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.90 Median:61.00 stddev:6.05 (9.9%) stddev-sans-first:6.00 22:59:30 INFO - 2015-11-10 22:59:30,036 DEBUG : BROWSER_OUTPUT: Values: 68.0 57.0 57.0 68.0 61.0 58.0 59.0 74.0 56.0 61.0 22:59:30 INFO - 2015-11-10 22:59:30,036 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,037 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 22:59:30 INFO - 2015-11-10 22:59:30,037 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 66.0 67.0 66.0 67.0 67.0 66.0 66.0 66.0 22:59:30 INFO - 2015-11-10 22:59:30,037 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,037 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:1.48 (1.7%) stddev-sans-first:1.17 22:59:30 INFO - 2015-11-10 22:59:30,037 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 85.0 84.0 86.0 85.0 85.0 85.0 87.0 86.0 22:59:30 INFO - 2015-11-10 22:59:30,037 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,037 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:120.00 stddev:7.23 (6.0%) stddev-sans-first:7.25 22:59:30 INFO - 2015-11-10 22:59:30,037 DEBUG : BROWSER_OUTPUT: Values: 113.0 122.0 122.0 115.0 128.0 112.0 118.0 116.0 135.0 116.0 22:59:30 INFO - 2015-11-10 22:59:30,037 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,037 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:150.00 stddev:5.87 (3.9%) stddev-sans-first:5.74 22:59:30 INFO - 2015-11-10 22:59:30,037 DEBUG : BROWSER_OUTPUT: Values: 140.0 151.0 149.0 151.0 151.0 136.0 152.0 148.0 148.0 139.0 22:59:30 INFO - 2015-11-10 22:59:30,037 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,037 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.55 (2.3%) stddev-sans-first:1.62 22:59:30 INFO - 2015-11-10 22:59:30,037 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 65.0 66.0 65.0 68.0 66.0 69.0 68.0 69.0 22:59:30 INFO - 2015-11-10 22:59:30,037 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:59:30 INFO - 2015-11-10 22:59:30,037 DEBUG : BROWSER_OUTPUT: 22:59:30 INFO - 2015-11-10 22:59:30,849 INFO : Browser exited with error code: 0 22:59:30 INFO - 2015-11-10 22:59:30,901 INFO : Completed test kraken (00:00:58) 22:59:30 INFO - 2015-11-10 22:59:30,901 INFO : Starting test v8_7 22:59:30 INFO - 2015-11-10 22:59:30,901 DEBUG : operating with platform_type : linux_ 22:59:30 INFO - 2015-11-10 22:59:30,901 INFO : Initialising browser for v8_7 test... 22:59:30 INFO - 2015-11-10 22:59:30,907 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSg9WaB/profile http://localhost:35287/getInfo.html 22:59:34 INFO - 2015-11-10 22:59:34,623 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:59:34 INFO - 2015-11-10 22:59:34,624 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:59:34 INFO - 2015-11-10 22:59:34,624 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:59:34 INFO - 2015-11-10 22:59:34,624 DEBUG : BROWSER_OUTPUT: __metrics 22:59:34 INFO - 2015-11-10 22:59:34,705 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:59:35 INFO - 2015-11-10 22:59:35,944 INFO : Browser initialized. 22:59:35 INFO - 2015-11-10 22:59:35,944 INFO : Running cycle 1/1 for v8_7 test... 22:59:35 INFO - 2015-11-10 22:59:35,945 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSg9WaB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:59:47 INFO - 2015-11-10 22:59:47,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 138768384 22:59:47 INFO - 2015-11-10 22:59:47,635 DEBUG : BROWSER_OUTPUT: 23:00:09 INFO - 2015-11-10 23:00:09,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35287/tests/v8_7/run.html (next: http://localhost:35287/tests/v8_7/run.html) 23:00:09 INFO - 2015-11-10 23:00:09,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 609968128 23:00:09 INFO - 2015-11-10 23:00:09,314 DEBUG : BROWSER_OUTPUT: 23:00:09 INFO - 2015-11-10 23:00:09,314 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:00:09 INFO - 2015-11-10 23:00:09,314 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:00:09 INFO - 2015-11-10 23:00:09,314 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:00:09 INFO - 2015-11-10 23:00:09,315 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:00:09 INFO - 2015-11-10 23:00:09,315 DEBUG : BROWSER_OUTPUT: |0;Richards;163.61256544502618 23:00:09 INFO - 2015-11-10 23:00:09,315 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.02405898331392 23:00:09 INFO - 2015-11-10 23:00:09,315 DEBUG : BROWSER_OUTPUT: |2;Encrypt;287.60425654299684 23:00:09 INFO - 2015-11-10 23:00:09,315 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 23:00:09 INFO - 2015-11-10 23:00:09,315 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1109.8779134295228 23:00:09 INFO - 2015-11-10 23:00:09,315 DEBUG : BROWSER_OUTPUT: |5;Earley;793.0214115781126 23:00:09 INFO - 2015-11-10 23:00:09,315 DEBUG : BROWSER_OUTPUT: |6;Boyer;11764.70588235294 23:00:09 INFO - 2015-11-10 23:00:09,315 DEBUG : BROWSER_OUTPUT: |7;RegExp;25250 23:00:09 INFO - 2015-11-10 23:00:09,315 DEBUG : BROWSER_OUTPUT: |8;Splay;655.7377049180328 23:00:09 INFO - 2015-11-10 23:00:09,316 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 23:00:09 INFO - 2015-11-10 23:00:09,316 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:00:09 INFO - 2015-11-10 23:00:09,316 DEBUG : BROWSER_OUTPUT: __startTimestamp1447225209307__endTimestamp 23:00:09 INFO - 2015-11-10 23:00:09,316 DEBUG : BROWSER_OUTPUT: 23:00:09 INFO - 2015-11-10 23:00:09,316 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:00:09 INFO - 2015-11-10 23:00:09,316 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:00:09 INFO - 2015-11-10 23:00:09,316 DEBUG : BROWSER_OUTPUT: 23:00:09 INFO - 2015-11-10 23:00:09,316 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.61 Median:163.61 stddev:0.00 (0.0%) 23:00:09 INFO - 2015-11-10 23:00:09,317 DEBUG : BROWSER_OUTPUT: Values: 163.6 23:00:09 INFO - 2015-11-10 23:00:09,317 DEBUG : BROWSER_OUTPUT: 23:00:09 INFO - 2015-11-10 23:00:09,317 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.02 Median:194.02 stddev:0.00 (0.0%) 23:00:09 INFO - 2015-11-10 23:00:09,317 DEBUG : BROWSER_OUTPUT: Values: 194.0 23:00:09 INFO - 2015-11-10 23:00:09,317 DEBUG : BROWSER_OUTPUT: 23:00:09 INFO - 2015-11-10 23:00:09,318 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:287.60 Median:287.60 stddev:0.00 (0.0%) 23:00:09 INFO - 2015-11-10 23:00:09,318 DEBUG : BROWSER_OUTPUT: Values: 287.6 23:00:09 INFO - 2015-11-10 23:00:09,318 DEBUG : BROWSER_OUTPUT: 23:00:09 INFO - 2015-11-10 23:00:09,318 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 23:00:09 INFO - 2015-11-10 23:00:09,319 DEBUG : BROWSER_OUTPUT: Values: 5045.2 23:00:09 INFO - 2015-11-10 23:00:09,319 DEBUG : BROWSER_OUTPUT: 23:00:09 INFO - 2015-11-10 23:00:09,319 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1109.88 Median:1109.88 stddev:0.00 (0.0%) 23:00:09 INFO - 2015-11-10 23:00:09,319 DEBUG : BROWSER_OUTPUT: Values: 1109.9 23:00:09 INFO - 2015-11-10 23:00:09,319 DEBUG : BROWSER_OUTPUT: 23:00:09 INFO - 2015-11-10 23:00:09,320 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.02 Median:793.02 stddev:0.00 (0.0%) 23:00:09 INFO - 2015-11-10 23:00:09,320 DEBUG : BROWSER_OUTPUT: Values: 793.0 23:00:09 INFO - 2015-11-10 23:00:09,320 DEBUG : BROWSER_OUTPUT: 23:00:09 INFO - 2015-11-10 23:00:09,320 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11764.71 Median:11764.71 stddev:0.00 (0.0%) 23:00:09 INFO - 2015-11-10 23:00:09,321 DEBUG : BROWSER_OUTPUT: Values: 11764.7 23:00:09 INFO - 2015-11-10 23:00:09,321 DEBUG : BROWSER_OUTPUT: 23:00:09 INFO - 2015-11-10 23:00:09,321 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25250.00 Median:25250.00 stddev:0.00 (0.0%) 23:00:09 INFO - 2015-11-10 23:00:09,321 DEBUG : BROWSER_OUTPUT: Values: 25250.0 23:00:09 INFO - 2015-11-10 23:00:09,321 DEBUG : BROWSER_OUTPUT: 23:00:09 INFO - 2015-11-10 23:00:09,321 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:655.74 Median:655.74 stddev:0.00 (0.0%) 23:00:09 INFO - 2015-11-10 23:00:09,321 DEBUG : BROWSER_OUTPUT: Values: 655.7 23:00:09 INFO - 2015-11-10 23:00:09,321 DEBUG : BROWSER_OUTPUT: 23:00:09 INFO - 2015-11-10 23:00:09,321 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 23:00:09 INFO - 2015-11-10 23:00:09,321 DEBUG : BROWSER_OUTPUT: Values: 4830.9 23:00:09 INFO - 2015-11-10 23:00:09,322 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:00:09 INFO - 2015-11-10 23:00:09,322 DEBUG : BROWSER_OUTPUT: 23:00:10 INFO - 2015-11-10 23:00:10,177 INFO : Browser exited with error code: 0 23:00:10 INFO - 2015-11-10 23:00:10,191 INFO : Completed test v8_7 (00:00:39) 23:00:10 INFO - 2015-11-10 23:00:10,311 INFO : Completed test suite (00:20:10) 23:00:10 INFO - 2015-11-10 23:00:10,311 DEBUG : Working with test: dromaeo_css 23:00:10 INFO - 2015-11-10 23:00:10,311 DEBUG : Generating results file: dromaeo_css 23:00:10 INFO - 2015-11-10 23:00:10,312 DEBUG : Working with test: kraken 23:00:10 INFO - 2015-11-10 23:00:10,312 DEBUG : Generating results file: kraken 23:00:10 INFO - 2015-11-10 23:00:10,313 INFO : javascript benchmark 23:00:10 INFO - 2015-11-10 23:00:10,313 DEBUG : Working with test: v8_7 23:00:10 INFO - 2015-11-10 23:00:10,313 DEBUG : Generating results file: v8_7 23:00:10 INFO - 2015-11-10 23:00:10,313 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:00:10 INFO - 2015-11-10 23:00:10,466 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 23:00:10 INFO - 2015-11-10 23:00:10,466 DEBUG : process_Request line: dromaeo_css 6745.79 graph.html#tests=[[72,63,35]] 23:00:10 INFO - 2015-11-10 23:00:10,466 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:00:10 INFO - 2015-11-10 23:00:10,605 DEBUG : process_Request line: kraken 1496.20 graph.html#tests=[[232,63,35]] 23:00:10 INFO - 2015-11-10 23:00:10,606 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:00:10 INFO - 2015-11-10 23:00:10,741 DEBUG : process_Request line: v8_7 20953.44 graph.html#tests=[[230,63,35]] 23:00:10 INFO - 2015-11-10 23:00:10,742 INFO : javascript benchmark 23:00:10 INFO - 2015-11-10 23:00:10,746 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [356.5543071161049, 356.8715262505499, 357.23016898583563, 357.5227071859068, 359.10582649203485, 14319.284035798195, 14334.71330573388, 16772.41296554621, 16978.320867165316, 17608.2076306566, 15639.374425023014, 15728.685426291497, 16030.198490075509, 16101.83898161018, 16132.0, 5256.474352564742, 5432.538234250073, 5435.864103397407, 5437.102878025121, 5439.048166570854, 4003.539592946819, 4093.549709531964, 5359.812406565771, 5400.675959442446, 5806.651600903938, 5783.334916484616, 5878.970605146968, 5923.526117910578, 5936.88126237475, 5940.079287710412, 5731.684757338345, 5799.8690255400215, 5920.79277225295, 5927.110933359987, 5935.970320148414, 5178.430372659042, 5211.166213405875, 5221.112410890158, 5238.266642670029, 5245.10833158364, 15243.847561524353, 15321.080735155814, 16500.009999400074, 17402.564935876577, 20288.898555507276, 2075.8443116766302, 2130.4886827161527, 2192.495725983017, 2268.956280111134, 2344.3553022918663, 13244.337783110903, 13407.262600556965, 13512.797308040388, 13590.456381744718, 13665.658358541017, 1704.8891822031528, 1713.049257661997, 1776.1563257452735, 1821.6538857617143, 1897.8291953724092, 58169.70915145397, 59075.704621476616, 59270.0, 59953.700231498566, 60810.0, 9124.635014599342, 9164.450132992042, 9286.349955503185, 9396.436213827192, 9451.149396554343, 11952.40237988097, 11987.400629968466, 11994.880051199376, 12001.699957501132, 12036.39818009096, 6829.282925292872, 6888.690008949609, 6894.586324820527, 6902.413294869993, 6963.268856770068, 6461.224653041571, 6557.868842623121, 6587.703553340111, 6657.667116644148, 6687.966560167168, 5664.6034777566, 5748.338941021836, 5760.107183386582, 5767.106098554731, 5793.565482588822, 1619.7408414653598, 1679.4289941419977, 1687.9915600422164, 1707.3170731707417, 1757.8593712502968, 927.9304052195977, 939.3612343606413, 964.9758756031156, 970.0590427285522, 1005.6982905128432, 11299.830502542469, 12406.81389779154, 12532.624021279376, 16927.238274277443, 17608.647827043387, 500.2671086857771, 500.57201093065635, 501.5586284069995, 514.531776083762, 523.7643060622659, 6597.175353080865, 6753.696083676246, 6761.898571521431, 6856.24581296057, 6879.2432832389395, 558009.0, 559780.0, 571953.0, 591145.0, 595950.0809983776, 73953.26046739571, 76029.61985190038, 77929.83105253425, 78924.60537697274, 78961.60519197483, 568.1591244957486, 570.9143628455682, 572.9484346408843, 573.3292048303495, 573.3549756523911, 11103.111751059734, 11255.437228138724, 11348.489317980546, 11390.715232119263, 11515.884841151481, 35968.460473092404, 36202.09494762652, 36232.63767362293, 36322.09194770152, 36439.63560364363, 46987.295190572855, 47085.52914470811, 48784.75607621939, 49196.508034920626, 49405.50594494153, 6696.899546506709, 6970.895436568557, 6979.581225126306, 6981.441484681111, 6982.650867456506, 12278.693032674255, 12445.697545954028, 12664.493420263087, 12673.55642552543, 12737.98096152324, 10991.175661825555, 10996.560137594406, 11040.5031773572, 11086.833697494705, 11170.162237832032, 10502.579896804042, 10624.734381640521, 10656.520456579317, 10747.0, 10894.291871028357, 10881.455927203766, 11102.777944441228, 11255.718607034889, 11265.0, 11316.660500185008, 6755.952827311775, 6825.931740682529, 6861.931380686129, 6879.89680154788, 6901.275366086488, 10544.472776361305, 10549.736256593647, 10594.629187978384, 11067.778644427228, 11183.608573699881], "dojo.html": [3125.421796967561, 3232.48280275156, 3270.8201048942296, 3277.213468767495, 3290.3912776136417, 5093.923591146136, 5251.028559716446, 5423.457654234579, 5450.182472629108, 5480.342358916931, 5292.708901010443, 5306.204069389593, 5362.865928351784, 5375.543078838304, 5403.945960540394, 4852.854414367557, 4854.077725232203, 4871.805127794884, 4905.533974272438, 4958.231474121517, 4853.320535125085, 5046.268291097788, 5067.163917953533, 5104.795808167669, 5134.537891589756, 4880.292357608145, 4913.926291105637, 4974.9751251243515, 4978.9751051244875, 4980.252962055684, 4887.633427492917, 4895.339129217546, 4900.093482705711, 4918.926216106761, 4930.876728081791, 4734.786934587952, 4849.127157111719, 4879.097366987084, 4896.338994235768, 4930.260460930889, 5129.12804823181, 5217.139172036609, 5217.5565076968505, 5221.765020574046, 5239.895202095937, 5775.682337471438, 5797.0, 5797.333306669702, 5799.536037117063, 5800.187973683687, 5653.23681303027, 5711.742971566289, 5791.623544469596, 5823.126531020339, 5837.737301821428, 5475.616706830563, 5509.256250406184, 5522.392536820947, 5525.944740552583, 5527.170924361338, 5938.406159384027, 5952.107183922446, 5964.105384192406, 5974.40255974399, 5977.163197152402, 5529.917051244234, 5619.971900140473, 5642.520385767174, 5699.145128230715, 5778.479936805707, 5771.422857714279, 5775.913361299584, 5790.565707571949, 5791.507721843691, 5813.331466881363, 5728.656280623092, 5742.942570574241, 5748.166515855178, 5751.9424805751405, 5756.884862302731, 5633.774649014075, 5696.857578560569, 5718.085106382959, 5801.216835727208, 5808.07070868659, 4352.956470435255, 4364.148990946798, 4392.626626736699, 4412.801423935931, 4507.256302710081, 3925.0, 3926.155876486569, 3941.034446560611, 3952.2885880541203, 3960.960390396059, 5252.763625636779, 5352.437994010573, 5357.7589008494715, 5365.7585408656705, 5460.563154947595, 5785.768569257182, 5853.64878107315, 5855.151003104526, 5867.530597552186, 5879.029960056543, 5501.669899806025, 5512.007838589093, 5527.723613819293, 5533.253010843565, 5533.418991005967, 4905.460399356068, 4919.803207871717, 4953.6037117030555, 5008.949910500921, 5025.195968644999, 5875.236219291465, 5926.644401335848, 5932.940670593239, 5942.7920022799, 5953.3451320354725, 5655.293088363955, 5852.06366981298, 5861.238039054895, 5866.090755932837, 5890.852728681817, 5747.051736463437, 5754.798582049608, 5862.032764593965, 5948.226730525004, 5996.370381110095, 5716.857078573069, 5727.198192253005, 5728.598998070095, 5737.569682273763, 5744.253247077853, 5437.3747019091725, 5796.21751063601, 5824.504917082096, 5831.650100993954, 5838.708064596668, 5465.9726701366235, 5502.312210973629, 5540.168974653673, 5552.722363881709, 5586.888262234814, 5649.830505084854, 5666.886662266814, 5683.488486036111, 5689.34572524165, 5700.828975130753, 5333.359996800409, 5442.782288708408, 5567.63810352342, 5585.720713964367, 5604.439556044363, 5598.524125449382, 5678.0, 5698.800541981011, 5736.827895163152, 5739.512141467855, 5507.862303442446, 5509.807156749494, 5513.2005859151, 5515.61390702663, 5635.9436405635415], "mootools.html": [1323.2523624152348, 1687.974680379794, 1728.636986232891, 1760.1375326090215, 1774.5918438759093, 6546.247181574115, 7490.9250907490905, 7574.09110906692, 7582.165961744217, 7586.544807311565, 7417.925820741791, 7521.811954701136, 7532.322091011808, 7534.0, 7535.773926782205, 2010.4069299556593, 2053.722747429093, 2276.465030717788, 2294.7590502997236, 2319.0491898321693, 2243.921462748804, 2276.46503071778, 2277.339571524256, 2278.783515566027, 2280.2019293247313, 2246.8988895499742, 2311.861288322706, 2315.143396943133, 2316.177756896303, 2316.9884150579223, 1989.9900500497477, 2017.6973453981873, 2247.112390605718, 2275.3174047785596, 2278.9886050569808, 2300.413394584387, 2309.1802410144323, 2332.428555004035, 2341.2273949596593, 2344.859308441499, 7130.322619351154, 7136.3220494052985, 7160.140783106009, 7165.0, 7182.604956727378, 4502.41468609082, 4564.383808185886, 4578.542145785428, 4586.7477288749105, 4595.586397224266, 2983.418233444479, 2996.2659148508537, 3020.1241639924397, 3030.757539396865, 3104.984475077633, 886.1670030171618, 890.7505898348472, 906.3927168796922, 925.7963248085478, 926.9860952085725, 10039.34744241622, 10149.289549731522, 10166.034226748447, 10183.89816101837, 10205.336653117598, 4282.336237883133, 4324.762138082373, 4367.781610919441, 4429.756363400044, 4432.069265454226, 8738.912610873937, 8741.082186370466, 8742.519161446182, 8750.64997400097, 8776.16626420489, 4502.729836209773, 4507.18870603288, 4521.0, 4536.092781443725, 4536.61438777701, 4024.3762216856435, 4040.595940405936, 4044.292248856438, 4050.6354428101613, 4057.8173982170874, 3523.5947865995226, 3561.44797556374, 3565.625609310985, 3570.1610121621397, 3590.820458977093, 1137.6928229378186, 1169.1114752787773, 1190.660661711408, 1195.5994741761608, 1218.5856808684912, 926.5969303353063, 1302.6808431934048, 1304.373900527752, 1319.5381616434363, 1331.73365326935, 6300.369963003663, 6766.323367663194, 6932.306769323028, 6939.930600693929, 6941.583504989717, 673.3636713305879, 684.6029303004245, 687.9724811007503, 693.5977133262695, 696.7596179318127, 5529.889402211933, 5560.7488315129585, 5566.721663916788, 5568.9443105568425, 5570.470805273492, 8700.216980471789, 8765.737027889174, 8941.552922353856, 8999.730008099637, 9087.954560227157, 8992.505412202261, 8994.460332379947, 9000.36997410175, 9003.36976411658, 9006.954965225132, 6478.740850365933, 6584.0, 7000.894986575104, 7022.438204943593, 7066.3640272374705, 6657.533972622064, 6751.628660423724, 6762.222344430454, 6767.35710107539, 6771.356721111487, 7759.107702614272, 7866.0, 7920.366370690446, 7969.043714754266, 7992.36061115121, 8064.314533264738, 8153.266206041485, 8230.794230144294, 8235.588220588827, 8309.916900831156, 6706.262311145672, 6721.831954201184, 6756.223034351113, 6838.897416538855, 6857.485688573477, 7107.0, 7142.214356420894, 7202.567845929261, 7203.0, 7205.747798827016, 6632.668366581748, 6673.866522669617, 6691.888271953565, 6725.461963042847, 6738.764143254963, 6418.0, 6696.59820410777, 6818.897716534157, 6840.623765692934, 6957.060796792368, 6035.939640603538, 6212.161358216583, 6354.618722876642, 6829.317068293131, 6874.587524748331, 6337.081123237197, 6360.332165122595, 6375.74497020114, 6380.617162970237, 6382.808515744535, 6247.562670613195, 6368.949123394588, 6373.776917807854, 6406.327335629691, 6418.101465794699], "ext.html": [580.7909152705026, 581.7469400810647, 590.1914377303094, 596.5972968246433, 606.7451670298474, 31072.378552428938, 31728.841355793218, 31762.68237317626, 39538.60461395385, 40164.598354016525, 42454.363184552254, 42676.0, 42797.144057118836, 42879.78560107203, 43026.13947721051, 7529.47293689442, 8483.236508714215, 8617.698380556682, 8741.082186370435, 8769.649214031462, 7657.617119144048, 10343.431111288914, 10559.260851740342, 10616.04455598996, 10640.361578305326, 10276.537555810006, 10429.269951103426, 10433.686989390293, 10433.947830260839, 10441.216908731876, 7785.026871641073, 7984.880226796603, 10298.897011029907, 10433.113185379214, 10457.79084418315, 10175.13511351536, 10318.793624127551, 10320.380777153396, 10320.432376219305, 10321.225908056926, 38763.612363876564, 38956.61043389587, 39079.0, 39255.607443925765, 39289.607103929164, 3190.1546090286092, 3373.8987830365127, 3924.548676902136, 3950.940735888964, 4008.939865902014, 29794.0, 29823.10530684083, 30036.0, 30945.535816962765, 31270.218244544067, 3299.554560134375, 3354.4297469430257, 3391.4573668213216, 3433.7424693148114, 3459.7924124552355, 281484.0, 283265.0040997547, 283640.0, 284465.0, 285224.0, 55110.448895511334, 55782.44217557772, 56203.43796561982, 56822.147667785015, 62387.37612623906, 58692.83725208791, 58889.41110588925, 58894.41105588889, 59296.0, 59355.703221483614, 12694.746105077847, 12809.871901281054, 12833.101682882296, 12872.935635321763, 12879.613611591667, 9958.651447199314, 10053.899461005443, 10066.144377727975, 10066.949665251626, 10069.0, 18987.905060474885, 19024.71462928057, 19189.808101919083, 19200.71198932017, 19211.32760353409, 7285.0, 7475.081402411672, 7537.133229678548, 7539.170691223961, 7625.504342217738, 935.1443429262149, 983.955721992512, 993.6373223773415, 1004.8241557727368, 1041.0786453988276, 28457.288567785556, 28543.0, 28747.28131796722, 28953.565696514568, 29136.562951555745, 1043.212374657129, 1054.3884546962743, 1070.978580428387, 1121.3103941076342, 1121.3496172220093, 15408.691826163638, 16254.43109491162, 16283.511494655178, 16427.123180950945, 16440.917795410947, 330582.0, 335011.0, 336164.0, 337242.0, 337724.0, 52502.47497525052, 52815.47184528183, 52906.735466322425, 53042.0, 53095.46904530982, 1313.507434711983, 1325.0658285908412, 1331.54061848664, 1336.1782503760312, 1342.8321459817523, 23914.55097856255, 25221.621675674513, 27941.0, 28569.857150714113, 29169.270768230115, 43512.56487435085, 43540.0, 43718.0, 43759.0, 43959.78020110007, 229779.0, 230606.0, 230657.0, 230974.0, 401485.0, 28558.857205713837, 30656.386872262876, 32131.822863027657, 32158.356832862744, 32523.512147317335, 37424.43863341997, 37696.43455348117, 37932.81033594815, 38082.61917380791, 38482.6151738479, 32045.359092817547, 32708.34583308368, 32732.836335818167, 33258.83370583132, 33271.50092748659, 28840.278993025342, 29390.412191756473, 30130.246743830703, 30265.394692105594, 34712.0, 32800.0, 33225.833870830495, 33327.83336083304, 33609.327813444084, 33756.0, 29421.26446838846, 29952.25119372033, 30550.541741873447, 30597.694023059485, 30656.386872261985, 24619.753802462463, 25271.0, 25379.746202538478, 25830.933525318305, 26614.866925665247], "prototype.html": [311.8440779610195, 315.3566723883278, 322.81438173050503, 324.6428928179005, 331.6401704150996, 5756.971215143929, 5825.621334613247, 5871.060630299153, 5888.676122813249, 5903.940960590398, 5669.6314739542, 5707.942920570793, 5740.827775166741, 5779.971100144504, 5791.160281759142, 4408.3167109097985, 4416.381706561076, 4416.889577760549, 4416.955830441687, 4422.071365013335, 4284.935725964113, 4332.198543269489, 4360.781960901958, 4414.02891363901, 4432.645388368923, 4393.340998850166, 4395.692301538894, 4402.25161722508, 4402.669799765014, 4414.249577571821, 4392.780360981938, 4395.164918665443, 4395.428594282739, 4402.295632698785, 4403.581659742319, 3819.5607505136986, 3834.9808250958845, 3838.1556057667267, 3841.154945911895, 3842.3083844907906, 5424.0, 5508.944910550883, 5533.0, 5598.888022239533, 5605.775768969236, 5146.614003949719, 5151.278820965068, 5151.536361727425, 5151.7681704323395, 5161.993411284801, 6163.599366041193, 6169.167162433059, 6169.29053158888, 6170.691465426711, 6178.135061091451, 4294.141171765659, 4296.849610263625, 4296.935545966813, 4298.183345164409, 4299.247631664446, 6271.153394291758, 6353.777617783356, 6373.107764912916, 6378.170837791104, 6380.425761681471, 4286.721363111388, 4311.741295522279, 4314.71954322968, 4314.978425107917, 4315.287977483743, 4355.956440435619, 4360.345948107746, 4365.585269399402, 4369.541198174209, 4369.825206991684, 5055.241713742968, 5060.544550990428, 5067.619928505377, 5073.949260507347, 5074.340335756402, 6116.724747386378, 6232.968835155886, 6239.438450539473, 6241.875162496724, 6245.531585131042, 1570.685862827439, 1589.0703938196284, 1589.276879020043, 1589.3404237241646, 1589.737693280619, 1027.5273374247781, 1036.1969473657975, 1041.9791604167874, 1050.6637875879644, 1061.0397590180899, 6038.758449662052, 6039.184710064085, 6063.454289114001, 6069.36271691466, 6070.726817293233, 6214.223222097238, 6289.8742025159245, 6308.0537919311555, 6394.904076438857, 6398.8080357588415, 5958.314793798769, 5999.730012149464, 6008.609440386361, 6011.759529618854, 6040.7583696651645, 3497.5802903651725, 3522.9823850881094, 3525.259695463981, 3530.117470632342, 3532.911677208039, 6377.5216858735785, 6439.839004024843, 6469.288378278386, 6489.1888513935755, 6490.610563366213, 6468.126802881551, 6473.06140609609, 6489.156409666807, 6566.540342176002, 6568.047633093175, 6585.769498067544, 6588.439982601532, 6594.70323835419, 6599.340065993362, 6602.504812139109, 6276.246850377984, 6424.357564243538, 6450.193725784277, 6467.320931302145, 6472.385123413268, 6300.936990630218, 6309.873802523832, 6324.4940404766585, 6349.841253968688, 6351.110844481684, 6462.256840463218, 6513.739450422119, 6517.674116294261, 6524.706388212637, 6528.934710652833, 4357.760323182255, 4391.429114215131, 4391.692581519263, 4392.0, 4393.978030109829, 6266.185395898504, 6339.429451349401, 6378.77674281398, 6422.0, 6449.193850768654, 6272.466840318624, 6283.0, 6286.277078136073, 6289.433950944437, 6293.905591416041, 6258.280297765815, 6269.12232287471, 6269.404406581368, 6274.372562743689, 6277.027060805583, 6045.758169673164, 6179.258488981351, 6181.196444462191, 6183.721732522137, 6185.597936134137, 6321.273053598711, 6321.905171422524, 6322.399372059647, 6325.4939604832425, 6326.0, 5917.289925209003, 6158.076288556573, 6159.876802463836, 6160.568760186744, 6163.7842675506145], "yui.html": [780.6409051836155, 821.9958900205498, 832.7543374704461, 836.5942517878829, 850.07766573268, 12425.875741242586, 12700.110992230524, 12721.618351449448, 12723.936380318097, 12739.171953822995, 12782.169159004658, 13029.478820847178, 13062.804057939138, 13117.540886068966, 13134.343282835844, 680.2415306932784, 687.821166496712, 812.7927378518469, 813.0, 828.4739190613973, 819.8647223208163, 820.8727647214691, 824.286991752136, 825.455199568285, 826.0747962282252, 859.8108416148438, 865.4374656473279, 867.7960679240374, 867.9522626255554, 867.9522626255554, 704.5631708340836, 711.6263961420244, 846.8645016797313, 857.1300130367682, 859.2910848549909, 627.3694936588745, 628.6856571714143, 629.2637613991641, 629.4523764325066, 629.8582818865718, 13188.142770719873, 13517.729645407135, 13529.797053044213, 13532.188068715908, 13543.187408755506, 11570.305781653044, 12010.0, 12493.312867792269, 12605.0, 12857.742845143139, 10239.948800255952, 10258.1022510835, 10428.530716117717, 10436.895631043744, 10453.05922466974, 3529.4529347951107, 3576.517170182044, 3581.3732596795458, 3589.4436362363876, 3749.062734316421, 44479.0, 44668.3299750504, 44761.0, 44964.0, 44984.3252351215, 9662.903370966342, 9707.0, 9769.0, 9812.116909478038, 9931.702048938543, 17673.469795906145, 17718.734218986727, 17721.556961075818, 17723.911380443016, 17925.28298868031, 6877.89683154753, 6934.791956241321, 7277.89083163753, 7457.7016919323705, 7575.6969721211635, 4095.8566450174103, 4285.185814695198, 4314.245007123741, 4329.675274354436, 4356.6514678825615, 2644.6165306030903, 2665.5068812269405, 2669.8131130820657, 2675.317793962527, 2677.54481738105, 407.7920260667081, 413.1344832575749, 413.59880915511906, 415.167588984085, 415.3292432721134, 658.9406953374123, 662.4998126414526, 663.0617675988518, 663.598522893652, 685.9931400686029, 8122.959385203036, 8163.632636531371, 8290.792730181673, 8425.536595487307, 8476.194761497647, 648.9351064893567, 654.5418207254941, 661.4278648968608, 662.3707477896018, 676.0839063069568, 4269.167512335065, 4348.804303806336, 4361.672874534423, 4375.321825117112, 4536.342230376643, 52581.0, 53174.468255317726, 53616.73191634017, 58280.41719582835, 58456.70771646115, 48984.75507622439, 49916.75041624841, 50456.495435045916, 50637.74681126571, 50978.490215098114, 46407.0, 46752.2987155193, 47532.5246747535, 47635.285470717965, 47887.76056119697, 8678.349123815613, 8809.955950220208, 9077.500737459502, 9146.588403521724, 9370.969193388859, 34196.48705269473, 35525.82237088798, 35918.10204744902, 36376.0, 36490.270194595425, 42295.36556951587, 42990.35514467348, 43265.567344326155, 44102.0, 44263.55736442594, 7583.582902940391, 8184.181581841768, 8188.222118898695, 8225.054118776177, 8249.711260105867, 12184.51261949512, 12213.633590992284, 12238.265704057785, 12564.87435125637, 12752.553660621834, 10862.185336099667, 11018.173636977099, 11128.0, 11229.550817967516, 11407.201495895208, 11392.316461012366, 11397.772044559228, 11523.423828808358, 12049.33728644898, 12149.453274602487, 8572.142785721628, 10451.895481045092, 11268.549258029587, 11342.489587968395, 11837.053035756946, 9875.40747555149, 9917.404955702392, 10121.190304775748, 10123.595056197964, 10298.485075746332, 8214.301784348398, 9562.952185239308, 10081.44552049615, 10215.846762298721, 10286.331388459726]}, "summary": {"lowerIsBetter": false, "suite": 6745.7893063138035, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7924.470861751443, "unit": "ms", "value": 7924.470861751443}, "dojo.html": {"lowerIsBetter": false, "filtered": 5318.833356086764, "unit": "ms", "value": 5318.833356086764}, "mootools.html": {"lowerIsBetter": false, "filtered": 4296.841105295976, "unit": "ms", "value": 4296.841105295976}, "ext.html": {"lowerIsBetter": false, "filtered": 18177.754572272024, "unit": "ms", "value": 18177.754572272024}, "prototype.html": {"lowerIsBetter": false, "filtered": 4657.485803998487, "unit": "ms", "value": 4657.485803998487}, "yui.html": {"lowerIsBetter": false, "filtered": 6145.112813661286, "unit": "ms", "value": 6145.112813661286}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-061"}, "testrun": {"date": 1447223999, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151110205821", "branch": "Mozilla-Inbound", "revision": "5ce07357c5f7e458b0b5cfe1daad8e8eb772f765"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 160.0, 160.0, 160.0, 161.0, 163.0, 160.0, 165.0, 163.0, 164.0], "ai-astar": [108.0, 109.0, 103.0, 110.0, 110.0, 111.0, 101.0, 109.0, 108.0, 111.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0], "audio-beat-detection": [149.0, 124.0, 149.0, 164.0, 128.0, 148.0, 158.0, 124.0, 166.0, 126.0], "json-stringify-tinderbox": [66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0], "stanford-crypto-pbkdf2": [140.0, 151.0, 149.0, 151.0, 151.0, 136.0, 152.0, 148.0, 148.0, 139.0], "json-parse-financial": [68.0, 57.0, 57.0, 68.0, 61.0, 58.0, 59.0, 74.0, 56.0, 61.0], "stanford-crypto-sha256-iterative": [66.0, 66.0, 65.0, 66.0, 65.0, 68.0, 66.0, 69.0, 68.0, 69.0], "audio-fft": [73.0, 71.0, 85.0, 92.0, 71.0, 73.0, 71.0, 96.0, 90.0, 77.0], "imaging-darkroom": [146.0, 145.0, 146.0, 145.0, 144.0, 145.0, 145.0, 146.0, 146.0, 146.0], "stanford-crypto-ccm": [113.0, 122.0, 122.0, 115.0, 128.0, 112.0, 118.0, 116.0, 135.0, 116.0], "audio-oscillator": [92.0, 91.0, 142.0, 92.0, 93.0, 93.0, 147.0, 91.0, 91.0, 133.0], "stanford-crypto-aes": [82.0, 83.0, 85.0, 84.0, 86.0, 85.0, 85.0, 85.0, 87.0, 86.0], "imaging-desaturate": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1496.2, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.9, "unit": "ms", "value": 79.9}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 146.5, "unit": "ms", "value": 146.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 143.6, "unit": "ms", "value": 143.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 119.7, "unit": "ms", "value": 119.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.4, "unit": "ms", "value": 145.4}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 61.9, "unit": "ms", "value": 61.9}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 106.5, "unit": "ms", "value": 106.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.0, "unit": "ms", "value": 108.0}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.6, "unit": "ms", "value": 161.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.8, "unit": "ms", "value": 66.8}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.3, "unit": "ms", "value": 66.3}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.7, "unit": "ms", "value": 109.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.8, "unit": "ms", "value": 84.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.5, "unit": "ms", "value": 95.5}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-061"}, "testrun": {"date": 1447223999, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151110205821", "branch": "Mozilla-Inbound", "revision": "5ce07357c5f7e458b0b5cfe1daad8e8eb772f765"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.02405898331392], "Encrypt": [287.60425654299684], "NavierStokes": [4830.917874396136], "Decrypt": [5045.226130653266], "Splay": [655.7377049180328], "Richards": [163.61256544502618], "RegExp": [25250.0], "Earley": [793.0214115781126], "Boyer": [11764.70588235294], "RayTrace": [1109.8779134295228]}, "summary": {"lowerIsBetter": false, "suite": 20953.444795386833, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.772172, "unit": "score", "value": 340.772172}, "Encrypt": {"lowerIsBetter": false, "filtered": 925.5113369999998, "unit": "score", "value": 925.5113369999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.75898306772911, "unit": "score", "value": 52.75898306772911}, "Splay": {"lowerIsBetter": false, "filtered": 124.27377499999997, "unit": "score", "value": 124.27377499999997}, "RegExp": {"lowerIsBetter": false, "filtered": 36.07861386138617, "unit": "score", "value": 36.07861386138617}, "Richards": {"lowerIsBetter": false, "filtered": 215.76582400000007, "unit": "score", "value": 215.76582400000007}, "Earley": {"lowerIsBetter": false, "filtered": 840.4098429999997, "unit": "score", "value": 840.4098429999997}, "Boyer": {"lowerIsBetter": false, "filtered": 56.64935499999997, "unit": "score", "value": 56.64935499999997}, "RayTrace": {"lowerIsBetter": false, "filtered": 666.7300889999998, "unit": "score", "value": 666.7300889999998}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-061"}, "testrun": {"date": 1447223999, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151110205821", "branch": "Mozilla-Inbound", "revision": "5ce07357c5f7e458b0b5cfe1daad8e8eb772f765"}}] 23:00:10 INFO - RETURN: dromaeo_css: 6745.79 23:00:10 INFO - RETURN: kraken: 1496.20 23:00:10 INFO - RETURN: v8_7: 20953.44 23:00:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20953.44"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1496.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6745.79"}}} 23:00:10 INFO - Return code: 0 23:00:10 INFO - # TBPL SUCCESS # 23:00:10 INFO - Running post-action listener: _resource_record_post_action 23:00:10 INFO - Running post-run listener: _resource_record_post_run 23:00:11 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511090688; Read time: 12; Write time: 354120 23:00:11 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 174977024; Read time: 0; Write time: 158028 23:00:11 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 336109568; Read time: 0; Write time: 196092 23:00:11 INFO - Running post-run listener: _upload_blobber_files 23:00:11 INFO - Blob upload gear active. 23:00:11 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:00:11 INFO - Copying logs to upload dir... 23:00:11 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1252.486438 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2015-11-10 23:00:11.142040) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-10 23:00:11.145595) ========= 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=5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/zVvxPWjFTCWG4Knti7IPQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010027 build_url: 'https://queue.taskcluster.net/v1/task/zVvxPWjFTCWG4Knti7IPQw/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-10 23:00:11.199460) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 23:00:11.199872) ========= 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=5804b9f07a53938c557deee7000001c5-1447223957.672424-1837485616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 23:00:11.250426) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-10 23:00:11.250735) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-10 23:00:11.251023) ========= ========= Total master_lag: 0.21 =========