builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1447685977.24 results: success (0) buildid: 20151116043001 builduid: 7724e2f2551a49978b8608042f38806d revision: 48d636f678b0e5162ab868dc9024a5ffe350460c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:37.235740) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:37.236280) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:37.236573) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005861 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:37.254002) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:37.254298) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:37.263502) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:37.263897) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004143 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:37.312798) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:37.313105) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:37.313455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:37.313721) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 06:59:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2015-11-16 06:59:37 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109686 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:37.436881) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:37.437255) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022238 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:37.487985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:37.488325) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 48d636f678b0e5162ab868dc9024a5ffe350460c --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 48d636f678b0e5162ab868dc9024a5ffe350460c --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=6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 06:59:37,826 truncating revision to first 12 chars 2015-11-16 06:59:37,826 Setting DEBUG logging. 2015-11-16 06:59:37,826 attempt 1/10 2015-11-16 06:59:37,826 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/48d636f678b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 06:59:38,069 unpacking tar archive at: mozilla-central-48d636f678b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.515936 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:38.017026) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:38.017327) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:38.027356) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:38.027699) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 06:59:38.028153) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-16 06:59:38.028477) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:59:38 INFO - MultiFileLogger online at 20151116 06:59:38 in /builds/slave/test-pgo 06:59:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:59:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:59:38 INFO - {'append_to_log': False, 06:59:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:59:38 INFO - 'blob_upload_branch': 'Firefox', 06:59:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:59:38 INFO - 'branch': 'Firefox', 06:59:38 INFO - 'buildbot_json_path': 'buildprops.json', 06:59:38 INFO - 'config_files': ('talos/linux_config.py',), 06:59:38 INFO - 'default_actions': ('clobber', 06:59:38 INFO - 'read-buildbot-config', 06:59:38 INFO - 'download-and-extract', 06:59:38 INFO - 'populate-webroot', 06:59:38 INFO - 'create-virtualenv', 06:59:38 INFO - 'install', 06:59:38 INFO - 'run-tests'), 06:59:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:59:38 INFO - 'download_minidump_stackwalk': True, 06:59:38 INFO - 'download_symbols': 'ondemand', 06:59:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:59:38 INFO - 'tooltool.py': '/tools/tooltool.py', 06:59:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:59:38 INFO - '/tools/misc-python/virtualenv.py')}, 06:59:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:59:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:59:38 INFO - 'installer_path': 'installer.exe', 06:59:38 INFO - 'log_level': 'info', 06:59:38 INFO - 'log_name': 'talos', 06:59:38 INFO - 'log_to_console': True, 06:59:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:59:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:59:38 INFO - 'opt_config_files': (), 06:59:38 INFO - 'pip_index': False, 06:59:38 INFO - 'sps_profile': False, 06:59:38 INFO - 'sps_profile_interval': 0, 06:59:38 INFO - 'suite': 'dromaeojs', 06:59:38 INFO - 'system_bits': '64', 06:59:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:59:38 INFO - 'title': 'talos-linux64-ix-057', 06:59:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:59:38 INFO - 'use_talos_json': True, 06:59:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:59:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:59:38 INFO - 'work_dir': 'build'} 06:59:38 INFO - ##### 06:59:38 INFO - ##### Running clobber step. 06:59:38 INFO - ##### 06:59:38 INFO - Running pre-action listener: _resource_record_pre_action 06:59:38 INFO - Running main action method: clobber 06:59:38 INFO - rmtree: /builds/slave/test-pgo/build 06:59:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:59:38 INFO - Running post-action listener: _resource_record_post_action 06:59:38 INFO - ##### 06:59:38 INFO - ##### Running read-buildbot-config step. 06:59:38 INFO - ##### 06:59:38 INFO - Running pre-action listener: _resource_record_pre_action 06:59:38 INFO - Running main action method: read_buildbot_config 06:59:38 INFO - Using buildbot properties: 06:59:38 INFO - { 06:59:38 INFO - "properties": { 06:59:38 INFO - "buildnumber": 557, 06:59:38 INFO - "product": "firefox", 06:59:38 INFO - "script_repo_revision": "production", 06:59:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:59:38 INFO - "repository": "", 06:59:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:59:38 INFO - "buildid": "20151116043001", 06:59:38 INFO - "slavename": "talos-linux64-ix-057", 06:59:38 INFO - "pgo_build": "True", 06:59:38 INFO - "basedir": "/builds/slave/test-pgo", 06:59:38 INFO - "project": "", 06:59:38 INFO - "platform": "ubuntu64_hw", 06:59:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:59:38 INFO - "slavebuilddir": "test", 06:59:38 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:59:38 INFO - "branch": "mozilla-central", 06:59:38 INFO - "repo_path": "mozilla-central", 06:59:38 INFO - "stage_platform": "linux64-pgo", 06:59:38 INFO - "builduid": "7724e2f2551a49978b8608042f38806d", 06:59:38 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 06:59:38 INFO - }, 06:59:38 INFO - "sourcestamp": { 06:59:38 INFO - "repository": "", 06:59:38 INFO - "hasPatch": false, 06:59:38 INFO - "project": "", 06:59:38 INFO - "branch": "mozilla-central-linux64-pgo-talos", 06:59:38 INFO - "changes": [ 06:59:38 INFO - { 06:59:38 INFO - "category": null, 06:59:38 INFO - "files": [ 06:59:38 INFO - { 06:59:38 INFO - "url": null, 06:59:38 INFO - "name": "https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:59:38 INFO - } 06:59:38 INFO - ], 06:59:38 INFO - "repository": "", 06:59:38 INFO - "rev": "48d636f678b0e5162ab868dc9024a5ffe350460c", 06:59:38 INFO - "who": "sendchange", 06:59:38 INFO - "when": 1447685925, 06:59:38 INFO - "number": 6666018, 06:59:38 INFO - "comments": "", 06:59:38 INFO - "project": "", 06:59:38 INFO - "at": "Mon 16 Nov 2015 06:58:45", 06:59:38 INFO - "branch": "mozilla-central-linux64-pgo-talos", 06:59:38 INFO - "revlink": "", 06:59:38 INFO - "properties": [ 06:59:38 INFO - [ 06:59:38 INFO - "buildid", 06:59:38 INFO - "20151116043001", 06:59:38 INFO - "Change" 06:59:38 INFO - ], 06:59:38 INFO - [ 06:59:38 INFO - "builduid", 06:59:38 INFO - "7724e2f2551a49978b8608042f38806d", 06:59:38 INFO - "Change" 06:59:38 INFO - ], 06:59:38 INFO - [ 06:59:38 INFO - "pgo_build", 06:59:38 INFO - "True", 06:59:38 INFO - "Change" 06:59:38 INFO - ] 06:59:38 INFO - ], 06:59:38 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 06:59:38 INFO - } 06:59:38 INFO - ], 06:59:38 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 06:59:38 INFO - } 06:59:38 INFO - } 06:59:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:59:38 INFO - Running post-action listener: _resource_record_post_action 06:59:38 INFO - ##### 06:59:38 INFO - ##### Running download-and-extract step. 06:59:38 INFO - ##### 06:59:38 INFO - Running pre-action listener: _resource_record_pre_action 06:59:38 INFO - Running main action method: download_and_extract 06:59:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:38 INFO - https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:59:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/test_packages.json 06:59:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/test_packages.json 06:59:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:59:41 INFO - Downloaded 1302 bytes. 06:59:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:59:41 INFO - Using the following test package requirements: 06:59:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:59:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:41 INFO - u'jsshell-linux-x86_64.zip'], 06:59:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:59:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:59:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:59:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:59:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:59:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:59: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')]} 06:59:41 INFO - https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:59:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:59:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:59:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 06:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 06:59:43 INFO - Downloaded 22462077 bytes. 06:59:43 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 06:59:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:59:43 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 06:59:44 INFO - Return code: 0 06:59:44 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 06:59: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')]} 06:59:44 INFO - https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:59:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:59:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:59:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 06:59:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 06:59:46 INFO - Downloaded 22462077 bytes. 06:59:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:59:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:59:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:59:47 INFO - Return code: 0 06:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:47 INFO - https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:59:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:59:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:59:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 06:59:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 06:59:48 INFO - Downloaded 11131693 bytes. 06:59:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 06:59:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:59:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:59:48 INFO - Return code: 0 06:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:48 INFO - https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:59:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:59:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:59:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 06:59:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtB12eTmT7-XxGGQBdpdQw/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 06:59:49 INFO - Downloaded 57132176 bytes. 06:59:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:59:49 INFO - mkdir: /builds/slave/test-pgo/properties 06:59:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:59:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:59:49 INFO - Contents: 06:59:49 INFO - build_url:https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:59:49 INFO - Running post-action listener: _resource_record_post_action 06:59:49 INFO - Running post-action listener: set_extra_try_arguments 06:59:49 INFO - ##### 06:59:49 INFO - ##### Running populate-webroot step. 06:59:49 INFO - ##### 06:59:49 INFO - Running pre-action listener: _resource_record_pre_action 06:59:49 INFO - Running main action method: populate_webroot 06:59:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:59:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:59:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:59:49 INFO - '../fennec_ids.txt'], 06:59:49 INFO - 'tests': ['tcheck2']}, 06:59:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:59:49 INFO - '--tppagecycles', 06:59:49 INFO - '7'], 06:59:49 INFO - 'tests': ['tsvgm']}}, 06:59:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:59:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:59:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:59:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:59:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:59:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:59:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:59:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:49 INFO - 'talos_options': ['--e10s'], 06:59:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:59:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:49 INFO - 'tests': ['damp', 'tps']}, 06:59:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:49 INFO - 'talos_options': ['--e10s'], 06:59:49 INFO - 'tests': ['damp', 'tps']}, 06:59:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:59:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:59:49 INFO - 'other': {'tests': ['a11yr', 06:59:49 INFO - 'ts_paint', 06:59:49 INFO - 'tpaint', 06:59:49 INFO - 'sessionrestore', 06:59:49 INFO - 'sessionrestore_no_auto_restore']}, 06:59:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:59:49 INFO - 'tests': ['a11yr', 06:59:49 INFO - 'ts_paint', 06:59:49 INFO - 'tpaint', 06:59:49 INFO - 'sessionrestore', 06:59:49 INFO - 'sessionrestore_no_auto_restore']}, 06:59:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:59:49 INFO - 'tests': ['a11yr', 06:59:49 INFO - 'ts_paint', 06:59:49 INFO - 'tpaint', 06:59:49 INFO - 'sessionrestore', 06:59:49 INFO - 'sessionrestore_no_auto_restore']}, 06:59:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:59:49 INFO - 'tests': ['a11yr', 06:59:49 INFO - 'ts_paint', 06:59:49 INFO - 'tpaint', 06:59:49 INFO - 'sessionrestore', 06:59:49 INFO - 'sessionrestore_no_auto_restore']}, 06:59:49 INFO - 'other_l64': {'tests': ['a11yr', 06:59:49 INFO - 'ts_paint', 06:59:49 INFO - 'tpaint', 06:59:49 INFO - 'sessionrestore', 06:59:49 INFO - 'sessionrestore_no_auto_restore']}, 06:59:49 INFO - 'other_nol64': {'tests': ['a11yr', 06:59:49 INFO - 'ts_paint', 06:59:49 INFO - 'tpaint', 06:59:49 INFO - 'sessionrestore', 06:59:49 INFO - 'sessionrestore_no_auto_restore']}, 06:59:49 INFO - 'svgr': {'tests': ['tsvgx', 06:59:49 INFO - 'tsvgr_opacity', 06:59:49 INFO - 'tart', 06:59:49 INFO - 'tscrollx', 06:59:49 INFO - 'cart']}, 06:59:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:59:49 INFO - 'tests': ['tsvgx', 06:59:49 INFO - 'tsvgr_opacity', 06:59:49 INFO - 'tart', 06:59:49 INFO - 'tscrollx', 06:59:49 INFO - 'cart']}, 06:59:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:49 INFO - 'tests': ['tp5o']}, 06:59:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:49 INFO - 'talos_options': ['--e10s'], 06:59:49 INFO - 'tests': ['tp5o']}, 06:59:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:49 INFO - 'talos_options': ['--xperf_path', 06:59:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:59:49 INFO - 'tests': ['tp5n']}, 06:59:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:49 INFO - 'talos_options': ['--e10s', 06:59:49 INFO - '--xperf_path', 06:59:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:59:49 INFO - 'tests': ['tp5n']}}, 06:59:49 INFO - 'talos.zip': {'path': '', 06:59:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:59:49 INFO - Running post-action listener: _resource_record_post_action 06:59:49 INFO - ##### 06:59:49 INFO - ##### Running create-virtualenv step. 06:59:49 INFO - ##### 06:59:49 INFO - Running pre-action listener: _resource_record_pre_action 06:59:49 INFO - Running main action method: create_virtualenv 06:59:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:59:49 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 06:59:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:59:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:59:49 INFO - Using real prefix '/usr' 06:59:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:59:50 INFO - Installing distribute.............................................................................................................................................................................................done. 06:59:52 INFO - Installing pip.................done. 06:59:52 INFO - Return code: 0 06:59:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:52 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 0x7fc5f1dccc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bee6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c24a90>, '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 0x1c76f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c772e0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026', '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 06:59:52 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 06:59:52 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 06:59:52 INFO - Using env: {'DISPLAY': ':0', 06:59:52 INFO - 'HOME': '/home/cltbld', 06:59:52 INFO - 'LANG': 'en_US.UTF-8', 06:59:52 INFO - 'LANGUAGE': 'en_US:en', 06:59:52 INFO - 'LOGNAME': 'cltbld', 06:59:52 INFO - 'MAIL': '/var/mail/cltbld', 06:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:52 INFO - 'MOZ_NO_REMOTE': '1', 06:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:52 INFO - 'NO_EM_RESTART': '1', 06:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:59:52 INFO - 'PWD': '/builds/slave/test-pgo', 06:59:52 INFO - 'SHELL': '/bin/bash', 06:59:52 INFO - 'SHLVL': '1', 06:59:52 INFO - 'TERM': 'linux', 06:59:52 INFO - 'TMOUT': '86400', 06:59:52 INFO - 'USER': 'cltbld', 06:59:52 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026', 06:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:52 INFO - '_': '/tools/buildbot/bin/python'} 06:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:52 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 06:59:52 INFO - Cleaning up... 06:59:52 INFO - Return code: 0 06:59:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:52 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 0x7fc5f1dccc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bee6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c24a90>, '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 0x1c76f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c772e0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026', '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 06:59:52 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 06:59:52 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 06:59:52 INFO - Using env: {'DISPLAY': ':0', 06:59:52 INFO - 'HOME': '/home/cltbld', 06:59:52 INFO - 'LANG': 'en_US.UTF-8', 06:59:52 INFO - 'LANGUAGE': 'en_US:en', 06:59:52 INFO - 'LOGNAME': 'cltbld', 06:59:52 INFO - 'MAIL': '/var/mail/cltbld', 06:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:52 INFO - 'MOZ_NO_REMOTE': '1', 06:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:52 INFO - 'NO_EM_RESTART': '1', 06:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:59:52 INFO - 'PWD': '/builds/slave/test-pgo', 06:59:52 INFO - 'SHELL': '/bin/bash', 06:59:52 INFO - 'SHLVL': '1', 06:59:52 INFO - 'TERM': 'linux', 06:59:52 INFO - 'TMOUT': '86400', 06:59:52 INFO - 'USER': 'cltbld', 06:59:52 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026', 06:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:52 INFO - '_': '/tools/buildbot/bin/python'} 06:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:52 INFO - Downloading/unpacking psutil>=0.7.1 06:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:59:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:59:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:59:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:59:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:59:54 INFO - Installing collected packages: psutil 06:59:54 INFO - Running setup.py install for psutil 06:59:54 INFO - building 'psutil._psutil_linux' extension 06:59:54 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 06:59:54 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 06:59:54 INFO - building 'psutil._psutil_posix' extension 06:59:54 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 06:59:54 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 06:59:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:59:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:59:55 INFO - Successfully installed psutil 06:59:55 INFO - Cleaning up... 06:59:55 INFO - Return code: 0 06:59:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:59:55 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')]} 06:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:55 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')]} 06:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:55 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 0x7fc5f1dccc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bee6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c24a90>, '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 0x1c76f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c772e0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026', '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 06:59:55 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 06:59:55 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 06:59:55 INFO - Using env: {'DISPLAY': ':0', 06:59:55 INFO - 'HOME': '/home/cltbld', 06:59:55 INFO - 'LANG': 'en_US.UTF-8', 06:59:55 INFO - 'LANGUAGE': 'en_US:en', 06:59:55 INFO - 'LOGNAME': 'cltbld', 06:59:55 INFO - 'MAIL': '/var/mail/cltbld', 06:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:55 INFO - 'MOZ_NO_REMOTE': '1', 06:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:55 INFO - 'NO_EM_RESTART': '1', 06:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:59:55 INFO - 'PWD': '/builds/slave/test-pgo', 06:59:55 INFO - 'SHELL': '/bin/bash', 06:59:55 INFO - 'SHLVL': '1', 06:59:55 INFO - 'TERM': 'linux', 06:59:55 INFO - 'TMOUT': '86400', 06:59:55 INFO - 'USER': 'cltbld', 06:59:55 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026', 06:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:55 INFO - '_': '/tools/buildbot/bin/python'} 06:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:59:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:59:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:59:56 INFO - Installing collected packages: mozsystemmonitor 06:59:56 INFO - Running setup.py install for mozsystemmonitor 06:59:57 INFO - Successfully installed mozsystemmonitor 06:59:57 INFO - Cleaning up... 06:59:57 INFO - Return code: 0 06:59:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc5f1dccc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bee6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c24a90>, '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 0x1c76f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c772e0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026', '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 06:59:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 06:59:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:59:57 INFO - Using env: {'DISPLAY': ':0', 06:59:57 INFO - 'HOME': '/home/cltbld', 06:59:57 INFO - 'LANG': 'en_US.UTF-8', 06:59:57 INFO - 'LANGUAGE': 'en_US:en', 06:59:57 INFO - 'LOGNAME': 'cltbld', 06:59:57 INFO - 'MAIL': '/var/mail/cltbld', 06:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:57 INFO - 'MOZ_NO_REMOTE': '1', 06:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:57 INFO - 'NO_EM_RESTART': '1', 06:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:59:57 INFO - 'PWD': '/builds/slave/test-pgo', 06:59:57 INFO - 'SHELL': '/bin/bash', 06:59:57 INFO - 'SHLVL': '1', 06:59:57 INFO - 'TERM': 'linux', 06:59:57 INFO - 'TMOUT': '86400', 06:59:57 INFO - 'USER': 'cltbld', 06:59:57 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026', 06:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:57 INFO - '_': '/tools/buildbot/bin/python'} 06:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:57 INFO - Downloading/unpacking blobuploader==1.2.4 06:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:58 INFO - Downloading blobuploader-1.2.4.tar.gz 06:59:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:59:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:59:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:59:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:59:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:59 INFO - Downloading docopt-0.6.1.tar.gz 06:59:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:59:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:59:59 INFO - Installing collected packages: blobuploader, requests, docopt 06:59:59 INFO - Running setup.py install for blobuploader 06:59:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:59:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:59:59 INFO - Running setup.py install for requests 07:00:00 INFO - Running setup.py install for docopt 07:00:00 INFO - Successfully installed blobuploader requests docopt 07:00:00 INFO - Cleaning up... 07:00:00 INFO - Return code: 0 07:00:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:00 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 0x7fc5f1dccc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bee6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c24a90>, '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 0x1c76f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c772e0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026', '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 07:00:00 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 07:00:00 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 07:00:00 INFO - Using env: {'DISPLAY': ':0', 07:00:00 INFO - 'HOME': '/home/cltbld', 07:00:00 INFO - 'LANG': 'en_US.UTF-8', 07:00:00 INFO - 'LANGUAGE': 'en_US:en', 07:00:00 INFO - 'LOGNAME': 'cltbld', 07:00:00 INFO - 'MAIL': '/var/mail/cltbld', 07:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:00 INFO - 'MOZ_NO_REMOTE': '1', 07:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:00 INFO - 'NO_EM_RESTART': '1', 07:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:00 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:00 INFO - 'SHELL': '/bin/bash', 07:00:00 INFO - 'SHLVL': '1', 07:00:00 INFO - 'TERM': 'linux', 07:00:00 INFO - 'TMOUT': '86400', 07:00:00 INFO - 'USER': 'cltbld', 07:00:00 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026', 07:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:00 INFO - '_': '/tools/buildbot/bin/python'} 07:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:00 INFO - Running setup.py (path:/tmp/pip-fkWg2Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:00 INFO - Running setup.py (path:/tmp/pip-m4JViP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:00:00 INFO - Running setup.py (path:/tmp/pip-3gKqTC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:00:00 INFO - Running setup.py (path:/tmp/pip-nc7bj8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:00:00 INFO - Running setup.py (path:/tmp/pip-dbIdUx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:00:00 INFO - Running setup.py (path:/tmp/pip-CoxUQC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:00:00 INFO - Running setup.py (path:/tmp/pip-TlGoQ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:00:01 INFO - Running setup.py (path:/tmp/pip-BUlkoF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:00:01 INFO - Running setup.py (path:/tmp/pip-bG5q29-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:00:01 INFO - Running setup.py (path:/tmp/pip-c2Jz0s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:00:01 INFO - Running setup.py (path:/tmp/pip-wvSiHu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:00:01 INFO - Running setup.py (path:/tmp/pip-JJ1a9f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:00:01 INFO - Running setup.py (path:/tmp/pip-xIPiYk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:00:01 INFO - Running setup.py (path:/tmp/pip-QfhcT1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:00:01 INFO - Running setup.py (path:/tmp/pip-cXjM9o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:00:01 INFO - Running setup.py (path:/tmp/pip-i7UEdD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:00:01 INFO - Running setup.py (path:/tmp/pip-gq1Ue4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:00:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:00:01 INFO - Running setup.py install for manifestparser 07:00:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:00:01 INFO - Running setup.py install for mozcrash 07:00:01 INFO - Running setup.py install for mozdebug 07:00:02 INFO - Running setup.py install for mozdevice 07:00:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:00:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:00:02 INFO - Running setup.py install for mozfile 07:00:02 INFO - Running setup.py install for mozhttpd 07:00:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:00:02 INFO - Running setup.py install for mozinfo 07:00:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:00:02 INFO - Running setup.py install for mozInstall 07:00:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:00:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:00:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:00:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:00:02 INFO - Running setup.py install for mozleak 07:00:02 INFO - Running setup.py install for mozlog 07:00:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:00:02 INFO - Running setup.py install for moznetwork 07:00:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:00:02 INFO - Running setup.py install for mozprocess 07:00:03 INFO - Running setup.py install for mozprofile 07:00:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:00:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:00:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:00:03 INFO - Running setup.py install for mozrunner 07:00:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:00:03 INFO - Running setup.py install for mozscreenshot 07:00:03 INFO - Running setup.py install for moztest 07:00:03 INFO - Running setup.py install for mozversion 07:00:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:00:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:00:03 INFO - Cleaning up... 07:00:03 INFO - Return code: 0 07:00:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fc5f1dccc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bee6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c24a90>, '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 0x1c76f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c772e0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026', '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 07:00:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 07:00:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 07:00:03 INFO - Using env: {'DISPLAY': ':0', 07:00:03 INFO - 'HOME': '/home/cltbld', 07:00:03 INFO - 'LANG': 'en_US.UTF-8', 07:00:03 INFO - 'LANGUAGE': 'en_US:en', 07:00:03 INFO - 'LOGNAME': 'cltbld', 07:00:03 INFO - 'MAIL': '/var/mail/cltbld', 07:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:03 INFO - 'MOZ_NO_REMOTE': '1', 07:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:03 INFO - 'NO_EM_RESTART': '1', 07:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:03 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:03 INFO - 'SHELL': '/bin/bash', 07:00:03 INFO - 'SHLVL': '1', 07:00:03 INFO - 'TERM': 'linux', 07:00:03 INFO - 'TMOUT': '86400', 07:00:03 INFO - 'USER': 'cltbld', 07:00:03 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026', 07:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:03 INFO - '_': '/tools/buildbot/bin/python'} 07:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:03 INFO - Running setup.py (path:/tmp/pip-R_ghi9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:03 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)) 07:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:03 INFO - Running setup.py (path:/tmp/pip-4GG5_P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:03 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)) 07:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:00:03 INFO - Running setup.py (path:/tmp/pip-dBs_8d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:00:03 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)) 07:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:00:04 INFO - Running setup.py (path:/tmp/pip-xJHoXJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:00:04 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)) 07:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:00:04 INFO - Running setup.py (path:/tmp/pip-HCVPJf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:00:04 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)) 07:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:00:04 INFO - Running setup.py (path:/tmp/pip-TLbTqM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:00:04 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)) 07:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:00:04 INFO - Running setup.py (path:/tmp/pip-v11tk7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:00:04 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)) 07:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:00:04 INFO - Running setup.py (path:/tmp/pip-2hyAv9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:00:04 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)) 07:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:00:04 INFO - Running setup.py (path:/tmp/pip-SPi7FX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:00:04 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)) 07:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:00:04 INFO - Running setup.py (path:/tmp/pip-cOITqS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:00:04 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)) 07:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:00:04 INFO - Running setup.py (path:/tmp/pip-yDVJSg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:00:04 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)) 07:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:00:04 INFO - Running setup.py (path:/tmp/pip-xu1PO_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:00:04 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)) 07:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:00:04 INFO - Running setup.py (path:/tmp/pip-sdYdCe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:00:04 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)) 07:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:00:04 INFO - Running setup.py (path:/tmp/pip-aVddT3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:00:04 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)) 07:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:00:04 INFO - Running setup.py (path:/tmp/pip-ck8J8J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:00:04 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)) 07:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:00:04 INFO - Running setup.py (path:/tmp/pip-IYgH0_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:00:04 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)) 07:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:00:04 INFO - Running setup.py (path:/tmp/pip-L_Evem-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:00:05 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)) 07:00:05 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)) 07:00:05 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)) 07:00:05 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)) 07:00:05 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)) 07:00:05 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)) 07:00:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:06 INFO - Downloading blessings-1.5.1.tar.gz 07:00:06 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 07:00:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:00:06 INFO - Installing collected packages: blessings 07:00:06 INFO - Running setup.py install for blessings 07:00:06 INFO - Successfully installed blessings 07:00:06 INFO - Cleaning up... 07:00:06 INFO - Return code: 0 07:00:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:00:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:00:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:00:07 INFO - Reading from file tmpfile_stdout 07:00:07 INFO - Current package versions: 07:00:07 INFO - argparse == 1.2.1 07:00:07 INFO - blessings == 1.5.1 07:00:07 INFO - blobuploader == 1.2.4 07:00:07 INFO - docopt == 0.6.1 07:00:07 INFO - manifestparser == 1.1 07:00:07 INFO - mozInstall == 1.12 07:00:07 INFO - mozcrash == 0.16 07:00:07 INFO - mozdebug == 0.1 07:00:07 INFO - mozdevice == 0.47 07:00:07 INFO - mozfile == 1.2 07:00:07 INFO - mozhttpd == 0.7 07:00:07 INFO - mozinfo == 0.9 07:00:07 INFO - mozleak == 0.1 07:00:07 INFO - mozlog == 3.0 07:00:07 INFO - moznetwork == 0.27 07:00:07 INFO - mozprocess == 0.22 07:00:07 INFO - mozprofile == 0.27 07:00:07 INFO - mozrunner == 6.11 07:00:07 INFO - mozscreenshot == 0.1 07:00:07 INFO - mozsystemmonitor == 0.0 07:00:07 INFO - moztest == 0.7 07:00:07 INFO - mozversion == 1.4 07:00:07 INFO - psutil == 3.1.1 07:00:07 INFO - requests == 1.2.3 07:00:07 INFO - wsgiref == 0.1.2 07:00:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:00:07 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')]} 07:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:07 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')]} 07:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:07 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 0x7fc5f1dccc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bee6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c24a90>, '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 0x1c76f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c772e0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026', '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 07:00:07 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 07:00:07 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 07:00:07 INFO - Using env: {'DISPLAY': ':0', 07:00:07 INFO - 'HOME': '/home/cltbld', 07:00:07 INFO - 'LANG': 'en_US.UTF-8', 07:00:07 INFO - 'LANGUAGE': 'en_US:en', 07:00:07 INFO - 'LOGNAME': 'cltbld', 07:00:07 INFO - 'MAIL': '/var/mail/cltbld', 07:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:07 INFO - 'MOZ_NO_REMOTE': '1', 07:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:07 INFO - 'NO_EM_RESTART': '1', 07:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:07 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:07 INFO - 'SHELL': '/bin/bash', 07:00:07 INFO - 'SHLVL': '1', 07:00:07 INFO - 'TERM': 'linux', 07:00:07 INFO - 'TMOUT': '86400', 07:00:07 INFO - 'USER': 'cltbld', 07:00:07 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026', 07:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:07 INFO - '_': '/tools/buildbot/bin/python'} 07:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:07 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)) 07:00:07 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)) 07:00:07 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)) 07:00:07 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)) 07:00:07 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)) 07:00:07 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)) 07:00:07 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)) 07:00:07 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)) 07:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 07:00:07 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)) 07:00:07 INFO - Cleaning up... 07:00:07 INFO - Return code: 0 07:00:07 INFO - Running post-action listener: _resource_record_post_action 07:00:07 INFO - Running post-action listener: _start_resource_monitoring 07:00:07 INFO - Starting resource monitoring. 07:00:07 INFO - ##### 07:00:07 INFO - ##### Running install step. 07:00:07 INFO - ##### 07:00:07 INFO - Running pre-action listener: _resource_record_pre_action 07:00:07 INFO - Running main action method: install 07:00:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:00:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:00:07 INFO - Reading from file tmpfile_stdout 07:00:07 INFO - Detecting whether we're running mozinstall >=1.0... 07:00:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:00:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:00:07 INFO - Reading from file tmpfile_stdout 07:00:07 INFO - Output received: 07:00:07 INFO - Usage: mozinstall [options] installer 07:00:07 INFO - Options: 07:00:07 INFO - -h, --help show this help message and exit 07:00:07 INFO - -d DEST, --destination=DEST 07:00:07 INFO - Directory to install application into. [default: 07:00:07 INFO - "/builds/slave/test-pgo"] 07:00:07 INFO - --app=APP Application being installed. [default: firefox] 07:00:07 INFO - mkdir: /builds/slave/test-pgo/build/application 07:00:07 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'] 07:00:07 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 07:00:22 INFO - Reading from file tmpfile_stdout 07:00:22 INFO - Output received: 07:00:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:00:22 INFO - Running post-action listener: _resource_record_post_action 07:00:22 INFO - ##### 07:00:22 INFO - ##### Running run-tests step. 07:00:22 INFO - ##### 07:00:22 INFO - Running pre-action listener: _resource_record_pre_action 07:00:22 INFO - Running main action method: run_tests 07:00:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:00:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:00:22 INFO - Python 2.7.3 07:00:22 INFO - Return code: 0 07:00:22 INFO - grabbing minidump binary from tooltool 07:00: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')]} 07:00:22 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 0x1c24a90>, '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 0x1c76f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c772e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:00:22 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 07:00:22 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 07:00:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:00:22 INFO - Return code: 0 07:00:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:00:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:00:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:00:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:00:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:00:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 07:00:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost 07:00:22 INFO - Using env: {'DISPLAY': ':0', 07:00:22 INFO - 'HOME': '/home/cltbld', 07:00:22 INFO - 'LANG': 'en_US.UTF-8', 07:00:22 INFO - 'LANGUAGE': 'en_US:en', 07:00:22 INFO - 'LOGNAME': 'cltbld', 07:00:22 INFO - 'MAIL': '/var/mail/cltbld', 07:00:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:00:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:22 INFO - 'MOZ_NO_REMOTE': '1', 07:00:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:22 INFO - 'NO_EM_RESTART': '1', 07:00:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:22 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:00:22 INFO - 'SHELL': '/bin/bash', 07:00:22 INFO - 'SHLVL': '1', 07:00:22 INFO - 'TERM': 'linux', 07:00:22 INFO - 'TMOUT': '86400', 07:00:22 INFO - 'USER': 'cltbld', 07:00:22 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026', 07:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:22 INFO - '_': '/tools/buildbot/bin/python'} 07:00:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost'] with output_timeout 3600 07:00:22 INFO - mozversion INFO | application_buildid: 20151116043001 07:00:22 INFO - mozversion INFO | application_changeset: 48d636f678b0e5162ab868dc9024a5ffe350460c 07:00:22 INFO - mozversion INFO | application_display_name: Nightly 07:00:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:00:22 INFO - mozversion INFO | application_name: Firefox 07:00:22 INFO - mozversion INFO | application_remotingname: firefox 07:00:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 07:00:22 INFO - mozversion INFO | application_vendor: Mozilla 07:00:22 INFO - mozversion INFO | application_version: 45.0a1 07:00:22 INFO - mozversion INFO | platform_buildid: 20151116043001 07:00:22 INFO - mozversion INFO | platform_changeset: 48d636f678b0e5162ab868dc9024a5ffe350460c 07:00:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 07:00:22 INFO - mozversion INFO | platform_version: 45.0a1 07:00:22 INFO - 2015-11-16 07:00:22,299 DEBUG : using testdate: 1447686022 07:00:22 INFO - 2015-11-16 07:00:22,299 DEBUG : actual date: 1447686022 07:00:22 INFO - 2015-11-16 07:00:22,377 INFO : starting webserver on 'localhost:44636' 07:00:22 INFO - 2015-11-16 07:00:22,378 INFO : Starting test suite talos-linux64-ix-057 07:00:22 INFO - 2015-11-16 07:00:22,378 INFO : Starting test dromaeo_css 07:00:22 INFO - 2015-11-16 07:00:22,378 DEBUG : operating with platform_type : linux_ 07:00:22 INFO - 2015-11-16 07:00:22,379 INFO : Initialising browser for dromaeo_css test... 07:00:22 INFO - 2015-11-16 07:00:22,394 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYaThCk/profile http://localhost:44636/getInfo.html 07:00:27 INFO - 2015-11-16 07:00:27,130 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:00:27 INFO - 2015-11-16 07:00:27,130 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:00:27 INFO - 2015-11-16 07:00:27,130 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:00:27 INFO - 2015-11-16 07:00:27,130 DEBUG : BROWSER_OUTPUT: __metrics 07:00:27 INFO - 2015-11-16 07:00:27,252 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:00:28 INFO - 2015-11-16 07:00:28,365 INFO : Browser initialized. 07:00:28 INFO - 2015-11-16 07:00:28,365 INFO : Running cycle 1/1 for dromaeo_css test... 07:00:28 INFO - 2015-11-16 07:00:28,365 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYaThCk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:00:40 INFO - 2015-11-16 07:00:40,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 141922304 07:00:40 INFO - 2015-11-16 07:00:40,191 DEBUG : BROWSER_OUTPUT: 07:01:31 INFO - 2015-11-16 07:01:31,793 DEBUG : BROWSER_OUTPUT: 1447686091792 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] 07:03:40 INFO - 2015-11-16 07:03:40,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44636/tests/dromaeo/cssquery-ext.html) 07:03:41 INFO - 2015-11-16 07:03:41,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 241029120 07:03:41 INFO - 2015-11-16 07:03:41,391 DEBUG : BROWSER_OUTPUT: 07:06:43 INFO - 2015-11-16 07:06:43,763 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/dromaeo/cssquery-ext.html (next: http://localhost:44636/tests/dromaeo/cssquery-jquery.html) 07:06:44 INFO - 2015-11-16 07:06:44,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 215924736 07:06:44 INFO - 2015-11-16 07:06:44,329 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2015-11-16 07:09:46,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44636/tests/dromaeo/cssquery-mootools.html) 07:09:46 INFO - 2015-11-16 07:09:46,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 217116672 07:09:46 INFO - 2015-11-16 07:09:46,795 DEBUG : BROWSER_OUTPUT: 07:12:48 INFO - 2015-11-16 07:12:48,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44636/tests/dromaeo/cssquery-prototype.html) 07:12:49 INFO - 2015-11-16 07:12:49,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 194211840 07:12:49 INFO - 2015-11-16 07:12:49,201 DEBUG : BROWSER_OUTPUT: 07:15:51 INFO - 2015-11-16 07:15:51,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44636/tests/dromaeo/cssquery-yui.html) 07:15:52 INFO - 2015-11-16 07:15:52,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 203051008 07:15:52 INFO - 2015-11-16 07:15:52,209 DEBUG : BROWSER_OUTPUT: 07:18:54 INFO - 2015-11-16 07:18:54,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/dromaeo/cssquery-yui.html (next: http://localhost:44636/tests/dromaeo/cssquery-dojo.html) 07:18:54 INFO - 2015-11-16 07:18:54,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 261713920 07:18:54 INFO - 2015-11-16 07:18:54,834 DEBUG : BROWSER_OUTPUT: 07:18:54 INFO - 2015-11-16 07:18:54,834 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:18:54 INFO - 2015-11-16 07:18:54,835 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:18:54 INFO - 2015-11-16 07:18:54,835 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:18:54 INFO - 2015-11-16 07:18:54,835 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:18:54 INFO - 2015-11-16 07:18:54,835 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3206.390785750707;3206.8936217005125;3286.622038465577;3296.324253528027;3305.4711246200613;5248.5538729208065;5323.307969963904;5367.436419175989;5468.6171967962255;5481.862953426166;5421.83734487965;5450.991566560189;5458.836234912959;5485.670859748418;5513.531349835269;5034.622403319757;5061.468545802693;5080.7967681292885;5082.923756143661;5107.540321371076;4850.248211527219;5140.742962851861;5167.664101833388;5208.140656791625;5235.6596821206695;4951.480094590071;5007.824726134568;5008.499150084981;5038.143515602356;5039.798408063673;5033.119204139261;5084.110280700863;5093.821716239951;5108.080545501808;5148.279240906276;4841.757912104381;4924.482929292444;5049;5077.898442031139;5087.211482220262;5191.480851914778;5242.6330156889035;5247.449017853147;5249.370075590953;5260;5975.581709280352;5979.342272350038;5982.4316689914385;5983.222181116427;6003.129546215818;5768.250127483442;5833.7374818133285;5893.970530147321;6009.699515024231;6010.819675409744;5551.306086739158;5553.278073850373;5557.5831812614215;5573.164025396182;5677.659340439587;6032.245969253843;6042.4561789438285;6046.667433291212;6053;6057.545684073712;5627.634203776742;5782.10377391505;5848.619839710405;5864.9413505864395;5963.837051774863;5995.970020149872;6003.189569408161;6013.639181649115;6022.1870047543025;6028.638281703112;5961.344252132262;5961.5230781537375;5968.522518198533;5972.044472884318;5972.611780234271;5633.521150702236;5745.052066409079;5787.681677507778;5878.147668588031;5922.8815423691285;4529.343245229489;4546.431696037996;4548.090381923628;4551.40831691878;4578.816847326137;3929.9978505480917;4046.2918989177365;4046.352583586612;4066.6543343815515;4089.7750623715983;5412.7564259607625;5412.891742165135;5467;5489;5533.972330138324;5878.265216847894;5884.646921184657;5887.735051922674;5890.969080410911;5894.145348924382;5178.275041494194;5341.198820177005;5509.614326997152;5510.338759348904;5521.861953451196;5028.220625803006;5069.366329208849;5104.69371837691;5112.693238405707;5134.512221338967;6089.969550152221;6094.177286066413;6095.238095238095;6096.542759293071;6105;5687.573431992534;5734.082546792493;5829.417058294137;5896.380880007538;5903.822885313448;6115.908261375994;6127.1261596101485;6159.753609855556;6161.199044124235;6168.321484636596;5867.295924489089;5867.970660146672;5871.178035075008;5878;5896.941030589639;5584.888302234014;5711.428857114255;5833.562482813891;5935.940640593712;5948.672822994604;5745.138229265476;5778.36437991829;5812.21535092757;5825.825225243249;5852.4440178184705;5780.566457515619;5809.709514524172;5818.2436283282905;5826.388229235869;5829.883402331845;5499.175123731472;5641.464060914206;5684.7157642118555;5790.826275211751;5832.037713777349;5813.593048486566;5834.27071616048;5841.474267315962;5843.035899076604;5846.064629659234;5341.332333458317;5725.484706376279;5725.942740572707;5732.828015159552;5753.3958934311295 07:18:54 INFO - 2015-11-16 07:18:54,835 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.0880876940942;593.6764463367464;594.491709588302;608.9573729838913;612.0574315554047;31901.36197276056;39793;40421.19157616846;40736.79631601845;40790.79604601973;43086.56913430865;43476.56523434765;43576;43617.12765744691;43667.56332436683;7685.193054729257;7779.066512018566;8687.869681954775;8864.423812452202;10171.288009839314;10312.278140530167;10452.843207351858;10467.581296748122;10472.738181545485;10478.842817357745;10462.372257664527;10530.631427900025;10580.735481612983;10587.100096491808;10604.15166786659;7805.492642978216;7978.9202107979045;10559.788804223872;10808.729781755519;10814.945925270324;10235.590576376935;10341.327813692162;10348.172146228359;10351.63769268072;10359.378437293786;40109.598904010876;40497.392539111934;40575;40599.39100913489;40620;3089.1504836170234;3254.300325430044;3375.4093033719;3510.9648903510893;3594.1076938389674;29972.400551988838;30066.84966575153;30072.248193795112;30330.393392132035;30615.2346191347;3398.898033059012;3459.913502162441;3476.9826150869335;3546.8226588670464;3577.0342007657787;296314;296879;297235;300712.9999999978;300737;56121.79086568524;57241;59152;59378;59496.70251648714;67804;68672.65663671649;68911;68931.65534172297;68951;15488.690226195638;15559.922200388926;15667.138307392976;15770.211489425483;15782.68434631301;11578.94210528942;11718.589849355232;11737.295762254293;11737.589184378507;11741.060715142768;19280.4215873524;19461.693598585818;19503.588636318393;19540.70688939667;19560;7707;7861.283230062031;7876;7904.841903161904;7953.960230198812;871.9128087191357;920.3787443475627;960.841461158915;1032.1112265597912;1038.6520515627199;27634.723652763616;27884.721152788214;28150.155495334762;28540;29396.559051614244;966.1739212972948;972.4700038479045;1015.0864222200079;1045.8065257927308;1056.144522936424;14101.647458813406;14522.709545809024;14611.78082328766;14725.705485890223;15401.691966160613;318070;323114;324736;324976;325566;53716.73141634345;53804;53978.19032714512;53980.46019539833;54138;1270.30133426615;1282.7562763074986;1297.1244410023196;1349.1298112717243;1376.6695992961618;25915.22254332373;26961.325966850985;28261.15216543507;28278;28830.855845720638;43218.56781432145;43559.56440435555;43658;43757.78121109501;43774.34338484862;291009;298137;298851;387878;390427;30538.694613053583;30746.077617671504;30750.53874191844;30827.229319267197;30861.69138308678;41136;41922;41975.370369443874;42689;42781.35827962645;34888.651113489555;35772.28455430929;35930.82034589915;35953;36783.44824827576;33193;33571.35010436163;34137.31725365429;34328.313433730684;35118.29763404666;34919.82540087283;35835.82082089573;35910.8204458976;35945.820270898475;36217.45673814948;30114.397712046073;32629.18427039343;33310.83344583261;33423.33153336871;33445.83277083599;24808.25575232746;25157.24528264155;25206.369840754127;25277.87361063183;25391 07:18:54 INFO - 2015-11-16 07:18:54,835 DEBUG : BROWSER_OUTPUT: |2;jquery.html;344.46435792342913;348.4738045551217;348.63335723962064;350.82458770614676;353.2634457156828;14324.140551566914;14727.116373017627;16596.91701541492;16914.74627880581;17671.823281767178;13324.600261992131;13345;13377;14842.851571484282;15706;5147.871303217431;5387.138057910735;5411.512963833255;5420.051490989081;5432.728363581825;3815.179736356683;3901;5397.568194544447;5805.709714514279;5960.284765828107;5993.160957465936;6014.578979471439;6016.96991515044;6019.247594050744;6042.184305118797;5815.185873977625;5938.257717785277;5943.524518038546;5950.523958083343;5955.255593050869;5104.157813960692;5187.221916712486;5199.14214154664;5204.583633309327;5205.349331333583;20987.055582498826;21044.894775526023;21060;21768.782312176834;21915.780842191532;2021.373374253986;2077.5325551750884;2138.754043285011;2143.164165975271;2215.4239897626735;13014.609561713163;13071.411786469536;13114.934425327907;13148.934255328757;13818.37817298224;1778.1464896849584;1823.8449731772814;1868.981405134205;1874.3439796071402;1877.8309952104375;59960.10059849106;60365;61417.6929115356;62757.686211569104;63333.366666333204;9260.49067301305;9513.66702165421;9702.417854928726;9714.077162669535;9744.95127524372;12545.937270313772;12567.93716031414;12568.685782855502;12580.559680411141;12583.559575414816;5345.518903298644;5492.972535137379;5505.697186654692;5576.498115169654;7222.602756848319;5544.500994910478;5587.832365028974;5597.972010139923;5614.522765564891;5742.54059675225;3097.2566584020124;3144.905652830373;3161.668024857357;3173.2066983254185;3193.536937144101;1106.7897099551221;1140.2645293785463;1149.6321177223376;1155.8786327435666;1160.14729174057;446.76768080597907;448.15075432056074;450.2121287746444;466.37039996005797;471.3942583779895;10097;11413;11479.598214062635;11607.651770446731;11839.940800296115;463.85388602590075;470.68934503227706;476.26417185448565;480.4042986696471;480.4498848818084;6255.374462553708;6323.841903952438;6366.904496432558;6430.421262086341;6451.516136289797;473781;476874;477409;514188;547267.9549033839;69015;71580.28419715737;75357.62321188468;75462;76004.61997689976;528.5269683633127;534.9759260833272;536.4796147736689;538.68217751526;539.3042974562849;10213.182945364502;10377.273590848568;10611.257211995086;10827.837582436427;10942.835857462303;33434.49848252327;34315.31369372549;35893;36052.45921311235;37025.629743702215;46890;48365;48747.268790968876;48809.75595122002;49467.50532494629;6544.607323560602;6630.138082049302;6688.398044176048;6769.3907548320885;6843.418309443753;11502.482388292714;11765.941170294094;11869.109816763605;11887.821682674594;11918.463669134737;10209.846852297072;10615;10703.839442408525;11083.501242443948;11084.667459976214;10088.596456141966;10374.118199953089;10429;10480.68557943263;10721.41032243203;9051.728448146567;9055.094490550891;10237.48812559384;10387.480625968823;10439.37363758177;6590.637514936724;6686.899696504459;6757.594544327356;6823.044773731781;6836.077129587442;10586.947065264625;10613.9469302653;10786.838197426889;10820.242583019113;10872.945635271773 07:18:54 INFO - 2015-11-16 07:18:54,836 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1381.0608786025498;1707.5731067233191;1745.5461579989208;1776.7867855857296;1779.5817982774047;6335.08141319509;6821.8294542636395;6982.860342793141;7003.439724822015;7019.68411421486;7197.496175267734;7296.270372962701;7299.2335804740405;7311.817204569888;7329;1911.5985643014915;1946.6593346164436;2163;2182.487115527854;2210.3921421609025;2239.854409463388;2244.921427750029;2246.809021233197;2248.123231939545;2253.6844841722173;2087.812096911278;2126.8085872271495;2131.477787941956;2135.380739585526;2136.7649558548546;1906.085079162003;1939.5829896572234;2105.757837848652;2142.9785702142935;2144.5603651251454;2163.383435720812;2175.38001669525;2193.0679461228915;2212.7123473948445;2214.1918199857096;7292.453066020017;7346.59593722345;7373.483856130073;7401.3338799507765;7413.74051908186;4477.462704475483;4572.497025327211;4574.4510658721165;4575.176468235716;4578.10726908253;2854.4576530459144;2859.656841179051;2877.6402949631297;2895.623568936046;2970.8663110160096;918.7289749523907;930.1349744737391;970.1268858027761;970.8446648536271;995.9103680668775;9761.121499065048;9785.902140978642;9807.460589667495;9814.263930205192;9843.655472058443;3903.843846246175;3904.06302487401;3972.920541589152;4093.2222877653153;4097.713160078766;8591.871121933176;8598.828023439497;8616.612252448655;8616.870746938801;8617.224449799549;4555.316702494652;4570.177368073712;4577.404937358122;4590.42619672541;4590.839320623762;4172.436721042681;4174.499060112806;4177.206330797138;4177.415161877339;4184.205001049791;3544.9822750886083;3583.498310236569;3584.534010578608;3591.3894637911094;3617.4212126059706;1114.8717897441736;1115.0187834705569;1125.9155563332783;1127.932324060559;1155.7399585093456;1015.355249416611;1022.8670272864629;1025.9487025648689;1028.922830787679;1078.7141407527013;6892.483063770237;6954.721811127498;6975.372216500437;6977.197622273504;6984.615846128511;417.6241382755484;1190.7737529869298;1206.1436380170003;1213.435752375132;1237.7215126596443;5185.818496352609;5217.895642087137;5226.790928362899;5231.607629427808;5233.058049551118;8897.822043559223;8978.775530611656;9043.819123617492;9105.863412048824;9223.400478968846;8964.282857371394;9064.954675226581;9076.31927605419;9082.22801061904;9099;6785.42323902464;6950.930490695028;6951.65241737911;6987;6993.89509157363;6536.202544300165;6569.901451478136;6578.04618330349;6580.374864387875;6590.8352291193105;7747.147813740597;7793.454458187873;8155.306798922158;8197.549134797644;8203.794905127419;8195.098539160568;8351.832963340821;8363.080061193386;8412.327013839;8419.62111704987;6126.724297406538;6349.714262858275;6364;6382.042693595998;6387.041943708481;6483.319251478715;6755.560888542229;6767.796966091025;6773.898391524032;6774.830629234111;6406.240648005772;6604.669766511559;6709.865802684017;6714.328567143247;6820.3861652451515;5591.832245032656;6596.30738772422;6643.335666433318;6747.156605424322;6767.966160169364;6564.704588293443;6595.043718660863;6616.073749674953;6623.271440141677;6626.503012274003;5943.762249509971;5988.431099045583;6010.669413182317;6110.480609148272;6191.783287584913;6193.969030154821;6226.283977342664;6241;6247.937520624736;6252.280987686474 07:18:54 INFO - 2015-11-16 07:18:54,839 DEBUG : BROWSER_OUTPUT: |4;prototype.html;292.1877181435609;295.5330577687254;295.995560066599;296.3953534789028;298.2097441779285;5941.910871336933;5969.134475501055;6070.484008859241;6094.299155597102;6109.6945152742355;5908.704564771755;6031.788887388942;6051.909221361683;6061.090836374546;6063.393660633935;4515.6613254005915;4519.52544982777;4520.706154099989;4521.073179998109;4521.660875434339;4333.60997510224;4392.38506609075;4455.487618923833;4535.229011068126;4535.977320113395;4469.486009108945;4469.664775141861;4482.731036137826;4487.371767952489;4503.594676479116;4484.5291244419195;4488.1696886076015;4489.528599497071;4501.684882058257;4505.211587972124;3822.694184465236;3827.7320587558884;3828.0429892526868;3830.042489377656;3830.4637350770913;5663.66018038919;5752.597318187729;5761.769529218826;5766.961946849566;5777.393373695785;5122.641415100945;5125.436202017775;5131.4098878629065;5132.563732082777;5142;6121.571489995702;6350.491960643184;6355.682215889234;6358.364163583651;6361.854866124142;4113.876583702494;4126.484189476316;4183.1215444756635;4194.8112334945;4200.348945913388;6627.668616569201;6734.191896972346;6744.8313792155095;6745.763898263537;6747.05541224229;4218.767967761742;4219.683523735671;4225.788710564521;4229.703920725519;4230.788460576959;4180.916381672349;4268.87193384199;4274;4278.743275403485;4295.634871035997;5101.132807422747;5111.974440127776;5112.9744351278005;5113.1052065888325;5114.5652619527755;6482.222133344029;6484.481241500669;6486.027095935648;6493.22081350241;6494.545381823322;1512.568917858405;1532.6245069957931;1535.7005383950245;1535.8464153584553;1537.7308970930042;979.7893452907659;981.7349315684725;985.7387792235063;1002.3534820041033;1007.8840933292619;6205.572718274731;6239.78160764371;6249.500039996789;6252.3122456529745;6257.624542527463;6659.334066593399;6668.199816022108;6669;6676.699548520328;6686.13080299558;6061.393860613904;6219.937800622027;6239.656818875005;6240.219972503437;6242.812715618538;3598;3624.2389098289655;3625.7672391387055;3629.4737263096704;3630.128769095451;6932.930670693228;6943.409810166192;6947.826304342432;6949.131358580177;6958.199807022156;6701.463882889358;6861.4853885958755;6869.278725733726;6876.243613202544;6876.724931002704;6944.375006249462;6944.826379340557;6948.722051117999;6949.027136200936;6950.513464057569;6428.646424446701;6600.1089852869245;6600.735970561123;6629.602223866584;6664.300248473841;6495.837604059747;6577.934220657732;6588.8352791180605;6593.142891424084;6593.934060659524;6971.5468494547695;6975.128108986377;6976.19773726028;6976.5814051157095;6979.4765392594745;4193.811278492536;4270.636995855387;4276.273033584361;4276.850310239127;4277.123189746157;6684.06423100776;6700.865982680221;6707.195136583641;6708.865822683421;6719.227288861648;6512.088307637029;6531.608103513804;6537.215534135934;6537.7058032389605;6539.607623542603;6351.618902865843;6516.218053833571;6520.7391704333195;6521.7065232065615;6554.410103090554;6414.198225221848;6424.743010279536;6425.10048593188;6428.067930150196;6432.839179020562;6560.475161986934;6560.967195163994;6572.244191917799;6580.177477815273;6583.80248592543;6178.938210617836;6368.076628888878;6369.235691717024;6370.394812492806;6410.903836442364 07:18:54 INFO - 2015-11-16 07:18:54,840 DEBUG : BROWSER_OUTPUT: |5;yui.html;713.9036230108934;790.8414173236209;841.873718942159;846.1515516092784;863.4862256957108;12428.875711242885;12736.363181840894;12761.425735841885;12763.872361276384;12765.744685106303;12267.63197104086;12452.315122668273;13532.458701651922;13704.794428083587;13722.931385343085;688.3460712323288;694.6492021529147;810.1452967119701;819.2053707903324;828.2131974624101;817.4196320612342;819.9467034642729;825.2160447574798;825.4263287015526;825.6614787936948;849.6091797773032;861.8965724113115;861.9353548483857;862.4135587800293;863.0808189278398;699.8635266123108;708.9610071446068;843.2284459719319;854.4275335525213;855.0850589868843;620.4416025576971;622.0637939900466;622.947049500793;624.316373570939;624.6158612453354;12095.092868034933;12153.93923030388;12183.51265949361;12208.816867746991;12209.267443953391;9386.530673466368;9525.666601668909;9653.806923861483;9689.079537443931;10020.398776073458;9272.629094836198;9438.669646562337;9491.38306010107;9567.808643827084;9759.853602195974;3036.2105852478294;3097.845107744604;3111.23774675206;3134.7805653604255;3187.0757480330676;46179;46513;46617.30074048892;46644.53355466436;46719.29921051187;6913.1358580177475;7044.084269045094;7073.646317684095;7160.051725852958;7400.481966262418;11440.94279528597;11478.770424591461;11482.368469734245;11482.483288251882;11482.540698372139;6544.574602650812;6596.30738772422;6736.562123461959;6744.865102697919;6903.1371078615175;4053.8783836484954;4125.8968525786495;4145.0880806222585;4168.353905144708;4183.979080104641;2687.7177896320995;2715.0361621624434;2717.144099608617;2719.830472896634;2722.48272828162;428.55644408037534;429.13743375814215;437.49250868992453;444.13393881930364;444.7931711753985;551.6000899348021;623.4085956927289;623.5666211982629;640.4876099120685;666.167290886392;8017.839643207103;8092.71675491355;8290.792730181673;8302.335372346965;8334.749957501284;549.3662491153199;630.8012975912573;638.8626445314187;661.5600625584029;671.1074271219267;3751.6998640108727;3753.249350129985;3806.4480650306105;3842.423636454498;3910.354791459434;56770;60329;60351.39648603545;60869.39130608726;60945.39054609486;48698.75650621724;50171;50278.49721502811;50689.493105068475;50728;46233.53766462292;46317.768411157725;46453.767731161126;46600.06799863984;47086.5291347089;8478.533680647377;8575.3997220194;8679.34904882149;8681;8910.821783564423;35867.28265434624;35927.28145437129;36376.45435318419;36970;37089.44365834461;41625.37561936513;41698.791506042275;43513;46185.76907115577;46782.298265526726;7598.8100297493;7602.771916842504;7637.579933103732;7773.883391749016;7845.882311765214;11696.888795564408;12208.877911220774;12359.50561977511;12607.054470914902;13013.869861301644;10919.126469882549;10920.18098642589;10932.890671093506;11048.779024419628;11408.315501069963;10958.126754673925;11112.944435277772;11139.665810025388;11222.943885280847;11403.315801051964;10768.730781730206;11175.329480231212;11707.2975621463;11846.644600661994;11960.222585531912;9258.703781470735;9306.860397093913;9317.322881881326;9383.530823458936;9529.809403812023;8821.867671985054;9440.575174117319;9466.668666596635;9559.378640388353;9585.376950498196 07:18:54 INFO - 2015-11-16 07:18:54,841 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:18:54 INFO - 2015-11-16 07:18:54,841 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:18:54 INFO - 2015-11-16 07:18:54,841 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,840 07:18:54 INFO - 2015-11-16 07:18:54,841 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:18:54 INFO - 2015-11-16 07:18:54,841 DEBUG : BROWSER_OUTPUT: __startTimestamp1447687134827__endTimestamp 07:18:54 INFO - 2015-11-16 07:18:54,841 DEBUG : BROWSER_OUTPUT: 07:18:54 INFO - 2015-11-16 07:18:54,841 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:18:54 INFO - 2015-11-16 07:18:54,841 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:18:54 INFO - 2015-11-16 07:18:54,841 DEBUG : BROWSER_OUTPUT: 07:18:54 INFO - 2015-11-16 07:18:54,842 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5476.10 Median:5687.57 stddev:616.01 (10.8%) stddev-sans-first:591.61 07:18:54 INFO - 2015-11-16 07:18:54,842 DEBUG : BROWSER_OUTPUT: Values: 3206.4 3206.9 3286.6 3296.3 3305.5 5248.6 5323.3 5367.4 5468.6 5481.9 5421.8 5451.0 5458.8 5485.7 5513.5 5034.6 5061.5 5080.8 5082.9 5107.5 4850.2 5140.7 5167.7 5208.1 5235.7 4951.5 5007.8 5008.5 5038.1 5039.8 5033.1 5084.1 5093.8 5108.1 5148.3 4841.8 4924.5 5049.0 5077.9 5087.2 5191.5 5242.6 5247.4 5249.4 5260.0 5975.6 5979.3 5982.4 5983.2 6003.1 5768.3 5833.7 5894.0 6009.7 6010.8 5551.3 5553.3 5557.6 5573.2 5677.7 6032.2 6042.5 6046.7 6053.0 6057.5 5627.6 5782.1 5848.6 5864.9 5963.8 5996.0 6003.2 6013.6 6022.2 6028.6 5961.3 5961.5 5968.5 5972.0 5972.6 5633.5 5745.1 5787.7 5878.1 5922.9 4529.3 4546.4 4548.1 4551.4 4578.8 3930.0 4046.3 4046.4 4066.7 4089.8 5412.8 5412.9 5467.0 5489.0 5534.0 5878.3 5884.6 5887.7 5891.0 5894.1 5178.3 5341.2 5509.6 5510.3 5521.9 5028.2 5069.4 5104.7 5112.7 5134.5 6090.0 6094.2 6095.2 6096.5 6105.0 5687.6 5734.1 5829.4 5896.4 5903.8 6115.9 6127.1 6159.8 6161.2 6168.3 5867.3 5868.0 5871.2 5878.0 5896.9 5584.9 5711.4 5833.6 5935.9 5948.7 5745.1 5778.4 5812.2 5825.8 5852.4 5780.6 5809.7 5818.2 5826.4 5829.9 5499.2 5641.5 5684.7 5790.8 5832.0 5813.6 5834.3 5841.5 5843.0 5846.1 5341.3 5725.5 5725.9 5732.8 5753.4 07:18:54 INFO - 2015-11-16 07:18:54,842 DEBUG : BROWSER_OUTPUT: 07:18:54 INFO - 2015-11-16 07:18:54,842 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48727.76 Median:179097.59 stddev:83795.93 (46.8%) stddev-sans-first:83952.92 07:18:54 INFO - 2015-11-16 07:18:54,843 DEBUG : BROWSER_OUTPUT: Values: 548.1 593.7 594.5 609.0 612.1 31901.4 39793.0 40421.2 40736.8 40790.8 43086.6 43476.6 43576.0 43617.1 43667.6 7685.2 7779.1 8687.9 8864.4 10171.3 10312.3 10452.8 10467.6 10472.7 10478.8 10462.4 10530.6 10580.7 10587.1 10604.2 7805.5 7978.9 10559.8 10808.7 10814.9 10235.6 10341.3 10348.2 10351.6 10359.4 40109.6 40497.4 40575.0 40599.4 40620.0 3089.2 3254.3 3375.4 3511.0 3594.1 29972.4 30066.8 30072.2 30330.4 30615.2 3398.9 3459.9 3477.0 3546.8 3577.0 296314.0 296879.0 297235.0 300713.0 300737.0 56121.8 57241.0 59152.0 59378.0 59496.7 67804.0 68672.7 68911.0 68931.7 68951.0 15488.7 15559.9 15667.1 15770.2 15782.7 11578.9 11718.6 11737.3 11737.6 11741.1 19280.4 19461.7 19503.6 19540.7 19560.0 7707.0 7861.3 7876.0 7904.8 7954.0 871.9 920.4 960.8 1032.1 1038.7 27634.7 27884.7 28150.2 28540.0 29396.6 966.2 972.5 1015.1 1045.8 1056.1 14101.6 14522.7 14611.8 14725.7 15401.7 318070.0 323114.0 324736.0 324976.0 325566.0 53716.7 53804.0 53978.2 53980.5 54138.0 1270.3 1282.8 1297.1 1349.1 1376.7 25915.2 26961.3 28261.2 28278.0 28830.9 43218.6 43559.6 43658.0 43757.8 43774.3 291009.0 298137.0 298851.0 387878.0 390427.0 30538.7 30746.1 30750.5 30827.2 30861.7 41136.0 41922.0 41975.4 42689.0 42781.4 34888.7 35772.3 35930.8 35953.0 36783.4 33193.0 33571.4 34137.3 34328.3 35118.3 34919.8 35835.8 35910.8 35945.8 36217.5 30114.4 32629.2 33310.8 33423.3 33445.8 24808.3 25157.2 25206.4 25277.9 25391.0 07:18:54 INFO - 2015-11-16 07:18:54,843 DEBUG : BROWSER_OUTPUT: 07:18:54 INFO - 2015-11-16 07:18:54,843 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26328.92 Median:447.46 stddev:81724.91 (18264.2%) stddev-sans-first:81930.88 07:18:54 INFO - 2015-11-16 07:18:54,843 DEBUG : BROWSER_OUTPUT: Values: 344.5 348.5 348.6 350.8 353.3 14324.1 14727.1 16596.9 16914.7 17671.8 13324.6 13345.0 13377.0 14842.9 15706.0 5147.9 5387.1 5411.5 5420.1 5432.7 3815.2 3901.0 5397.6 5805.7 5960.3 5993.2 6014.6 6017.0 6019.2 6042.2 5815.2 5938.3 5943.5 5950.5 5955.3 5104.2 5187.2 5199.1 5204.6 5205.3 20987.1 21044.9 21060.0 21768.8 21915.8 2021.4 2077.5 2138.8 2143.2 2215.4 13014.6 13071.4 13114.9 13148.9 13818.4 1778.1 1823.8 1869.0 1874.3 1877.8 59960.1 60365.0 61417.7 62757.7 63333.4 9260.5 9513.7 9702.4 9714.1 9745.0 12545.9 12567.9 12568.7 12580.6 12583.6 5345.5 5493.0 5505.7 5576.5 7222.6 5544.5 5587.8 5598.0 5614.5 5742.5 3097.3 3144.9 3161.7 3173.2 3193.5 1106.8 1140.3 1149.6 1155.9 1160.1 446.8 448.2 450.2 466.4 471.4 10097.0 11413.0 11479.6 11607.7 11839.9 463.9 470.7 476.3 480.4 480.4 6255.4 6323.8 6366.9 6430.4 6451.5 473781.0 476874.0 477409.0 514188.0 547268.0 69015.0 71580.3 75357.6 75462.0 76004.6 528.5 535.0 536.5 538.7 539.3 10213.2 10377.3 10611.3 10827.8 10942.8 33434.5 34315.3 35893.0 36052.5 37025.6 46890.0 48365.0 48747.3 48809.8 49467.5 6544.6 6630.1 6688.4 6769.4 6843.4 11502.5 11765.9 11869.1 11887.8 11918.5 10209.8 10615.0 10703.8 11083.5 11084.7 10088.6 10374.1 10429.0 10480.7 10721.4 9051.7 9055.1 10237.5 10387.5 10439.4 6590.6 6686.9 6757.6 6823.0 6836.1 10586.9 10613.9 10786.8 10820.2 10872.9 07:18:54 INFO - 2015-11-16 07:18:54,843 DEBUG : BROWSER_OUTPUT: 07:18:54 INFO - 2015-11-16 07:18:54,843 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5150.41 Median:6250.11 stddev:2648.91 (42.4%) stddev-sans-first:2641.18 07:18:54 INFO - 2015-11-16 07:18:54,845 DEBUG : BROWSER_OUTPUT: Values: 1381.1 1707.6 1745.5 1776.8 1779.6 6335.1 6821.8 6982.9 7003.4 7019.7 7197.5 7296.3 7299.2 7311.8 7329.0 1911.6 1946.7 2163.0 2182.5 2210.4 2239.9 2244.9 2246.8 2248.1 2253.7 2087.8 2126.8 2131.5 2135.4 2136.8 1906.1 1939.6 2105.8 2143.0 2144.6 2163.4 2175.4 2193.1 2212.7 2214.2 7292.5 7346.6 7373.5 7401.3 7413.7 4477.5 4572.5 4574.5 4575.2 4578.1 2854.5 2859.7 2877.6 2895.6 2970.9 918.7 930.1 970.1 970.8 995.9 9761.1 9785.9 9807.5 9814.3 9843.7 3903.8 3904.1 3972.9 4093.2 4097.7 8591.9 8598.8 8616.6 8616.9 8617.2 4555.3 4570.2 4577.4 4590.4 4590.8 4172.4 4174.5 4177.2 4177.4 4184.2 3545.0 3583.5 3584.5 3591.4 3617.4 1114.9 1115.0 1125.9 1127.9 1155.7 1015.4 1022.9 1025.9 1028.9 1078.7 6892.5 6954.7 6975.4 6977.2 6984.6 417.6 1190.8 1206.1 1213.4 1237.7 5185.8 5217.9 5226.8 5231.6 5233.1 8897.8 8978.8 9043.8 9105.9 9223.4 8964.3 9065.0 9076.3 9082.2 9099.0 6785.4 6950.9 6951.7 6987.0 6993.9 6536.2 6569.9 6578.0 6580.4 6590.8 7747.1 7793.5 8155.3 8197.5 8203.8 8195.1 8351.8 8363.1 8412.3 8419.6 6126.7 6349.7 6364.0 6382.0 6387.0 6483.3 6755.6 6767.8 6773.9 6774.8 6406.2 6604.7 6709.9 6714.3 6820.4 5591.8 6596.3 6643.3 6747.2 6768.0 6564.7 6595.0 6616.1 6623.3 6626.5 5943.8 5988.4 6010.7 6110.5 6191.8 6194.0 6226.3 6241.0 6247.9 6252.3 07:18:54 INFO - 2015-11-16 07:18:54,845 DEBUG : BROWSER_OUTPUT: 07:18:54 INFO - 2015-11-16 07:18:54,845 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5325.69 Median:6212.76 stddev:1689.47 (27.2%) stddev-sans-first:1651.43 07:18:54 INFO - 2015-11-16 07:18:54,845 DEBUG : BROWSER_OUTPUT: Values: 292.2 295.5 296.0 296.4 298.2 5941.9 5969.1 6070.5 6094.3 6109.7 5908.7 6031.8 6051.9 6061.1 6063.4 4515.7 4519.5 4520.7 4521.1 4521.7 4333.6 4392.4 4455.5 4535.2 4536.0 4469.5 4469.7 4482.7 4487.4 4503.6 4484.5 4488.2 4489.5 4501.7 4505.2 3822.7 3827.7 3828.0 3830.0 3830.5 5663.7 5752.6 5761.8 5767.0 5777.4 5122.6 5125.4 5131.4 5132.6 5142.0 6121.6 6350.5 6355.7 6358.4 6361.9 4113.9 4126.5 4183.1 4194.8 4200.3 6627.7 6734.2 6744.8 6745.8 6747.1 4218.8 4219.7 4225.8 4229.7 4230.8 4180.9 4268.9 4274.0 4278.7 4295.6 5101.1 5112.0 5113.0 5113.1 5114.6 6482.2 6484.5 6486.0 6493.2 6494.5 1512.6 1532.6 1535.7 1535.8 1537.7 979.8 981.7 985.7 1002.4 1007.9 6205.6 6239.8 6249.5 6252.3 6257.6 6659.3 6668.2 6669.0 6676.7 6686.1 6061.4 6219.9 6239.7 6240.2 6242.8 3598.0 3624.2 3625.8 3629.5 3630.1 6932.9 6943.4 6947.8 6949.1 6958.2 6701.5 6861.5 6869.3 6876.2 6876.7 6944.4 6944.8 6948.7 6949.0 6950.5 6428.6 6600.1 6600.7 6629.6 6664.3 6495.8 6577.9 6588.8 6593.1 6593.9 6971.5 6975.1 6976.2 6976.6 6979.5 4193.8 4270.6 4276.3 4276.9 4277.1 6684.1 6700.9 6707.2 6708.9 6719.2 6512.1 6531.6 6537.2 6537.7 6539.6 6351.6 6516.2 6520.7 6521.7 6554.4 6414.2 6424.7 6425.1 6428.1 6432.8 6560.5 6561.0 6572.2 6580.2 6583.8 6178.9 6368.1 6369.2 6370.4 6410.9 07:18:54 INFO - 2015-11-16 07:18:54,845 DEBUG : BROWSER_OUTPUT: 07:18:54 INFO - 2015-11-16 07:18:54,845 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13206.16 Median:25638.68 stddev:16093.01 (62.8%) stddev-sans-first:16110.81 07:18:54 INFO - 2015-11-16 07:18:54,845 DEBUG : BROWSER_OUTPUT: Values: 713.9 790.8 841.9 846.2 863.5 12428.9 12736.4 12761.4 12763.9 12765.7 12267.6 12452.3 13532.5 13704.8 13722.9 688.3 694.6 810.1 819.2 828.2 817.4 819.9 825.2 825.4 825.7 849.6 861.9 861.9 862.4 863.1 699.9 709.0 843.2 854.4 855.1 620.4 622.1 622.9 624.3 624.6 12095.1 12153.9 12183.5 12208.8 12209.3 9386.5 9525.7 9653.8 9689.1 10020.4 9272.6 9438.7 9491.4 9567.8 9759.9 3036.2 3097.8 3111.2 3134.8 3187.1 46179.0 46513.0 46617.3 46644.5 46719.3 6913.1 7044.1 7073.6 7160.1 7400.5 11440.9 11478.8 11482.4 11482.5 11482.5 6544.6 6596.3 6736.6 6744.9 6903.1 4053.9 4125.9 4145.1 4168.4 4184.0 2687.7 2715.0 2717.1 2719.8 2722.5 428.6 429.1 437.5 444.1 444.8 551.6 623.4 623.6 640.5 666.2 8017.8 8092.7 8290.8 8302.3 8334.7 549.4 630.8 638.9 661.6 671.1 3751.7 3753.2 3806.4 3842.4 3910.4 56770.0 60329.0 60351.4 60869.4 60945.4 48698.8 50171.0 50278.5 50689.5 50728.0 46233.5 46317.8 46453.8 46600.1 47086.5 8478.5 8575.4 8679.3 8681.0 8910.8 35867.3 35927.3 36376.5 36970.0 37089.4 41625.4 41698.8 43513.0 46185.8 46782.3 7598.8 7602.8 7637.6 7773.9 7845.9 11696.9 12208.9 12359.5 12607.1 13013.9 10919.1 10920.2 10932.9 11048.8 11408.3 10958.1 11112.9 11139.7 11222.9 11403.3 10768.7 11175.3 11707.3 11846.6 11960.2 9258.7 9306.9 9317.3 9383.5 9529.8 8821.9 9440.6 9466.7 9559.4 9585.4 07:18:54 INFO - 2015-11-16 07:18:54,845 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:18:54 INFO - 2015-11-16 07:18:54,845 DEBUG : BROWSER_OUTPUT: 07:18:55 INFO - 2015-11-16 07:18:55,521 INFO : Browser exited with error code: 0 07:18:55 INFO - 2015-11-16 07:18:55,545 INFO : Completed test dromaeo_css (00:18:33) 07:18:55 INFO - 2015-11-16 07:18:55,545 INFO : Starting test kraken 07:18:55 INFO - 2015-11-16 07:18:55,545 DEBUG : operating with platform_type : linux_ 07:18:55 INFO - 2015-11-16 07:18:55,545 INFO : Initialising browser for kraken test... 07:18:55 INFO - 2015-11-16 07:18:55,551 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBQJgJr/profile http://localhost:44636/getInfo.html 07:18:59 INFO - 2015-11-16 07:18:59,234 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:18:59 INFO - 2015-11-16 07:18:59,235 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:18:59 INFO - 2015-11-16 07:18:59,235 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:18:59 INFO - 2015-11-16 07:18:59,235 DEBUG : BROWSER_OUTPUT: __metrics 07:18:59 INFO - 2015-11-16 07:18:59,384 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:19:00 INFO - 2015-11-16 07:19:00,522 INFO : Browser initialized. 07:19:00 INFO - 2015-11-16 07:19:00,522 INFO : Running cycle 1/1 for kraken test... 07:19:00 INFO - 2015-11-16 07:19:00,522 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBQJgJr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:19:12 INFO - 2015-11-16 07:19:12,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 141611008 07:19:12 INFO - 2015-11-16 07:19:12,296 DEBUG : BROWSER_OUTPUT: 07:19:14 INFO - 2015-11-16 07:19:14,763 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44636/tests/kraken/driver.html?testName=audio-beat-detection) 07:19:15 INFO - 2015-11-16 07:19:15,344 DEBUG : BROWSER_OUTPUT: RSS: Main: 180002816 07:19:15 INFO - 2015-11-16 07:19:15,344 DEBUG : BROWSER_OUTPUT: 07:19:17 INFO - 2015-11-16 07:19:17,921 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44636/tests/kraken/driver.html?testName=audio-dft) 07:19:18 INFO - 2015-11-16 07:19:18,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 167501824 07:19:18 INFO - 2015-11-16 07:19:18,494 DEBUG : BROWSER_OUTPUT: 07:19:21 INFO - 2015-11-16 07:19:21,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44636/tests/kraken/driver.html?testName=audio-fft) 07:19:21 INFO - 2015-11-16 07:19:21,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 151834624 07:19:21 INFO - 2015-11-16 07:19:21,892 DEBUG : BROWSER_OUTPUT: 07:19:23 INFO - 2015-11-16 07:19:23,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44636/tests/kraken/driver.html?testName=audio-oscillator) 07:19:24 INFO - 2015-11-16 07:19:24,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 154492928 07:19:24 INFO - 2015-11-16 07:19:24,410 DEBUG : BROWSER_OUTPUT: 07:19:26 INFO - 2015-11-16 07:19:26,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44636/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:19:27 INFO - 2015-11-16 07:19:27,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 156676096 07:19:27 INFO - 2015-11-16 07:19:27,125 DEBUG : BROWSER_OUTPUT: 07:19:30 INFO - 2015-11-16 07:19:30,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44636/tests/kraken/driver.html?testName=imaging-darkroom) 07:19:30 INFO - 2015-11-16 07:19:30,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 155443200 07:19:30 INFO - 2015-11-16 07:19:30,756 DEBUG : BROWSER_OUTPUT: 07:19:34 INFO - 2015-11-16 07:19:34,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44636/tests/kraken/driver.html?testName=imaging-desaturate) 07:19:34 INFO - 2015-11-16 07:19:34,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 154415104 07:19:34 INFO - 2015-11-16 07:19:34,826 DEBUG : BROWSER_OUTPUT: 07:19:37 INFO - 2015-11-16 07:19:37,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44636/tests/kraken/driver.html?testName=json-parse-financial) 07:19:38 INFO - 2015-11-16 07:19:38,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 154402816 07:19:38 INFO - 2015-11-16 07:19:38,265 DEBUG : BROWSER_OUTPUT: 07:19:39 INFO - 2015-11-16 07:19:39,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44636/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:19:40 INFO - 2015-11-16 07:19:40,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 166785024 07:19:40 INFO - 2015-11-16 07:19:40,395 DEBUG : BROWSER_OUTPUT: 07:19:42 INFO - 2015-11-16 07:19:42,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44636/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:19:42 INFO - 2015-11-16 07:19:42,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 167546880 07:19:42 INFO - 2015-11-16 07:19:42,812 DEBUG : BROWSER_OUTPUT: 07:19:44 INFO - 2015-11-16 07:19:44,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44636/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:19:45 INFO - 2015-11-16 07:19:45,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 172064768 07:19:45 INFO - 2015-11-16 07:19:45,451 DEBUG : BROWSER_OUTPUT: 07:19:47 INFO - 2015-11-16 07:19:47,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:19:48 INFO - 2015-11-16 07:19:48,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 180068352 07:19:48 INFO - 2015-11-16 07:19:48,467 DEBUG : BROWSER_OUTPUT: 07:19:51 INFO - 2015-11-16 07:19:51,043 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:19:51 INFO - 2015-11-16 07:19:51,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 177467392 07:19:51 INFO - 2015-11-16 07:19:51,612 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44636/tests/kraken/driver.html?testName=ai-astar) 07:19:53 INFO - 2015-11-16 07:19:53,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 236118016 07:19:53 INFO - 2015-11-16 07:19:53,516 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,516 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:19:53 INFO - 2015-11-16 07:19:53,516 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:19:53 INFO - 2015-11-16 07:19:53,516 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:19:53 INFO - 2015-11-16 07:19:53,516 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:19:53 INFO - 2015-11-16 07:19:53,516 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;104;111;113;112;100;110;110;113 07:19:53 INFO - 2015-11-16 07:19:53,516 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;129;155;160;129;146;152;125;166;125 07:19:53 INFO - 2015-11-16 07:19:53,517 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;160;161;161;159;159;160;163;160;160 07:19:53 INFO - 2015-11-16 07:19:53,517 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;83;93;72;73;72;116;92;72 07:19:53 INFO - 2015-11-16 07:19:53,517 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;136;89;90;90;133;91;91;138 07:19:53 INFO - 2015-11-16 07:19:53,517 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;110;110;109;109;110 07:19:53 INFO - 2015-11-16 07:19:53,517 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;145;145;145;146;145;145;146 07:19:53 INFO - 2015-11-16 07:19:53,517 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;95;95;96;96;96;95 07:19:53 INFO - 2015-11-16 07:19:53,517 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;58;60;58;59;59;59;66;56;56 07:19:53 INFO - 2015-11-16 07:19:53,518 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;71;69;70;69;69;70;70;70 07:19:53 INFO - 2015-11-16 07:19:53,518 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;84;84;86;90;86;87;86;88;94 07:19:53 INFO - 2015-11-16 07:19:53,518 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;127;115;113;115;120;122;114;128;114 07:19:53 INFO - 2015-11-16 07:19:53,518 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;154;146;139;160;145;150;149;151;142 07:19:53 INFO - 2015-11-16 07:19:53,518 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;66;67;67;65;68;66;66;65;65 07:19:53 INFO - 2015-11-16 07:19:53,518 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:19:53 INFO - 2015-11-16 07:19:53,518 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:19:53 INFO - 2015-11-16 07:19:53,519 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,899 07:19:53 INFO - 2015-11-16 07:19:53,519 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:19:53 INFO - 2015-11-16 07:19:53,519 DEBUG : BROWSER_OUTPUT: __startTimestamp1447687193514__endTimestamp 07:19:53 INFO - 2015-11-16 07:19:53,519 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,522 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:19:53 INFO - 2015-11-16 07:19:53,522 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:19:53 INFO - 2015-11-16 07:19:53,522 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,522 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.50 Median:111.50 stddev:4.22 (3.8%) stddev-sans-first:4.48 07:19:53 INFO - 2015-11-16 07:19:53,523 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 104.0 111.0 113.0 112.0 100.0 110.0 110.0 113.0 07:19:53 INFO - 2015-11-16 07:19:53,523 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,523 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.40 Median:149.50 stddev:15.30 (10.2%) stddev-sans-first:16.17 07:19:53 INFO - 2015-11-16 07:19:53,523 DEBUG : BROWSER_OUTPUT: Values: 147.0 129.0 155.0 160.0 129.0 146.0 152.0 125.0 166.0 125.0 07:19:53 INFO - 2015-11-16 07:19:53,523 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,523 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:160.50 stddev:1.64 (1.0%) stddev-sans-first:1.22 07:19:53 INFO - 2015-11-16 07:19:53,523 DEBUG : BROWSER_OUTPUT: Values: 164.0 160.0 161.0 161.0 159.0 159.0 160.0 163.0 160.0 160.0 07:19:53 INFO - 2015-11-16 07:19:53,523 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,523 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.60 Median:72.50 stddev:14.83 (20.5%) stddev-sans-first:15.31 07:19:53 INFO - 2015-11-16 07:19:53,523 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 83.0 93.0 72.0 73.0 72.0 116.0 92.0 72.0 07:19:53 INFO - 2015-11-16 07:19:53,523 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,523 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.80 Median:90.00 stddev:22.03 (24.5%) stddev-sans-first:22.79 07:19:53 INFO - 2015-11-16 07:19:53,523 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 136.0 89.0 90.0 90.0 133.0 91.0 91.0 138.0 07:19:53 INFO - 2015-11-16 07:19:53,523 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,523 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:19:53 INFO - 2015-11-16 07:19:53,524 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 110.0 07:19:53 INFO - 2015-11-16 07:19:53,524 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,524 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:19:53 INFO - 2015-11-16 07:19:53,524 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 07:19:53 INFO - 2015-11-16 07:19:53,524 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,524 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:19:53 INFO - 2015-11-16 07:19:53,524 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 07:19:53 INFO - 2015-11-16 07:19:53,524 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,524 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:2.81 (4.8%) stddev-sans-first:2.96 07:19:53 INFO - 2015-11-16 07:19:53,524 DEBUG : BROWSER_OUTPUT: Values: 60.0 58.0 60.0 58.0 59.0 59.0 59.0 66.0 56.0 56.0 07:19:53 INFO - 2015-11-16 07:19:53,524 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,524 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 07:19:53 INFO - 2015-11-16 07:19:53,524 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 71.0 69.0 70.0 69.0 69.0 70.0 70.0 70.0 07:19:53 INFO - 2015-11-16 07:19:53,524 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,524 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:86.50 stddev:3.06 (3.5%) stddev-sans-first:3.15 07:19:53 INFO - 2015-11-16 07:19:53,524 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 84.0 86.0 90.0 86.0 87.0 86.0 88.0 94.0 07:19:53 INFO - 2015-11-16 07:19:53,525 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,525 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:117.50 stddev:5.69 (4.8%) stddev-sans-first:5.83 07:19:53 INFO - 2015-11-16 07:19:53,525 DEBUG : BROWSER_OUTPUT: Values: 114.0 127.0 115.0 113.0 115.0 120.0 122.0 114.0 128.0 114.0 07:19:53 INFO - 2015-11-16 07:19:53,525 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,525 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:149.50 stddev:6.55 (4.4%) stddev-sans-first:6.35 07:19:53 INFO - 2015-11-16 07:19:53,525 DEBUG : BROWSER_OUTPUT: Values: 140.0 154.0 146.0 139.0 160.0 145.0 150.0 149.0 151.0 142.0 07:19:53 INFO - 2015-11-16 07:19:53,525 DEBUG : BROWSER_OUTPUT: 07:19:53 INFO - 2015-11-16 07:19:53,525 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.35 (2.0%) stddev-sans-first:1.05 07:19:53 INFO - 2015-11-16 07:19:53,525 DEBUG : BROWSER_OUTPUT: Values: 69.0 66.0 67.0 67.0 65.0 68.0 66.0 66.0 65.0 65.0 07:19:53 INFO - 2015-11-16 07:19:53,525 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:19:53 INFO - 2015-11-16 07:19:53,525 DEBUG : BROWSER_OUTPUT: 07:19:54 INFO - 2015-11-16 07:19:54,393 INFO : Browser exited with error code: 0 07:19:54 INFO - 2015-11-16 07:19:54,447 INFO : Completed test kraken (00:00:58) 07:19:54 INFO - 2015-11-16 07:19:54,447 INFO : Starting test v8_7 07:19:54 INFO - 2015-11-16 07:19:54,447 DEBUG : operating with platform_type : linux_ 07:19:54 INFO - 2015-11-16 07:19:54,447 INFO : Initialising browser for v8_7 test... 07:19:54 INFO - 2015-11-16 07:19:54,453 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYcRTvS/profile http://localhost:44636/getInfo.html 07:19:58 INFO - 2015-11-16 07:19:58,137 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:19:58 INFO - 2015-11-16 07:19:58,138 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:19:58 INFO - 2015-11-16 07:19:58,138 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:19:58 INFO - 2015-11-16 07:19:58,138 DEBUG : BROWSER_OUTPUT: __metrics 07:19:58 INFO - 2015-11-16 07:19:58,287 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:19:59 INFO - 2015-11-16 07:19:59,424 INFO : Browser initialized. 07:19:59 INFO - 2015-11-16 07:19:59,424 INFO : Running cycle 1/1 for v8_7 test... 07:19:59 INFO - 2015-11-16 07:19:59,424 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYcRTvS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:20:11 INFO - 2015-11-16 07:20:11,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 141500416 07:20:11 INFO - 2015-11-16 07:20:11,139 DEBUG : BROWSER_OUTPUT: 07:20:32 INFO - 2015-11-16 07:20:32,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44636/tests/v8_7/run.html (next: http://localhost:44636/tests/v8_7/run.html) 07:20:32 INFO - 2015-11-16 07:20:32,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 597213184 07:20:32 INFO - 2015-11-16 07:20:32,875 DEBUG : BROWSER_OUTPUT: 07:20:32 INFO - 2015-11-16 07:20:32,875 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:20:32 INFO - 2015-11-16 07:20:32,877 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:20:32 INFO - 2015-11-16 07:20:32,877 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:20:32 INFO - 2015-11-16 07:20:32,877 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:20:32 INFO - 2015-11-16 07:20:32,877 DEBUG : BROWSER_OUTPUT: |0;Richards;163.18537859007833 07:20:32 INFO - 2015-11-16 07:20:32,877 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.9487975174554 07:20:32 INFO - 2015-11-16 07:20:32,877 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.4141069397042 07:20:32 INFO - 2015-11-16 07:20:32,877 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 07:20:32 INFO - 2015-11-16 07:20:32,878 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1096.4912280701753 07:20:32 INFO - 2015-11-16 07:20:32,878 DEBUG : BROWSER_OUTPUT: |5;Earley;808.4074373484236 07:20:32 INFO - 2015-11-16 07:20:32,878 DEBUG : BROWSER_OUTPUT: |6;Boyer;12637.5 07:20:32 INFO - 2015-11-16 07:20:32,878 DEBUG : BROWSER_OUTPUT: |7;RegExp;25820.51282051282 07:20:32 INFO - 2015-11-16 07:20:32,878 DEBUG : BROWSER_OUTPUT: |8;Splay;578.1609195402299 07:20:32 INFO - 2015-11-16 07:20:32,878 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 07:20:32 INFO - 2015-11-16 07:20:32,878 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:20:32 INFO - 2015-11-16 07:20:32,879 DEBUG : BROWSER_OUTPUT: __startTimestamp1447687232875__endTimestamp 07:20:32 INFO - 2015-11-16 07:20:32,879 DEBUG : BROWSER_OUTPUT: 07:20:32 INFO - 2015-11-16 07:20:32,879 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:20:32 INFO - 2015-11-16 07:20:32,879 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:20:32 INFO - 2015-11-16 07:20:32,879 DEBUG : BROWSER_OUTPUT: 07:20:32 INFO - 2015-11-16 07:20:32,879 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.19 Median:163.19 stddev:0.00 (0.0%) 07:20:32 INFO - 2015-11-16 07:20:32,879 DEBUG : BROWSER_OUTPUT: Values: 163.2 07:20:32 INFO - 2015-11-16 07:20:32,879 DEBUG : BROWSER_OUTPUT: 07:20:32 INFO - 2015-11-16 07:20:32,879 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.95 Median:193.95 stddev:0.00 (0.0%) 07:20:32 INFO - 2015-11-16 07:20:32,879 DEBUG : BROWSER_OUTPUT: Values: 193.9 07:20:32 INFO - 2015-11-16 07:20:32,879 DEBUG : BROWSER_OUTPUT: 07:20:32 INFO - 2015-11-16 07:20:32,881 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.41 Median:284.41 stddev:0.00 (0.0%) 07:20:32 INFO - 2015-11-16 07:20:32,881 DEBUG : BROWSER_OUTPUT: Values: 284.4 07:20:32 INFO - 2015-11-16 07:20:32,881 DEBUG : BROWSER_OUTPUT: 07:20:32 INFO - 2015-11-16 07:20:32,881 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 07:20:32 INFO - 2015-11-16 07:20:32,881 DEBUG : BROWSER_OUTPUT: Values: 5045.2 07:20:32 INFO - 2015-11-16 07:20:32,881 DEBUG : BROWSER_OUTPUT: 07:20:32 INFO - 2015-11-16 07:20:32,881 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1096.49 Median:1096.49 stddev:0.00 (0.0%) 07:20:32 INFO - 2015-11-16 07:20:32,881 DEBUG : BROWSER_OUTPUT: Values: 1096.5 07:20:32 INFO - 2015-11-16 07:20:32,881 DEBUG : BROWSER_OUTPUT: 07:20:32 INFO - 2015-11-16 07:20:32,881 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:808.41 Median:808.41 stddev:0.00 (0.0%) 07:20:32 INFO - 2015-11-16 07:20:32,881 DEBUG : BROWSER_OUTPUT: Values: 808.4 07:20:32 INFO - 2015-11-16 07:20:32,881 DEBUG : BROWSER_OUTPUT: 07:20:32 INFO - 2015-11-16 07:20:32,881 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12637.50 Median:12637.50 stddev:0.00 (0.0%) 07:20:32 INFO - 2015-11-16 07:20:32,881 DEBUG : BROWSER_OUTPUT: Values: 12637.5 07:20:32 INFO - 2015-11-16 07:20:32,882 DEBUG : BROWSER_OUTPUT: 07:20:32 INFO - 2015-11-16 07:20:32,882 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25820.51 Median:25820.51 stddev:0.00 (0.0%) 07:20:32 INFO - 2015-11-16 07:20:32,882 DEBUG : BROWSER_OUTPUT: Values: 25820.5 07:20:32 INFO - 2015-11-16 07:20:32,882 DEBUG : BROWSER_OUTPUT: 07:20:32 INFO - 2015-11-16 07:20:32,882 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:578.16 Median:578.16 stddev:0.00 (0.0%) 07:20:32 INFO - 2015-11-16 07:20:32,882 DEBUG : BROWSER_OUTPUT: Values: 578.2 07:20:32 INFO - 2015-11-16 07:20:32,882 DEBUG : BROWSER_OUTPUT: 07:20:32 INFO - 2015-11-16 07:20:32,882 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 07:20:32 INFO - 2015-11-16 07:20:32,882 DEBUG : BROWSER_OUTPUT: Values: 4830.9 07:20:32 INFO - 2015-11-16 07:20:32,882 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:20:32 INFO - 2015-11-16 07:20:32,882 DEBUG : BROWSER_OUTPUT: 07:20:33 INFO - 2015-11-16 07:20:33,741 INFO : Browser exited with error code: 0 07:20:33 INFO - 2015-11-16 07:20:33,758 INFO : Completed test v8_7 (00:00:39) 07:20:33 INFO - 2015-11-16 07:20:33,825 INFO : Completed test suite (00:20:11) 07:20:33 INFO - 2015-11-16 07:20:33,825 DEBUG : Working with test: dromaeo_css 07:20:33 INFO - 2015-11-16 07:20:33,825 DEBUG : Generating results file: dromaeo_css 07:20:33 INFO - 2015-11-16 07:20:33,827 DEBUG : Working with test: kraken 07:20:33 INFO - 2015-11-16 07:20:33,827 DEBUG : Generating results file: kraken 07:20:33 INFO - 2015-11-16 07:20:33,827 INFO : javascript benchmark 07:20:33 INFO - 2015-11-16 07:20:33,827 DEBUG : Working with test: v8_7 07:20:33 INFO - 2015-11-16 07:20:33,827 DEBUG : Generating results file: v8_7 07:20:33 INFO - 2015-11-16 07:20:33,828 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:20:34 INFO - 2015-11-16 07:20:34,015 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:20:34 INFO - 2015-11-16 07:20:34,015 DEBUG : process_Request line: dromaeo_css 6677.95 graph.html#tests=[[72,1,35]] 07:20:34 INFO - 2015-11-16 07:20:34,015 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:20:34 INFO - 2015-11-16 07:20:34,050 DEBUG : process_Request line: kraken 1497.30 graph.html#tests=[[232,1,35]] 07:20:34 INFO - 2015-11-16 07:20:34,050 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:20:34 INFO - 2015-11-16 07:20:34,085 DEBUG : process_Request line: v8_7 21037.84 graph.html#tests=[[230,1,35]] 07:20:34 INFO - 2015-11-16 07:20:34,086 INFO : javascript benchmark 07:20:34 INFO - 2015-11-16 07:20:34,090 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [344.46435792342913, 348.4738045551217, 348.63335723962064, 350.82458770614676, 353.2634457156828, 14324.140551566914, 14727.116373017627, 16596.91701541492, 16914.74627880581, 17671.823281767178, 13324.600261992131, 13345.0, 13377.0, 14842.851571484282, 15706.0, 5147.871303217431, 5387.138057910735, 5411.512963833255, 5420.051490989081, 5432.728363581825, 3815.179736356683, 3901.0, 5397.568194544447, 5805.709714514279, 5960.284765828107, 5993.160957465936, 6014.578979471439, 6016.96991515044, 6019.247594050744, 6042.184305118797, 5815.185873977625, 5938.257717785277, 5943.524518038546, 5950.523958083343, 5955.255593050869, 5104.157813960692, 5187.221916712486, 5199.14214154664, 5204.583633309327, 5205.349331333583, 20987.055582498826, 21044.894775526023, 21060.0, 21768.782312176834, 21915.780842191532, 2021.373374253986, 2077.5325551750884, 2138.754043285011, 2143.164165975271, 2215.4239897626735, 13014.609561713163, 13071.411786469536, 13114.934425327907, 13148.934255328757, 13818.37817298224, 1778.1464896849584, 1823.8449731772814, 1868.981405134205, 1874.3439796071402, 1877.8309952104375, 59960.10059849106, 60365.0, 61417.6929115356, 62757.686211569104, 63333.366666333204, 9260.49067301305, 9513.66702165421, 9702.417854928726, 9714.077162669535, 9744.95127524372, 12545.937270313772, 12567.93716031414, 12568.685782855502, 12580.559680411141, 12583.559575414816, 5345.518903298644, 5492.972535137379, 5505.697186654692, 5576.498115169654, 7222.602756848319, 5544.500994910478, 5587.832365028974, 5597.972010139923, 5614.522765564891, 5742.54059675225, 3097.2566584020124, 3144.905652830373, 3161.668024857357, 3173.2066983254185, 3193.536937144101, 1106.7897099551221, 1140.2645293785463, 1149.6321177223376, 1155.8786327435666, 1160.14729174057, 446.76768080597907, 448.15075432056074, 450.2121287746444, 466.37039996005797, 471.3942583779895, 10097.0, 11413.0, 11479.598214062635, 11607.651770446731, 11839.940800296115, 463.85388602590075, 470.68934503227706, 476.26417185448565, 480.4042986696471, 480.4498848818084, 6255.374462553708, 6323.841903952438, 6366.904496432558, 6430.421262086341, 6451.516136289797, 473781.0, 476874.0, 477409.0, 514188.0, 547267.9549033839, 69015.0, 71580.28419715737, 75357.62321188468, 75462.0, 76004.61997689976, 528.5269683633127, 534.9759260833272, 536.4796147736689, 538.68217751526, 539.3042974562849, 10213.182945364502, 10377.273590848568, 10611.257211995086, 10827.837582436427, 10942.835857462303, 33434.49848252327, 34315.31369372549, 35893.0, 36052.45921311235, 37025.629743702215, 46890.0, 48365.0, 48747.268790968876, 48809.75595122002, 49467.50532494629, 6544.607323560602, 6630.138082049302, 6688.398044176048, 6769.3907548320885, 6843.418309443753, 11502.482388292714, 11765.941170294094, 11869.109816763605, 11887.821682674594, 11918.463669134737, 10209.846852297072, 10615.0, 10703.839442408525, 11083.501242443948, 11084.667459976214, 10088.596456141966, 10374.118199953089, 10429.0, 10480.68557943263, 10721.41032243203, 9051.728448146567, 9055.094490550891, 10237.48812559384, 10387.480625968823, 10439.37363758177, 6590.637514936724, 6686.899696504459, 6757.594544327356, 6823.044773731781, 6836.077129587442, 10586.947065264625, 10613.9469302653, 10786.838197426889, 10820.242583019113, 10872.945635271773], "dojo.html": [3206.390785750707, 3206.8936217005125, 3286.622038465577, 3296.324253528027, 3305.4711246200613, 5248.5538729208065, 5323.307969963904, 5367.436419175989, 5468.6171967962255, 5481.862953426166, 5421.83734487965, 5450.991566560189, 5458.836234912959, 5485.670859748418, 5513.531349835269, 5034.622403319757, 5061.468545802693, 5080.7967681292885, 5082.923756143661, 5107.540321371076, 4850.248211527219, 5140.742962851861, 5167.664101833388, 5208.140656791625, 5235.6596821206695, 4951.480094590071, 5007.824726134568, 5008.499150084981, 5038.143515602356, 5039.798408063673, 5033.119204139261, 5084.110280700863, 5093.821716239951, 5108.080545501808, 5148.279240906276, 4841.757912104381, 4924.482929292444, 5049.0, 5077.898442031139, 5087.211482220262, 5191.480851914778, 5242.6330156889035, 5247.449017853147, 5249.370075590953, 5260.0, 5975.581709280352, 5979.342272350038, 5982.4316689914385, 5983.222181116427, 6003.129546215818, 5768.250127483442, 5833.7374818133285, 5893.970530147321, 6009.699515024231, 6010.819675409744, 5551.306086739158, 5553.278073850373, 5557.5831812614215, 5573.164025396182, 5677.659340439587, 6032.245969253843, 6042.4561789438285, 6046.667433291212, 6053.0, 6057.545684073712, 5627.634203776742, 5782.10377391505, 5848.619839710405, 5864.9413505864395, 5963.837051774863, 5995.970020149872, 6003.189569408161, 6013.639181649115, 6022.1870047543025, 6028.638281703112, 5961.344252132262, 5961.5230781537375, 5968.522518198533, 5972.044472884318, 5972.611780234271, 5633.521150702236, 5745.052066409079, 5787.681677507778, 5878.147668588031, 5922.8815423691285, 4529.343245229489, 4546.431696037996, 4548.090381923628, 4551.40831691878, 4578.816847326137, 3929.9978505480917, 4046.2918989177365, 4046.352583586612, 4066.6543343815515, 4089.7750623715983, 5412.7564259607625, 5412.891742165135, 5467.0, 5489.0, 5533.972330138324, 5878.265216847894, 5884.646921184657, 5887.735051922674, 5890.969080410911, 5894.145348924382, 5178.275041494194, 5341.198820177005, 5509.614326997152, 5510.338759348904, 5521.861953451196, 5028.220625803006, 5069.366329208849, 5104.69371837691, 5112.693238405707, 5134.512221338967, 6089.969550152221, 6094.177286066413, 6095.238095238095, 6096.542759293071, 6105.0, 5687.573431992534, 5734.082546792493, 5829.417058294137, 5896.380880007538, 5903.822885313448, 6115.908261375994, 6127.1261596101485, 6159.753609855556, 6161.199044124235, 6168.321484636596, 5867.295924489089, 5867.970660146672, 5871.178035075008, 5878.0, 5896.941030589639, 5584.888302234014, 5711.428857114255, 5833.562482813891, 5935.940640593712, 5948.672822994604, 5745.138229265476, 5778.36437991829, 5812.21535092757, 5825.825225243249, 5852.4440178184705, 5780.566457515619, 5809.709514524172, 5818.2436283282905, 5826.388229235869, 5829.883402331845, 5499.175123731472, 5641.464060914206, 5684.7157642118555, 5790.826275211751, 5832.037713777349, 5813.593048486566, 5834.27071616048, 5841.474267315962, 5843.035899076604, 5846.064629659234, 5341.332333458317, 5725.484706376279, 5725.942740572707, 5732.828015159552, 5753.3958934311295], "mootools.html": [1381.0608786025498, 1707.5731067233191, 1745.5461579989208, 1776.7867855857296, 1779.5817982774047, 6335.08141319509, 6821.8294542636395, 6982.860342793141, 7003.439724822015, 7019.68411421486, 7197.496175267734, 7296.270372962701, 7299.2335804740405, 7311.817204569888, 7329.0, 1911.5985643014915, 1946.6593346164436, 2163.0, 2182.487115527854, 2210.3921421609025, 2239.854409463388, 2244.921427750029, 2246.809021233197, 2248.123231939545, 2253.6844841722173, 2087.812096911278, 2126.8085872271495, 2131.477787941956, 2135.380739585526, 2136.7649558548546, 1906.085079162003, 1939.5829896572234, 2105.757837848652, 2142.9785702142935, 2144.5603651251454, 2163.383435720812, 2175.38001669525, 2193.0679461228915, 2212.7123473948445, 2214.1918199857096, 7292.453066020017, 7346.59593722345, 7373.483856130073, 7401.3338799507765, 7413.74051908186, 4477.462704475483, 4572.497025327211, 4574.4510658721165, 4575.176468235716, 4578.10726908253, 2854.4576530459144, 2859.656841179051, 2877.6402949631297, 2895.623568936046, 2970.8663110160096, 918.7289749523907, 930.1349744737391, 970.1268858027761, 970.8446648536271, 995.9103680668775, 9761.121499065048, 9785.902140978642, 9807.460589667495, 9814.263930205192, 9843.655472058443, 3903.843846246175, 3904.06302487401, 3972.920541589152, 4093.2222877653153, 4097.713160078766, 8591.871121933176, 8598.828023439497, 8616.612252448655, 8616.870746938801, 8617.224449799549, 4555.316702494652, 4570.177368073712, 4577.404937358122, 4590.42619672541, 4590.839320623762, 4172.436721042681, 4174.499060112806, 4177.206330797138, 4177.415161877339, 4184.205001049791, 3544.9822750886083, 3583.498310236569, 3584.534010578608, 3591.3894637911094, 3617.4212126059706, 1114.8717897441736, 1115.0187834705569, 1125.9155563332783, 1127.932324060559, 1155.7399585093456, 1015.355249416611, 1022.8670272864629, 1025.9487025648689, 1028.922830787679, 1078.7141407527013, 6892.483063770237, 6954.721811127498, 6975.372216500437, 6977.197622273504, 6984.615846128511, 417.6241382755484, 1190.7737529869298, 1206.1436380170003, 1213.435752375132, 1237.7215126596443, 5185.818496352609, 5217.895642087137, 5226.790928362899, 5231.607629427808, 5233.058049551118, 8897.822043559223, 8978.775530611656, 9043.819123617492, 9105.863412048824, 9223.400478968846, 8964.282857371394, 9064.954675226581, 9076.31927605419, 9082.22801061904, 9099.0, 6785.42323902464, 6950.930490695028, 6951.65241737911, 6987.0, 6993.89509157363, 6536.202544300165, 6569.901451478136, 6578.04618330349, 6580.374864387875, 6590.8352291193105, 7747.147813740597, 7793.454458187873, 8155.306798922158, 8197.549134797644, 8203.794905127419, 8195.098539160568, 8351.832963340821, 8363.080061193386, 8412.327013839, 8419.62111704987, 6126.724297406538, 6349.714262858275, 6364.0, 6382.042693595998, 6387.041943708481, 6483.319251478715, 6755.560888542229, 6767.796966091025, 6773.898391524032, 6774.830629234111, 6406.240648005772, 6604.669766511559, 6709.865802684017, 6714.328567143247, 6820.3861652451515, 5591.832245032656, 6596.30738772422, 6643.335666433318, 6747.156605424322, 6767.966160169364, 6564.704588293443, 6595.043718660863, 6616.073749674953, 6623.271440141677, 6626.503012274003, 5943.762249509971, 5988.431099045583, 6010.669413182317, 6110.480609148272, 6191.783287584913, 6193.969030154821, 6226.283977342664, 6241.0, 6247.937520624736, 6252.280987686474], "ext.html": [548.0880876940942, 593.6764463367464, 594.491709588302, 608.9573729838913, 612.0574315554047, 31901.36197276056, 39793.0, 40421.19157616846, 40736.79631601845, 40790.79604601973, 43086.56913430865, 43476.56523434765, 43576.0, 43617.12765744691, 43667.56332436683, 7685.193054729257, 7779.066512018566, 8687.869681954775, 8864.423812452202, 10171.288009839314, 10312.278140530167, 10452.843207351858, 10467.581296748122, 10472.738181545485, 10478.842817357745, 10462.372257664527, 10530.631427900025, 10580.735481612983, 10587.100096491808, 10604.15166786659, 7805.492642978216, 7978.9202107979045, 10559.788804223872, 10808.729781755519, 10814.945925270324, 10235.590576376935, 10341.327813692162, 10348.172146228359, 10351.63769268072, 10359.378437293786, 40109.598904010876, 40497.392539111934, 40575.0, 40599.39100913489, 40620.0, 3089.1504836170234, 3254.300325430044, 3375.4093033719, 3510.9648903510893, 3594.1076938389674, 29972.400551988838, 30066.84966575153, 30072.248193795112, 30330.393392132035, 30615.2346191347, 3398.898033059012, 3459.913502162441, 3476.9826150869335, 3546.8226588670464, 3577.0342007657787, 296314.0, 296879.0, 297235.0, 300712.9999999978, 300737.0, 56121.79086568524, 57241.0, 59152.0, 59378.0, 59496.70251648714, 67804.0, 68672.65663671649, 68911.0, 68931.65534172297, 68951.0, 15488.690226195638, 15559.922200388926, 15667.138307392976, 15770.211489425483, 15782.68434631301, 11578.94210528942, 11718.589849355232, 11737.295762254293, 11737.589184378507, 11741.060715142768, 19280.4215873524, 19461.693598585818, 19503.588636318393, 19540.70688939667, 19560.0, 7707.0, 7861.283230062031, 7876.0, 7904.841903161904, 7953.960230198812, 871.9128087191357, 920.3787443475627, 960.841461158915, 1032.1112265597912, 1038.6520515627199, 27634.723652763616, 27884.721152788214, 28150.155495334762, 28540.0, 29396.559051614244, 966.1739212972948, 972.4700038479045, 1015.0864222200079, 1045.8065257927308, 1056.144522936424, 14101.647458813406, 14522.709545809024, 14611.78082328766, 14725.705485890223, 15401.691966160613, 318070.0, 323114.0, 324736.0, 324976.0, 325566.0, 53716.73141634345, 53804.0, 53978.19032714512, 53980.46019539833, 54138.0, 1270.30133426615, 1282.7562763074986, 1297.1244410023196, 1349.1298112717243, 1376.6695992961618, 25915.22254332373, 26961.325966850985, 28261.15216543507, 28278.0, 28830.855845720638, 43218.56781432145, 43559.56440435555, 43658.0, 43757.78121109501, 43774.34338484862, 291009.0, 298137.0, 298851.0, 387878.0, 390427.0, 30538.694613053583, 30746.077617671504, 30750.53874191844, 30827.229319267197, 30861.69138308678, 41136.0, 41922.0, 41975.370369443874, 42689.0, 42781.35827962645, 34888.651113489555, 35772.28455430929, 35930.82034589915, 35953.0, 36783.44824827576, 33193.0, 33571.35010436163, 34137.31725365429, 34328.313433730684, 35118.29763404666, 34919.82540087283, 35835.82082089573, 35910.8204458976, 35945.820270898475, 36217.45673814948, 30114.397712046073, 32629.18427039343, 33310.83344583261, 33423.33153336871, 33445.83277083599, 24808.25575232746, 25157.24528264155, 25206.369840754127, 25277.87361063183, 25391.0], "prototype.html": [292.1877181435609, 295.5330577687254, 295.995560066599, 296.3953534789028, 298.2097441779285, 5941.910871336933, 5969.134475501055, 6070.484008859241, 6094.299155597102, 6109.6945152742355, 5908.704564771755, 6031.788887388942, 6051.909221361683, 6061.090836374546, 6063.393660633935, 4515.6613254005915, 4519.52544982777, 4520.706154099989, 4521.073179998109, 4521.660875434339, 4333.60997510224, 4392.38506609075, 4455.487618923833, 4535.229011068126, 4535.977320113395, 4469.486009108945, 4469.664775141861, 4482.731036137826, 4487.371767952489, 4503.594676479116, 4484.5291244419195, 4488.1696886076015, 4489.528599497071, 4501.684882058257, 4505.211587972124, 3822.694184465236, 3827.7320587558884, 3828.0429892526868, 3830.042489377656, 3830.4637350770913, 5663.66018038919, 5752.597318187729, 5761.769529218826, 5766.961946849566, 5777.393373695785, 5122.641415100945, 5125.436202017775, 5131.4098878629065, 5132.563732082777, 5142.0, 6121.571489995702, 6350.491960643184, 6355.682215889234, 6358.364163583651, 6361.854866124142, 4113.876583702494, 4126.484189476316, 4183.1215444756635, 4194.8112334945, 4200.348945913388, 6627.668616569201, 6734.191896972346, 6744.8313792155095, 6745.763898263537, 6747.05541224229, 4218.767967761742, 4219.683523735671, 4225.788710564521, 4229.703920725519, 4230.788460576959, 4180.916381672349, 4268.87193384199, 4274.0, 4278.743275403485, 4295.634871035997, 5101.132807422747, 5111.974440127776, 5112.9744351278005, 5113.1052065888325, 5114.5652619527755, 6482.222133344029, 6484.481241500669, 6486.027095935648, 6493.22081350241, 6494.545381823322, 1512.568917858405, 1532.6245069957931, 1535.7005383950245, 1535.8464153584553, 1537.7308970930042, 979.7893452907659, 981.7349315684725, 985.7387792235063, 1002.3534820041033, 1007.8840933292619, 6205.572718274731, 6239.78160764371, 6249.500039996789, 6252.3122456529745, 6257.624542527463, 6659.334066593399, 6668.199816022108, 6669.0, 6676.699548520328, 6686.13080299558, 6061.393860613904, 6219.937800622027, 6239.656818875005, 6240.219972503437, 6242.812715618538, 3598.0, 3624.2389098289655, 3625.7672391387055, 3629.4737263096704, 3630.128769095451, 6932.930670693228, 6943.409810166192, 6947.826304342432, 6949.131358580177, 6958.199807022156, 6701.463882889358, 6861.4853885958755, 6869.278725733726, 6876.243613202544, 6876.724931002704, 6944.375006249462, 6944.826379340557, 6948.722051117999, 6949.027136200936, 6950.513464057569, 6428.646424446701, 6600.1089852869245, 6600.735970561123, 6629.602223866584, 6664.300248473841, 6495.837604059747, 6577.934220657732, 6588.8352791180605, 6593.142891424084, 6593.934060659524, 6971.5468494547695, 6975.128108986377, 6976.19773726028, 6976.5814051157095, 6979.4765392594745, 4193.811278492536, 4270.636995855387, 4276.273033584361, 4276.850310239127, 4277.123189746157, 6684.06423100776, 6700.865982680221, 6707.195136583641, 6708.865822683421, 6719.227288861648, 6512.088307637029, 6531.608103513804, 6537.215534135934, 6537.7058032389605, 6539.607623542603, 6351.618902865843, 6516.218053833571, 6520.7391704333195, 6521.7065232065615, 6554.410103090554, 6414.198225221848, 6424.743010279536, 6425.10048593188, 6428.067930150196, 6432.839179020562, 6560.475161986934, 6560.967195163994, 6572.244191917799, 6580.177477815273, 6583.80248592543, 6178.938210617836, 6368.076628888878, 6369.235691717024, 6370.394812492806, 6410.903836442364], "yui.html": [713.9036230108934, 790.8414173236209, 841.873718942159, 846.1515516092784, 863.4862256957108, 12428.875711242885, 12736.363181840894, 12761.425735841885, 12763.872361276384, 12765.744685106303, 12267.63197104086, 12452.315122668273, 13532.458701651922, 13704.794428083587, 13722.931385343085, 688.3460712323288, 694.6492021529147, 810.1452967119701, 819.2053707903324, 828.2131974624101, 817.4196320612342, 819.9467034642729, 825.2160447574798, 825.4263287015526, 825.6614787936948, 849.6091797773032, 861.8965724113115, 861.9353548483857, 862.4135587800293, 863.0808189278398, 699.8635266123108, 708.9610071446068, 843.2284459719319, 854.4275335525213, 855.0850589868843, 620.4416025576971, 622.0637939900466, 622.947049500793, 624.316373570939, 624.6158612453354, 12095.092868034933, 12153.93923030388, 12183.51265949361, 12208.816867746991, 12209.267443953391, 9386.530673466368, 9525.666601668909, 9653.806923861483, 9689.079537443931, 10020.398776073458, 9272.629094836198, 9438.669646562337, 9491.38306010107, 9567.808643827084, 9759.853602195974, 3036.2105852478294, 3097.845107744604, 3111.23774675206, 3134.7805653604255, 3187.0757480330676, 46179.0, 46513.0, 46617.30074048892, 46644.53355466436, 46719.29921051187, 6913.1358580177475, 7044.084269045094, 7073.646317684095, 7160.051725852958, 7400.481966262418, 11440.94279528597, 11478.770424591461, 11482.368469734245, 11482.483288251882, 11482.540698372139, 6544.574602650812, 6596.30738772422, 6736.562123461959, 6744.865102697919, 6903.1371078615175, 4053.8783836484954, 4125.8968525786495, 4145.0880806222585, 4168.353905144708, 4183.979080104641, 2687.7177896320995, 2715.0361621624434, 2717.144099608617, 2719.830472896634, 2722.48272828162, 428.55644408037534, 429.13743375814215, 437.49250868992453, 444.13393881930364, 444.7931711753985, 551.6000899348021, 623.4085956927289, 623.5666211982629, 640.4876099120685, 666.167290886392, 8017.839643207103, 8092.71675491355, 8290.792730181673, 8302.335372346965, 8334.749957501284, 549.3662491153199, 630.8012975912573, 638.8626445314187, 661.5600625584029, 671.1074271219267, 3751.6998640108727, 3753.249350129985, 3806.4480650306105, 3842.423636454498, 3910.354791459434, 56770.0, 60329.0, 60351.39648603545, 60869.39130608726, 60945.39054609486, 48698.75650621724, 50171.0, 50278.49721502811, 50689.493105068475, 50728.0, 46233.53766462292, 46317.768411157725, 46453.767731161126, 46600.06799863984, 47086.5291347089, 8478.533680647377, 8575.3997220194, 8679.34904882149, 8681.0, 8910.821783564423, 35867.28265434624, 35927.28145437129, 36376.45435318419, 36970.0, 37089.44365834461, 41625.37561936513, 41698.791506042275, 43513.0, 46185.76907115577, 46782.298265526726, 7598.8100297493, 7602.771916842504, 7637.579933103732, 7773.883391749016, 7845.882311765214, 11696.888795564408, 12208.877911220774, 12359.50561977511, 12607.054470914902, 13013.869861301644, 10919.126469882549, 10920.18098642589, 10932.890671093506, 11048.779024419628, 11408.315501069963, 10958.126754673925, 11112.944435277772, 11139.665810025388, 11222.943885280847, 11403.315801051964, 10768.730781730206, 11175.329480231212, 11707.2975621463, 11846.644600661994, 11960.222585531912, 9258.703781470735, 9306.860397093913, 9317.322881881326, 9383.530823458936, 9529.809403812023, 8821.867671985054, 9440.575174117319, 9466.668666596635, 9559.378640388353, 9585.376950498196]}, "summary": {"lowerIsBetter": false, "suite": 6677.95264702391, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7319.319888320839, "unit": "ms", "value": 7319.319888320839}, "dojo.html": {"lowerIsBetter": false, "filtered": 5435.749547551769, "unit": "ms", "value": 5435.749547551769}, "mootools.html": {"lowerIsBetter": false, "filtered": 4246.445909391134, "unit": "ms", "value": 4246.445909391134}, "ext.html": {"lowerIsBetter": false, "filtered": 18830.70317396368, "unit": "ms", "value": 18830.70317396368}, "prototype.html": {"lowerIsBetter": false, "filtered": 4754.7459257474675, "unit": "ms", "value": 4754.7459257474675}, "yui.html": {"lowerIsBetter": false, "filtered": 5862.33486386093, "unit": "ms", "value": 5862.33486386093}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-057"}, "testrun": {"date": 1447686022, "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": "20151116043001", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}, {"talos_counters": {}, "results": {"audio-dft": [164.0, 160.0, 161.0, 161.0, 159.0, 159.0, 160.0, 163.0, 160.0, 160.0], "ai-astar": [110.0, 112.0, 104.0, 111.0, 113.0, 112.0, 100.0, 110.0, 110.0, 113.0], "imaging-gaussian-blur": [109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0], "audio-beat-detection": [147.0, 129.0, 155.0, 160.0, 129.0, 146.0, 152.0, 125.0, 166.0, 125.0], "json-stringify-tinderbox": [69.0, 69.0, 71.0, 69.0, 70.0, 69.0, 69.0, 70.0, 70.0, 70.0], "stanford-crypto-pbkdf2": [140.0, 154.0, 146.0, 139.0, 160.0, 145.0, 150.0, 149.0, 151.0, 142.0], "json-parse-financial": [60.0, 58.0, 60.0, 58.0, 59.0, 59.0, 59.0, 66.0, 56.0, 56.0], "stanford-crypto-sha256-iterative": [69.0, 66.0, 67.0, 67.0, 65.0, 68.0, 66.0, 66.0, 65.0, 65.0], "audio-fft": [72.0, 71.0, 83.0, 93.0, 72.0, 73.0, 72.0, 116.0, 92.0, 72.0], "imaging-darkroom": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0], "stanford-crypto-ccm": [114.0, 127.0, 115.0, 113.0, 115.0, 120.0, 122.0, 114.0, 128.0, 114.0], "audio-oscillator": [90.0, 90.0, 136.0, 89.0, 90.0, 90.0, 133.0, 91.0, 91.0, 138.0], "stanford-crypto-aes": [85.0, 84.0, 84.0, 86.0, 90.0, 86.0, 87.0, 86.0, 88.0, 94.0], "imaging-desaturate": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1497.3000000000002, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 81.6, "unit": "ms", "value": 81.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.6, "unit": "ms", "value": 147.6}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 143.4, "unit": "ms", "value": 143.4}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 118.2, "unit": "ms", "value": 118.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.3, "unit": "ms", "value": 145.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 59.1, "unit": "ms", "value": 59.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.8, "unit": "ms", "value": 103.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.5, "unit": "ms", "value": 109.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.7, "unit": "ms", "value": 160.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.4, "unit": "ms", "value": 66.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.6, "unit": "ms", "value": 69.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.4, "unit": "ms", "value": 109.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 87.0, "unit": "ms", "value": 87.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.7, "unit": "ms", "value": 95.7}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-057"}, "testrun": {"date": 1447686022, "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": "20151116043001", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.9487975174554], "Encrypt": [284.4141069397042], "NavierStokes": [4830.917874396136], "Decrypt": [5045.226130653266], "Splay": [578.1609195402299], "Richards": [163.18537859007833], "RegExp": [25820.51282051282], "Earley": [808.4074373484236], "Boyer": [12637.5], "RayTrace": [1096.4912280701753]}, "summary": {"lowerIsBetter": false, "suite": 21037.840939332447, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.90440800000005, "unit": "score", "value": 340.90440800000005}, "Encrypt": {"lowerIsBetter": false, "filtered": 935.8923959999998, "unit": "score", "value": 935.8923959999998}, "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": 140.948648111332, "unit": "score", "value": 140.948648111332}, "RegExp": {"lowerIsBetter": false, "filtered": 35.28144488579943, "unit": "score", "value": 35.28144488579943}, "Richards": {"lowerIsBetter": false, "filtered": 216.33065600000006, "unit": "score", "value": 216.33065600000006}, "Earley": {"lowerIsBetter": false, "filtered": 824.4147309999997, "unit": "score", "value": 824.4147309999997}, "Boyer": {"lowerIsBetter": false, "filtered": 52.73693372898122, "unit": "score", "value": 52.73693372898122}, "RayTrace": {"lowerIsBetter": false, "filtered": 674.869968, "unit": "score", "value": 674.869968}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-057"}, "testrun": {"date": 1447686022, "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": "20151116043001", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}] 07:20:34 INFO - RETURN: dromaeo_css: 6677.95 07:20:34 INFO - RETURN: kraken: 1497.30 07:20:34 INFO - RETURN: v8_7: 21037.84 07:20:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "21037.84"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1497.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6677.95"}}} 07:20:34 INFO - Return code: 0 07:20:34 INFO - # TBPL SUCCESS # 07:20:34 INFO - Running post-action listener: _resource_record_post_action 07:20:34 INFO - Running post-run listener: _resource_record_post_run 07:20:35 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 503496704; Read time: 12; Write time: 452892 07:20:35 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 218914816; Read time: 0; Write time: 267504 07:20:35 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282505216; Read time: 12; Write time: 185256 07:20:35 INFO - Running post-run listener: _upload_blobber_files 07:20:35 INFO - Blob upload gear active. 07:20:35 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:20:35 INFO - Copying logs to upload dir... 07:20:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.950504 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-16 07:20:34.993149) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 07:20:34.996370) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009976 build_url: 'https://queue.taskcluster.net/v1/task/LtB12eTmT7-XxGGQBdpdQw/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-16 07:20:35.048149) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:20:35.048489) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1447685971.844488-1433166026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:20:35.102631) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 07:20:35.102958) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 07:20:35.103328) ========= ========= Total master_lag: 0.22 =========