builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1447508664.64 results: success (0) buildid: 20151114030404 builduid: 568447c2ffd94f3882ec6291393c705d revision: 202b199b9fcf37a687bef882f2513e191f079622 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:24.637932) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:24.638430) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:24.638726) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009081 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:24.700842) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:24.701246) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:24.806761) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:24.807296) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:24.860900) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:24.861258) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:24.861612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:24.861915) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-14 05:44:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-11-14 05:44:25 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190060 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:25.066448) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:25.066727) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017150 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:25.120815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:25.121265) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 202b199b9fcf37a687bef882f2513e191f079622 --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 202b199b9fcf37a687bef882f2513e191f079622 --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=b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-14 05:44:25,460 truncating revision to first 12 chars 2015-11-14 05:44:25,460 Setting DEBUG logging. 2015-11-14 05:44:25,460 attempt 1/10 2015-11-14 05:44:25,460 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/202b199b9fcf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-14 05:44:25,701 unpacking tar archive at: mozilla-central-202b199b9fcf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528221 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:25.669066) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:25.669329) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:25.740760) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:25.741107) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 05:44:25.741526) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 39 secs) (at 2015-11-14 05:44:25.741802) ========= /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=b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:44:26 INFO - MultiFileLogger online at 20151114 05:44:26 in /builds/slave/test-pgo 05:44:26 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 05:44:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:44:26 INFO - {'append_to_log': False, 05:44:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:44:26 INFO - 'blob_upload_branch': 'Firefox', 05:44:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:44:26 INFO - 'branch': 'Firefox', 05:44:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:44:26 INFO - 'config_files': ('talos/linux_config.py',), 05:44:26 INFO - 'default_actions': ('clobber', 05:44:26 INFO - 'read-buildbot-config', 05:44:26 INFO - 'download-and-extract', 05:44:26 INFO - 'populate-webroot', 05:44:26 INFO - 'create-virtualenv', 05:44:26 INFO - 'install', 05:44:26 INFO - 'run-tests'), 05:44:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:44:26 INFO - 'download_minidump_stackwalk': True, 05:44:26 INFO - 'download_symbols': 'ondemand', 05:44:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:44:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:44:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:44:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:44:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:44:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:44:26 INFO - 'installer_path': 'installer.exe', 05:44:26 INFO - 'log_level': 'info', 05:44:26 INFO - 'log_name': 'talos', 05:44:26 INFO - 'log_to_console': True, 05:44:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:44:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:44:26 INFO - 'opt_config_files': (), 05:44:26 INFO - 'pip_index': False, 05:44:26 INFO - 'sps_profile': False, 05:44:26 INFO - 'sps_profile_interval': 0, 05:44:26 INFO - 'suite': 'dromaeojs', 05:44:26 INFO - 'system_bits': '64', 05:44:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:44:26 INFO - 'title': 'talos-linux64-ix-001', 05:44:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:44:26 INFO - 'use_talos_json': True, 05:44:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:44:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:44:26 INFO - 'work_dir': 'build'} 05:44:26 INFO - ##### 05:44:26 INFO - ##### Running clobber step. 05:44:26 INFO - ##### 05:44:26 INFO - Running pre-action listener: _resource_record_pre_action 05:44:26 INFO - Running main action method: clobber 05:44:26 INFO - rmtree: /builds/slave/test-pgo/build 05:44:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:44:26 INFO - Running post-action listener: _resource_record_post_action 05:44:26 INFO - ##### 05:44:26 INFO - ##### Running read-buildbot-config step. 05:44:26 INFO - ##### 05:44:26 INFO - Running pre-action listener: _resource_record_pre_action 05:44:26 INFO - Running main action method: read_buildbot_config 05:44:26 INFO - Using buildbot properties: 05:44:26 INFO - { 05:44:26 INFO - "properties": { 05:44:26 INFO - "buildnumber": 551, 05:44:26 INFO - "product": "firefox", 05:44:26 INFO - "script_repo_revision": "production", 05:44:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:44:26 INFO - "repository": "", 05:44:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:44:26 INFO - "buildid": "20151114030404", 05:44:26 INFO - "slavename": "talos-linux64-ix-001", 05:44:26 INFO - "stage_platform": "linux64-pgo", 05:44:26 INFO - "basedir": "/builds/slave/test-pgo", 05:44:26 INFO - "nightly_build": "True", 05:44:26 INFO - "project": "", 05:44:26 INFO - "platform": "ubuntu64_hw", 05:44:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:44:26 INFO - "slavebuilddir": "test", 05:44:26 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:44:26 INFO - "branch": "mozilla-central", 05:44:26 INFO - "repo_path": "mozilla-central", 05:44:26 INFO - "pgo_build": "True", 05:44:26 INFO - "builduid": "568447c2ffd94f3882ec6291393c705d", 05:44:26 INFO - "revision": "202b199b9fcf37a687bef882f2513e191f079622" 05:44:26 INFO - }, 05:44:26 INFO - "sourcestamp": { 05:44:26 INFO - "repository": "", 05:44:26 INFO - "hasPatch": false, 05:44:26 INFO - "project": "", 05:44:26 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:44:26 INFO - "changes": [ 05:44:26 INFO - { 05:44:26 INFO - "category": null, 05:44:26 INFO - "files": [ 05:44:26 INFO - { 05:44:26 INFO - "url": null, 05:44:26 INFO - "name": "https://queue.taskcluster.net/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:44:26 INFO - } 05:44:26 INFO - ], 05:44:26 INFO - "repository": "", 05:44:26 INFO - "rev": "202b199b9fcf37a687bef882f2513e191f079622", 05:44:26 INFO - "who": "sendchange", 05:44:26 INFO - "when": 1447508600, 05:44:26 INFO - "number": 6662114, 05:44:26 INFO - "comments": "", 05:44:26 INFO - "project": "", 05:44:26 INFO - "at": "Sat 14 Nov 2015 05:43:20", 05:44:26 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:44:26 INFO - "revlink": "", 05:44:26 INFO - "properties": [ 05:44:26 INFO - [ 05:44:26 INFO - "buildid", 05:44:26 INFO - "20151114030404", 05:44:26 INFO - "Change" 05:44:26 INFO - ], 05:44:26 INFO - [ 05:44:26 INFO - "builduid", 05:44:26 INFO - "568447c2ffd94f3882ec6291393c705d", 05:44:26 INFO - "Change" 05:44:26 INFO - ], 05:44:26 INFO - [ 05:44:26 INFO - "nightly_build", 05:44:26 INFO - "True", 05:44:26 INFO - "Change" 05:44:26 INFO - ], 05:44:26 INFO - [ 05:44:26 INFO - "pgo_build", 05:44:26 INFO - "True", 05:44:26 INFO - "Change" 05:44:26 INFO - ] 05:44:26 INFO - ], 05:44:26 INFO - "revision": "202b199b9fcf37a687bef882f2513e191f079622" 05:44:26 INFO - } 05:44:26 INFO - ], 05:44:26 INFO - "revision": "202b199b9fcf37a687bef882f2513e191f079622" 05:44:26 INFO - } 05:44:26 INFO - } 05:44:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:44:26 INFO - Running post-action listener: _resource_record_post_action 05:44:26 INFO - ##### 05:44:26 INFO - ##### Running download-and-extract step. 05:44:26 INFO - ##### 05:44:26 INFO - Running pre-action listener: _resource_record_pre_action 05:44:26 INFO - Running main action method: download_and_extract 05:44:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:26 INFO - https://queue.taskcluster.net/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:44:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/test_packages.json 05:44:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/test_packages.json 05:44:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:44:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:44:34 INFO - Downloaded 1302 bytes. 05:44:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:44:34 INFO - Using the following test package requirements: 05:44:34 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:34 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:44:34 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:34 INFO - u'jsshell-linux-x86_64.zip'], 05:44:34 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:44:34 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:34 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:44:34 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:44:34 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:44:34 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:34 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:44:34 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:34 INFO - https://queue.taskcluster.net/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:44:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:44:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:44:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/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 05:44:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/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 05:44:50 INFO - Downloaded 22443994 bytes. 05:44:50 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 05:44:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:44:50 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 05:44:51 INFO - Return code: 0 05:44:51 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 05:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:51 INFO - https://queue.taskcluster.net/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:44:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:44:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:44:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/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 05:44:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/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 05:44:52 INFO - Downloaded 22443994 bytes. 05:44:52 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 05:44:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:44:52 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 05:44:53 INFO - Return code: 0 05:44:53 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')]} 05:44:53 INFO - https://queue.taskcluster.net/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:44:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/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 05:44:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/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 05:44:54 INFO - Downloaded 11131693 bytes. 05:44:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:44:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:44:54 INFO - Return code: 0 05:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:54 INFO - https://queue.taskcluster.net/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:44:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:44:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:44:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/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 05:44:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EL42x9hZSpebWZg4oFUMUA/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 05:44:55 INFO - Downloaded 57163880 bytes. 05:44:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:44:55 INFO - mkdir: /builds/slave/test-pgo/properties 05:44:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:44:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:44:55 INFO - Contents: 05:44:55 INFO - build_url:https://queue.taskcluster.net/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:44:55 INFO - Running post-action listener: _resource_record_post_action 05:44:55 INFO - Running post-action listener: set_extra_try_arguments 05:44:55 INFO - ##### 05:44:55 INFO - ##### Running populate-webroot step. 05:44:55 INFO - ##### 05:44:55 INFO - Running pre-action listener: _resource_record_pre_action 05:44:55 INFO - Running main action method: populate_webroot 05:44:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:44:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:44:55 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:44:55 INFO - '../fennec_ids.txt'], 05:44:55 INFO - 'tests': ['tcheck2']}, 05:44:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:44:55 INFO - '--tppagecycles', 05:44:55 INFO - '7'], 05:44:55 INFO - 'tests': ['tsvgm']}}, 05:44:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:44:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:44:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:44:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:44:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:44:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:44:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:44:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:55 INFO - 'talos_options': ['--e10s'], 05:44:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:44:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:55 INFO - 'tests': ['damp', 'tps']}, 05:44:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:55 INFO - 'talos_options': ['--e10s'], 05:44:55 INFO - 'tests': ['damp', 'tps']}, 05:44:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:44:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:44:55 INFO - 'other': {'tests': ['a11yr', 05:44:55 INFO - 'ts_paint', 05:44:55 INFO - 'tpaint', 05:44:55 INFO - 'sessionrestore', 05:44:55 INFO - 'sessionrestore_no_auto_restore']}, 05:44:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:44:55 INFO - 'tests': ['a11yr', 05:44:55 INFO - 'ts_paint', 05:44:55 INFO - 'tpaint', 05:44:55 INFO - 'sessionrestore', 05:44:55 INFO - 'sessionrestore_no_auto_restore']}, 05:44:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:44:55 INFO - 'tests': ['a11yr', 05:44:55 INFO - 'ts_paint', 05:44:55 INFO - 'tpaint', 05:44:55 INFO - 'sessionrestore', 05:44:55 INFO - 'sessionrestore_no_auto_restore']}, 05:44:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:44:55 INFO - 'tests': ['a11yr', 05:44:55 INFO - 'ts_paint', 05:44:55 INFO - 'tpaint', 05:44:55 INFO - 'sessionrestore', 05:44:55 INFO - 'sessionrestore_no_auto_restore']}, 05:44:55 INFO - 'other_l64': {'tests': ['a11yr', 05:44:55 INFO - 'ts_paint', 05:44:55 INFO - 'tpaint', 05:44:55 INFO - 'sessionrestore', 05:44:55 INFO - 'sessionrestore_no_auto_restore']}, 05:44:55 INFO - 'other_nol64': {'tests': ['a11yr', 05:44:55 INFO - 'ts_paint', 05:44:55 INFO - 'tpaint', 05:44:55 INFO - 'sessionrestore', 05:44:55 INFO - 'sessionrestore_no_auto_restore']}, 05:44:55 INFO - 'svgr': {'tests': ['tsvgx', 05:44:55 INFO - 'tsvgr_opacity', 05:44:55 INFO - 'tart', 05:44:55 INFO - 'tscrollx', 05:44:55 INFO - 'cart']}, 05:44:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:44:55 INFO - 'tests': ['tsvgx', 05:44:55 INFO - 'tsvgr_opacity', 05:44:55 INFO - 'tart', 05:44:55 INFO - 'tscrollx', 05:44:55 INFO - 'cart']}, 05:44:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:55 INFO - 'tests': ['tp5o']}, 05:44:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:55 INFO - 'talos_options': ['--e10s'], 05:44:55 INFO - 'tests': ['tp5o']}, 05:44:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:55 INFO - 'talos_options': ['--xperf_path', 05:44:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:44:55 INFO - 'tests': ['tp5n']}, 05:44:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:55 INFO - 'talos_options': ['--e10s', 05:44:55 INFO - '--xperf_path', 05:44:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:44:55 INFO - 'tests': ['tp5n']}}, 05:44:55 INFO - 'talos.zip': {'path': '', 05:44:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:44:55 INFO - Running post-action listener: _resource_record_post_action 05:44:55 INFO - ##### 05:44:55 INFO - ##### Running create-virtualenv step. 05:44:55 INFO - ##### 05:44:55 INFO - Running pre-action listener: _resource_record_pre_action 05:44:55 INFO - Running main action method: create_virtualenv 05:44:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:44:55 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 05:44:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:44:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:44:55 INFO - Using real prefix '/usr' 05:44:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:44:56 INFO - Installing distribute.............................................................................................................................................................................................done. 05:44:58 INFO - Installing pip.................done. 05:44:58 INFO - Return code: 0 05:44:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:44:58 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')]} 05:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:58 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')]} 05:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:58 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 0x7f3ab35d5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78c0>, '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 0xd54420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd548b0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653', '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 05:44:58 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 05:44:58 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 05:44:58 INFO - Using env: {'DISPLAY': ':0', 05:44:58 INFO - 'HOME': '/home/cltbld', 05:44:58 INFO - 'LANG': 'en_US.UTF-8', 05:44:58 INFO - 'LANGUAGE': 'en_US:en', 05:44:58 INFO - 'LOGNAME': 'cltbld', 05:44:58 INFO - 'MAIL': '/var/mail/cltbld', 05:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:58 INFO - 'MOZ_NO_REMOTE': '1', 05:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:58 INFO - 'NO_EM_RESTART': '1', 05:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:58 INFO - 'SHELL': '/bin/bash', 05:44:58 INFO - 'SHLVL': '1', 05:44:58 INFO - 'TERM': 'linux', 05:44:58 INFO - 'TMOUT': '86400', 05:44:58 INFO - 'USER': 'cltbld', 05:44:58 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653', 05:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:58 INFO - '_': '/tools/buildbot/bin/python'} 05:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:58 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 05:44:58 INFO - Cleaning up... 05:44:58 INFO - Return code: 0 05:44:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:44:58 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')]} 05:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:58 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')]} 05:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:58 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 0x7f3ab35d5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78c0>, '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 0xd54420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd548b0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653', '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 05:44:58 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 05:44:58 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 05:44:58 INFO - Using env: {'DISPLAY': ':0', 05:44:58 INFO - 'HOME': '/home/cltbld', 05:44:58 INFO - 'LANG': 'en_US.UTF-8', 05:44:58 INFO - 'LANGUAGE': 'en_US:en', 05:44:58 INFO - 'LOGNAME': 'cltbld', 05:44:58 INFO - 'MAIL': '/var/mail/cltbld', 05:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:58 INFO - 'MOZ_NO_REMOTE': '1', 05:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:58 INFO - 'NO_EM_RESTART': '1', 05:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:58 INFO - 'SHELL': '/bin/bash', 05:44:58 INFO - 'SHLVL': '1', 05:44:58 INFO - 'TERM': 'linux', 05:44:58 INFO - 'TMOUT': '86400', 05:44:58 INFO - 'USER': 'cltbld', 05:44:58 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653', 05:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:58 INFO - '_': '/tools/buildbot/bin/python'} 05:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:58 INFO - Downloading/unpacking psutil>=0.7.1 05:44:58 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 05:44:58 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 05:44:58 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 05:44:58 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 05:44:58 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 05:44:58 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 05:45:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:45:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:45:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:45:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:00 INFO - Installing collected packages: psutil 05:45:00 INFO - Running setup.py install for psutil 05:45:00 INFO - building 'psutil._psutil_linux' extension 05:45:00 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 05:45:00 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 05:45:00 INFO - building 'psutil._psutil_posix' extension 05:45:00 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 05:45:01 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 05:45:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:01 INFO - Successfully installed psutil 05:45:01 INFO - Cleaning up... 05:45:01 INFO - Return code: 0 05:45:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:45:01 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')]} 05:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:01 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')]} 05:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:01 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 0x7f3ab35d5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78c0>, '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 0xd54420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd548b0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653', '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 05:45:01 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 05:45:01 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 05:45:01 INFO - Using env: {'DISPLAY': ':0', 05:45:01 INFO - 'HOME': '/home/cltbld', 05:45:01 INFO - 'LANG': 'en_US.UTF-8', 05:45:01 INFO - 'LANGUAGE': 'en_US:en', 05:45:01 INFO - 'LOGNAME': 'cltbld', 05:45:01 INFO - 'MAIL': '/var/mail/cltbld', 05:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:01 INFO - 'MOZ_NO_REMOTE': '1', 05:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:01 INFO - 'NO_EM_RESTART': '1', 05:45:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:01 INFO - 'SHELL': '/bin/bash', 05:45:01 INFO - 'SHLVL': '1', 05:45:01 INFO - 'TERM': 'linux', 05:45:01 INFO - 'TMOUT': '86400', 05:45:01 INFO - 'USER': 'cltbld', 05:45:01 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653', 05:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:01 INFO - '_': '/tools/buildbot/bin/python'} 05:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:45:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:45:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:45:03 INFO - Installing collected packages: mozsystemmonitor 05:45:03 INFO - Running setup.py install for mozsystemmonitor 05:45:03 INFO - Successfully installed mozsystemmonitor 05:45:03 INFO - Cleaning up... 05:45:03 INFO - Return code: 0 05:45:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:45: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')]} 05:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3ab35d5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78c0>, '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 0xd54420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd548b0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653', '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 05:45:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:45:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:45:03 INFO - Using env: {'DISPLAY': ':0', 05:45:03 INFO - 'HOME': '/home/cltbld', 05:45:03 INFO - 'LANG': 'en_US.UTF-8', 05:45:03 INFO - 'LANGUAGE': 'en_US:en', 05:45:03 INFO - 'LOGNAME': 'cltbld', 05:45:03 INFO - 'MAIL': '/var/mail/cltbld', 05:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:03 INFO - 'MOZ_NO_REMOTE': '1', 05:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:03 INFO - 'NO_EM_RESTART': '1', 05:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:03 INFO - 'SHELL': '/bin/bash', 05:45:03 INFO - 'SHLVL': '1', 05:45:03 INFO - 'TERM': 'linux', 05:45:03 INFO - 'TMOUT': '86400', 05:45:03 INFO - 'USER': 'cltbld', 05:45:03 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653', 05:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:03 INFO - '_': '/tools/buildbot/bin/python'} 05:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:03 INFO - Downloading/unpacking blobuploader==1.2.4 05:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:05 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:45:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:45:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:45:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:05 INFO - Downloading docopt-0.6.1.tar.gz 05:45:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:45:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:05 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:05 INFO - Running setup.py install for blobuploader 05:45:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:45:05 INFO - Running setup.py install for requests 05:45:06 INFO - Running setup.py install for docopt 05:45:06 INFO - Successfully installed blobuploader requests docopt 05:45:06 INFO - Cleaning up... 05:45:06 INFO - Return code: 0 05:45:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:06 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')]} 05:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:06 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')]} 05:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:06 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 0x7f3ab35d5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78c0>, '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 0xd54420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd548b0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653', '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 05:45:06 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 05:45:06 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 05:45:06 INFO - Using env: {'DISPLAY': ':0', 05:45:06 INFO - 'HOME': '/home/cltbld', 05:45:06 INFO - 'LANG': 'en_US.UTF-8', 05:45:06 INFO - 'LANGUAGE': 'en_US:en', 05:45:06 INFO - 'LOGNAME': 'cltbld', 05:45:06 INFO - 'MAIL': '/var/mail/cltbld', 05:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:06 INFO - 'MOZ_NO_REMOTE': '1', 05:45:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:06 INFO - 'NO_EM_RESTART': '1', 05:45:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:06 INFO - 'SHELL': '/bin/bash', 05:45:06 INFO - 'SHLVL': '1', 05:45:06 INFO - 'TERM': 'linux', 05:45:06 INFO - 'TMOUT': '86400', 05:45:06 INFO - 'USER': 'cltbld', 05:45:06 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653', 05:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:06 INFO - '_': '/tools/buildbot/bin/python'} 05:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:06 INFO - Running setup.py (path:/tmp/pip-fpkNIg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:06 INFO - Running setup.py (path:/tmp/pip-3mPQjo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:06 INFO - Running setup.py (path:/tmp/pip-UiSFyV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:06 INFO - Running setup.py (path:/tmp/pip-awGIuv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:06 INFO - Running setup.py (path:/tmp/pip-0odojA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:06 INFO - Running setup.py (path:/tmp/pip-Zs2VIy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:07 INFO - Running setup.py (path:/tmp/pip-sjMCVh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:07 INFO - Running setup.py (path:/tmp/pip-DzbiRY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:07 INFO - Running setup.py (path:/tmp/pip-bHPPI6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:07 INFO - Running setup.py (path:/tmp/pip-Ju7Xi4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:07 INFO - Running setup.py (path:/tmp/pip-Lem3dv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:07 INFO - Running setup.py (path:/tmp/pip-GMsuWF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:07 INFO - Running setup.py (path:/tmp/pip-ZmBa7t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:07 INFO - Running setup.py (path:/tmp/pip-KiB2BB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:07 INFO - Running setup.py (path:/tmp/pip-wGUH2S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:07 INFO - Running setup.py (path:/tmp/pip-n33EWH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:07 INFO - Running setup.py (path:/tmp/pip-5L5lLx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:07 INFO - Running setup.py install for manifestparser 05:45:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:45:07 INFO - Running setup.py install for mozcrash 05:45:08 INFO - Running setup.py install for mozdebug 05:45:08 INFO - Running setup.py install for mozdevice 05:45:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:45:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:45:08 INFO - Running setup.py install for mozfile 05:45:08 INFO - Running setup.py install for mozhttpd 05:45:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:45:08 INFO - Running setup.py install for mozinfo 05:45:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:45:08 INFO - Running setup.py install for mozInstall 05:45:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:45:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:45:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:45:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:45:08 INFO - Running setup.py install for mozleak 05:45:08 INFO - Running setup.py install for mozlog 05:45:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:45:08 INFO - Running setup.py install for moznetwork 05:45:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:45:08 INFO - Running setup.py install for mozprocess 05:45:09 INFO - Running setup.py install for mozprofile 05:45:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:45:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:45:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:45:09 INFO - Running setup.py install for mozrunner 05:45:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:45:09 INFO - Running setup.py install for mozscreenshot 05:45:09 INFO - Running setup.py install for moztest 05:45:09 INFO - Running setup.py install for mozversion 05:45:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:45:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:09 INFO - Cleaning up... 05:45:09 INFO - Return code: 0 05:45:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f3ab35d5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78c0>, '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 0xd54420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd548b0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653', '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 05:45:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 05:45:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 05:45:09 INFO - Using env: {'DISPLAY': ':0', 05:45:09 INFO - 'HOME': '/home/cltbld', 05:45:09 INFO - 'LANG': 'en_US.UTF-8', 05:45:09 INFO - 'LANGUAGE': 'en_US:en', 05:45:09 INFO - 'LOGNAME': 'cltbld', 05:45:09 INFO - 'MAIL': '/var/mail/cltbld', 05:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:09 INFO - 'MOZ_NO_REMOTE': '1', 05:45:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:09 INFO - 'NO_EM_RESTART': '1', 05:45:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:09 INFO - 'SHELL': '/bin/bash', 05:45:09 INFO - 'SHLVL': '1', 05:45:09 INFO - 'TERM': 'linux', 05:45:09 INFO - 'TMOUT': '86400', 05:45:09 INFO - 'USER': 'cltbld', 05:45:09 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653', 05:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:09 INFO - '_': '/tools/buildbot/bin/python'} 05:45:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:09 INFO - Running setup.py (path:/tmp/pip-tvsv_O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:09 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)) 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:09 INFO - Running setup.py (path:/tmp/pip-k3QglG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:09 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)) 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:09 INFO - Running setup.py (path:/tmp/pip-lrZM1x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:10 INFO - Running setup.py (path:/tmp/pip-gpRbNR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:10 INFO - Running setup.py (path:/tmp/pip-DB_xFJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:10 INFO - Running setup.py (path:/tmp/pip-9weOL_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:10 INFO - Running setup.py (path:/tmp/pip-QRCvrn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:10 INFO - Running setup.py (path:/tmp/pip-JNGChN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:10 INFO - Running setup.py (path:/tmp/pip-CmZgym-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:10 INFO - Running setup.py (path:/tmp/pip-zn983K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:10 INFO - Running setup.py (path:/tmp/pip-oc7zCu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:10 INFO - Running setup.py (path:/tmp/pip-BkfDTI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:10 INFO - Running setup.py (path:/tmp/pip-Q0etpN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:10 INFO - Running setup.py (path:/tmp/pip-WMaUqy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:10 INFO - Running setup.py (path:/tmp/pip-Po9juF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:10 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)) 05:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:10 INFO - Running setup.py (path:/tmp/pip-hMT7bZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:11 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)) 05:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:11 INFO - Running setup.py (path:/tmp/pip-sDjvz7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:11 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)) 05:45:11 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)) 05:45:11 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)) 05:45:11 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)) 05:45:11 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)) 05:45:11 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)) 05:45:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:12 INFO - Downloading blessings-1.5.1.tar.gz 05:45:12 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 05:45:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:45:12 INFO - Installing collected packages: blessings 05:45:12 INFO - Running setup.py install for blessings 05:45:12 INFO - Successfully installed blessings 05:45:12 INFO - Cleaning up... 05:45:12 INFO - Return code: 0 05:45:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:45:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:45:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:45:13 INFO - Reading from file tmpfile_stdout 05:45:13 INFO - Current package versions: 05:45:13 INFO - argparse == 1.2.1 05:45:13 INFO - blessings == 1.5.1 05:45:13 INFO - blobuploader == 1.2.4 05:45:13 INFO - docopt == 0.6.1 05:45:13 INFO - manifestparser == 1.1 05:45:13 INFO - mozInstall == 1.12 05:45:13 INFO - mozcrash == 0.16 05:45:13 INFO - mozdebug == 0.1 05:45:13 INFO - mozdevice == 0.47 05:45:13 INFO - mozfile == 1.2 05:45:13 INFO - mozhttpd == 0.7 05:45:13 INFO - mozinfo == 0.9 05:45:13 INFO - mozleak == 0.1 05:45:13 INFO - mozlog == 3.0 05:45:13 INFO - moznetwork == 0.27 05:45:13 INFO - mozprocess == 0.22 05:45:13 INFO - mozprofile == 0.27 05:45:13 INFO - mozrunner == 6.11 05:45:13 INFO - mozscreenshot == 0.1 05:45:13 INFO - mozsystemmonitor == 0.0 05:45:13 INFO - moztest == 0.7 05:45:13 INFO - mozversion == 1.4 05:45:13 INFO - psutil == 3.1.1 05:45:13 INFO - requests == 1.2.3 05:45:13 INFO - wsgiref == 0.1.2 05:45:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:13 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 0x7f3ab35d5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78c0>, '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 0xd54420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd548b0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653', '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 05:45:13 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 05:45:13 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 05:45:13 INFO - Using env: {'DISPLAY': ':0', 05:45:13 INFO - 'HOME': '/home/cltbld', 05:45:13 INFO - 'LANG': 'en_US.UTF-8', 05:45:13 INFO - 'LANGUAGE': 'en_US:en', 05:45:13 INFO - 'LOGNAME': 'cltbld', 05:45:13 INFO - 'MAIL': '/var/mail/cltbld', 05:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:13 INFO - 'MOZ_NO_REMOTE': '1', 05:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:13 INFO - 'NO_EM_RESTART': '1', 05:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:13 INFO - 'SHELL': '/bin/bash', 05:45:13 INFO - 'SHLVL': '1', 05:45:13 INFO - 'TERM': 'linux', 05:45:13 INFO - 'TMOUT': '86400', 05:45:13 INFO - 'USER': 'cltbld', 05:45:13 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653', 05:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:13 INFO - '_': '/tools/buildbot/bin/python'} 05:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 INFO - Cleaning up... 05:45:13 INFO - Return code: 0 05:45:13 INFO - Running post-action listener: _resource_record_post_action 05:45:13 INFO - Running post-action listener: _start_resource_monitoring 05:45:13 INFO - Starting resource monitoring. 05:45:13 INFO - ##### 05:45:13 INFO - ##### Running install step. 05:45:13 INFO - ##### 05:45:13 INFO - Running pre-action listener: _resource_record_pre_action 05:45:13 INFO - Running main action method: install 05:45:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:45:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:45:13 INFO - Reading from file tmpfile_stdout 05:45:13 INFO - Detecting whether we're running mozinstall >=1.0... 05:45:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:45:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:45:13 INFO - Reading from file tmpfile_stdout 05:45:13 INFO - Output received: 05:45:13 INFO - Usage: mozinstall [options] installer 05:45:13 INFO - Options: 05:45:13 INFO - -h, --help show this help message and exit 05:45:13 INFO - -d DEST, --destination=DEST 05:45:13 INFO - Directory to install application into. [default: 05:45:13 INFO - "/builds/slave/test-pgo"] 05:45:13 INFO - --app=APP Application being installed. [default: firefox] 05:45:13 INFO - mkdir: /builds/slave/test-pgo/build/application 05:45:13 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'] 05:45:13 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 05:45:28 INFO - Reading from file tmpfile_stdout 05:45:28 INFO - Output received: 05:45:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:45:28 INFO - Running post-action listener: _resource_record_post_action 05:45:28 INFO - ##### 05:45:28 INFO - ##### Running run-tests step. 05:45:28 INFO - ##### 05:45:28 INFO - Running pre-action listener: _resource_record_pre_action 05:45:28 INFO - Running main action method: run_tests 05:45:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:45:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:45:28 INFO - Python 2.7.3 05:45:28 INFO - Return code: 0 05:45:28 INFO - grabbing minidump binary from tooltool 05:45:28 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')]} 05:45:28 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 0xda78c0>, '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 0xd54420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd548b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:45:28 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 05:45:28 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 05:45:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:45:28 INFO - Return code: 0 05:45:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:45:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:45:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:45:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:45:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:45:28 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/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:45:28 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/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost 05:45:28 INFO - Using env: {'DISPLAY': ':0', 05:45:28 INFO - 'HOME': '/home/cltbld', 05:45:28 INFO - 'LANG': 'en_US.UTF-8', 05:45:28 INFO - 'LANGUAGE': 'en_US:en', 05:45:28 INFO - 'LOGNAME': 'cltbld', 05:45:28 INFO - 'MAIL': '/var/mail/cltbld', 05:45:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:45:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:28 INFO - 'MOZ_NO_REMOTE': '1', 05:45:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:28 INFO - 'NO_EM_RESTART': '1', 05:45:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:28 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:45:28 INFO - 'SHELL': '/bin/bash', 05:45:28 INFO - 'SHLVL': '1', 05:45:28 INFO - 'TERM': 'linux', 05:45:28 INFO - 'TMOUT': '86400', 05:45:28 INFO - 'USER': 'cltbld', 05:45:28 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653', 05:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:28 INFO - '_': '/tools/buildbot/bin/python'} 05:45:28 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/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] with output_timeout 3600 05:45:28 INFO - mozversion INFO | application_buildid: 20151114030404 05:45:28 INFO - mozversion INFO | application_changeset: 202b199b9fcf37a687bef882f2513e191f079622 05:45:28 INFO - mozversion INFO | application_display_name: Nightly 05:45:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:45:28 INFO - mozversion INFO | application_name: Firefox 05:45:28 INFO - mozversion INFO | application_remotingname: firefox 05:45:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:45:28 INFO - mozversion INFO | application_vendor: Mozilla 05:45:28 INFO - mozversion INFO | application_version: 45.0a1 05:45:28 INFO - mozversion INFO | platform_buildid: 20151114030404 05:45:28 INFO - mozversion INFO | platform_changeset: 202b199b9fcf37a687bef882f2513e191f079622 05:45:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:45:28 INFO - mozversion INFO | platform_version: 45.0a1 05:45:28 INFO - 2015-11-14 05:45:28,421 DEBUG : using testdate: 1447508728 05:45:28 INFO - 2015-11-14 05:45:28,421 DEBUG : actual date: 1447508728 05:45:28 INFO - 2015-11-14 05:45:28,516 INFO : starting webserver on 'localhost:52083' 05:45:28 INFO - 2015-11-14 05:45:28,517 INFO : Starting test suite talos-linux64-ix-001 05:45:28 INFO - 2015-11-14 05:45:28,518 INFO : Starting test dromaeo_css 05:45:28 INFO - 2015-11-14 05:45:28,518 DEBUG : operating with platform_type : linux_ 05:45:28 INFO - 2015-11-14 05:45:28,518 INFO : Initialising browser for dromaeo_css test... 05:45:28 INFO - 2015-11-14 05:45:28,535 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcA2NnB/profile http://localhost:52083/getInfo.html 05:45:32 INFO - 2015-11-14 05:45:32,504 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:45:32 INFO - 2015-11-14 05:45:32,504 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:45:32 INFO - 2015-11-14 05:45:32,505 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:45:32 INFO - 2015-11-14 05:45:32,505 DEBUG : BROWSER_OUTPUT: __metrics 05:45:32 INFO - 2015-11-14 05:45:32,788 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:45:34 INFO - 2015-11-14 05:45:34,105 INFO : Browser initialized. 05:45:34 INFO - 2015-11-14 05:45:34,106 INFO : Running cycle 1/1 for dromaeo_css test... 05:45:34 INFO - 2015-11-14 05:45:34,106 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcA2NnB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:45:45 INFO - 2015-11-14 05:45:45,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 141848576 05:45:45 INFO - 2015-11-14 05:45:45,829 DEBUG : BROWSER_OUTPUT: 05:46:37 INFO - 2015-11-14 05:46:37,386 DEBUG : BROWSER_OUTPUT: 1447508797384 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] 05:48:45 INFO - 2015-11-14 05:48:45,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52083/tests/dromaeo/cssquery-ext.html) 05:48:46 INFO - 2015-11-14 05:48:46,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 228405248 05:48:46 INFO - 2015-11-14 05:48:46,682 DEBUG : BROWSER_OUTPUT: 05:51:48 INFO - 2015-11-14 05:51:48,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/dromaeo/cssquery-ext.html (next: http://localhost:52083/tests/dromaeo/cssquery-jquery.html) 05:51:49 INFO - 2015-11-14 05:51:49,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 216772608 05:51:49 INFO - 2015-11-14 05:51:49,396 DEBUG : BROWSER_OUTPUT: 05:54:51 INFO - 2015-11-14 05:54:51,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52083/tests/dromaeo/cssquery-mootools.html) 05:54:51 INFO - 2015-11-14 05:54:51,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 214253568 05:54:51 INFO - 2015-11-14 05:54:51,779 DEBUG : BROWSER_OUTPUT: 05:57:53 INFO - 2015-11-14 05:57:53,524 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52083/tests/dromaeo/cssquery-prototype.html) 05:57:54 INFO - 2015-11-14 05:57:54,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 201228288 05:57:54 INFO - 2015-11-14 05:57:54,110 DEBUG : BROWSER_OUTPUT: 06:00:56 INFO - 2015-11-14 06:00:56,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52083/tests/dromaeo/cssquery-yui.html) 06:00:57 INFO - 2015-11-14 06:00:57,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 200232960 06:00:57 INFO - 2015-11-14 06:00:57,054 DEBUG : BROWSER_OUTPUT: 06:03:59 INFO - 2015-11-14 06:03:59,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/dromaeo/cssquery-yui.html (next: http://localhost:52083/tests/dromaeo/cssquery-dojo.html) 06:03:59 INFO - 2015-11-14 06:03:59,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 259649536 06:03:59 INFO - 2015-11-14 06:03:59,720 DEBUG : BROWSER_OUTPUT: 06:03:59 INFO - 2015-11-14 06:03:59,720 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:03:59 INFO - 2015-11-14 06:03:59,720 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:03:59 INFO - 2015-11-14 06:03:59,721 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:03:59 INFO - 2015-11-14 06:03:59,721 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:03:59 INFO - 2015-11-14 06:03:59,724 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3158.778885478017;3210.293735378216;3245.9612923864356;3249.4475939090366;3281.27811881386;5143.511366420194;5237.92622512385;5347.946520534793;5383.138697808351;5400.513953744167;5293.126634105368;5331.946680533193;5339.199120131982;5503.532199763025;5639.464250896158;4888.877778055541;4943.6539442239055;4981.078500477405;5027.673201241926;5041.8487445376695;4942.6293028022865;4988.401391832985;5015.022070696215;5031.169856973595;5035.295058691786;4696.53034696531;4807.807687692488;4844.2733589961435;4961.776720047606;4966.726830024347;4884.780184891689;4896.045271172123;4900.705957642553;4903.436104847952;4936.6297527685565;4864.635152363551;4886.584640305578;4902.681325713817;4909.950900491021;4956.033573453142;5096.79612815487;5169.483051694838;5213.2701421800975;5273.367195936512;5334.413214546396;5726.627769194989;5730.541556675456;5734.827955161351;5738.454846789548;5738.885222295531;5683.943160568383;5734.827955161351;5738.167965645;5747.540196784247;5761.711914404263;5345.412004679482;5424.430434804368;5446.019716451037;5474.671519708831;5488.368837583649;5911.40885911414;5917.349091599921;5923.851903702356;5929.762809487572;5969.492593129633;5717.714114294268;5758.74085666146;5763.394843541368;5764.827055188267;5825.621334613236;5808.506276966421;5904.61619994699;5907.616004959664;5913.793017244376;5949.970250148722;5752.194692743019;5758.712064396847;5758.971205144031;5761.251037365116;5763.279590051244;5590.301212348457;5663.461971112738;5734.340550836624;5739.311282646109;5755.3381361144;4460.643148548108;4462.397576327219;4487.887802804956;4492.775361231926;4499.955000449953;3965.2267807777207;3965.78188199646;3986.0433495961342;3990.182012687392;4014.016565941363;5314.73426328682;5402.864928376744;5420.620556561082;5449.291592093082;5488.91766623501;5691.971540142273;5714.314282286152;5715.714214289269;5736.913946290809;5778.711064446761;5370.543503802142;5378.677279363251;5383.16560933056;5388.245645609618;5417.918731219035;4800.423949126127;4883.267509873547;5008.12357837377;5021.14640511114;5119.667221630582;6091.878162436727;6095.268567771807;6095.451409373178;6100.359462256488;6111;5831.679257640701;5839.299284085937;5845.941540584539;5846.94153058464;5847.619904706181;5815.680137592473;5912.290525137011;5933.495652869555;5980.19267398913;6008.188894499187;5669.5180909621495;5683.60214784961;5696.373398926197;5698.088305871206;5710.371859095413;5700.458456446631;5768.394318596487;5769.884602308014;5774.364819869895;5786.94213057864;5619.100943848965;5640.492355688008;5740.942590574208;5748.109043098327;5765.8558536036935;5713.514351280188;5753.683547404933;5757;5758.856028599319;5773.3072031356505;5370.543503802221;5476.069068258326;5636.915446268227;5663.1788390682295;5668.26312579362;5653.858653533694;5753.884922301614;5778.191053252632;5799.623024503394;5801.216835727123;5485.561155107662;5540.695261760642;5542.8337149885565;5543.3902270751;5551.111822108443 06:03:59 INFO - 2015-11-14 06:03:59,726 DEBUG : BROWSER_OUTPUT: |1;ext.html;571.45997032804;604.0335463258785;607.7022259093044;620.9689515524228;674.787441955784;31252.374952500937;32068.67931320686;32096;40893.18213635725;41396.37905431421;43732.56267437325;44199.33700994487;44243.77878110613;44313;44352;7679.57762323072;8650.783730406743;8841.38110332277;8842.204201621853;8844.73465796027;7712;10118.291719579633;10314.1748660107;10319.742006449824;10320.690379288595;10080.143187829044;10131.797364052714;10203;10206.081452669257;10220.74448138795;7800.492967957065;7929.920700792976;9920.90079099207;10034.849477257847;10513.158947284199;10210.642627508076;10382.896171038268;10410.323328983592;10411.947940260327;10418;39835.60164398348;40223.59776402228;40297.79851100755;40319.79840100781;40338;3210;3248.5614442050255;3402.897913062612;3683.171286460525;3704.685101766353;30072;30727.846360768275;30828.845855770578;30837.825907979604;31920.521192182136;3511.877084302037;3532.9116772080647;3533.787972721619;3544.9113772155642;3573.249617580311;297114;297507.5124624385;297828;298124;298318;57230.427695723345;58070;59858;60204;65184.696306073616;61848;62192.37807621956;62446;62580.374196258366;62679.37320626827;16165.353385864433;16324.265408056666;16346;16350.264238109314;16369;12609.49562017509;12665.366731663564;12689.048321375934;12697.809532857014;12700.110992230455;19686.70469942952;19992.400227993185;20021.899890500456;20078.89960550188;20103.597928041356;7686.692532298757;7889.526628402315;7908.367330613537;7960.800979975431;8080.39397045224;887.924526415249;892.2594246775161;938.863864739609;1046.7173863056933;1069.1233188785277;28825.85587072093;29529.26176845596;29691.85154074259;30147.246318841764;30203.546946795817;1014.5434554450379;1034.6947650443137;1038.771470276538;1050.7373156710823;1089.6191820871422;14170.787438188436;14394.496192633416;14529.564113076625;14705.117692938458;14726;343526;350402;350691.20507166954;351092;351267;51456.48543514592;51535.742321288904;51764;51888.74055629773;51895.48104518982;1271.5613113475836;1288.1112032697408;1289.5099862052548;1289.8194252804803;1317.92751398674;21014.789852101283;29906.401871962873;30991.69008309888;31120.688793111778;31444.213894652818;48909.51090489049;49073.5092649069;49294.50705492899;49371;49422.50577494179;277647;279223;280349;298480;303486;31025.8448707755;31324.373512530077;31339.68660313459;31718;31833.5224971621;39252.803735981135;41386.379204312565;41457.1708565833;41677.79161104175;42466;35318.117047074025;35430.114247143;35435.291294173454;35555.46666800052;36649;35475.64524354723;36499.81750091232;36570.26859462849;36677.799332040166;36698.26603467969;35884.28231435409;36847.44728829123;37268;37385.81307093556;37416.43875341817;30066;32751.836240819597;33242.33515329728;33302.16744581405;33321.33357332792;24943;25103.74896251014;25235.495290093728;25247.747522525275;25563.23310300694 06:03:59 INFO - 2015-11-14 06:03:59,727 DEBUG : BROWSER_OUTPUT: |2;jquery.html;347.86259427526113;351.1677324740366;351.8135388244231;352.89942366425566;353.79126315473866;14422.278886055708;14498.442336644086;16667.916660416697;17247.3101075957;19137.138828752704;15985.760213596805;16164.676706465863;16369.181540922966;16768.66462670749;16829.242684079214;5337.67973921564;5479.342478902538;5480.424555421683;5481.616286859921;5483.424240454755;4022.376531637586;4119;5424.5117939385445;5473.452654734535;5902.144189092579;5964.343922168558;5992.10118482229;6024.48791852693;6028.788992385267;6039.969800150993;4516.616087632555;4626.167289887819;4631.60631346336;4633.884152896171;5983.9102413463615;3932.9016774580864;3933.272344616255;3939.172773717523;3943.7239393242485;3952.209558088365;10640.042396184303;10669.573217071307;10679.145668346513;10682.359058456439;11075;1797.4787311679597;1814.9818501814946;1982.33591746765;1982.474644219283;2106.6418708819538;9026.684066057656;9398.154166125014;9441.858372124423;9519.857202141973;9596.90403095974;1562.6015366081576;1602.9427157318562;1674.9413770518095;1692.9068901210428;1706.6074802795301;60339.698301508215;60891.39108608946;61373.69313153451;63077;63711.68144159296;6720.798376048726;6764.255931847493;6780.864382712417;6803.115594972622;6809.216940051859;7991.560464174526;8006.199380062064;8026.916366290593;8027.117017128111;8049.315808156372;5303.36359636846;5350;5464.562834973192;5524.06090964537;5557.083081291623;5754.251947246831;5754.280714910637;5798.159266906275;5808.273965754281;5829.387914269026;3102.0383681058943;3113.5952326197903;3121.562981182636;3137.9686203137676;3168.556402103707;1087.3856271206744;1089.226649079147;1128.5711429656678;1137.2664631312923;1149.6608500492375;439.701003317747;445.5010388364987;448.4685647507714;450.4189595421869;459.69889722231994;10711.625093121704;10893.618723344645;10940.671779846618;11009.724756880982;11011.28426652265;448.84514842379326;459.4348950790546;460.8041582327497;461.7714231455451;465.6600681502454;5835.824925252249;6132;6154.846128846814;6173.32093469718;6230.127782110508;541189;549087;551823;562802;570288;75763;80519;81739;82209.58895205485;82325;496.2853490972987;508.3112382721433;509.92351147328196;510.77015343095013;511.48595661360093;10568.630097946534;11075.667729968114;11112.777744445228;11145.944270278922;11179.552817887194;35773;36443.27113457769;36451.27097457983;36634;37050.44424333691;46451.53548464472;48757.268640969705;49351;50152.749236253585;50537.74731126321;6478.676066196577;6491.091247225487;6544;6554.770583029571;6575.967120164369;11732.648020559396;11756.23584467007;11877.406129693309;11946.701332466759;11949.820752688891;9891.703248902544;9904.405735655884;9986.101250887456;10182;10398.480075996322;10034.147097496794;10307.94846025765;10320.380777153396;10441.477926103513;10467.685969420929;10392.844107338246;10398.22013349017;10464.215183861088;10469.895301046892;10667.413292269;6419.454346380423;6499.1876015498065;6592.077109204619;6599.208095028627;6606.405423511907;10129.088382045651;10189;10439.686809395731;10475.214358922958;10538 06:03:59 INFO - 2015-11-14 06:03:59,730 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1364.7270545890824;1376.8778445566868;1383.391307824557;1697.5331783759468;1759.3666280139148;6737.427318677912;7644.159142494328;7785.922140778604;7807.765767026984;7809.0238720159905;7599.620018999056;7712;7731.381489480842;7735.033120859893;7738.690452381912;2240.0367841828006;2247.3932038349635;2250.437390652337;2252.5832720946596;2252.68462415262;2232.5423288225875;2234.575430668176;2245.4610893385634;2254.7068881045443;2271.8977646005887;2202.2952655150357;2205.5699138667965;2222.388843068153;2225.310153852311;2225.944351391212;2221.7222847144108;2225.265662331427;2248.7976082152604;2251.2570851618925;2251.5609456156058;2250.8199344052437;2264.30938563738;2264.615015447378;2267.648514480258;2269.977300226993;6792.524523283372;6924.688389022506;7686.154523002465;7718.729844455417;7725.343345815612;4372.737635741833;4483.910321793546;4496.100779844011;4503.954960450386;4506.864794056183;3066.632004159515;3085.3366526196974;3130.780845340827;3134.310451700645;3220.677932206784;936.8126374725082;938.7653086728318;945.0738276489011;964.2719746591349;986.2208855004537;10497.4226417547;10528.947355263252;10567.207459440497;10600;10621.893781062168;4059.65492933104;4114.773687447159;4159.563245859141;4168.916621667549;4191.8532851350055;8228.25945664893;8252.958735206286;8254.339652827759;8261.752147435587;8266.958665206635;4463.62059224963;4486;4487.304467807495;4498.212812757754;4499.842505512292;4131.690123240769;4132.090939993197;4134.979325103355;4139.151473947833;4141.668666506672;3359.983200083984;3414.8804791832167;3415.7267418606452;3422.0418282880833;3443.0359499340225;1030.160419258302;1037.4760745823312;1038.1746511523356;1052.752603138262;1058.7035630023606;1278.8209650648917;1306.79744639581;1316.2694704439127;1317.157019507516;1334.1394800353912;7222.3860971817985;7456.32893039629;7475.514091584138;7476.514026588255;7477.70089196426;438.38625923707065;445.0564802618405;446.3037661248463;447.42729306487746;458.2301733088443;5430.375506816687;5606.859828504238;5779.306483222041;5834.416558344216;5840.737166827418;8559.529225892637;8780.165884240987;8795.384323097322;8843.60203790831;8874.556272186494;8432.578371081545;8589.957050214834;8689.348298877609;9251.121143491358;9344.2524598032;7204.459665525002;7307.488475806643;7364.2635736427;7372.668229929666;7381.040464739657;7187.2453392393045;7259.455540834353;7266.091738532684;7274.345308922222;7282.890756638549;8044.718434854752;8232.588370581327;8265.46274492156;8282.378821588285;8337.291330236998;8326.750197494084;8454.704085356983;8467.153284671484;8477.067522572635;8676.696315628922;6534.967325163344;6596.7031483584315;6597.1423714916755;6599.109120268702;6614.6361950093205;7494.850102998019;7524.811879703051;7575.7348492804695;7587.658555364911;7597.2022937590755;6865.141857267841;6902.516823822284;7095.432365410651;7211.314925082109;7226.89159662616;6843.281455447106;6926.826829329307;6947.3747362737595;7043.964780176067;7064.894026589503;7031.507794454339;7080.114985626797;7120.359167674934;7168.068151140527;7172.139343278631;6495.447886929664;6574.441172500391;6605.240397354366;6608.504362172953;6645.435138013323;6639.203295604559;6668.83327916806;6679.599224046573;6683.231428385603;6686.5653732507235 06:03:59 INFO - 2015-11-14 06:03:59,732 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.0713833546837;303.5371059134819;306.98618562164694;310.9751219902408;312.5639732573062;5991.940080599193;6059.757609695613;6071.271447426309;6091.6649584272955;6203.038529027996;5876.970615146929;6032.788852390167;6033;6056;6060.909086363708;4372.366006928994;4587.334836448729;4588.587027167554;4598.65510086744;4601.769911504428;4450.176717307292;4517;4575.725456472605;4605.217113090765;4619.122366750306;4501.909961800762;4510.909781804362;4515.841945531907;4523.163214805255;4561.270196768518;4566.246569316058;4567;4572.725636461823;4573.291139873309;4587.449506059261;3981.163955569334;3983.0440694233466;3983.40248962655;3995.06116062725;4003.799810009488;5615.578831587606;5751.856203594902;5756.568257380672;5765.711714414305;5770.394108618577;5302.602304827154;5302.602304827154;5319.5744340452675;5323.387810401815;5324.281222035014;6414.1340918976275;6431.324710905381;6437.935620643781;6438.839029024265;6445.291017988017;4315.892102697458;4392.934105988381;4409.096135292258;4413.249747542925;4426.513083560806;6603.306652801482;6670.833229169261;6671.366220209073;6675.86648267032;6687.598744075371;4369.584889435499;4375.584319489643;4376.321670141133;4378.540253273361;4383.408239887574;4422.601965823027;4425.579569940851;4428.645708343325;4430.734155950653;4438.356438316426;5135.12702840518;5205.583553315726;5282.366116066097;5286.444923283077;5293.100172970604;6433.131527243856;6433.517486188554;6438.098666186737;6440.420362167334;6443.226812782496;1567.8588926996624;1601.1513897634272;1606.3414000259838;1607;1607.075931339461;1023.2530252915265;1025.379645314574;1043.5408420295046;1044.081208536483;1049.1659130990881;6143.631382117087;6252.937470625327;6261.311255761862;6269.435750782452;6275.309715931244;6502.642354670444;6545.770898018642;6663.267040625527;6701.195856497252;6708.329167083252;6256.874862502725;6264.5301602380005;6303.054541818764;6329.493640508748;6332.905006424908;3611.638836116367;3641.5448068991377;3647.8905632831056;3650.069232345788;3650.4159334506353;6847.554908930903;6973.3375329343635;7001.369876711018;7008.789736307817;7026.543274687129;6893.207765980881;6896.034555162281;6904.067950826675;6907.20567134786;6913.481488888354;6984.895226571605;6991.965040174869;7005.789826305219;7008.649567521604;7040.049593304941;6569.507286953402;6746.730130794714;6755.223149337692;6758.93241067583;6760.323967603397;6659.034440006269;6668.399844014062;6673.366030227121;6686.632235226914;6687;6911.067005954333;7033.366996970297;7036.401905838061;7039.120109986252;7042.0493233412835;4511.142882852248;4522.253828118323;4524.932126018047;4527;4528.864134075983;6724.798256052326;6727.293634168342;6736.966315168393;6753.932460675527;6756.662166891734;6435.06691529735;6488.091667166695;6488.70800813974;6498.960166373357;6504.544681872224;6371.171747672773;6512.837179070561;6518.152640156749;6520.250171230369;6525.510586705921;6382.36176382358;6396.104545363746;6396.744130234739;6408.775692850728;6412.1664183657695;6460.709268082854;6556.8360790980605;6557.672116394257;6562.34376562359;6569.901451478136;6167;6259.061140828912;6327.303996560283;6374.681265936777;6409.391107844747 06:03:59 INFO - 2015-11-14 06:03:59,733 DEBUG : BROWSER_OUTPUT: |5;yui.html;724.4059870905859;735.7057177129147;760.4486747108347;777.6383981448625;796.2236819101377;14242.572722818331;14278.214698191596;14533.345999430025;14561.417543298256;14580.854191458095;13566.864331356683;13619.795703064437;13635.659108522292;13648.795268070988;13653.72692546151;688.6006116452446;694.0803435448051;803.4375936844218;820.1593366799019;822.1326500541926;807.64059993303;815.7389635316702;818.9590520473982;820.3601191070944;822.01358369956;859.8882145321099;862.7239283429305;864.3215076165211;864.3387808326635;864.4251572704144;723.0491903147345;726.0017475970541;853.7737499562589;855.495257797896;869.5304535550795;640.8974564069773;641.9037144428327;642.1138828416802;642.6882961763541;644.1336402538578;13490.730185396334;13592.38834252461;13593.320333983262;13601.659958501017;13603.86396136036;12242.081843861657;12477.875221247852;12530.561430349893;12614;12687.365631718378;10184;10440.425776582286;10720.195985301056;10925;10957.06864916483;3236.6277878044093;3275.6724327567053;3307.834608269577;3332.6000879894327;3337.9666203338143;42538;42627.57372426267;42804;42854.78572607148;42942.78528607337;7723.34351580122;7880.172581878935;7906.683732650745;7909.841803164019;7948.841023179504;12458.501659933501;12469.127161098817;12564.183328083645;12578.55975040869;12586.24482531051;6996.8950465743055;7082.362587367162;7111.644417779194;7130.5721656699725;7231.819204519929;4465.37484752135;4494.851099359895;4501.639868810487;4506.324051392252;4506.684532082788;2718.687350954626;2735.7674597659025;2741.040635777502;2745.4509098180442;2746.3546066674317;430.1075268817217;433.8828516300644;438.46726227633576;447.83653966302717;448.66350237322007;618.3723520626568;634.8888944434706;676.7766637009775;678.1997243253008;682.7098483144644;8622.396432249683;8680.782980425414;8752.737417877473;8829.38194326391;9050.954745226232;536.6163193316719;540.3758658749151;628.7547856336032;690.0477341269117;704.429412176139;3998.7400818946676;4028.254772867029;4138.255114079434;4157.1313898818435;4163.521195062606;56153.43846561482;56404.71797641068;56519.71740141273;59130.70434647799;59916.40083599108;51220.487795121575;51761.48238517567;52134;52212.21681674778;53512.19731704028;45471.090578188254;45953.31070033952;46005.539944600794;46361.53638463572;46960.765196174485;8616.526091065052;8674.349423793366;8854.723752211723;8965.686200982935;9017.5233297302;33862.83068584641;33978.32043359168;34061.65938340585;34879.47680784739;35180.472292916136;43233.56766432421;44894;44959.55040449554;45059.77470112628;45403.77298113488;6916.135483064617;7086.50394472382;7523.3981281498445;7622.237776222333;7829.7259595913865;12159.392030398622;12290.75418491643;12313.44589493457;12338.259704417764;12706.174098683556;11227.88772112301;11641.359725214856;11904.642860714192;11937.522499100287;12071.275723456622;11306.4912078955;11782.410879456163;11855.466504007169;11917.52329906794;12111.091668125102;11152.163587731115;11239.100871930063;11331.943340283246;11496.885031149915;11606.535738570363;9547.42715437076;9563;9722.562484688064;9941.453220072965;9959.800803983735;8480.321574274167;9127.908720912706;9288.489133097473;9704.320697551104;9755.707328780149 06:03:59 INFO - 2015-11-14 06:03:59,733 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:03:59 INFO - 2015-11-14 06:03:59,733 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:03:59 INFO - 2015-11-14 06:03:59,733 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,740 06:03:59 INFO - 2015-11-14 06:03:59,733 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:03:59 INFO - 2015-11-14 06:03:59,733 DEBUG : BROWSER_OUTPUT: __startTimestamp1447509839719__endTimestamp 06:03:59 INFO - 2015-11-14 06:03:59,733 DEBUG : BROWSER_OUTPUT: 06:03:59 INFO - 2015-11-14 06:03:59,735 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:03:59 INFO - 2015-11-14 06:03:59,735 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:03:59 INFO - 2015-11-14 06:03:59,735 DEBUG : BROWSER_OUTPUT: 06:03:59 INFO - 2015-11-14 06:03:59,735 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5374.46 Median:5619.10 stddev:599.31 (10.7%) stddev-sans-first:575.39 06:03:59 INFO - 2015-11-14 06:03:59,735 DEBUG : BROWSER_OUTPUT: Values: 3158.8 3210.3 3246.0 3249.4 3281.3 5143.5 5237.9 5347.9 5383.1 5400.5 5293.1 5331.9 5339.2 5503.5 5639.5 4888.9 4943.7 4981.1 5027.7 5041.8 4942.6 4988.4 5015.0 5031.2 5035.3 4696.5 4807.8 4844.3 4961.8 4966.7 4884.8 4896.0 4900.7 4903.4 4936.6 4864.6 4886.6 4902.7 4910.0 4956.0 5096.8 5169.5 5213.3 5273.4 5334.4 5726.6 5730.5 5734.8 5738.5 5738.9 5683.9 5734.8 5738.2 5747.5 5761.7 5345.4 5424.4 5446.0 5474.7 5488.4 5911.4 5917.3 5923.9 5929.8 5969.5 5717.7 5758.7 5763.4 5764.8 5825.6 5808.5 5904.6 5907.6 5913.8 5950.0 5752.2 5758.7 5759.0 5761.3 5763.3 5590.3 5663.5 5734.3 5739.3 5755.3 4460.6 4462.4 4487.9 4492.8 4500.0 3965.2 3965.8 3986.0 3990.2 4014.0 5314.7 5402.9 5420.6 5449.3 5488.9 5692.0 5714.3 5715.7 5736.9 5778.7 5370.5 5378.7 5383.2 5388.2 5417.9 4800.4 4883.3 5008.1 5021.1 5119.7 6091.9 6095.3 6095.5 6100.4 6111.0 5831.7 5839.3 5845.9 5846.9 5847.6 5815.7 5912.3 5933.5 5980.2 6008.2 5669.5 5683.6 5696.4 5698.1 5710.4 5700.5 5768.4 5769.9 5774.4 5786.9 5619.1 5640.5 5740.9 5748.1 5765.9 5713.5 5753.7 5757.0 5758.9 5773.3 5370.5 5476.1 5636.9 5663.2 5668.3 5653.9 5753.9 5778.2 5799.6 5801.2 5485.6 5540.7 5542.8 5543.4 5551.1 06:03:59 INFO - 2015-11-14 06:03:59,735 DEBUG : BROWSER_OUTPUT: 06:03:59 INFO - 2015-11-14 06:03:59,735 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48267.06 Median:33272.25 stddev:81867.95 (246.1%) stddev-sans-first:82019.29 06:03:59 INFO - 2015-11-14 06:03:59,736 DEBUG : BROWSER_OUTPUT: Values: 571.5 604.0 607.7 621.0 674.8 31252.4 32068.7 32096.0 40893.2 41396.4 43732.6 44199.3 44243.8 44313.0 44352.0 7679.6 8650.8 8841.4 8842.2 8844.7 7712.0 10118.3 10314.2 10319.7 10320.7 10080.1 10131.8 10203.0 10206.1 10220.7 7800.5 7929.9 9920.9 10034.8 10513.2 10210.6 10382.9 10410.3 10411.9 10418.0 39835.6 40223.6 40297.8 40319.8 40338.0 3210.0 3248.6 3402.9 3683.2 3704.7 30072.0 30727.8 30828.8 30837.8 31920.5 3511.9 3532.9 3533.8 3544.9 3573.2 297114.0 297507.5 297828.0 298124.0 298318.0 57230.4 58070.0 59858.0 60204.0 65184.7 61848.0 62192.4 62446.0 62580.4 62679.4 16165.4 16324.3 16346.0 16350.3 16369.0 12609.5 12665.4 12689.0 12697.8 12700.1 19686.7 19992.4 20021.9 20078.9 20103.6 7686.7 7889.5 7908.4 7960.8 8080.4 887.9 892.3 938.9 1046.7 1069.1 28825.9 29529.3 29691.9 30147.2 30203.5 1014.5 1034.7 1038.8 1050.7 1089.6 14170.8 14394.5 14529.6 14705.1 14726.0 343526.0 350402.0 350691.2 351092.0 351267.0 51456.5 51535.7 51764.0 51888.7 51895.5 1271.6 1288.1 1289.5 1289.8 1317.9 21014.8 29906.4 30991.7 31120.7 31444.2 48909.5 49073.5 49294.5 49371.0 49422.5 277647.0 279223.0 280349.0 298480.0 303486.0 31025.8 31324.4 31339.7 31718.0 31833.5 39252.8 41386.4 41457.2 41677.8 42466.0 35318.1 35430.1 35435.3 35555.5 36649.0 35475.6 36499.8 36570.3 36677.8 36698.3 35884.3 36847.4 37268.0 37385.8 37416.4 30066.0 32751.8 33242.3 33302.2 33321.3 24943.0 25103.7 25235.5 25247.7 25563.2 06:03:59 INFO - 2015-11-14 06:03:59,736 DEBUG : BROWSER_OUTPUT: 06:03:59 INFO - 2015-11-14 06:03:59,736 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27527.34 Median:459.57 stddev:91074.88 (19817.5%) stddev-sans-first:91307.50 06:03:59 INFO - 2015-11-14 06:03:59,736 DEBUG : BROWSER_OUTPUT: Values: 347.9 351.2 351.8 352.9 353.8 14422.3 14498.4 16667.9 17247.3 19137.1 15985.8 16164.7 16369.2 16768.7 16829.2 5337.7 5479.3 5480.4 5481.6 5483.4 4022.4 4119.0 5424.5 5473.5 5902.1 5964.3 5992.1 6024.5 6028.8 6040.0 4516.6 4626.2 4631.6 4633.9 5983.9 3932.9 3933.3 3939.2 3943.7 3952.2 10640.0 10669.6 10679.1 10682.4 11075.0 1797.5 1815.0 1982.3 1982.5 2106.6 9026.7 9398.2 9441.9 9519.9 9596.9 1562.6 1602.9 1674.9 1692.9 1706.6 60339.7 60891.4 61373.7 63077.0 63711.7 6720.8 6764.3 6780.9 6803.1 6809.2 7991.6 8006.2 8026.9 8027.1 8049.3 5303.4 5350.0 5464.6 5524.1 5557.1 5754.3 5754.3 5798.2 5808.3 5829.4 3102.0 3113.6 3121.6 3138.0 3168.6 1087.4 1089.2 1128.6 1137.3 1149.7 439.7 445.5 448.5 450.4 459.7 10711.6 10893.6 10940.7 11009.7 11011.3 448.8 459.4 460.8 461.8 465.7 5835.8 6132.0 6154.8 6173.3 6230.1 541189.0 549087.0 551823.0 562802.0 570288.0 75763.0 80519.0 81739.0 82209.6 82325.0 496.3 508.3 509.9 510.8 511.5 10568.6 11075.7 11112.8 11145.9 11179.6 35773.0 36443.3 36451.3 36634.0 37050.4 46451.5 48757.3 49351.0 50152.7 50537.7 6478.7 6491.1 6544.0 6554.8 6576.0 11732.6 11756.2 11877.4 11946.7 11949.8 9891.7 9904.4 9986.1 10182.0 10398.5 10034.1 10307.9 10320.4 10441.5 10467.7 10392.8 10398.2 10464.2 10469.9 10667.4 6419.5 6499.2 6592.1 6599.2 6606.4 10129.1 10189.0 10439.7 10475.2 10538.0 06:03:59 INFO - 2015-11-14 06:03:59,737 DEBUG : BROWSER_OUTPUT: 06:03:59 INFO - 2015-11-14 06:03:59,737 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5341.49 Median:6602.17 stddev:2783.97 (42.2%) stddev-sans-first:2775.74 06:03:59 INFO - 2015-11-14 06:03:59,737 DEBUG : BROWSER_OUTPUT: Values: 1364.7 1376.9 1383.4 1697.5 1759.4 6737.4 7644.2 7785.9 7807.8 7809.0 7599.6 7712.0 7731.4 7735.0 7738.7 2240.0 2247.4 2250.4 2252.6 2252.7 2232.5 2234.6 2245.5 2254.7 2271.9 2202.3 2205.6 2222.4 2225.3 2225.9 2221.7 2225.3 2248.8 2251.3 2251.6 2250.8 2264.3 2264.6 2267.6 2270.0 6792.5 6924.7 7686.2 7718.7 7725.3 4372.7 4483.9 4496.1 4504.0 4506.9 3066.6 3085.3 3130.8 3134.3 3220.7 936.8 938.8 945.1 964.3 986.2 10497.4 10528.9 10567.2 10600.0 10621.9 4059.7 4114.8 4159.6 4168.9 4191.9 8228.3 8253.0 8254.3 8261.8 8267.0 4463.6 4486.0 4487.3 4498.2 4499.8 4131.7 4132.1 4135.0 4139.2 4141.7 3360.0 3414.9 3415.7 3422.0 3443.0 1030.2 1037.5 1038.2 1052.8 1058.7 1278.8 1306.8 1316.3 1317.2 1334.1 7222.4 7456.3 7475.5 7476.5 7477.7 438.4 445.1 446.3 447.4 458.2 5430.4 5606.9 5779.3 5834.4 5840.7 8559.5 8780.2 8795.4 8843.6 8874.6 8432.6 8590.0 8689.3 9251.1 9344.3 7204.5 7307.5 7364.3 7372.7 7381.0 7187.2 7259.5 7266.1 7274.3 7282.9 8044.7 8232.6 8265.5 8282.4 8337.3 8326.8 8454.7 8467.2 8477.1 8676.7 6535.0 6596.7 6597.1 6599.1 6614.6 7494.9 7524.8 7575.7 7587.7 7597.2 6865.1 6902.5 7095.4 7211.3 7226.9 6843.3 6926.8 6947.4 7044.0 7064.9 7031.5 7080.1 7120.4 7168.1 7172.1 6495.4 6574.4 6605.2 6608.5 6645.4 6639.2 6668.8 6679.6 6683.2 6686.6 06:03:59 INFO - 2015-11-14 06:03:59,737 DEBUG : BROWSER_OUTPUT: 06:03:59 INFO - 2015-11-14 06:03:59,738 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5383.75 Median:6185.02 stddev:1667.40 (27.0%) stddev-sans-first:1627.82 06:03:59 INFO - 2015-11-14 06:03:59,738 DEBUG : BROWSER_OUTPUT: Values: 299.1 303.5 307.0 311.0 312.6 5991.9 6059.8 6071.3 6091.7 6203.0 5877.0 6032.8 6033.0 6056.0 6060.9 4372.4 4587.3 4588.6 4598.7 4601.8 4450.2 4517.0 4575.7 4605.2 4619.1 4501.9 4510.9 4515.8 4523.2 4561.3 4566.2 4567.0 4572.7 4573.3 4587.4 3981.2 3983.0 3983.4 3995.1 4003.8 5615.6 5751.9 5756.6 5765.7 5770.4 5302.6 5302.6 5319.6 5323.4 5324.3 6414.1 6431.3 6437.9 6438.8 6445.3 4315.9 4392.9 4409.1 4413.2 4426.5 6603.3 6670.8 6671.4 6675.9 6687.6 4369.6 4375.6 4376.3 4378.5 4383.4 4422.6 4425.6 4428.6 4430.7 4438.4 5135.1 5205.6 5282.4 5286.4 5293.1 6433.1 6433.5 6438.1 6440.4 6443.2 1567.9 1601.2 1606.3 1607.0 1607.1 1023.3 1025.4 1043.5 1044.1 1049.2 6143.6 6252.9 6261.3 6269.4 6275.3 6502.6 6545.8 6663.3 6701.2 6708.3 6256.9 6264.5 6303.1 6329.5 6332.9 3611.6 3641.5 3647.9 3650.1 3650.4 6847.6 6973.3 7001.4 7008.8 7026.5 6893.2 6896.0 6904.1 6907.2 6913.5 6984.9 6992.0 7005.8 7008.6 7040.0 6569.5 6746.7 6755.2 6758.9 6760.3 6659.0 6668.4 6673.4 6686.6 6687.0 6911.1 7033.4 7036.4 7039.1 7042.0 4511.1 4522.3 4524.9 4527.0 4528.9 6724.8 6727.3 6737.0 6753.9 6756.7 6435.1 6488.1 6488.7 6499.0 6504.5 6371.2 6512.8 6518.2 6520.3 6525.5 6382.4 6396.1 6396.7 6408.8 6412.2 6460.7 6556.8 6557.7 6562.3 6569.9 6167.0 6259.1 6327.3 6374.7 6409.4 06:03:59 INFO - 2015-11-14 06:03:59,738 DEBUG : BROWSER_OUTPUT: 06:03:59 INFO - 2015-11-14 06:03:59,738 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13400.42 Median:45712.20 stddev:15722.89 (34.4%) stddev-sans-first:15738.18 06:03:59 INFO - 2015-11-14 06:03:59,738 DEBUG : BROWSER_OUTPUT: Values: 724.4 735.7 760.4 777.6 796.2 14242.6 14278.2 14533.3 14561.4 14580.9 13566.9 13619.8 13635.7 13648.8 13653.7 688.6 694.1 803.4 820.2 822.1 807.6 815.7 819.0 820.4 822.0 859.9 862.7 864.3 864.3 864.4 723.0 726.0 853.8 855.5 869.5 640.9 641.9 642.1 642.7 644.1 13490.7 13592.4 13593.3 13601.7 13603.9 12242.1 12477.9 12530.6 12614.0 12687.4 10184.0 10440.4 10720.2 10925.0 10957.1 3236.6 3275.7 3307.8 3332.6 3338.0 42538.0 42627.6 42804.0 42854.8 42942.8 7723.3 7880.2 7906.7 7909.8 7948.8 12458.5 12469.1 12564.2 12578.6 12586.2 6996.9 7082.4 7111.6 7130.6 7231.8 4465.4 4494.9 4501.6 4506.3 4506.7 2718.7 2735.8 2741.0 2745.5 2746.4 430.1 433.9 438.5 447.8 448.7 618.4 634.9 676.8 678.2 682.7 8622.4 8680.8 8752.7 8829.4 9051.0 536.6 540.4 628.8 690.0 704.4 3998.7 4028.3 4138.3 4157.1 4163.5 56153.4 56404.7 56519.7 59130.7 59916.4 51220.5 51761.5 52134.0 52212.2 53512.2 45471.1 45953.3 46005.5 46361.5 46960.8 8616.5 8674.3 8854.7 8965.7 9017.5 33862.8 33978.3 34061.7 34879.5 35180.5 43233.6 44894.0 44959.6 45059.8 45403.8 6916.1 7086.5 7523.4 7622.2 7829.7 12159.4 12290.8 12313.4 12338.3 12706.2 11227.9 11641.4 11904.6 11937.5 12071.3 11306.5 11782.4 11855.5 11917.5 12111.1 11152.2 11239.1 11331.9 11496.9 11606.5 9547.4 9563.0 9722.6 9941.5 9959.8 8480.3 9127.9 9288.5 9704.3 9755.7 06:03:59 INFO - 2015-11-14 06:03:59,738 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:03:59 INFO - 2015-11-14 06:03:59,738 DEBUG : BROWSER_OUTPUT: 06:04:00 INFO - 2015-11-14 06:04:00,453 INFO : Browser exited with error code: 0 06:04:00 INFO - 2015-11-14 06:04:00,474 INFO : Completed test dromaeo_css (00:18:31) 06:04:00 INFO - 2015-11-14 06:04:00,474 INFO : Starting test kraken 06:04:00 INFO - 2015-11-14 06:04:00,475 DEBUG : operating with platform_type : linux_ 06:04:00 INFO - 2015-11-14 06:04:00,475 INFO : Initialising browser for kraken test... 06:04:00 INFO - 2015-11-14 06:04:00,481 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIF6L2k/profile http://localhost:52083/getInfo.html 06:04:04 INFO - 2015-11-14 06:04:04,524 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:04:04 INFO - 2015-11-14 06:04:04,524 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:04:04 INFO - 2015-11-14 06:04:04,524 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:04:04 INFO - 2015-11-14 06:04:04,524 DEBUG : BROWSER_OUTPUT: __metrics 06:04:04 INFO - 2015-11-14 06:04:04,686 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:04:05 INFO - 2015-11-14 06:04:05,900 INFO : Browser initialized. 06:04:05 INFO - 2015-11-14 06:04:05,901 INFO : Running cycle 1/1 for kraken test... 06:04:05 INFO - 2015-11-14 06:04:05,901 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIF6L2k/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:04:17 INFO - 2015-11-14 06:04:17,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 140836864 06:04:17 INFO - 2015-11-14 06:04:17,633 DEBUG : BROWSER_OUTPUT: 06:04:20 INFO - 2015-11-14 06:04:20,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52083/tests/kraken/driver.html?testName=audio-beat-detection) 06:04:20 INFO - 2015-11-14 06:04:20,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 182087680 06:04:20 INFO - 2015-11-14 06:04:20,669 DEBUG : BROWSER_OUTPUT: 06:04:23 INFO - 2015-11-14 06:04:23,286 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52083/tests/kraken/driver.html?testName=audio-dft) 06:04:23 INFO - 2015-11-14 06:04:23,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 169820160 06:04:23 INFO - 2015-11-14 06:04:23,853 DEBUG : BROWSER_OUTPUT: 06:04:26 INFO - 2015-11-14 06:04:26,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52083/tests/kraken/driver.html?testName=audio-fft) 06:04:27 INFO - 2015-11-14 06:04:27,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 149540864 06:04:27 INFO - 2015-11-14 06:04:27,260 DEBUG : BROWSER_OUTPUT: 06:04:29 INFO - 2015-11-14 06:04:29,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52083/tests/kraken/driver.html?testName=audio-oscillator) 06:04:29 INFO - 2015-11-14 06:04:29,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 152993792 06:04:29 INFO - 2015-11-14 06:04:29,812 DEBUG : BROWSER_OUTPUT: 06:04:31 INFO - 2015-11-14 06:04:31,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52083/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:04:32 INFO - 2015-11-14 06:04:32,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 155525120 06:04:32 INFO - 2015-11-14 06:04:32,532 DEBUG : BROWSER_OUTPUT: 06:04:35 INFO - 2015-11-14 06:04:35,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52083/tests/kraken/driver.html?testName=imaging-darkroom) 06:04:35 INFO - 2015-11-14 06:04:35,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 156278784 06:04:35 INFO - 2015-11-14 06:04:35,983 DEBUG : BROWSER_OUTPUT: 06:04:39 INFO - 2015-11-14 06:04:39,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52083/tests/kraken/driver.html?testName=imaging-desaturate) 06:04:39 INFO - 2015-11-14 06:04:39,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 156651520 06:04:39 INFO - 2015-11-14 06:04:39,977 DEBUG : BROWSER_OUTPUT: 06:04:42 INFO - 2015-11-14 06:04:42,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52083/tests/kraken/driver.html?testName=json-parse-financial) 06:04:43 INFO - 2015-11-14 06:04:43,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 155381760 06:04:43 INFO - 2015-11-14 06:04:43,324 DEBUG : BROWSER_OUTPUT: 06:04:44 INFO - 2015-11-14 06:04:44,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52083/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:04:45 INFO - 2015-11-14 06:04:45,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 163934208 06:04:45 INFO - 2015-11-14 06:04:45,449 DEBUG : BROWSER_OUTPUT: 06:04:47 INFO - 2015-11-14 06:04:47,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52083/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:04:47 INFO - 2015-11-14 06:04:47,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 164601856 06:04:47 INFO - 2015-11-14 06:04:47,811 DEBUG : BROWSER_OUTPUT: 06:04:49 INFO - 2015-11-14 06:04:49,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52083/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:04:50 INFO - 2015-11-14 06:04:50,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 174034944 06:04:50 INFO - 2015-11-14 06:04:50,455 DEBUG : BROWSER_OUTPUT: 06:04:52 INFO - 2015-11-14 06:04:52,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52083/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:04:53 INFO - 2015-11-14 06:04:53,422 DEBUG : BROWSER_OUTPUT: RSS: Main: 180686848 06:04:53 INFO - 2015-11-14 06:04:53,422 DEBUG : BROWSER_OUTPUT: 06:04:55 INFO - 2015-11-14 06:04:55,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52083/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:04:56 INFO - 2015-11-14 06:04:56,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 179564544 06:04:56 INFO - 2015-11-14 06:04:56,522 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52083/tests/kraken/driver.html?testName=ai-astar) 06:04:58 INFO - 2015-11-14 06:04:58,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 238948352 06:04:58 INFO - 2015-11-14 06:04:58,421 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,421 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:04:58 INFO - 2015-11-14 06:04:58,422 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:04:58 INFO - 2015-11-14 06:04:58,422 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:04:58 INFO - 2015-11-14 06:04:58,423 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:04:58 INFO - 2015-11-14 06:04:58,423 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;104;110;111;111;100;110;112;110 06:04:58 INFO - 2015-11-14 06:04:58,423 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;124;149;172;126;147;152;125;166;127 06:04:58 INFO - 2015-11-14 06:04:58,423 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;163;160;160;160;161;161;161;162 06:04:58 INFO - 2015-11-14 06:04:58,423 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;85;94;84;72;73;106;92;71 06:04:58 INFO - 2015-11-14 06:04:58,424 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;136;89;90;90;138;89;91;134 06:04:58 INFO - 2015-11-14 06:04:58,424 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;110;109;110;108;109 06:04:58 INFO - 2015-11-14 06:04:58,424 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;146;145;147;147;145;145;145;144 06:04:58 INFO - 2015-11-14 06:04:58,424 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;95;95;96;95;95;96 06:04:58 INFO - 2015-11-14 06:04:58,424 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;57;57;56;58;58;56;65;55;55 06:04:58 INFO - 2015-11-14 06:04:58,425 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;66;67;67;68;67;66;67;66;70 06:04:58 INFO - 2015-11-14 06:04:58,425 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;86;84;93;85;85;88;90;87;87 06:04:58 INFO - 2015-11-14 06:04:58,425 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;116;122;127;119;117;125;118;121;115 06:04:58 INFO - 2015-11-14 06:04:58,425 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;140;149;150;149;140;148;150;147;138 06:04:58 INFO - 2015-11-14 06:04:58,425 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;66;67;66;66;66;72;66;67 06:04:58 INFO - 2015-11-14 06:04:58,425 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:04:58 INFO - 2015-11-14 06:04:58,425 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:04:58 INFO - 2015-11-14 06:04:58,425 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,906 06:04:58 INFO - 2015-11-14 06:04:58,426 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:04:58 INFO - 2015-11-14 06:04:58,426 DEBUG : BROWSER_OUTPUT: __startTimestamp1447509898420__endTimestamp 06:04:58 INFO - 2015-11-14 06:04:58,426 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,427 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:04:58 INFO - 2015-11-14 06:04:58,427 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:04:58 INFO - 2015-11-14 06:04:58,427 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,427 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.77 (3.4%) stddev-sans-first:3.97 06:04:58 INFO - 2015-11-14 06:04:58,427 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 104.0 110.0 111.0 111.0 100.0 110.0 112.0 110.0 06:04:58 INFO - 2015-11-14 06:04:58,428 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,428 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.50 Median:150.50 stddev:17.97 (11.9%) stddev-sans-first:18.48 06:04:58 INFO - 2015-11-14 06:04:58,428 DEBUG : BROWSER_OUTPUT: Values: 157.0 124.0 149.0 172.0 126.0 147.0 152.0 125.0 166.0 127.0 06:04:58 INFO - 2015-11-14 06:04:58,428 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,428 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 06:04:58 INFO - 2015-11-14 06:04:58,428 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 163.0 160.0 160.0 160.0 161.0 161.0 161.0 162.0 06:04:58 INFO - 2015-11-14 06:04:58,428 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,428 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.10 Median:78.50 stddev:12.18 (15.5%) stddev-sans-first:12.36 06:04:58 INFO - 2015-11-14 06:04:58,428 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 85.0 94.0 84.0 72.0 73.0 106.0 92.0 71.0 06:04:58 INFO - 2015-11-14 06:04:58,428 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,428 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.80 Median:90.00 stddev:22.25 (24.7%) stddev-sans-first:23.03 06:04:58 INFO - 2015-11-14 06:04:58,429 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 136.0 89.0 90.0 90.0 138.0 89.0 91.0 134.0 06:04:58 INFO - 2015-11-14 06:04:58,429 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,429 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:04:58 INFO - 2015-11-14 06:04:58,429 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 108.0 109.0 06:04:58 INFO - 2015-11-14 06:04:58,429 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,429 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 06:04:58 INFO - 2015-11-14 06:04:58,429 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 146.0 145.0 147.0 147.0 145.0 145.0 145.0 144.0 06:04:58 INFO - 2015-11-14 06:04:58,429 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,429 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:04:58 INFO - 2015-11-14 06:04:58,430 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 06:04:58 INFO - 2015-11-14 06:04:58,430 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,430 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.50 stddev:2.91 (5.1%) stddev-sans-first:3.05 06:04:58 INFO - 2015-11-14 06:04:58,430 DEBUG : BROWSER_OUTPUT: Values: 59.0 57.0 57.0 56.0 58.0 58.0 56.0 65.0 55.0 55.0 06:04:58 INFO - 2015-11-14 06:04:58,430 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,430 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 06:04:58 INFO - 2015-11-14 06:04:58,431 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 67.0 67.0 68.0 67.0 66.0 67.0 66.0 70.0 06:04:58 INFO - 2015-11-14 06:04:58,431 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,431 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:2.69 (3.1%) stddev-sans-first:2.82 06:04:58 INFO - 2015-11-14 06:04:58,431 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 84.0 93.0 85.0 85.0 88.0 90.0 87.0 87.0 06:04:58 INFO - 2015-11-14 06:04:58,431 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,432 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:120.50 stddev:3.86 (3.2%) stddev-sans-first:4.09 06:04:58 INFO - 2015-11-14 06:04:58,432 DEBUG : BROWSER_OUTPUT: Values: 120.0 116.0 122.0 127.0 119.0 117.0 125.0 118.0 121.0 115.0 06:04:58 INFO - 2015-11-14 06:04:58,432 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,432 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.60 Median:148.50 stddev:4.60 (3.1%) stddev-sans-first:4.87 06:04:58 INFO - 2015-11-14 06:04:58,432 DEBUG : BROWSER_OUTPUT: Values: 145.0 140.0 149.0 150.0 149.0 140.0 148.0 150.0 147.0 138.0 06:04:58 INFO - 2015-11-14 06:04:58,433 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2015-11-14 06:04:58,433 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.50 stddev:1.85 (2.8%) stddev-sans-first:1.96 06:04:58 INFO - 2015-11-14 06:04:58,433 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 66.0 67.0 66.0 66.0 66.0 72.0 66.0 67.0 06:04:58 INFO - 2015-11-14 06:04:58,433 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:04:58 INFO - 2015-11-14 06:04:58,433 DEBUG : BROWSER_OUTPUT: 06:04:59 INFO - 2015-11-14 06:04:59,245 INFO : Browser exited with error code: 0 06:04:59 INFO - 2015-11-14 06:04:59,297 INFO : Completed test kraken (00:00:58) 06:04:59 INFO - 2015-11-14 06:04:59,297 INFO : Starting test v8_7 06:04:59 INFO - 2015-11-14 06:04:59,297 DEBUG : operating with platform_type : linux_ 06:04:59 INFO - 2015-11-14 06:04:59,297 INFO : Initialising browser for v8_7 test... 06:04:59 INFO - 2015-11-14 06:04:59,303 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpneVjmY/profile http://localhost:52083/getInfo.html 06:05:03 INFO - 2015-11-14 06:05:03,070 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:05:03 INFO - 2015-11-14 06:05:03,070 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:05:03 INFO - 2015-11-14 06:05:03,070 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:05:03 INFO - 2015-11-14 06:05:03,070 DEBUG : BROWSER_OUTPUT: __metrics 06:05:03 INFO - 2015-11-14 06:05:03,179 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:05:04 INFO - 2015-11-14 06:05:04,422 INFO : Browser initialized. 06:05:04 INFO - 2015-11-14 06:05:04,422 INFO : Running cycle 1/1 for v8_7 test... 06:05:04 INFO - 2015-11-14 06:05:04,422 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpneVjmY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:05:16 INFO - 2015-11-14 06:05:16,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 140857344 06:05:16 INFO - 2015-11-14 06:05:16,157 DEBUG : BROWSER_OUTPUT: 06:05:37 INFO - 2015-11-14 06:05:37,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52083/tests/v8_7/run.html (next: http://localhost:52083/tests/v8_7/run.html) 06:05:37 INFO - 2015-11-14 06:05:37,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 601972736 06:05:37 INFO - 2015-11-14 06:05:37,801 DEBUG : BROWSER_OUTPUT: 06:05:37 INFO - 2015-11-14 06:05:37,801 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:05:37 INFO - 2015-11-14 06:05:37,802 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:05:37 INFO - 2015-11-14 06:05:37,802 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:05:37 INFO - 2015-11-14 06:05:37,802 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:05:37 INFO - 2015-11-14 06:05:37,802 DEBUG : BROWSER_OUTPUT: |0;Richards;165.53550736633008 06:05:37 INFO - 2015-11-14 06:05:37,802 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.06171162429652 06:05:37 INFO - 2015-11-14 06:05:37,802 DEBUG : BROWSER_OUTPUT: |2;Encrypt;288.6002886002886 06:05:37 INFO - 2015-11-14 06:05:37,802 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5015 06:05:37 INFO - 2015-11-14 06:05:37,803 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1101.3215859030836 06:05:37 INFO - 2015-11-14 06:05:37,803 DEBUG : BROWSER_OUTPUT: |5;Earley;792.3930269413629 06:05:37 INFO - 2015-11-14 06:05:37,803 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 06:05:37 INFO - 2015-11-14 06:05:37,803 DEBUG : BROWSER_OUTPUT: |7;RegExp;25948.71794871795 06:05:37 INFO - 2015-11-14 06:05:37,803 DEBUG : BROWSER_OUTPUT: |8;Splay;667.989417989418 06:05:37 INFO - 2015-11-14 06:05:37,804 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 06:05:37 INFO - 2015-11-14 06:05:37,804 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:05:37 INFO - 2015-11-14 06:05:37,804 DEBUG : BROWSER_OUTPUT: __startTimestamp1447509937799__endTimestamp 06:05:37 INFO - 2015-11-14 06:05:37,804 DEBUG : BROWSER_OUTPUT: 06:05:37 INFO - 2015-11-14 06:05:37,804 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:05:37 INFO - 2015-11-14 06:05:37,804 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:05:37 INFO - 2015-11-14 06:05:37,805 DEBUG : BROWSER_OUTPUT: 06:05:37 INFO - 2015-11-14 06:05:37,805 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.54 Median:165.54 stddev:0.00 (0.0%) 06:05:37 INFO - 2015-11-14 06:05:37,805 DEBUG : BROWSER_OUTPUT: Values: 165.5 06:05:37 INFO - 2015-11-14 06:05:37,805 DEBUG : BROWSER_OUTPUT: 06:05:37 INFO - 2015-11-14 06:05:37,805 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.06 Median:194.06 stddev:0.00 (0.0%) 06:05:37 INFO - 2015-11-14 06:05:37,805 DEBUG : BROWSER_OUTPUT: Values: 194.1 06:05:37 INFO - 2015-11-14 06:05:37,806 DEBUG : BROWSER_OUTPUT: 06:05:37 INFO - 2015-11-14 06:05:37,807 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:288.60 Median:288.60 stddev:0.00 (0.0%) 06:05:37 INFO - 2015-11-14 06:05:37,807 DEBUG : BROWSER_OUTPUT: Values: 288.6 06:05:37 INFO - 2015-11-14 06:05:37,807 DEBUG : BROWSER_OUTPUT: 06:05:37 INFO - 2015-11-14 06:05:37,807 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5015.00 Median:5015.00 stddev:0.00 (0.0%) 06:05:37 INFO - 2015-11-14 06:05:37,807 DEBUG : BROWSER_OUTPUT: Values: 5015.0 06:05:37 INFO - 2015-11-14 06:05:37,808 DEBUG : BROWSER_OUTPUT: 06:05:37 INFO - 2015-11-14 06:05:37,808 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1101.32 Median:1101.32 stddev:0.00 (0.0%) 06:05:37 INFO - 2015-11-14 06:05:37,808 DEBUG : BROWSER_OUTPUT: Values: 1101.3 06:05:37 INFO - 2015-11-14 06:05:37,808 DEBUG : BROWSER_OUTPUT: 06:05:37 INFO - 2015-11-14 06:05:37,808 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 06:05:37 INFO - 2015-11-14 06:05:37,808 DEBUG : BROWSER_OUTPUT: Values: 792.4 06:05:37 INFO - 2015-11-14 06:05:37,808 DEBUG : BROWSER_OUTPUT: 06:05:37 INFO - 2015-11-14 06:05:37,809 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 06:05:37 INFO - 2015-11-14 06:05:37,809 DEBUG : BROWSER_OUTPUT: Values: 12120.5 06:05:37 INFO - 2015-11-14 06:05:37,809 DEBUG : BROWSER_OUTPUT: 06:05:37 INFO - 2015-11-14 06:05:37,809 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25948.72 Median:25948.72 stddev:0.00 (0.0%) 06:05:37 INFO - 2015-11-14 06:05:37,809 DEBUG : BROWSER_OUTPUT: Values: 25948.7 06:05:37 INFO - 2015-11-14 06:05:37,809 DEBUG : BROWSER_OUTPUT: 06:05:37 INFO - 2015-11-14 06:05:37,809 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:667.99 Median:667.99 stddev:0.00 (0.0%) 06:05:37 INFO - 2015-11-14 06:05:37,809 DEBUG : BROWSER_OUTPUT: Values: 668.0 06:05:37 INFO - 2015-11-14 06:05:37,809 DEBUG : BROWSER_OUTPUT: 06:05:37 INFO - 2015-11-14 06:05:37,809 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 06:05:37 INFO - 2015-11-14 06:05:37,809 DEBUG : BROWSER_OUTPUT: Values: 4845.4 06:05:37 INFO - 2015-11-14 06:05:37,809 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:05:37 INFO - 2015-11-14 06:05:37,809 DEBUG : BROWSER_OUTPUT: 06:05:38 INFO - 2015-11-14 06:05:38,610 INFO : Browser exited with error code: 0 06:05:38 INFO - 2015-11-14 06:05:38,627 INFO : Completed test v8_7 (00:00:39) 06:05:38 INFO - 2015-11-14 06:05:38,811 INFO : Completed test suite (00:20:10) 06:05:38 INFO - 2015-11-14 06:05:38,811 DEBUG : Working with test: dromaeo_css 06:05:38 INFO - 2015-11-14 06:05:38,811 DEBUG : Generating results file: dromaeo_css 06:05:38 INFO - 2015-11-14 06:05:38,813 DEBUG : Working with test: kraken 06:05:38 INFO - 2015-11-14 06:05:38,813 DEBUG : Generating results file: kraken 06:05:38 INFO - 2015-11-14 06:05:38,813 INFO : javascript benchmark 06:05:38 INFO - 2015-11-14 06:05:38,814 DEBUG : Working with test: v8_7 06:05:38 INFO - 2015-11-14 06:05:38,814 DEBUG : Generating results file: v8_7 06:05:38 INFO - 2015-11-14 06:05:38,814 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:05:38 INFO - 2015-11-14 06:05:38,869 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:05:38 INFO - 2015-11-14 06:05:38,870 DEBUG : process_Request line: dromaeo_css 6657.27 graph.html#tests=[[72,1,35]] 06:05:38 INFO - 2015-11-14 06:05:38,870 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:05:38 INFO - 2015-11-14 06:05:38,912 DEBUG : process_Request line: kraken 1494.30 graph.html#tests=[[232,1,35]] 06:05:38 INFO - 2015-11-14 06:05:38,912 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:05:39 INFO - 2015-11-14 06:05:39,015 DEBUG : process_Request line: v8_7 20789.81 graph.html#tests=[[230,1,35]] 06:05:39 INFO - 2015-11-14 06:05:39,017 INFO : javascript benchmark 06:05:39 INFO - 2015-11-14 06:05:39,021 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [347.86259427526113, 351.1677324740366, 351.8135388244231, 352.89942366425566, 353.79126315473866, 14422.278886055708, 14498.442336644086, 16667.916660416697, 17247.3101075957, 19137.138828752704, 15985.760213596805, 16164.676706465863, 16369.181540922966, 16768.66462670749, 16829.242684079214, 5337.67973921564, 5479.342478902538, 5480.424555421683, 5481.616286859921, 5483.424240454755, 4022.376531637586, 4119.0, 5424.5117939385445, 5473.452654734535, 5902.144189092579, 5964.343922168558, 5992.10118482229, 6024.48791852693, 6028.788992385267, 6039.969800150993, 4516.616087632555, 4626.167289887819, 4631.60631346336, 4633.884152896171, 5983.9102413463615, 3932.9016774580864, 3933.272344616255, 3939.172773717523, 3943.7239393242485, 3952.209558088365, 10640.042396184303, 10669.573217071307, 10679.145668346513, 10682.359058456439, 11075.0, 1797.4787311679597, 1814.9818501814946, 1982.33591746765, 1982.474644219283, 2106.6418708819538, 9026.684066057656, 9398.154166125014, 9441.858372124423, 9519.857202141973, 9596.90403095974, 1562.6015366081576, 1602.9427157318562, 1674.9413770518095, 1692.9068901210428, 1706.6074802795301, 60339.698301508215, 60891.39108608946, 61373.69313153451, 63077.0, 63711.68144159296, 6720.798376048726, 6764.255931847493, 6780.864382712417, 6803.115594972622, 6809.216940051859, 7991.560464174526, 8006.199380062064, 8026.916366290593, 8027.117017128111, 8049.315808156372, 5303.36359636846, 5350.0, 5464.562834973192, 5524.06090964537, 5557.083081291623, 5754.251947246831, 5754.280714910637, 5798.159266906275, 5808.273965754281, 5829.387914269026, 3102.0383681058943, 3113.5952326197903, 3121.562981182636, 3137.9686203137676, 3168.556402103707, 1087.3856271206744, 1089.226649079147, 1128.5711429656678, 1137.2664631312923, 1149.6608500492375, 439.701003317747, 445.5010388364987, 448.4685647507714, 450.4189595421869, 459.69889722231994, 10711.625093121704, 10893.618723344645, 10940.671779846618, 11009.724756880982, 11011.28426652265, 448.84514842379326, 459.4348950790546, 460.8041582327497, 461.7714231455451, 465.6600681502454, 5835.824925252249, 6132.0, 6154.846128846814, 6173.32093469718, 6230.127782110508, 541189.0, 549087.0, 551823.0, 562802.0, 570288.0, 75763.0, 80519.0, 81739.0, 82209.58895205485, 82325.0, 496.2853490972987, 508.3112382721433, 509.92351147328196, 510.77015343095013, 511.48595661360093, 10568.630097946534, 11075.667729968114, 11112.777744445228, 11145.944270278922, 11179.552817887194, 35773.0, 36443.27113457769, 36451.27097457983, 36634.0, 37050.44424333691, 46451.53548464472, 48757.268640969705, 49351.0, 50152.749236253585, 50537.74731126321, 6478.676066196577, 6491.091247225487, 6544.0, 6554.770583029571, 6575.967120164369, 11732.648020559396, 11756.23584467007, 11877.406129693309, 11946.701332466759, 11949.820752688891, 9891.703248902544, 9904.405735655884, 9986.101250887456, 10182.0, 10398.480075996322, 10034.147097496794, 10307.94846025765, 10320.380777153396, 10441.477926103513, 10467.685969420929, 10392.844107338246, 10398.22013349017, 10464.215183861088, 10469.895301046892, 10667.413292269, 6419.454346380423, 6499.1876015498065, 6592.077109204619, 6599.208095028627, 6606.405423511907, 10129.088382045651, 10189.0, 10439.686809395731, 10475.214358922958, 10538.0], "dojo.html": [3158.778885478017, 3210.293735378216, 3245.9612923864356, 3249.4475939090366, 3281.27811881386, 5143.511366420194, 5237.92622512385, 5347.946520534793, 5383.138697808351, 5400.513953744167, 5293.126634105368, 5331.946680533193, 5339.199120131982, 5503.532199763025, 5639.464250896158, 4888.877778055541, 4943.6539442239055, 4981.078500477405, 5027.673201241926, 5041.8487445376695, 4942.6293028022865, 4988.401391832985, 5015.022070696215, 5031.169856973595, 5035.295058691786, 4696.53034696531, 4807.807687692488, 4844.2733589961435, 4961.776720047606, 4966.726830024347, 4884.780184891689, 4896.045271172123, 4900.705957642553, 4903.436104847952, 4936.6297527685565, 4864.635152363551, 4886.584640305578, 4902.681325713817, 4909.950900491021, 4956.033573453142, 5096.79612815487, 5169.483051694838, 5213.2701421800975, 5273.367195936512, 5334.413214546396, 5726.627769194989, 5730.541556675456, 5734.827955161351, 5738.454846789548, 5738.885222295531, 5683.943160568383, 5734.827955161351, 5738.167965645, 5747.540196784247, 5761.711914404263, 5345.412004679482, 5424.430434804368, 5446.019716451037, 5474.671519708831, 5488.368837583649, 5911.40885911414, 5917.349091599921, 5923.851903702356, 5929.762809487572, 5969.492593129633, 5717.714114294268, 5758.74085666146, 5763.394843541368, 5764.827055188267, 5825.621334613236, 5808.506276966421, 5904.61619994699, 5907.616004959664, 5913.793017244376, 5949.970250148722, 5752.194692743019, 5758.712064396847, 5758.971205144031, 5761.251037365116, 5763.279590051244, 5590.301212348457, 5663.461971112738, 5734.340550836624, 5739.311282646109, 5755.3381361144, 4460.643148548108, 4462.397576327219, 4487.887802804956, 4492.775361231926, 4499.955000449953, 3965.2267807777207, 3965.78188199646, 3986.0433495961342, 3990.182012687392, 4014.016565941363, 5314.73426328682, 5402.864928376744, 5420.620556561082, 5449.291592093082, 5488.91766623501, 5691.971540142273, 5714.314282286152, 5715.714214289269, 5736.913946290809, 5778.711064446761, 5370.543503802142, 5378.677279363251, 5383.16560933056, 5388.245645609618, 5417.918731219035, 4800.423949126127, 4883.267509873547, 5008.12357837377, 5021.14640511114, 5119.667221630582, 6091.878162436727, 6095.268567771807, 6095.451409373178, 6100.359462256488, 6111.0, 5831.679257640701, 5839.299284085937, 5845.941540584539, 5846.94153058464, 5847.619904706181, 5815.680137592473, 5912.290525137011, 5933.495652869555, 5980.19267398913, 6008.188894499187, 5669.5180909621495, 5683.60214784961, 5696.373398926197, 5698.088305871206, 5710.371859095413, 5700.458456446631, 5768.394318596487, 5769.884602308014, 5774.364819869895, 5786.94213057864, 5619.100943848965, 5640.492355688008, 5740.942590574208, 5748.109043098327, 5765.8558536036935, 5713.514351280188, 5753.683547404933, 5757.0, 5758.856028599319, 5773.3072031356505, 5370.543503802221, 5476.069068258326, 5636.915446268227, 5663.1788390682295, 5668.26312579362, 5653.858653533694, 5753.884922301614, 5778.191053252632, 5799.623024503394, 5801.216835727123, 5485.561155107662, 5540.695261760642, 5542.8337149885565, 5543.3902270751, 5551.111822108443], "mootools.html": [1364.7270545890824, 1376.8778445566868, 1383.391307824557, 1697.5331783759468, 1759.3666280139148, 6737.427318677912, 7644.159142494328, 7785.922140778604, 7807.765767026984, 7809.0238720159905, 7599.620018999056, 7712.0, 7731.381489480842, 7735.033120859893, 7738.690452381912, 2240.0367841828006, 2247.3932038349635, 2250.437390652337, 2252.5832720946596, 2252.68462415262, 2232.5423288225875, 2234.575430668176, 2245.4610893385634, 2254.7068881045443, 2271.8977646005887, 2202.2952655150357, 2205.5699138667965, 2222.388843068153, 2225.310153852311, 2225.944351391212, 2221.7222847144108, 2225.265662331427, 2248.7976082152604, 2251.2570851618925, 2251.5609456156058, 2250.8199344052437, 2264.30938563738, 2264.615015447378, 2267.648514480258, 2269.977300226993, 6792.524523283372, 6924.688389022506, 7686.154523002465, 7718.729844455417, 7725.343345815612, 4372.737635741833, 4483.910321793546, 4496.100779844011, 4503.954960450386, 4506.864794056183, 3066.632004159515, 3085.3366526196974, 3130.780845340827, 3134.310451700645, 3220.677932206784, 936.8126374725082, 938.7653086728318, 945.0738276489011, 964.2719746591349, 986.2208855004537, 10497.4226417547, 10528.947355263252, 10567.207459440497, 10600.0, 10621.893781062168, 4059.65492933104, 4114.773687447159, 4159.563245859141, 4168.916621667549, 4191.8532851350055, 8228.25945664893, 8252.958735206286, 8254.339652827759, 8261.752147435587, 8266.958665206635, 4463.62059224963, 4486.0, 4487.304467807495, 4498.212812757754, 4499.842505512292, 4131.690123240769, 4132.090939993197, 4134.979325103355, 4139.151473947833, 4141.668666506672, 3359.983200083984, 3414.8804791832167, 3415.7267418606452, 3422.0418282880833, 3443.0359499340225, 1030.160419258302, 1037.4760745823312, 1038.1746511523356, 1052.752603138262, 1058.7035630023606, 1278.8209650648917, 1306.79744639581, 1316.2694704439127, 1317.157019507516, 1334.1394800353912, 7222.3860971817985, 7456.32893039629, 7475.514091584138, 7476.514026588255, 7477.70089196426, 438.38625923707065, 445.0564802618405, 446.3037661248463, 447.42729306487746, 458.2301733088443, 5430.375506816687, 5606.859828504238, 5779.306483222041, 5834.416558344216, 5840.737166827418, 8559.529225892637, 8780.165884240987, 8795.384323097322, 8843.60203790831, 8874.556272186494, 8432.578371081545, 8589.957050214834, 8689.348298877609, 9251.121143491358, 9344.2524598032, 7204.459665525002, 7307.488475806643, 7364.2635736427, 7372.668229929666, 7381.040464739657, 7187.2453392393045, 7259.455540834353, 7266.091738532684, 7274.345308922222, 7282.890756638549, 8044.718434854752, 8232.588370581327, 8265.46274492156, 8282.378821588285, 8337.291330236998, 8326.750197494084, 8454.704085356983, 8467.153284671484, 8477.067522572635, 8676.696315628922, 6534.967325163344, 6596.7031483584315, 6597.1423714916755, 6599.109120268702, 6614.6361950093205, 7494.850102998019, 7524.811879703051, 7575.7348492804695, 7587.658555364911, 7597.2022937590755, 6865.141857267841, 6902.516823822284, 7095.432365410651, 7211.314925082109, 7226.89159662616, 6843.281455447106, 6926.826829329307, 6947.3747362737595, 7043.964780176067, 7064.894026589503, 7031.507794454339, 7080.114985626797, 7120.359167674934, 7168.068151140527, 7172.139343278631, 6495.447886929664, 6574.441172500391, 6605.240397354366, 6608.504362172953, 6645.435138013323, 6639.203295604559, 6668.83327916806, 6679.599224046573, 6683.231428385603, 6686.5653732507235], "ext.html": [571.45997032804, 604.0335463258785, 607.7022259093044, 620.9689515524228, 674.787441955784, 31252.374952500937, 32068.67931320686, 32096.0, 40893.18213635725, 41396.37905431421, 43732.56267437325, 44199.33700994487, 44243.77878110613, 44313.0, 44352.0, 7679.57762323072, 8650.783730406743, 8841.38110332277, 8842.204201621853, 8844.73465796027, 7712.0, 10118.291719579633, 10314.1748660107, 10319.742006449824, 10320.690379288595, 10080.143187829044, 10131.797364052714, 10203.0, 10206.081452669257, 10220.74448138795, 7800.492967957065, 7929.920700792976, 9920.90079099207, 10034.849477257847, 10513.158947284199, 10210.642627508076, 10382.896171038268, 10410.323328983592, 10411.947940260327, 10418.0, 39835.60164398348, 40223.59776402228, 40297.79851100755, 40319.79840100781, 40338.0, 3210.0, 3248.5614442050255, 3402.897913062612, 3683.171286460525, 3704.685101766353, 30072.0, 30727.846360768275, 30828.845855770578, 30837.825907979604, 31920.521192182136, 3511.877084302037, 3532.9116772080647, 3533.787972721619, 3544.9113772155642, 3573.249617580311, 297114.0, 297507.5124624385, 297828.0, 298124.0, 298318.0, 57230.427695723345, 58070.0, 59858.0, 60204.0, 65184.696306073616, 61848.0, 62192.37807621956, 62446.0, 62580.374196258366, 62679.37320626827, 16165.353385864433, 16324.265408056666, 16346.0, 16350.264238109314, 16369.0, 12609.49562017509, 12665.366731663564, 12689.048321375934, 12697.809532857014, 12700.110992230455, 19686.70469942952, 19992.400227993185, 20021.899890500456, 20078.89960550188, 20103.597928041356, 7686.692532298757, 7889.526628402315, 7908.367330613537, 7960.800979975431, 8080.39397045224, 887.924526415249, 892.2594246775161, 938.863864739609, 1046.7173863056933, 1069.1233188785277, 28825.85587072093, 29529.26176845596, 29691.85154074259, 30147.246318841764, 30203.546946795817, 1014.5434554450379, 1034.6947650443137, 1038.771470276538, 1050.7373156710823, 1089.6191820871422, 14170.787438188436, 14394.496192633416, 14529.564113076625, 14705.117692938458, 14726.0, 343526.0, 350402.0, 350691.20507166954, 351092.0, 351267.0, 51456.48543514592, 51535.742321288904, 51764.0, 51888.74055629773, 51895.48104518982, 1271.5613113475836, 1288.1112032697408, 1289.5099862052548, 1289.8194252804803, 1317.92751398674, 21014.789852101283, 29906.401871962873, 30991.69008309888, 31120.688793111778, 31444.213894652818, 48909.51090489049, 49073.5092649069, 49294.50705492899, 49371.0, 49422.50577494179, 277647.0, 279223.0, 280349.0, 298480.0, 303486.0, 31025.8448707755, 31324.373512530077, 31339.68660313459, 31718.0, 31833.5224971621, 39252.803735981135, 41386.379204312565, 41457.1708565833, 41677.79161104175, 42466.0, 35318.117047074025, 35430.114247143, 35435.291294173454, 35555.46666800052, 36649.0, 35475.64524354723, 36499.81750091232, 36570.26859462849, 36677.799332040166, 36698.26603467969, 35884.28231435409, 36847.44728829123, 37268.0, 37385.81307093556, 37416.43875341817, 30066.0, 32751.836240819597, 33242.33515329728, 33302.16744581405, 33321.33357332792, 24943.0, 25103.74896251014, 25235.495290093728, 25247.747522525275, 25563.23310300694], "prototype.html": [299.0713833546837, 303.5371059134819, 306.98618562164694, 310.9751219902408, 312.5639732573062, 5991.940080599193, 6059.757609695613, 6071.271447426309, 6091.6649584272955, 6203.038529027996, 5876.970615146929, 6032.788852390167, 6033.0, 6056.0, 6060.909086363708, 4372.366006928994, 4587.334836448729, 4588.587027167554, 4598.65510086744, 4601.769911504428, 4450.176717307292, 4517.0, 4575.725456472605, 4605.217113090765, 4619.122366750306, 4501.909961800762, 4510.909781804362, 4515.841945531907, 4523.163214805255, 4561.270196768518, 4566.246569316058, 4567.0, 4572.725636461823, 4573.291139873309, 4587.449506059261, 3981.163955569334, 3983.0440694233466, 3983.40248962655, 3995.06116062725, 4003.799810009488, 5615.578831587606, 5751.856203594902, 5756.568257380672, 5765.711714414305, 5770.394108618577, 5302.602304827154, 5302.602304827154, 5319.5744340452675, 5323.387810401815, 5324.281222035014, 6414.1340918976275, 6431.324710905381, 6437.935620643781, 6438.839029024265, 6445.291017988017, 4315.892102697458, 4392.934105988381, 4409.096135292258, 4413.249747542925, 4426.513083560806, 6603.306652801482, 6670.833229169261, 6671.366220209073, 6675.86648267032, 6687.598744075371, 4369.584889435499, 4375.584319489643, 4376.321670141133, 4378.540253273361, 4383.408239887574, 4422.601965823027, 4425.579569940851, 4428.645708343325, 4430.734155950653, 4438.356438316426, 5135.12702840518, 5205.583553315726, 5282.366116066097, 5286.444923283077, 5293.100172970604, 6433.131527243856, 6433.517486188554, 6438.098666186737, 6440.420362167334, 6443.226812782496, 1567.8588926996624, 1601.1513897634272, 1606.3414000259838, 1607.0, 1607.075931339461, 1023.2530252915265, 1025.379645314574, 1043.5408420295046, 1044.081208536483, 1049.1659130990881, 6143.631382117087, 6252.937470625327, 6261.311255761862, 6269.435750782452, 6275.309715931244, 6502.642354670444, 6545.770898018642, 6663.267040625527, 6701.195856497252, 6708.329167083252, 6256.874862502725, 6264.5301602380005, 6303.054541818764, 6329.493640508748, 6332.905006424908, 3611.638836116367, 3641.5448068991377, 3647.8905632831056, 3650.069232345788, 3650.4159334506353, 6847.554908930903, 6973.3375329343635, 7001.369876711018, 7008.789736307817, 7026.543274687129, 6893.207765980881, 6896.034555162281, 6904.067950826675, 6907.20567134786, 6913.481488888354, 6984.895226571605, 6991.965040174869, 7005.789826305219, 7008.649567521604, 7040.049593304941, 6569.507286953402, 6746.730130794714, 6755.223149337692, 6758.93241067583, 6760.323967603397, 6659.034440006269, 6668.399844014062, 6673.366030227121, 6686.632235226914, 6687.0, 6911.067005954333, 7033.366996970297, 7036.401905838061, 7039.120109986252, 7042.0493233412835, 4511.142882852248, 4522.253828118323, 4524.932126018047, 4527.0, 4528.864134075983, 6724.798256052326, 6727.293634168342, 6736.966315168393, 6753.932460675527, 6756.662166891734, 6435.06691529735, 6488.091667166695, 6488.70800813974, 6498.960166373357, 6504.544681872224, 6371.171747672773, 6512.837179070561, 6518.152640156749, 6520.250171230369, 6525.510586705921, 6382.36176382358, 6396.104545363746, 6396.744130234739, 6408.775692850728, 6412.1664183657695, 6460.709268082854, 6556.8360790980605, 6557.672116394257, 6562.34376562359, 6569.901451478136, 6167.0, 6259.061140828912, 6327.303996560283, 6374.681265936777, 6409.391107844747], "yui.html": [724.4059870905859, 735.7057177129147, 760.4486747108347, 777.6383981448625, 796.2236819101377, 14242.572722818331, 14278.214698191596, 14533.345999430025, 14561.417543298256, 14580.854191458095, 13566.864331356683, 13619.795703064437, 13635.659108522292, 13648.795268070988, 13653.72692546151, 688.6006116452446, 694.0803435448051, 803.4375936844218, 820.1593366799019, 822.1326500541926, 807.64059993303, 815.7389635316702, 818.9590520473982, 820.3601191070944, 822.01358369956, 859.8882145321099, 862.7239283429305, 864.3215076165211, 864.3387808326635, 864.4251572704144, 723.0491903147345, 726.0017475970541, 853.7737499562589, 855.495257797896, 869.5304535550795, 640.8974564069773, 641.9037144428327, 642.1138828416802, 642.6882961763541, 644.1336402538578, 13490.730185396334, 13592.38834252461, 13593.320333983262, 13601.659958501017, 13603.86396136036, 12242.081843861657, 12477.875221247852, 12530.561430349893, 12614.0, 12687.365631718378, 10184.0, 10440.425776582286, 10720.195985301056, 10925.0, 10957.06864916483, 3236.6277878044093, 3275.6724327567053, 3307.834608269577, 3332.6000879894327, 3337.9666203338143, 42538.0, 42627.57372426267, 42804.0, 42854.78572607148, 42942.78528607337, 7723.34351580122, 7880.172581878935, 7906.683732650745, 7909.841803164019, 7948.841023179504, 12458.501659933501, 12469.127161098817, 12564.183328083645, 12578.55975040869, 12586.24482531051, 6996.8950465743055, 7082.362587367162, 7111.644417779194, 7130.5721656699725, 7231.819204519929, 4465.37484752135, 4494.851099359895, 4501.639868810487, 4506.324051392252, 4506.684532082788, 2718.687350954626, 2735.7674597659025, 2741.040635777502, 2745.4509098180442, 2746.3546066674317, 430.1075268817217, 433.8828516300644, 438.46726227633576, 447.83653966302717, 448.66350237322007, 618.3723520626568, 634.8888944434706, 676.7766637009775, 678.1997243253008, 682.7098483144644, 8622.396432249683, 8680.782980425414, 8752.737417877473, 8829.38194326391, 9050.954745226232, 536.6163193316719, 540.3758658749151, 628.7547856336032, 690.0477341269117, 704.429412176139, 3998.7400818946676, 4028.254772867029, 4138.255114079434, 4157.1313898818435, 4163.521195062606, 56153.43846561482, 56404.71797641068, 56519.71740141273, 59130.70434647799, 59916.40083599108, 51220.487795121575, 51761.48238517567, 52134.0, 52212.21681674778, 53512.19731704028, 45471.090578188254, 45953.31070033952, 46005.539944600794, 46361.53638463572, 46960.765196174485, 8616.526091065052, 8674.349423793366, 8854.723752211723, 8965.686200982935, 9017.5233297302, 33862.83068584641, 33978.32043359168, 34061.65938340585, 34879.47680784739, 35180.472292916136, 43233.56766432421, 44894.0, 44959.55040449554, 45059.77470112628, 45403.77298113488, 6916.135483064617, 7086.50394472382, 7523.3981281498445, 7622.237776222333, 7829.7259595913865, 12159.392030398622, 12290.75418491643, 12313.44589493457, 12338.259704417764, 12706.174098683556, 11227.88772112301, 11641.359725214856, 11904.642860714192, 11937.522499100287, 12071.275723456622, 11306.4912078955, 11782.410879456163, 11855.466504007169, 11917.52329906794, 12111.091668125102, 11152.163587731115, 11239.100871930063, 11331.943340283246, 11496.885031149915, 11606.535738570363, 9547.42715437076, 9563.0, 9722.562484688064, 9941.453220072965, 9959.800803983735, 8480.321574274167, 9127.908720912706, 9288.489133097473, 9704.320697551104, 9755.707328780149]}, "summary": {"lowerIsBetter": false, "suite": 6657.26345809933, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6856.190868358783, "unit": "ms", "value": 6856.190868358783}, "dojo.html": {"lowerIsBetter": false, "filtered": 5335.547114077346, "unit": "ms", "value": 5335.547114077346}, "mootools.html": {"lowerIsBetter": false, "filtered": 4301.315724807619, "unit": "ms", "value": 4301.315724807619}, "ext.html": {"lowerIsBetter": false, "filtered": 18917.557525660886, "unit": "ms", "value": 18917.557525660886}, "prototype.html": {"lowerIsBetter": false, "filtered": 4826.017635711134, "unit": "ms", "value": 4826.017635711134}, "yui.html": {"lowerIsBetter": false, "filtered": 6059.2436351436745, "unit": "ms", "value": 6059.2436351436745}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-001"}, "testrun": {"date": 1447508728, "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": "20151114030404", "branch": "Firefox", "revision": "202b199b9fcf37a687bef882f2513e191f079622"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 161.0, 163.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 162.0], "ai-astar": [110.0, 110.0, 104.0, 110.0, 111.0, 111.0, 100.0, 110.0, 112.0, 110.0], "imaging-gaussian-blur": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 108.0, 109.0], "audio-beat-detection": [157.0, 124.0, 149.0, 172.0, 126.0, 147.0, 152.0, 125.0, 166.0, 127.0], "json-stringify-tinderbox": [67.0, 66.0, 67.0, 67.0, 68.0, 67.0, 66.0, 67.0, 66.0, 70.0], "stanford-crypto-pbkdf2": [145.0, 140.0, 149.0, 150.0, 149.0, 140.0, 148.0, 150.0, 147.0, 138.0], "json-parse-financial": [59.0, 57.0, 57.0, 56.0, 58.0, 58.0, 56.0, 65.0, 55.0, 55.0], "stanford-crypto-sha256-iterative": [67.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 72.0, 66.0, 67.0], "audio-fft": [72.0, 72.0, 85.0, 94.0, 84.0, 72.0, 73.0, 106.0, 92.0, 71.0], "imaging-darkroom": [145.0, 145.0, 146.0, 145.0, 147.0, 147.0, 145.0, 145.0, 145.0, 144.0], "stanford-crypto-ccm": [120.0, 116.0, 122.0, 127.0, 119.0, 117.0, 125.0, 118.0, 121.0, 115.0], "audio-oscillator": [90.0, 91.0, 136.0, 89.0, 90.0, 90.0, 138.0, 89.0, 91.0, 134.0], "stanford-crypto-aes": [86.0, 86.0, 84.0, 93.0, 85.0, 85.0, 88.0, 90.0, 87.0, 87.0], "imaging-desaturate": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1494.3, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 82.1, "unit": "ms", "value": 82.1}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 145.6, "unit": "ms", "value": 145.6}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.5, "unit": "ms", "value": 144.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 120.0, "unit": "ms", "value": 120.0}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.4, "unit": "ms", "value": 145.4}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 57.6, "unit": "ms", "value": 57.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.8, "unit": "ms", "value": 103.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.8, "unit": "ms", "value": 108.8}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.9, "unit": "ms", "value": 160.9}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.9, "unit": "ms", "value": 66.9}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.1, "unit": "ms", "value": 67.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.1, "unit": "ms", "value": 109.1}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 87.1, "unit": "ms", "value": 87.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.4, "unit": "ms", "value": 95.4}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-001"}, "testrun": {"date": 1447508728, "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": "20151114030404", "branch": "Firefox", "revision": "202b199b9fcf37a687bef882f2513e191f079622"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.06171162429652], "Encrypt": [288.6002886002886], "NavierStokes": [4845.410628019324], "Decrypt": [5015.0], "Splay": [667.989417989418], "Richards": [165.53550736633008], "RegExp": [25948.71794871795], "Earley": [792.3930269413629], "Boyer": [12120.481927710844], "RayTrace": [1101.3215859030836]}, "summary": {"lowerIsBetter": false, "suite": 20789.81093571455, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.70605400000017, "unit": "score", "value": 340.70605400000017}, "Encrypt": {"lowerIsBetter": false, "filtered": 922.3171650000002, "unit": "score", "value": 922.3171650000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.26919242273203, "unit": "score", "value": 306.26919242273203}, "Decrypt": {"lowerIsBetter": false, "filtered": 53.07696909272185, "unit": "score", "value": 53.07696909272185}, "Splay": {"lowerIsBetter": false, "filtered": 121.99444752475245, "unit": "score", "value": 121.99444752475245}, "RegExp": {"lowerIsBetter": false, "filtered": 35.107129446640336, "unit": "score", "value": 35.107129446640336}, "Richards": {"lowerIsBetter": false, "filtered": 213.25938200000004, "unit": "score", "value": 213.25938200000004}, "Earley": {"lowerIsBetter": false, "filtered": 841.0763060000003, "unit": "score", "value": 841.0763060000003}, "Boyer": {"lowerIsBetter": false, "filtered": 54.9865099403579, "unit": "score", "value": 54.9865099403579}, "RayTrace": {"lowerIsBetter": false, "filtered": 671.910012, "unit": "score", "value": 671.910012}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-001"}, "testrun": {"date": 1447508728, "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": "20151114030404", "branch": "Firefox", "revision": "202b199b9fcf37a687bef882f2513e191f079622"}}] 06:05:39 INFO - RETURN: dromaeo_css: 6657.27 06:05:39 INFO - RETURN: kraken: 1494.30 06:05:39 INFO - RETURN: v8_7: 20789.81 06:05:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20789.81"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1494.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6657.27"}}} 06:05:39 INFO - Return code: 0 06:05:39 INFO - # TBPL SUCCESS # 06:05:39 INFO - Running post-action listener: _resource_record_post_action 06:05:39 INFO - Running post-run listener: _resource_record_post_run 06:05:40 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 497463296; Read time: 16; Write time: 517508 06:05:40 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 169684992; Read time: 0; Write time: 243316 06:05:40 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 267444224; Read time: 16; Write time: 157492 06:05:40 INFO - Running post-run listener: _upload_blobber_files 06:05:40 INFO - Blob upload gear active. 06:05:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:05:40 INFO - Copying logs to upload dir... 06:05:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.205857 ========= master_lag: 85.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 39 secs) (at 2015-11-14 06:07:05.246173) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 06:07:05.249398) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010071 build_url: 'https://queue.taskcluster.net/v1/task/EL42x9hZSpebWZg4oFUMUA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.78 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 06:07:06.036291) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 06:07:06.036690) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447500280.184187-349647653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 06:07:06.060090) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 06:07:06.060432) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 06:07:06.061722) ========= ========= Total master_lag: 86.27 =========