builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1448257897.54 results: success (0) buildid: 20151122203110 builduid: 4773aaf7a70545bcbe43f59fb55247a2 revision: 95154dcdd06bdd40221f2032c91940f713e9a14e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:37.543575) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:37.544069) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:37.544560) ========= 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-1448248495.688507-780482988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006382 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:37.578381) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:37.578693) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:37.632597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:37.632853) ========= 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-1448248495.688507-780482988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:37.685439) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:37.685694) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:37.686030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:37.686314) ========= 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-1448248495.688507-780482988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-22 21:51:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 16.8M=0.001s 2015-11-22 21:51:38 (16.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191159 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:37.890264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:37.890551) ========= 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-1448248495.688507-780482988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014952 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:37.939624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:37.939978) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 95154dcdd06bdd40221f2032c91940f713e9a14e --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 95154dcdd06bdd40221f2032c91940f713e9a14e --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-1448248495.688507-780482988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-22 21:51:38,238 truncating revision to first 12 chars 2015-11-22 21:51:38,238 Setting DEBUG logging. 2015-11-22 21:51:38,238 attempt 1/10 2015-11-22 21:51:38,238 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/95154dcdd06b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-22 21:51:38,601 unpacking tar archive at: b2g-inbound-95154dcdd06b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637519 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:38.591927) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:38.592209) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:38.602327) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:38.602568) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-22 21:51:38.602920) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-22 21:51:38.603217) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b4e1481c633df10bed3f4cc0000001c7-1448248495.688507-780482988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:51:38 INFO - MultiFileLogger online at 20151122 21:51:38 in /builds/slave/test-pgo 21:51:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 21:51:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:51:38 INFO - {'append_to_log': False, 21:51:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:51:38 INFO - 'blob_upload_branch': 'B2G-Inbound', 21:51:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:51:38 INFO - 'branch': 'B2G-Inbound', 21:51:38 INFO - 'buildbot_json_path': 'buildprops.json', 21:51:38 INFO - 'config_files': ('talos/linux_config.py',), 21:51:38 INFO - 'default_actions': ('clobber', 21:51:38 INFO - 'read-buildbot-config', 21:51:38 INFO - 'download-and-extract', 21:51:38 INFO - 'populate-webroot', 21:51:38 INFO - 'create-virtualenv', 21:51:38 INFO - 'install', 21:51:38 INFO - 'run-tests'), 21:51:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:51:38 INFO - 'download_minidump_stackwalk': True, 21:51:38 INFO - 'download_symbols': 'ondemand', 21:51:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:51:38 INFO - 'tooltool.py': '/tools/tooltool.py', 21:51:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:51:38 INFO - '/tools/misc-python/virtualenv.py')}, 21:51:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:51:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:51:38 INFO - 'installer_path': 'installer.exe', 21:51:38 INFO - 'log_level': 'info', 21:51:38 INFO - 'log_name': 'talos', 21:51:38 INFO - 'log_to_console': True, 21:51:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:51:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:51:38 INFO - 'opt_config_files': (), 21:51:38 INFO - 'pip_index': False, 21:51:38 INFO - 'sps_profile': False, 21:51:38 INFO - 'sps_profile_interval': 0, 21:51:38 INFO - 'suite': 'dromaeojs', 21:51:38 INFO - 'system_bits': '64', 21:51:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:51:38 INFO - 'title': 'talos-linux64-ix-001', 21:51:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:51:38 INFO - 'use_talos_json': True, 21:51:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:51:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:51:38 INFO - 'work_dir': 'build'} 21:51:38 INFO - ##### 21:51:38 INFO - ##### Running clobber step. 21:51:38 INFO - ##### 21:51:38 INFO - Running pre-action listener: _resource_record_pre_action 21:51:38 INFO - Running main action method: clobber 21:51:38 INFO - rmtree: /builds/slave/test-pgo/build 21:51:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:51:39 INFO - Running post-action listener: _resource_record_post_action 21:51:39 INFO - ##### 21:51:39 INFO - ##### Running read-buildbot-config step. 21:51:39 INFO - ##### 21:51:39 INFO - Running pre-action listener: _resource_record_pre_action 21:51:39 INFO - Running main action method: read_buildbot_config 21:51:39 INFO - Using buildbot properties: 21:51:39 INFO - { 21:51:39 INFO - "properties": { 21:51:39 INFO - "buildnumber": 995, 21:51:39 INFO - "product": "firefox", 21:51:39 INFO - "script_repo_revision": "production", 21:51:39 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 21:51:39 INFO - "repository": "", 21:51:39 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 21:51:39 INFO - "buildid": "20151122203110", 21:51:39 INFO - "slavename": "talos-linux64-ix-001", 21:51:39 INFO - "pgo_build": "True", 21:51:39 INFO - "basedir": "/builds/slave/test-pgo", 21:51:39 INFO - "project": "", 21:51:39 INFO - "platform": "ubuntu64_hw", 21:51:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:51:39 INFO - "slavebuilddir": "test", 21:51:39 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 21:51:39 INFO - "branch": "b2g-inbound", 21:51:39 INFO - "repo_path": "integration/b2g-inbound", 21:51:39 INFO - "stage_platform": "linux64-pgo", 21:51:39 INFO - "builduid": "4773aaf7a70545bcbe43f59fb55247a2", 21:51:39 INFO - "revision": "95154dcdd06bdd40221f2032c91940f713e9a14e" 21:51:39 INFO - }, 21:51:39 INFO - "sourcestamp": { 21:51:39 INFO - "repository": "", 21:51:39 INFO - "hasPatch": false, 21:51:39 INFO - "project": "", 21:51:39 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 21:51:39 INFO - "changes": [ 21:51:39 INFO - { 21:51:39 INFO - "category": null, 21:51:39 INFO - "files": [ 21:51:39 INFO - { 21:51:39 INFO - "url": null, 21:51:39 INFO - "name": "https://queue.taskcluster.net/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:51:39 INFO - } 21:51:39 INFO - ], 21:51:39 INFO - "repository": "", 21:51:39 INFO - "rev": "95154dcdd06bdd40221f2032c91940f713e9a14e", 21:51:39 INFO - "who": "sendchange", 21:51:39 INFO - "when": 1448257852, 21:51:39 INFO - "number": 6694061, 21:51:39 INFO - "comments": "", 21:51:39 INFO - "project": "", 21:51:39 INFO - "at": "Sun 22 Nov 2015 21:50:52", 21:51:39 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 21:51:39 INFO - "revlink": "", 21:51:39 INFO - "properties": [ 21:51:39 INFO - [ 21:51:39 INFO - "buildid", 21:51:39 INFO - "20151122203110", 21:51:39 INFO - "Change" 21:51:39 INFO - ], 21:51:39 INFO - [ 21:51:39 INFO - "builduid", 21:51:39 INFO - "4773aaf7a70545bcbe43f59fb55247a2", 21:51:39 INFO - "Change" 21:51:39 INFO - ], 21:51:39 INFO - [ 21:51:39 INFO - "pgo_build", 21:51:39 INFO - "True", 21:51:39 INFO - "Change" 21:51:39 INFO - ] 21:51:39 INFO - ], 21:51:39 INFO - "revision": "95154dcdd06bdd40221f2032c91940f713e9a14e" 21:51:39 INFO - } 21:51:39 INFO - ], 21:51:39 INFO - "revision": "95154dcdd06bdd40221f2032c91940f713e9a14e" 21:51:39 INFO - } 21:51:39 INFO - } 21:51:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:51:39 INFO - Running post-action listener: _resource_record_post_action 21:51:39 INFO - ##### 21:51:39 INFO - ##### Running download-and-extract step. 21:51:39 INFO - ##### 21:51:39 INFO - Running pre-action listener: _resource_record_pre_action 21:51:39 INFO - Running main action method: download_and_extract 21:51:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:51:39 INFO - https://queue.taskcluster.net/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:51:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/test_packages.json 21:51:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/test_packages.json 21:51:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:51:44 INFO - Downloaded 1302 bytes. 21:51:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:51:44 INFO - Using the following test package requirements: 21:51:44 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:51:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:51:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:51:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:51:44 INFO - u'jsshell-linux-x86_64.zip'], 21:51:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:51:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:51:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:51:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:51:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:51:44 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:51:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:51:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:51:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:51:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:51:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:51:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:51:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:51:44 INFO - https://queue.taskcluster.net/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:51:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:51:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:51:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/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 21:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/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 21:51:49 INFO - Downloaded 22523004 bytes. 21:51:49 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 21:51:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:51:49 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 21:51:50 INFO - Return code: 0 21:51:50 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 21:51:50 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')]} 21:51:50 INFO - https://queue.taskcluster.net/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:51:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:51:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:51:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/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 21:51:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/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 21:51:51 INFO - Downloaded 22523004 bytes. 21:51:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:51:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:51:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:51:52 INFO - Return code: 0 21:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:51:52 INFO - https://queue.taskcluster.net/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:51:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:51:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:51:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/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 21:51:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/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 21:51:54 INFO - Downloaded 11130997 bytes. 21:51: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 21:51:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:51: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 21:51:54 INFO - Return code: 0 21:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:51:54 INFO - https://queue.taskcluster.net/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:51:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:51:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:51:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/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 21:51:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vTPL64ALRyidwSX-J6wZRQ/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 21:51:55 INFO - Downloaded 57444047 bytes. 21:51:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:51:55 INFO - mkdir: /builds/slave/test-pgo/properties 21:51:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:51:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:51:55 INFO - Contents: 21:51:55 INFO - build_url:https://queue.taskcluster.net/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:51:55 INFO - Running post-action listener: _resource_record_post_action 21:51:55 INFO - Running post-action listener: set_extra_try_arguments 21:51:55 INFO - ##### 21:51:55 INFO - ##### Running populate-webroot step. 21:51:55 INFO - ##### 21:51:55 INFO - Running pre-action listener: _resource_record_pre_action 21:51:55 INFO - Running main action method: populate_webroot 21:51:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:51:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:51:55 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:51:55 INFO - '../fennec_ids.txt'], 21:51:55 INFO - 'tests': ['tcheck2']}, 21:51:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:51:55 INFO - '--tppagecycles', 21:51:55 INFO - '7'], 21:51:55 INFO - 'tests': ['tsvgm']}}, 21:51:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:51:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:51:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:51:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:51:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:51:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:51:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:51:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:55 INFO - 'talos_options': ['--e10s'], 21:51:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:51:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:55 INFO - 'tests': ['damp', 'tps']}, 21:51:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:55 INFO - 'talos_options': ['--e10s'], 21:51:55 INFO - 'tests': ['damp', 'tps']}, 21:51:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:51:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:51:55 INFO - 'other': {'tests': ['a11yr', 21:51:55 INFO - 'ts_paint', 21:51:55 INFO - 'tpaint', 21:51:55 INFO - 'sessionrestore', 21:51:55 INFO - 'sessionrestore_no_auto_restore']}, 21:51:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:51:55 INFO - 'tests': ['a11yr', 21:51:55 INFO - 'ts_paint', 21:51:55 INFO - 'tpaint', 21:51:55 INFO - 'sessionrestore', 21:51:55 INFO - 'sessionrestore_no_auto_restore']}, 21:51:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:51:55 INFO - 'tests': ['a11yr', 21:51:55 INFO - 'ts_paint', 21:51:55 INFO - 'tpaint', 21:51:55 INFO - 'sessionrestore', 21:51:55 INFO - 'sessionrestore_no_auto_restore']}, 21:51:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:51:55 INFO - 'tests': ['a11yr', 21:51:55 INFO - 'ts_paint', 21:51:55 INFO - 'tpaint', 21:51:55 INFO - 'sessionrestore', 21:51:55 INFO - 'sessionrestore_no_auto_restore']}, 21:51:55 INFO - 'other_l64': {'tests': ['a11yr', 21:51:55 INFO - 'ts_paint', 21:51:55 INFO - 'tpaint', 21:51:55 INFO - 'sessionrestore', 21:51:55 INFO - 'sessionrestore_no_auto_restore']}, 21:51:55 INFO - 'other_nol64': {'tests': ['a11yr', 21:51:55 INFO - 'ts_paint', 21:51:55 INFO - 'tpaint', 21:51:55 INFO - 'sessionrestore', 21:51:55 INFO - 'sessionrestore_no_auto_restore']}, 21:51:55 INFO - 'svgr': {'tests': ['tsvgx', 21:51:55 INFO - 'tsvgr_opacity', 21:51:55 INFO - 'tart', 21:51:55 INFO - 'tscrollx', 21:51:55 INFO - 'cart']}, 21:51:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:51:55 INFO - 'tests': ['tsvgx', 21:51:55 INFO - 'tsvgr_opacity', 21:51:55 INFO - 'tart', 21:51:55 INFO - 'tscrollx', 21:51:55 INFO - 'cart']}, 21:51:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:55 INFO - 'tests': ['tp5o']}, 21:51:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:55 INFO - 'talos_options': ['--e10s'], 21:51:55 INFO - 'tests': ['tp5o']}, 21:51:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:55 INFO - 'talos_options': ['--xperf_path', 21:51:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:51:55 INFO - 'tests': ['tp5n']}, 21:51:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:55 INFO - 'talos_options': ['--e10s', 21:51:55 INFO - '--xperf_path', 21:51:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:51:55 INFO - 'tests': ['tp5n']}}, 21:51:55 INFO - 'talos.zip': {'path': '', 21:51:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:51:55 INFO - Running post-action listener: _resource_record_post_action 21:51:55 INFO - ##### 21:51:55 INFO - ##### Running create-virtualenv step. 21:51:55 INFO - ##### 21:51:55 INFO - Running pre-action listener: _resource_record_pre_action 21:51:55 INFO - Running main action method: create_virtualenv 21:51:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:51:56 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 21:51:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:51:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:51:56 INFO - Using real prefix '/usr' 21:51:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:51:56 INFO - Installing distribute.............................................................................................................................................................................................done. 21:51:58 INFO - Installing pip.................done. 21:51:58 INFO - Return code: 0 21:51:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:51: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')]} 21:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51: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')]} 21:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51: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 0x7eff67a9ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21696c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225fd70>, '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 0x2260b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2260fb0>, '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-1448248495.688507-780482988', '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 21:51: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 21:51: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 21:51:58 INFO - Using env: {'DISPLAY': ':0', 21:51:58 INFO - 'HOME': '/home/cltbld', 21:51:58 INFO - 'LANG': 'en_US.UTF-8', 21:51:58 INFO - 'LANGUAGE': 'en_US:en', 21:51:58 INFO - 'LOGNAME': 'cltbld', 21:51:58 INFO - 'MAIL': '/var/mail/cltbld', 21:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:58 INFO - 'MOZ_NO_REMOTE': '1', 21:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:58 INFO - 'NO_EM_RESTART': '1', 21:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:51:58 INFO - 'PWD': '/builds/slave/test-pgo', 21:51:58 INFO - 'SHELL': '/bin/bash', 21:51:58 INFO - 'SHLVL': '1', 21:51:58 INFO - 'TERM': 'linux', 21:51:58 INFO - 'TMOUT': '86400', 21:51:58 INFO - 'USER': 'cltbld', 21:51:58 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448248495.688507-780482988', 21:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:58 INFO - '_': '/tools/buildbot/bin/python'} 21:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51: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 21:51:58 INFO - Cleaning up... 21:51:58 INFO - Return code: 0 21:51:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:51: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')]} 21:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51: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')]} 21:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51: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 0x7eff67a9ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21696c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225fd70>, '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 0x2260b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2260fb0>, '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-1448248495.688507-780482988', '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 21:51: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 21:51: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 21:51:58 INFO - Using env: {'DISPLAY': ':0', 21:51:58 INFO - 'HOME': '/home/cltbld', 21:51:58 INFO - 'LANG': 'en_US.UTF-8', 21:51:58 INFO - 'LANGUAGE': 'en_US:en', 21:51:58 INFO - 'LOGNAME': 'cltbld', 21:51:58 INFO - 'MAIL': '/var/mail/cltbld', 21:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:58 INFO - 'MOZ_NO_REMOTE': '1', 21:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:58 INFO - 'NO_EM_RESTART': '1', 21:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:51:58 INFO - 'PWD': '/builds/slave/test-pgo', 21:51:58 INFO - 'SHELL': '/bin/bash', 21:51:58 INFO - 'SHLVL': '1', 21:51:58 INFO - 'TERM': 'linux', 21:51:58 INFO - 'TMOUT': '86400', 21:51:58 INFO - 'USER': 'cltbld', 21:51:58 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448248495.688507-780482988', 21:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:58 INFO - '_': '/tools/buildbot/bin/python'} 21:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:58 INFO - Downloading/unpacking psutil>=0.7.1 21:51: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 21:51: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 21:51: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 21:51: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 21:51: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 21:51: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 21:52:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:52:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:52:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:52:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:52:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:52:00 INFO - Installing collected packages: psutil 21:52:00 INFO - Running setup.py install for psutil 21:52:00 INFO - building 'psutil._psutil_linux' extension 21:52: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 21:52: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 21:52:01 INFO - building 'psutil._psutil_posix' extension 21:52:01 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 21:52: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 21:52:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:52:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:52:01 INFO - Successfully installed psutil 21:52:01 INFO - Cleaning up... 21:52:01 INFO - Return code: 0 21:52:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:52: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')]} 21:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52: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')]} 21:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52: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 0x7eff67a9ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21696c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225fd70>, '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 0x2260b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2260fb0>, '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-1448248495.688507-780482988', '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 21:52: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 21:52: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 21:52:01 INFO - Using env: {'DISPLAY': ':0', 21:52:01 INFO - 'HOME': '/home/cltbld', 21:52:01 INFO - 'LANG': 'en_US.UTF-8', 21:52:01 INFO - 'LANGUAGE': 'en_US:en', 21:52:01 INFO - 'LOGNAME': 'cltbld', 21:52:01 INFO - 'MAIL': '/var/mail/cltbld', 21:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:01 INFO - 'MOZ_NO_REMOTE': '1', 21:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:01 INFO - 'NO_EM_RESTART': '1', 21:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:01 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:01 INFO - 'SHELL': '/bin/bash', 21:52:01 INFO - 'SHLVL': '1', 21:52:01 INFO - 'TERM': 'linux', 21:52:01 INFO - 'TMOUT': '86400', 21:52:01 INFO - 'USER': 'cltbld', 21:52:01 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448248495.688507-780482988', 21:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:01 INFO - '_': '/tools/buildbot/bin/python'} 21:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:52: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 21:52: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 21:52: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 21:52: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 21:52: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 21:52: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 21:52:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:52:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:52:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:52: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) 21:52:03 INFO - Installing collected packages: mozsystemmonitor 21:52:03 INFO - Running setup.py install for mozsystemmonitor 21:52:03 INFO - Successfully installed mozsystemmonitor 21:52:03 INFO - Cleaning up... 21:52:03 INFO - Return code: 0 21:52:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:52: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')]} 21:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52: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')]} 21:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52: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 0x7eff67a9ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21696c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225fd70>, '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 0x2260b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2260fb0>, '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-1448248495.688507-780482988', '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 21:52: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 21:52: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 21:52:03 INFO - Using env: {'DISPLAY': ':0', 21:52:03 INFO - 'HOME': '/home/cltbld', 21:52:03 INFO - 'LANG': 'en_US.UTF-8', 21:52:03 INFO - 'LANGUAGE': 'en_US:en', 21:52:03 INFO - 'LOGNAME': 'cltbld', 21:52:03 INFO - 'MAIL': '/var/mail/cltbld', 21:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:03 INFO - 'MOZ_NO_REMOTE': '1', 21:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:03 INFO - 'NO_EM_RESTART': '1', 21:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:03 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:03 INFO - 'SHELL': '/bin/bash', 21:52:03 INFO - 'SHLVL': '1', 21:52:03 INFO - 'TERM': 'linux', 21:52:03 INFO - 'TMOUT': '86400', 21:52:03 INFO - 'USER': 'cltbld', 21:52:03 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448248495.688507-780482988', 21:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:03 INFO - '_': '/tools/buildbot/bin/python'} 21:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:03 INFO - Downloading/unpacking blobuploader==1.2.4 21:52: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 21:52: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 21:52: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 21:52: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 21:52: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 21:52: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 21:52:05 INFO - Downloading blobuploader-1.2.4.tar.gz 21:52:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:52:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:52:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:52: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 21:52: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 21:52: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 21:52: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 21:52: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 21:52: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 21:52:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:52:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:52:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:52: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 21:52: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 21:52: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 21:52: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 21:52: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 21:52: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 21:52:05 INFO - Downloading docopt-0.6.1.tar.gz 21:52:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:52:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:52:05 INFO - Installing collected packages: blobuploader, requests, docopt 21:52:05 INFO - Running setup.py install for blobuploader 21:52:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:52:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:52:05 INFO - Running setup.py install for requests 21:52:06 INFO - Running setup.py install for docopt 21:52:06 INFO - Successfully installed blobuploader requests docopt 21:52:06 INFO - Cleaning up... 21:52:06 INFO - Return code: 0 21:52:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:52: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')]} 21:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52: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')]} 21:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52: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 0x7eff67a9ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21696c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225fd70>, '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 0x2260b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2260fb0>, '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-1448248495.688507-780482988', '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 21:52: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 21:52: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 21:52:06 INFO - Using env: {'DISPLAY': ':0', 21:52:06 INFO - 'HOME': '/home/cltbld', 21:52:06 INFO - 'LANG': 'en_US.UTF-8', 21:52:06 INFO - 'LANGUAGE': 'en_US:en', 21:52:06 INFO - 'LOGNAME': 'cltbld', 21:52:06 INFO - 'MAIL': '/var/mail/cltbld', 21:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:06 INFO - 'MOZ_NO_REMOTE': '1', 21:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:06 INFO - 'NO_EM_RESTART': '1', 21:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:06 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:06 INFO - 'SHELL': '/bin/bash', 21:52:06 INFO - 'SHLVL': '1', 21:52:06 INFO - 'TERM': 'linux', 21:52:06 INFO - 'TMOUT': '86400', 21:52:06 INFO - 'USER': 'cltbld', 21:52:06 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448248495.688507-780482988', 21:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:06 INFO - '_': '/tools/buildbot/bin/python'} 21:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:52:06 INFO - Running setup.py (path:/tmp/pip-VCfEz7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:52:06 INFO - Running setup.py (path:/tmp/pip-zVZHJT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:52:06 INFO - Running setup.py (path:/tmp/pip-Ee4DLh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:52:06 INFO - Running setup.py (path:/tmp/pip-XB3CO8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:52:06 INFO - Running setup.py (path:/tmp/pip-aZew65-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:52:07 INFO - Running setup.py (path:/tmp/pip-ahxL70-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:52:07 INFO - Running setup.py (path:/tmp/pip-3mYKrm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:52:07 INFO - Running setup.py (path:/tmp/pip-3JiZVE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:52:07 INFO - Running setup.py (path:/tmp/pip-caTv4Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:52:07 INFO - Running setup.py (path:/tmp/pip-3V9nHW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:52:07 INFO - Running setup.py (path:/tmp/pip-dx1rga-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:52:07 INFO - Running setup.py (path:/tmp/pip-7wYb_i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:52:07 INFO - Running setup.py (path:/tmp/pip-lDObwb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:52:07 INFO - Running setup.py (path:/tmp/pip-BJQq0v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:52:07 INFO - Running setup.py (path:/tmp/pip-VyglJd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:52:07 INFO - Running setup.py (path:/tmp/pip-CqZHQA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:52:07 INFO - Running setup.py (path:/tmp/pip-6UxlPJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:52:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:52:07 INFO - Running setup.py install for manifestparser 21:52:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:52:08 INFO - Running setup.py install for mozcrash 21:52:08 INFO - Running setup.py install for mozdebug 21:52:08 INFO - Running setup.py install for mozdevice 21:52:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:52:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:52:08 INFO - Running setup.py install for mozfile 21:52:08 INFO - Running setup.py install for mozhttpd 21:52:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:52:08 INFO - Running setup.py install for mozinfo 21:52:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:52:08 INFO - Running setup.py install for mozInstall 21:52:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:52:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:52:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:52:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:52:08 INFO - Running setup.py install for mozleak 21:52:08 INFO - Running setup.py install for mozlog 21:52:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:52:08 INFO - Running setup.py install for moznetwork 21:52:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:52:09 INFO - Running setup.py install for mozprocess 21:52:09 INFO - Running setup.py install for mozprofile 21:52:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:52:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:52:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:52:09 INFO - Running setup.py install for mozrunner 21:52:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:52:09 INFO - Running setup.py install for mozscreenshot 21:52:09 INFO - Running setup.py install for moztest 21:52:09 INFO - Running setup.py install for mozversion 21:52:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:52:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:52:09 INFO - Cleaning up... 21:52:09 INFO - Return code: 0 21:52:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52: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 0x7eff67a9ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21696c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225fd70>, '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 0x2260b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2260fb0>, '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-1448248495.688507-780482988', '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 21:52: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 21:52: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 21:52:09 INFO - Using env: {'DISPLAY': ':0', 21:52:09 INFO - 'HOME': '/home/cltbld', 21:52:09 INFO - 'LANG': 'en_US.UTF-8', 21:52:09 INFO - 'LANGUAGE': 'en_US:en', 21:52:09 INFO - 'LOGNAME': 'cltbld', 21:52:09 INFO - 'MAIL': '/var/mail/cltbld', 21:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:09 INFO - 'MOZ_NO_REMOTE': '1', 21:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:09 INFO - 'NO_EM_RESTART': '1', 21:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:09 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:09 INFO - 'SHELL': '/bin/bash', 21:52:09 INFO - 'SHLVL': '1', 21:52:09 INFO - 'TERM': 'linux', 21:52:09 INFO - 'TMOUT': '86400', 21:52:09 INFO - 'USER': 'cltbld', 21:52:09 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448248495.688507-780482988', 21:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:09 INFO - '_': '/tools/buildbot/bin/python'} 21:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:52:09 INFO - Running setup.py (path:/tmp/pip-Q3HNvM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:52: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)) 21:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:52:09 INFO - Running setup.py (path:/tmp/pip-1pTOE7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:52:10 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)) 21:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:52:10 INFO - Running setup.py (path:/tmp/pip-z0mrJt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:52: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)) 21:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:52:10 INFO - Running setup.py (path:/tmp/pip-8KbTKC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:52: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)) 21:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:52:10 INFO - Running setup.py (path:/tmp/pip-wNoti7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:52: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)) 21:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:52:10 INFO - Running setup.py (path:/tmp/pip-9LD9wZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:52: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)) 21:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:52:10 INFO - Running setup.py (path:/tmp/pip-qNIJj_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:52: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)) 21:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:52:10 INFO - Running setup.py (path:/tmp/pip-IIP8ko-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:52: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)) 21:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:52:10 INFO - Running setup.py (path:/tmp/pip-RCb098-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:52: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)) 21:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:52:10 INFO - Running setup.py (path:/tmp/pip-KqYrB3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:52: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)) 21:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:52:10 INFO - Running setup.py (path:/tmp/pip-EnBC87-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:52: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)) 21:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:52:10 INFO - Running setup.py (path:/tmp/pip-PFNJi9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:52: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)) 21:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:52:10 INFO - Running setup.py (path:/tmp/pip-eJqvok-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:52: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)) 21:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:52:10 INFO - Running setup.py (path:/tmp/pip-nYL7lB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:52: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)) 21:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:52:10 INFO - Running setup.py (path:/tmp/pip-DB3cez-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:52:11 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)) 21:52:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:52:11 INFO - Running setup.py (path:/tmp/pip-VVKGgZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:52: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)) 21:52:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:52:11 INFO - Running setup.py (path:/tmp/pip-GOtenc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:52: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)) 21:52: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)) 21:52: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)) 21:52: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)) 21:52: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)) 21:52: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)) 21:52:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:52: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 21:52: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 21:52: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 21:52: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 21:52: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 21:52: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 21:52:12 INFO - Downloading blessings-1.5.1.tar.gz 21:52: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 21:52:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:52:12 INFO - Installing collected packages: blessings 21:52:12 INFO - Running setup.py install for blessings 21:52:12 INFO - Successfully installed blessings 21:52:12 INFO - Cleaning up... 21:52:13 INFO - Return code: 0 21:52:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:52:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:52:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:52:13 INFO - Reading from file tmpfile_stdout 21:52:13 INFO - Current package versions: 21:52:13 INFO - argparse == 1.2.1 21:52:13 INFO - blessings == 1.5.1 21:52:13 INFO - blobuploader == 1.2.4 21:52:13 INFO - docopt == 0.6.1 21:52:13 INFO - manifestparser == 1.1 21:52:13 INFO - mozInstall == 1.12 21:52:13 INFO - mozcrash == 0.16 21:52:13 INFO - mozdebug == 0.1 21:52:13 INFO - mozdevice == 0.47 21:52:13 INFO - mozfile == 1.2 21:52:13 INFO - mozhttpd == 0.7 21:52:13 INFO - mozinfo == 0.9 21:52:13 INFO - mozleak == 0.1 21:52:13 INFO - mozlog == 3.0 21:52:13 INFO - moznetwork == 0.27 21:52:13 INFO - mozprocess == 0.22 21:52:13 INFO - mozprofile == 0.27 21:52:13 INFO - mozrunner == 6.11 21:52:13 INFO - mozscreenshot == 0.1 21:52:13 INFO - mozsystemmonitor == 0.0 21:52:13 INFO - moztest == 0.7 21:52:13 INFO - mozversion == 1.4 21:52:13 INFO - psutil == 3.1.1 21:52:13 INFO - requests == 1.2.3 21:52:13 INFO - wsgiref == 0.1.2 21:52:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:52: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')]} 21:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52: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')]} 21:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52: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 0x7eff67a9ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21696c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221b7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225fd70>, '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 0x2260b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2260fb0>, '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-1448248495.688507-780482988', '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 21:52: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 21:52: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 21:52:13 INFO - Using env: {'DISPLAY': ':0', 21:52:13 INFO - 'HOME': '/home/cltbld', 21:52:13 INFO - 'LANG': 'en_US.UTF-8', 21:52:13 INFO - 'LANGUAGE': 'en_US:en', 21:52:13 INFO - 'LOGNAME': 'cltbld', 21:52:13 INFO - 'MAIL': '/var/mail/cltbld', 21:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:13 INFO - 'MOZ_NO_REMOTE': '1', 21:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:13 INFO - 'NO_EM_RESTART': '1', 21:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:13 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:13 INFO - 'SHELL': '/bin/bash', 21:52:13 INFO - 'SHLVL': '1', 21:52:13 INFO - 'TERM': 'linux', 21:52:13 INFO - 'TMOUT': '86400', 21:52:13 INFO - 'USER': 'cltbld', 21:52:13 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448248495.688507-780482988', 21:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:13 INFO - '_': '/tools/buildbot/bin/python'} 21:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52: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)) 21:52: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)) 21:52: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)) 21:52: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)) 21:52: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)) 21:52: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)) 21:52: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)) 21:52: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)) 21:52: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)) 21:52: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)) 21:52: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)) 21:52:13 INFO - Cleaning up... 21:52:13 INFO - Return code: 0 21:52:13 INFO - Running post-action listener: _resource_record_post_action 21:52:13 INFO - Running post-action listener: _start_resource_monitoring 21:52:13 INFO - Starting resource monitoring. 21:52:13 INFO - ##### 21:52:13 INFO - ##### Running install step. 21:52:13 INFO - ##### 21:52:13 INFO - Running pre-action listener: _resource_record_pre_action 21:52:13 INFO - Running main action method: install 21:52:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:52:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:52:13 INFO - Reading from file tmpfile_stdout 21:52:13 INFO - Detecting whether we're running mozinstall >=1.0... 21:52:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:52:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:52:13 INFO - Reading from file tmpfile_stdout 21:52:13 INFO - Output received: 21:52:13 INFO - Usage: mozinstall [options] installer 21:52:13 INFO - Options: 21:52:13 INFO - -h, --help show this help message and exit 21:52:13 INFO - -d DEST, --destination=DEST 21:52:13 INFO - Directory to install application into. [default: 21:52:13 INFO - "/builds/slave/test-pgo"] 21:52:13 INFO - --app=APP Application being installed. [default: firefox] 21:52:13 INFO - mkdir: /builds/slave/test-pgo/build/application 21:52: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'] 21:52: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 21:52:28 INFO - Reading from file tmpfile_stdout 21:52:28 INFO - Output received: 21:52:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:52:28 INFO - Running post-action listener: _resource_record_post_action 21:52:28 INFO - ##### 21:52:28 INFO - ##### Running run-tests step. 21:52:28 INFO - ##### 21:52:28 INFO - Running pre-action listener: _resource_record_pre_action 21:52:28 INFO - Running main action method: run_tests 21:52:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:52:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:52:28 INFO - Python 2.7.3 21:52:28 INFO - Return code: 0 21:52:28 INFO - grabbing minidump binary from tooltool 21:52: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')]} 21:52: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 0x225fd70>, '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 0x2260b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2260fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:52: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 21:52: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 21:52:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:52:28 INFO - Return code: 0 21:52:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:52:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:52:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:52:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:52:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:52: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', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vTPL64ALRyidwSX-J6wZRQ/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 21:52: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 B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost 21:52:28 INFO - Using env: {'DISPLAY': ':0', 21:52:28 INFO - 'HOME': '/home/cltbld', 21:52:28 INFO - 'LANG': 'en_US.UTF-8', 21:52:28 INFO - 'LANGUAGE': 'en_US:en', 21:52:28 INFO - 'LOGNAME': 'cltbld', 21:52:28 INFO - 'MAIL': '/var/mail/cltbld', 21:52:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:52:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:28 INFO - 'MOZ_NO_REMOTE': '1', 21:52:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:28 INFO - 'NO_EM_RESTART': '1', 21:52:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:28 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:52:28 INFO - 'SHELL': '/bin/bash', 21:52:28 INFO - 'SHLVL': '1', 21:52:28 INFO - 'TERM': 'linux', 21:52:28 INFO - 'TMOUT': '86400', 21:52:28 INFO - 'USER': 'cltbld', 21:52:28 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448248495.688507-780482988', 21:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:28 INFO - '_': '/tools/buildbot/bin/python'} 21:52:28 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vTPL64ALRyidwSX-J6wZRQ/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 21:52:28 INFO - mozversion INFO | application_buildid: 20151122203110 21:52:28 INFO - mozversion INFO | application_changeset: 95154dcdd06bdd40221f2032c91940f713e9a14e 21:52:28 INFO - mozversion INFO | application_display_name: Nightly 21:52:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:52:28 INFO - mozversion INFO | application_name: Firefox 21:52:28 INFO - mozversion INFO | application_remotingname: firefox 21:52:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 21:52:28 INFO - mozversion INFO | application_vendor: Mozilla 21:52:28 INFO - mozversion INFO | application_version: 45.0a1 21:52:28 INFO - mozversion INFO | platform_buildid: 20151122203110 21:52:28 INFO - mozversion INFO | platform_changeset: 95154dcdd06bdd40221f2032c91940f713e9a14e 21:52:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 21:52:28 INFO - mozversion INFO | platform_version: 45.0a1 21:52:28 INFO - 2015-11-22 21:52:28,569 DEBUG : using testdate: 1448257948 21:52:28 INFO - 2015-11-22 21:52:28,569 DEBUG : actual date: 1448257948 21:52:28 INFO - 2015-11-22 21:52:28,577 INFO : starting webserver on 'localhost:54163' 21:52:28 INFO - 2015-11-22 21:52:28,578 INFO : Starting test suite talos-linux64-ix-001 21:52:28 INFO - 2015-11-22 21:52:28,578 INFO : Starting test dromaeo_css 21:52:28 INFO - 2015-11-22 21:52:28,578 DEBUG : operating with platform_type : linux_ 21:52:28 INFO - 2015-11-22 21:52:28,579 INFO : Initialising browser for dromaeo_css test... 21:52:28 INFO - 2015-11-22 21:52:28,595 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5xXmQe/profile http://localhost:54163/getInfo.html 21:52:33 INFO - 2015-11-22 21:52:33,490 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:52:33 INFO - 2015-11-22 21:52:33,491 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:52:33 INFO - 2015-11-22 21:52:33,491 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:52:33 INFO - 2015-11-22 21:52:33,491 DEBUG : BROWSER_OUTPUT: __metrics 21:52:33 INFO - 2015-11-22 21:52:33,652 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:52:34 INFO - 2015-11-22 21:52:34,966 INFO : Browser initialized. 21:52:34 INFO - 2015-11-22 21:52:34,966 INFO : Running cycle 1/1 for dromaeo_css test... 21:52:34 INFO - 2015-11-22 21:52:34,966 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5xXmQe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:52:46 INFO - 2015-11-22 21:52:46,742 DEBUG : BROWSER_OUTPUT: RSS: Main: 142266368 21:52:46 INFO - 2015-11-22 21:52:46,743 DEBUG : BROWSER_OUTPUT: 21:53:37 INFO - 2015-11-22 21:53:37,496 DEBUG : BROWSER_OUTPUT: 1448258017492 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] 21:55:47 INFO - 2015-11-22 21:55:47,292 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54163/tests/dromaeo/cssquery-ext.html) 21:55:48 INFO - 2015-11-22 21:55:48,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 225751040 21:55:48 INFO - 2015-11-22 21:55:48,530 DEBUG : BROWSER_OUTPUT: 21:58:50 INFO - 2015-11-22 21:58:50,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/dromaeo/cssquery-ext.html (next: http://localhost:54163/tests/dromaeo/cssquery-jquery.html) 21:58:51 INFO - 2015-11-22 21:58:51,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 225837056 21:58:51 INFO - 2015-11-22 21:58:51,378 DEBUG : BROWSER_OUTPUT: 22:01:53 INFO - 2015-11-22 22:01:53,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54163/tests/dromaeo/cssquery-mootools.html) 22:01:54 INFO - 2015-11-22 22:01:54,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 223084544 22:01:54 INFO - 2015-11-22 22:01:54,069 DEBUG : BROWSER_OUTPUT: 22:04:56 INFO - 2015-11-22 22:04:56,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54163/tests/dromaeo/cssquery-prototype.html) 22:04:56 INFO - 2015-11-22 22:04:56,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 201142272 22:04:56 INFO - 2015-11-22 22:04:56,569 DEBUG : BROWSER_OUTPUT: 22:07:59 INFO - 2015-11-22 22:07:59,079 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54163/tests/dromaeo/cssquery-yui.html) 22:07:59 INFO - 2015-11-22 22:07:59,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 202280960 22:07:59 INFO - 2015-11-22 22:07:59,660 DEBUG : BROWSER_OUTPUT: 22:11:02 INFO - 2015-11-22 22:11:02,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/dromaeo/cssquery-yui.html (next: http://localhost:54163/tests/dromaeo/cssquery-dojo.html) 22:11:02 INFO - 2015-11-22 22:11:02,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 268324864 22:11:02 INFO - 2015-11-22 22:11:02,500 DEBUG : BROWSER_OUTPUT: 22:11:02 INFO - 2015-11-22 22:11:02,500 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:11:02 INFO - 2015-11-22 22:11:02,501 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:11:02 INFO - 2015-11-22 22:11:02,501 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:11:02 INFO - 2015-11-22 22:11:02,501 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:11:02 INFO - 2015-11-22 22:11:02,501 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3224.161717953332;3307.603087629485;3337.899863004109;3345.5149003394495;3367.040393487856;5290.153575427932;5376.865578360533;5416.350037995441;5531.668099914003;5569.832905012851;5428.511433970942;5451.536619387347;5497.532709719669;5513.365962914266;5593.692346920918;5074.873128171788;5077.035363280974;5095.79616815327;5134.204198349262;5163.173892177252;4926.802927882881;5160.096983027974;5180.093483640367;5213.635045546814;5244.318238628973;4904.656674032837;5011;5025.0954828130925;5027.296178535008;5027.874303142414;5080.79676812927;5087.389513258396;5092.719900405476;5102.9489705103215;5130.666506677091;4916.729579873106;5009.398872135331;5026;5029.547340739315;5031.798728050873;5292.523672869422;5310.7610157543;5377.381601115882;5383.75773090208;5421.701806400646;5994.760209591611;6015.518758499309;6018.127371531104;6018.6689732064715;6019.729112189962;5783.392743761887;5905.527557795366;6043.788467403664;6060;6063.666498342589;5468.7265636718;5507.889842203133;5516.834494965157;5531.917021244644;5570.610057295991;6035.818925432244;6039.1545183674325;6089.905260371706;6091.0558863376245;6091.208142941389;5760.884782304331;5882.852928676817;5935.228420305419;5942;5955.612885162451;5913.9112913306335;5915.852103697356;5988.760449581968;6006.699665016732;6046.909296360558;5975.19334889793;5982.252218472691;5982.73077711504;5983.042713165873;5984.8803023940145;5819.592628516048;5923.526117910556;5973.133895585116;5977;5981.162637230791;4519.5480451954545;4551.385562949025;4551.590356867898;4565.474970378383;4622.722636641813;4058.817353219112;4068.6948478864206;4071.145059537471;4101.958980410217;4119.8352065917625;5532;5600.35595906476;5616.1014237721765;5621.7189140542805;5630.915536266959;5791.7683292667825;5844.970775146182;5848.152017957373;5859.384764599741;5979;5529.723513824292;5610.186522954149;5686.886262274731;5718.771249149988;5722.7424765885635;5102.438731739506;5216.400113986864;5236.162214045735;5266.420693723688;5270.288511051036;6100.115483254903;6162.907556386658;6170.722317495633;6174.567780255429;6183.567150299616;5954.434328738763;6094.847628809315;6105;6107.175531303217;6111.480524155497;5917.733701983507;5974.044152935509;6039.6678182698615;6208.140005294085;6296.811095667137;5942.6731529766275;5982.0727787193055;5982.790602328898;5990.760369585342;6013.428724271187;6013.098035294741;6071.089336599545;6080.665563394055;6082.574219804571;6086.513078953762;5769.22115514417;5780.479756821738;5876.471117599436;5896.9115463268945;5929.140274660236;5855.238818953509;5858.179854820414;5860.38465961085;5864.530837532901;5920.200772895604;5799.884002319845;5804.883902322014;5807.303123625192;5811.62224455426;5813.447722466359;5754.884902302014;5809.186713860147;5875.823725288248;5881;6005.429484198994;5782.45066718661;5804.82585522435;5810.157527158453;5810.477057064884;5820.883582328414 22:11:02 INFO - 2015-11-22 22:11:02,502 DEBUG : BROWSER_OUTPUT: |1;ext.html;569.115026134361;596.9611975221611;600.807741522713;609.0650850943803;615.0221148374085;30110;39844.2031159377;40238;40323.59676403235;40405.19189616206;43549;43589.56410435895;43715.78142109293;43935.78032109835;44132;7569.545827250383;7683.807904802369;8798.956005219981;8924.107589241088;8984.865227021568;10491.213159013105;10751.62369317074;10767.954088723156;10772.946135269352;10779.46102694866;10443.84334234987;10541.6310429135;10543.47282635869;10545.314554553968;10552.419616921066;7729.884051739228;7899.210078992083;7905.288524032865;10352;10436.895631043706;10290.43402612856;10395.740106497322;10428.634997775118;10442.895571044344;10453.947730261376;39597.60402395997;40064.39903401451;40098.79950600257;40101.79949100265;40136.799316003235;3280.327532855759;3324.9501257481156;3442;3669.522962014921;3745.793981331026;30573.541396879064;30664.540031899316;30883.22791930197;31306.904258351075;32047;3922.0979174789672;3994.6404823566018;4020.2562525932794;4114.979425102885;4217.072244106292;288513;291497;292162;292230;292412.99999999785;54490.18264726032;55153.72423137858;55161.72419137879;65606.67196663986;66910.66544667343;64484;64529;64833.35166648273;64918;65006;14745.926270368795;15024.774628380583;15027.624309392353;15035.54893353201;15043.774343384857;10413.895861041445;10436.947815260875;10437.582496700199;10479.109275711497;10519.684409467729;20830.27094051701;20880.47798805042;21097;21110.261140860304;21141.471463213544;8070.063184835597;8101.797455063553;8228.876566851503;8270.214329638675;8281.710140145065;948.1040416806052;962.7448726087592;985.2315194148432;1010.934289271195;1081.3728037738092;28000.439991200063;28098.2975425616;28438;28491.57262641062;28593;1029.459533744775;1066.338869900651;1080.6109800471825;1119.0096764363598;1165.7668466306773;14643;14701.26493675312;14892.106473611619;15078.396864125532;15118.168500732565;413382;417600;419162;419213;419690;55273.72363138159;55521.167182492296;55533.44466555364;55736.72131639316;55809;1354.4108312883927;1356.2337279437086;1366.9521566745116;1370.04097132006;1377.407714682676;27670.723292766816;28100.297492562848;28624.42751145007;28693.426131476837;28767.136985890458;45210.32184517169;45684.314735278334;45690.54309456863;45737.77131114323;45811.54188458073;292341;292744;292958;294782;295253;32199.51700724444;32566.837165814966;32841.83579082089;33013.17467063342;33016.50475242825;43566;43697;44372;44550.10899781921;44621.77689111534;37345.813270933475;37517.62482375251;42090.368644469745;43312.78343608262;45405;39730.801345994245;41131.7943410281;41210;41400.79299603483;44003.77998110117;38525.80737096297;39613.80193099016;39628;40180;40236.798816005736;36309.45535817018;37931.2413751729;38716.61283387243;39282.410763839136;40660.18679626332;27304;29052.128436146948;29669.25826854346;29685.85157074201;30014.84992575023 22:11:02 INFO - 2015-11-22 22:11:02,502 DEBUG : BROWSER_OUTPUT: |2;jquery.html;346.15192777694654;355.92347645256274;359.99100022499437;362.7098321342925;365.91035196376885;13498.865011349884;17130.571735706613;17620.82379176208;18094.276228950825;18153.364632237874;10690.839637405445;13192.944564434822;14883.181425021647;15643.92178039111;15671.921640391782;3704.666580007799;3826.9043273918096;4801.639877009212;4918.409790825106;5268.473152684739;5373.059714549958;5377.516023557879;5402.405735369126;5418.160185171305;5419.241306217133;5359.249705041298;5374.7850085996515;5463;5658.830235092933;5665.065264231417;5631.662100273997;5649.830505084834;5663.830085097454;5664.178694089354;5892.941070589325;5234.607404444644;5240.947590524084;5241.056609810271;5243.161094224905;5244.108501554745;12446.875531244663;15226.619334516616;19956.800431995638;20327.89836050825;20389.694154587545;1999.5201151723627;2114.3551216878845;2156.827453803692;2179.3570896585547;2189.79196976287;8721.738347849574;9181.357304988653;9358.391704539252;11586.594469193538;13183.736325273441;1600.063962581891;1749.80752117267;1785.6071664233848;1805.3951926104771;1805.882617629863;36867;36919;36951;46808.76595617034;48213.071477140875;10297.17622590191;10322.948385258025;10336.224783141144;10372.533236004398;10404.843927341097;13486.595402137951;13490.865091349157;13524.256165910772;13529.391177397041;13563.982701297442;6661.100751398596;6681.465482761368;6681.766138185238;6686.364795344434;6766.729330826712;5930.703464826742;5996.670183139882;6017.819465416044;6119.357467465941;6134.202553667995;3853.9807300963316;3975.1652153048185;4315.78421078951;4445.622122119591;4490.618297444688;1805.1370068054375;1808.3038030358143;1822.6992546229724;1832.3495159218285;1840.2885316655372;932.2681694869631;951.1439704266078;957.5738796235747;968.9273304502191;985.2708995343394;13559.389827457788;15563.22183890801;15899.920500397655;16676.24956876919;18269.63460730778;900.2123142250531;946.3375637053952;950.8589692369185;984.2126298960802;991.2317953585884;8537.701180458778;9589.568469418893;9829.164521015651;10104.393736375841;10230.386176829265;587630;589629;594987;618057;620156;77555;80986;81092.18907810964;82368;82629.58685206536;1153.2042890405594;1159.3449700918954;1187.631834131422;1188.1600889382962;1198.3049831097942;15787.921060394625;15896.284667190235;15909;16064.919675401548;16214.67570648604;34538.48192277168;34876.825615872775;35329.57060095954;36107.27785444224;36310.8184459076;45156;46383;46858.53141468678;47014.294785578924;49639.255411169586;9415.717528474157;9500.95249523748;9794.118529332394;9794.412335259907;9799.216062715108;17059.317627295266;17350.47948561545;17478.73781893298;17511.912440437718;17681.646367072844;14283.928705346932;14363.56909292723;14505.927470362582;14556.636084097981;15039.849601503845;11139.275947063416;11640.185187037165;11775.646730598095;13986.300684965507;14645.510263255059;12118.394080296126;14028.438862445388;14239.928800355932;14263.144211347353;14855.92572037133;9723.124918757347;9777.755556111155;9792.314537982273;9799.167070799062;9841.60633574649;14442.205678687773;14580.489682861049;14643.414263429344;14968.625784355043;15046.097234165985 22:11:02 INFO - 2015-11-22 22:11:02,503 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1317.02540120311;1705.8208888066752;1740.3299729604098;1784.4825000749784;1807.4487281379181;6957.443404527632;7449.962750186248;7799.92200077999;7801.492902961318;7817.726379576702;7662.578558179298;7837.686492540306;7846.372290216783;7864.292213700765;7882.330001949841;2019.0712272354735;2063.3294179391683;2246.2250523569382;2256.593813113639;2269.4780200553882;2296.2996286132725;2301.0450662974845;2304.7003889494426;2305.8616483010987;2306.308107567723;2105.200023990881;2181.7490988536365;2183.3340831046526;2186.5517568898335;2187.0923566719794;1994.311962372979;2042.0810635214139;2213.3802535290224;2263.7736226377397;2265.29775769512;2256.8420210585264;2271.738750043733;2294.5181511882524;2296.1504243430036;2300.7354154272307;7755.379569634416;7811.179826118289;7816.257455541714;7821.413393995416;7821.452498325119;4487.19230538503;4576.633869290449;4581.244094724367;4584.35818985339;4592.2193227151465;3186.8725250989933;3187.10760986924;3202.055393658853;3223.6615155408813;3256.1696767324415;982.4841957972051;983.6458874805064;1015.3146626027476;1063.6011495689118;1078.6710053433699;10996.06533444658;11009.944950275278;11042.116630669527;11043.447827608587;11057.723556911062;4037.858674946363;4176.436181115571;4180.749155050707;4211.473565804275;4247.51153617338;9424.434533927986;9437.056294370645;9452.90547094534;9454.101860323259;9466.100720431687;4695.600873925686;4699.6240300776535;4700.388949436551;4701.412323459567;4701.976490117596;4206.3480160574545;4214.05183833635;4227.894302642397;4237.449131612871;4240.448741663564;3620.5293311869286;3651.068977410743;3669.5779985301497;3681.4661874028116;3688.9631103689157;1147.1281825812275;1168.818833080874;1169.4386694386742;1172.7068232941765;1175.1949914308725;1280.705437749323;1281.5706738242607;1284.5054653958293;1313.947442102305;1327.6349004023778;6915.135608048994;6918.965405172942;7605.923940760522;7661.272179142972;7670.693172273047;620.9937900621027;629.0969816305712;631.7946667333043;634.0837489827247;640.6668532363145;5665.915011274834;5910.320313164041;5913.58604897653;5952.553558483131;5958.612690175125;9528.809423811485;9722;9729.054189162196;9737.756556086013;9750.122488976027;9412.576434060484;9511.096445837635;9562.856557151648;9613.327067105376;9635.084666956627;7358.484906056632;7396.445266604918;7418.888716669254;7444.553326800409;7487.363574096154;7079.68141433647;7133.429325654039;7171.8565628688175;7202.099737532809;7332.266773322625;8116.918830811616;8424.241818236389;8452.873206901779;8528.701495447629;8536.871946920677;8446.619902104298;8499.617517211616;8604.956975215084;8632.438891472035;8834.558272086499;7070.646467676698;7191.748288809867;7197.8920316196345;7199.424046076406;7206.522662854207;7645.273698998586;7676.692932282869;7710.614469276402;7832.921670783219;7863.292303692695;6937.514373993772;6988;7304.598247096461;7407.518511296748;7502.174760776201;7076.32774886385;7108.147022357351;7238.059052323164;7277.708891644275;7381.889271660822;6365.172527571386;6508.674566271573;7341.375983041501;7391.482596218213;7398.223186565333;6521.967390163209;6676.766313179015;6693.966530167318;6715.865682686222;6728.259891412039;6588.901166482602;6645.734170633121;6668.499862510234;6685.866282674417;6694.062831203538 22:11:02 INFO - 2015-11-22 22:11:02,504 DEBUG : BROWSER_OUTPUT: |4;prototype.html;317.26553029736147;318.1267420929547;321.92595702988314;323.12594432061275;324.5602209006795;6026.608270462417;6067.817965461038;6104.664243466607;6127.479164271037;6152.077188421739;5994.970025149879;6008.519318454524;6014.759409623621;6015.518758499321;6026.9809613779325;4614.054118905617;4616.699914505546;4618.584327410533;4624.491305956342;4627.467841198271;4432.844850430236;4576.931346029813;4631.513691062441;4632.166210082184;4637.837675681352;4552.408186935694;4569.109023740372;4574.473935497411;4575.062112266977;4577.542245775412;4553;4556.088782243548;4560.794764235618;4563.406757121569;4583.449986001668;3833.4824798652103;3869.0520822398694;3897.2984862724697;3903.258380907647;3905.5899130591447;5770.451807078321;5804.564657650693;5833.766649334021;5874.9118763218585;5878.470937615635;5307.2835167252315;5322.467753224685;5322.520973112439;5327.360716714019;5328.227407025959;5975.940240597625;6185.56701030928;6287.276963149205;6298.118263443122;6420.807375778734;4370;4406.625436837872;4416.425864637608;4418.182636212279;4420.248557745191;6588.769393071219;6654.86690266192;6670.4663626910215;6674.399304062657;6680.83297917551;4494.887627809331;4496.078303947683;4497.370368148462;4497.8425755098415;4500.167469018242;4440.755758433317;4521.728696278234;4550.97724511382;4551.431071116111;4557.567031132037;5331.093714068617;5340.599455040888;5343.091674415358;5344;5344.064788661969;6514.348565143542;6522.315156908551;6526.641034743135;6526.934730652728;6532.934670653328;1589.3960295087793;1609.2677831586834;1610.3397606981082;1612;1612.3389410341938;1053.6039747334812;1060.6446840308429;1062.4687656171914;1070.6734445994045;1084.1272775415866;6274.309825919146;6274.341194174637;6278;6278.089676996809;6281.59169653971;6704.094947182166;6707.5975441473665;6708.228553716288;6710.83222919431;6724.125863637696;6112.816615501453;6263;6266.874662506815;6273.654948977759;6274.05889116627;3588.4796704477703;3604.062943634621;3606.170580766386;3610.476480910306;3618.2944325856206;6686.866262674719;6870.690818913161;6898.689558969859;6900.102986611709;7033.507654464241;6890.1731792184255;6905.205901321312;6913.2049814270995;6925.203601585781;6946.0622815919205;6821.181458224945;6975.825604359931;6978.685959131852;6979.89530157048;6988.44092472601;6784.185897692309;6785.728570857111;6786.558873673195;6786.8642627148165;6802.897956530557;6694.163229596301;6698.66506674674;6705.362990515893;6707.765228216989;6709.865802684017;6810.421114205348;6982.79051628452;6990.510664253454;6997.160340759141;6999.895001574879;4481.350204220435;4522.638188944942;4534.387857639176;4537.4328208973875;4538.773061346853;6714;6753.527253092237;6757.493188010821;6767.830804229934;6770;6416.550841441054;6571.145751052332;6578.210614726264;6581.44057755077;6593.538452308292;6527.738890444329;6571.145751052524;6576.638284894377;6578.210614726264;6588.538802283794;6388.840278992877;6407.935920640921;6427.710753016032;6438;6446.484281257582;6421.229452465734;6586.242582102927;6589.143411356493;6590.044443555754;6595.274519802721;6385.840353991001;6393.1688880445245;6402.967985160044;6417;6418.037294405876 22:11:02 INFO - 2015-11-22 22:11:02,506 DEBUG : BROWSER_OUTPUT: |5;yui.html;736.2269616902252;780.6448066129909;808.2967817998342;834.6202477872569;856.216561845911;15229.314680839361;15233.92383038086;15285.923570382132;15301.617459563502;15345.232738363078;14797.112173269612;15114.546563603082;15119.319630616621;15148.924255378708;15155.469558565452;703.1702590942685;719.8812195987682;826.0995514888755;837.623069618671;838.3921656798833;827.6275675945849;835.8244768598602;841.9663213471454;843.0305149078578;843.3801156150224;888.0276097673037;888.4935586715575;888.6001299415257;889.257470012537;889.5685592487638;722.5628494760647;738.2949283434334;879.0945326313907;888.9687961964155;889.5996801439346;655.2235600813052;655.3642966322659;655.6688872119549;657.6777379084263;659.5877576514679;13992.370343334574;14131.78802317966;14137.646558836008;14137.717245655133;14145.575632731034;12220.877791222063;12249.448774805156;12630.179038362478;12788.168769029984;13027.413766380536;9928;10202.846957295647;10427.582896684124;11763.647090587296;11949.462274197682;3701.444783282502;3709.573399059089;3713.3316003119426;3744.7753134811996;3870.0711829161082;48591.27113093306;48954.51045489571;49223.26165107491;49556.25665615019;49834;10002.449865257335;10222.080012798735;10364.326318789255;10529;10599.311044782064;19132.713009304873;19159.425217243504;19166.233350666094;19286.903565482084;19302.32441864556;7421;7624.8475030500185;7800.687972481037;7874.803129921798;7940.523568585903;4349.151915376535;4369.388285640013;4424.557544245549;4432.15789000089;4493.213687604656;3100.224943764059;3120.329129237225;3139.764517661139;3145.3394787094508;3151.023182813289;562.2550121089573;567.7104676614956;571.7398583644432;576.0380165124252;579.5247896724729;586.357938057826;611.9020956646915;638.8051644248549;659.6009414304277;670.9060731497594;7122.430205583644;7582.582957937367;8817.603207855662;9011.234045106108;9181;461.4093959731549;583.8569550460164;585.0931056861847;646.0793369448611;647.760328678392;3818.1218319786603;4067.8169482373364;4073.124278280184;4197.496300443966;4242.7242229255;58189.127163092584;58632.70683646554;58867;58940.7052964741;58961.70519147377;48858;49073.263901041515;50096;50915.74542127266;51096.233556496685;44815.32777008347;44983.32525012193;45418.091638167054;45420.77289613597;45646;8475.533845638303;8519.48883067018;8819.250363718898;8903.376763626484;8962.32782541299;35124.648753512134;35196;35701.82149089342;36019;36087.63912360843;41959.370609441496;43942.34086488641;44396;45381.77309113433;46523.76738116288;10886.292390994877;11002.284851484628;11046.061084807881;11233.775324493301;11376.715582110513;12533;12583.119181657195;12590.496380145058;12745.61763147107;13161.341932903126;9947.850782238127;10039.24705647094;10758.569657213937;10856.565737370416;10891.836622450828;11576.572547382502;11919.018538821283;11931.332617006852;11952.64142075739;12053.75892482163;10521.158307335241;10855.45722713877;10914.563417463212;10990.450477475933;11214.327140371604;9697.854532182164;9814.705558833246;9964.750881228027;9977.151942085004;10082.69751907444;9257.583408746757;9347.875572798494;9360.297977651839;9814.65648702292;10000.749981250527 22:11:02 INFO - 2015-11-22 22:11:02,506 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:11:02 INFO - 2015-11-22 22:11:02,506 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:11:02 INFO - 2015-11-22 22:11:02,506 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,966 22:11:02 INFO - 2015-11-22 22:11:02,506 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:11:02 INFO - 2015-11-22 22:11:02,506 DEBUG : BROWSER_OUTPUT: __startTimestamp1448259062493__endTimestamp 22:11:02 INFO - 2015-11-22 22:11:02,506 DEBUG : BROWSER_OUTPUT: 22:11:02 INFO - 2015-11-22 22:11:02,506 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:11:02 INFO - 2015-11-22 22:11:02,507 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:11:02 INFO - 2015-11-22 22:11:02,507 DEBUG : BROWSER_OUTPUT: 22:11:02 INFO - 2015-11-22 22:11:02,507 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5541.67 Median:5799.88 stddev:624.15 (10.8%) stddev-sans-first:599.00 22:11:02 INFO - 2015-11-22 22:11:02,508 DEBUG : BROWSER_OUTPUT: Values: 3224.2 3307.6 3337.9 3345.5 3367.0 5290.2 5376.9 5416.4 5531.7 5569.8 5428.5 5451.5 5497.5 5513.4 5593.7 5074.9 5077.0 5095.8 5134.2 5163.2 4926.8 5160.1 5180.1 5213.6 5244.3 4904.7 5011.0 5025.1 5027.3 5027.9 5080.8 5087.4 5092.7 5102.9 5130.7 4916.7 5009.4 5026.0 5029.5 5031.8 5292.5 5310.8 5377.4 5383.8 5421.7 5994.8 6015.5 6018.1 6018.7 6019.7 5783.4 5905.5 6043.8 6060.0 6063.7 5468.7 5507.9 5516.8 5531.9 5570.6 6035.8 6039.2 6089.9 6091.1 6091.2 5760.9 5882.9 5935.2 5942.0 5955.6 5913.9 5915.9 5988.8 6006.7 6046.9 5975.2 5982.3 5982.7 5983.0 5984.9 5819.6 5923.5 5973.1 5977.0 5981.2 4519.5 4551.4 4551.6 4565.5 4622.7 4058.8 4068.7 4071.1 4102.0 4119.8 5532.0 5600.4 5616.1 5621.7 5630.9 5791.8 5845.0 5848.2 5859.4 5979.0 5529.7 5610.2 5686.9 5718.8 5722.7 5102.4 5216.4 5236.2 5266.4 5270.3 6100.1 6162.9 6170.7 6174.6 6183.6 5954.4 6094.8 6105.0 6107.2 6111.5 5917.7 5974.0 6039.7 6208.1 6296.8 5942.7 5982.1 5982.8 5990.8 6013.4 6013.1 6071.1 6080.7 6082.6 6086.5 5769.2 5780.5 5876.5 5896.9 5929.1 5855.2 5858.2 5860.4 5864.5 5920.2 5799.9 5804.9 5807.3 5811.6 5813.4 5754.9 5809.2 5875.8 5881.0 6005.4 5782.5 5804.8 5810.2 5810.5 5820.9 22:11:02 INFO - 2015-11-22 22:11:02,508 DEBUG : BROWSER_OUTPUT: 22:11:02 INFO - 2015-11-22 22:11:02,508 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50968.52 Median:20545.80 stddev:89160.30 (434.0%) stddev-sans-first:89330.11 22:11:02 INFO - 2015-11-22 22:11:02,508 DEBUG : BROWSER_OUTPUT: Values: 569.1 597.0 600.8 609.1 615.0 30110.0 39844.2 40238.0 40323.6 40405.2 43549.0 43589.6 43715.8 43935.8 44132.0 7569.5 7683.8 8799.0 8924.1 8984.9 10491.2 10751.6 10768.0 10772.9 10779.5 10443.8 10541.6 10543.5 10545.3 10552.4 7729.9 7899.2 7905.3 10352.0 10436.9 10290.4 10395.7 10428.6 10442.9 10453.9 39597.6 40064.4 40098.8 40101.8 40136.8 3280.3 3325.0 3442.0 3669.5 3745.8 30573.5 30664.5 30883.2 31306.9 32047.0 3922.1 3994.6 4020.3 4115.0 4217.1 288513.0 291497.0 292162.0 292230.0 292413.0 54490.2 55153.7 55161.7 65606.7 66910.7 64484.0 64529.0 64833.4 64918.0 65006.0 14745.9 15024.8 15027.6 15035.5 15043.8 10413.9 10436.9 10437.6 10479.1 10519.7 20830.3 20880.5 21097.0 21110.3 21141.5 8070.1 8101.8 8228.9 8270.2 8281.7 948.1 962.7 985.2 1010.9 1081.4 28000.4 28098.3 28438.0 28491.6 28593.0 1029.5 1066.3 1080.6 1119.0 1165.8 14643.0 14701.3 14892.1 15078.4 15118.2 413382.0 417600.0 419162.0 419213.0 419690.0 55273.7 55521.2 55533.4 55736.7 55809.0 1354.4 1356.2 1367.0 1370.0 1377.4 27670.7 28100.3 28624.4 28693.4 28767.1 45210.3 45684.3 45690.5 45737.8 45811.5 292341.0 292744.0 292958.0 294782.0 295253.0 32199.5 32566.8 32841.8 33013.2 33016.5 43566.0 43697.0 44372.0 44550.1 44621.8 37345.8 37517.6 42090.4 43312.8 45405.0 39730.8 41131.8 41210.0 41400.8 44003.8 38525.8 39613.8 39628.0 40180.0 40236.8 36309.5 37931.2 38716.6 39282.4 40660.2 27304.0 29052.1 29669.3 29685.9 30014.8 22:11:02 INFO - 2015-11-22 22:11:02,508 DEBUG : BROWSER_OUTPUT: 22:11:02 INFO - 2015-11-22 22:11:02,508 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29895.36 Median:18234.99 stddev:98257.26 (538.8%) stddev-sans-first:98507.84 22:11:02 INFO - 2015-11-22 22:11:02,509 DEBUG : BROWSER_OUTPUT: Values: 346.2 355.9 360.0 362.7 365.9 13498.9 17130.6 17620.8 18094.3 18153.4 10690.8 13192.9 14883.2 15643.9 15671.9 3704.7 3826.9 4801.6 4918.4 5268.5 5373.1 5377.5 5402.4 5418.2 5419.2 5359.2 5374.8 5463.0 5658.8 5665.1 5631.7 5649.8 5663.8 5664.2 5892.9 5234.6 5240.9 5241.1 5243.2 5244.1 12446.9 15226.6 19956.8 20327.9 20389.7 1999.5 2114.4 2156.8 2179.4 2189.8 8721.7 9181.4 9358.4 11586.6 13183.7 1600.1 1749.8 1785.6 1805.4 1805.9 36867.0 36919.0 36951.0 46808.8 48213.1 10297.2 10322.9 10336.2 10372.5 10404.8 13486.6 13490.9 13524.3 13529.4 13564.0 6661.1 6681.5 6681.8 6686.4 6766.7 5930.7 5996.7 6017.8 6119.4 6134.2 3854.0 3975.2 4315.8 4445.6 4490.6 1805.1 1808.3 1822.7 1832.3 1840.3 932.3 951.1 957.6 968.9 985.3 13559.4 15563.2 15899.9 16676.2 18269.6 900.2 946.3 950.9 984.2 991.2 8537.7 9589.6 9829.2 10104.4 10230.4 587630.0 589629.0 594987.0 618057.0 620156.0 77555.0 80986.0 81092.2 82368.0 82629.6 1153.2 1159.3 1187.6 1188.2 1198.3 15787.9 15896.3 15909.0 16064.9 16214.7 34538.5 34876.8 35329.6 36107.3 36310.8 45156.0 46383.0 46858.5 47014.3 49639.3 9415.7 9501.0 9794.1 9794.4 9799.2 17059.3 17350.5 17478.7 17511.9 17681.6 14283.9 14363.6 14505.9 14556.6 15039.8 11139.3 11640.2 11775.6 13986.3 14645.5 12118.4 14028.4 14239.9 14263.1 14855.9 9723.1 9777.8 9792.3 9799.2 9841.6 14442.2 14580.5 14643.4 14968.6 15046.1 22:11:02 INFO - 2015-11-22 22:11:02,509 DEBUG : BROWSER_OUTPUT: 22:11:02 INFO - 2015-11-22 22:11:02,509 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5523.82 Median:6555.43 stddev:2918.71 (44.5%) stddev-sans-first:2909.77 22:11:02 INFO - 2015-11-22 22:11:02,510 DEBUG : BROWSER_OUTPUT: Values: 1317.0 1705.8 1740.3 1784.5 1807.4 6957.4 7450.0 7799.9 7801.5 7817.7 7662.6 7837.7 7846.4 7864.3 7882.3 2019.1 2063.3 2246.2 2256.6 2269.5 2296.3 2301.0 2304.7 2305.9 2306.3 2105.2 2181.7 2183.3 2186.6 2187.1 1994.3 2042.1 2213.4 2263.8 2265.3 2256.8 2271.7 2294.5 2296.2 2300.7 7755.4 7811.2 7816.3 7821.4 7821.5 4487.2 4576.6 4581.2 4584.4 4592.2 3186.9 3187.1 3202.1 3223.7 3256.2 982.5 983.6 1015.3 1063.6 1078.7 10996.1 11009.9 11042.1 11043.4 11057.7 4037.9 4176.4 4180.7 4211.5 4247.5 9424.4 9437.1 9452.9 9454.1 9466.1 4695.6 4699.6 4700.4 4701.4 4702.0 4206.3 4214.1 4227.9 4237.4 4240.4 3620.5 3651.1 3669.6 3681.5 3689.0 1147.1 1168.8 1169.4 1172.7 1175.2 1280.7 1281.6 1284.5 1313.9 1327.6 6915.1 6919.0 7605.9 7661.3 7670.7 621.0 629.1 631.8 634.1 640.7 5665.9 5910.3 5913.6 5952.6 5958.6 9528.8 9722.0 9729.1 9737.8 9750.1 9412.6 9511.1 9562.9 9613.3 9635.1 7358.5 7396.4 7418.9 7444.6 7487.4 7079.7 7133.4 7171.9 7202.1 7332.3 8116.9 8424.2 8452.9 8528.7 8536.9 8446.6 8499.6 8605.0 8632.4 8834.6 7070.6 7191.7 7197.9 7199.4 7206.5 7645.3 7676.7 7710.6 7832.9 7863.3 6937.5 6988.0 7304.6 7407.5 7502.2 7076.3 7108.1 7238.1 7277.7 7381.9 6365.2 6508.7 7341.4 7391.5 7398.2 6522.0 6676.8 6694.0 6715.9 6728.3 6588.9 6645.7 6668.5 6685.9 6694.1 22:11:02 INFO - 2015-11-22 22:11:02,510 DEBUG : BROWSER_OUTPUT: 22:11:02 INFO - 2015-11-22 22:11:02,510 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5401.41 Median:6139.78 stddev:1664.45 (27.1%) stddev-sans-first:1624.79 22:11:02 INFO - 2015-11-22 22:11:02,510 DEBUG : BROWSER_OUTPUT: Values: 317.3 318.1 321.9 323.1 324.6 6026.6 6067.8 6104.7 6127.5 6152.1 5995.0 6008.5 6014.8 6015.5 6027.0 4614.1 4616.7 4618.6 4624.5 4627.5 4432.8 4576.9 4631.5 4632.2 4637.8 4552.4 4569.1 4574.5 4575.1 4577.5 4553.0 4556.1 4560.8 4563.4 4583.4 3833.5 3869.1 3897.3 3903.3 3905.6 5770.5 5804.6 5833.8 5874.9 5878.5 5307.3 5322.5 5322.5 5327.4 5328.2 5975.9 6185.6 6287.3 6298.1 6420.8 4370.0 4406.6 4416.4 4418.2 4420.2 6588.8 6654.9 6670.5 6674.4 6680.8 4494.9 4496.1 4497.4 4497.8 4500.2 4440.8 4521.7 4551.0 4551.4 4557.6 5331.1 5340.6 5343.1 5344.0 5344.1 6514.3 6522.3 6526.6 6526.9 6532.9 1589.4 1609.3 1610.3 1612.0 1612.3 1053.6 1060.6 1062.5 1070.7 1084.1 6274.3 6274.3 6278.0 6278.1 6281.6 6704.1 6707.6 6708.2 6710.8 6724.1 6112.8 6263.0 6266.9 6273.7 6274.1 3588.5 3604.1 3606.2 3610.5 3618.3 6686.9 6870.7 6898.7 6900.1 7033.5 6890.2 6905.2 6913.2 6925.2 6946.1 6821.2 6975.8 6978.7 6979.9 6988.4 6784.2 6785.7 6786.6 6786.9 6802.9 6694.2 6698.7 6705.4 6707.8 6709.9 6810.4 6982.8 6990.5 6997.2 6999.9 4481.4 4522.6 4534.4 4537.4 4538.8 6714.0 6753.5 6757.5 6767.8 6770.0 6416.6 6571.1 6578.2 6581.4 6593.5 6527.7 6571.1 6576.6 6578.2 6588.5 6388.8 6407.9 6427.7 6438.0 6446.5 6421.2 6586.2 6589.1 6590.0 6595.3 6385.8 6393.2 6403.0 6417.0 6418.0 22:11:02 INFO - 2015-11-22 22:11:02,510 DEBUG : BROWSER_OUTPUT: 22:11:02 INFO - 2015-11-22 22:11:02,510 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14002.13 Median:45399.93 stddev:15978.14 (35.2%) stddev-sans-first:15991.91 22:11:02 INFO - 2015-11-22 22:11:02,511 DEBUG : BROWSER_OUTPUT: Values: 736.2 780.6 808.3 834.6 856.2 15229.3 15233.9 15285.9 15301.6 15345.2 14797.1 15114.5 15119.3 15148.9 15155.5 703.2 719.9 826.1 837.6 838.4 827.6 835.8 842.0 843.0 843.4 888.0 888.5 888.6 889.3 889.6 722.6 738.3 879.1 889.0 889.6 655.2 655.4 655.7 657.7 659.6 13992.4 14131.8 14137.6 14137.7 14145.6 12220.9 12249.4 12630.2 12788.2 13027.4 9928.0 10202.8 10427.6 11763.6 11949.5 3701.4 3709.6 3713.3 3744.8 3870.1 48591.3 48954.5 49223.3 49556.3 49834.0 10002.4 10222.1 10364.3 10529.0 10599.3 19132.7 19159.4 19166.2 19286.9 19302.3 7421.0 7624.8 7800.7 7874.8 7940.5 4349.2 4369.4 4424.6 4432.2 4493.2 3100.2 3120.3 3139.8 3145.3 3151.0 562.3 567.7 571.7 576.0 579.5 586.4 611.9 638.8 659.6 670.9 7122.4 7582.6 8817.6 9011.2 9181.0 461.4 583.9 585.1 646.1 647.8 3818.1 4067.8 4073.1 4197.5 4242.7 58189.1 58632.7 58867.0 58940.7 58961.7 48858.0 49073.3 50096.0 50915.7 51096.2 44815.3 44983.3 45418.1 45420.8 45646.0 8475.5 8519.5 8819.3 8903.4 8962.3 35124.6 35196.0 35701.8 36019.0 36087.6 41959.4 43942.3 44396.0 45381.8 46523.8 10886.3 11002.3 11046.1 11233.8 11376.7 12533.0 12583.1 12590.5 12745.6 13161.3 9947.9 10039.2 10758.6 10856.6 10891.8 11576.6 11919.0 11931.3 11952.6 12053.8 10521.2 10855.5 10914.6 10990.5 11214.3 9697.9 9814.7 9964.8 9977.2 10082.7 9257.6 9347.9 9360.3 9814.7 10000.7 22:11:02 INFO - 2015-11-22 22:11:02,512 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:11:02 INFO - 2015-11-22 22:11:02,512 DEBUG : BROWSER_OUTPUT: 22:11:03 INFO - 2015-11-22 22:11:03,233 INFO : Browser exited with error code: 0 22:11:03 INFO - 2015-11-22 22:11:03,254 INFO : Completed test dromaeo_css (00:18:34) 22:11:03 INFO - 2015-11-22 22:11:03,254 INFO : Starting test kraken 22:11:03 INFO - 2015-11-22 22:11:03,254 DEBUG : operating with platform_type : linux_ 22:11:03 INFO - 2015-11-22 22:11:03,255 INFO : Initialising browser for kraken test... 22:11:03 INFO - 2015-11-22 22:11:03,261 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWEVJIx/profile http://localhost:54163/getInfo.html 22:11:07 INFO - 2015-11-22 22:11:07,013 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:11:07 INFO - 2015-11-22 22:11:07,014 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:11:07 INFO - 2015-11-22 22:11:07,014 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:11:07 INFO - 2015-11-22 22:11:07,014 DEBUG : BROWSER_OUTPUT: __metrics 22:11:07 INFO - 2015-11-22 22:11:07,199 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:11:08 INFO - 2015-11-22 22:11:08,380 INFO : Browser initialized. 22:11:08 INFO - 2015-11-22 22:11:08,380 INFO : Running cycle 1/1 for kraken test... 22:11:08 INFO - 2015-11-22 22:11:08,380 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWEVJIx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:11:20 INFO - 2015-11-22 22:11:20,154 DEBUG : BROWSER_OUTPUT: RSS: Main: 142114816 22:11:20 INFO - 2015-11-22 22:11:20,154 DEBUG : BROWSER_OUTPUT: 22:11:22 INFO - 2015-11-22 22:11:22,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54163/tests/kraken/driver.html?testName=audio-beat-detection) 22:11:23 INFO - 2015-11-22 22:11:23,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 177954816 22:11:23 INFO - 2015-11-22 22:11:23,183 DEBUG : BROWSER_OUTPUT: 22:11:25 INFO - 2015-11-22 22:11:25,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54163/tests/kraken/driver.html?testName=audio-dft) 22:11:26 INFO - 2015-11-22 22:11:26,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 168083456 22:11:26 INFO - 2015-11-22 22:11:26,324 DEBUG : BROWSER_OUTPUT: 22:11:29 INFO - 2015-11-22 22:11:29,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54163/tests/kraken/driver.html?testName=audio-fft) 22:11:29 INFO - 2015-11-22 22:11:29,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 149848064 22:11:29 INFO - 2015-11-22 22:11:29,769 DEBUG : BROWSER_OUTPUT: 22:11:31 INFO - 2015-11-22 22:11:31,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54163/tests/kraken/driver.html?testName=audio-oscillator) 22:11:32 INFO - 2015-11-22 22:11:32,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 155406336 22:11:32 INFO - 2015-11-22 22:11:32,308 DEBUG : BROWSER_OUTPUT: 22:11:34 INFO - 2015-11-22 22:11:34,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54163/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:11:35 INFO - 2015-11-22 22:11:35,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 156729344 22:11:35 INFO - 2015-11-22 22:11:35,043 DEBUG : BROWSER_OUTPUT: 22:11:37 INFO - 2015-11-22 22:11:37,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54163/tests/kraken/driver.html?testName=imaging-darkroom) 22:11:38 INFO - 2015-11-22 22:11:38,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 155734016 22:11:38 INFO - 2015-11-22 22:11:38,481 DEBUG : BROWSER_OUTPUT: 22:11:41 INFO - 2015-11-22 22:11:41,862 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54163/tests/kraken/driver.html?testName=imaging-desaturate) 22:11:42 INFO - 2015-11-22 22:11:42,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 156397568 22:11:42 INFO - 2015-11-22 22:11:42,431 DEBUG : BROWSER_OUTPUT: 22:11:45 INFO - 2015-11-22 22:11:45,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54163/tests/kraken/driver.html?testName=json-parse-financial) 22:11:45 INFO - 2015-11-22 22:11:45,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 157028352 22:11:45 INFO - 2015-11-22 22:11:45,756 DEBUG : BROWSER_OUTPUT: 22:11:47 INFO - 2015-11-22 22:11:47,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54163/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:11:47 INFO - 2015-11-22 22:11:47,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 164888576 22:11:47 INFO - 2015-11-22 22:11:47,870 DEBUG : BROWSER_OUTPUT: 22:11:49 INFO - 2015-11-22 22:11:49,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54163/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:11:50 INFO - 2015-11-22 22:11:50,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 165027840 22:11:50 INFO - 2015-11-22 22:11:50,254 DEBUG : BROWSER_OUTPUT: 22:11:52 INFO - 2015-11-22 22:11:52,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54163/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:11:52 INFO - 2015-11-22 22:11:52,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 173383680 22:11:52 INFO - 2015-11-22 22:11:52,892 DEBUG : BROWSER_OUTPUT: 22:11:55 INFO - 2015-11-22 22:11:55,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:11:55 INFO - 2015-11-22 22:11:55,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 180215808 22:11:55 INFO - 2015-11-22 22:11:55,876 DEBUG : BROWSER_OUTPUT: 22:11:58 INFO - 2015-11-22 22:11:58,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:11:58 INFO - 2015-11-22 22:11:58,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 179240960 22:11:58 INFO - 2015-11-22 22:11:58,960 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54163/tests/kraken/driver.html?testName=ai-astar) 22:12:00 INFO - 2015-11-22 22:12:00,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 238366720 22:12:00 INFO - 2015-11-22 22:12:00,859 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,860 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:12:00 INFO - 2015-11-22 22:12:00,861 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:12:00 INFO - 2015-11-22 22:12:00,861 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:12:00 INFO - 2015-11-22 22:12:00,861 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:12:00 INFO - 2015-11-22 22:12:00,861 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;103;111;111;112;99;109;109;109 22:12:00 INFO - 2015-11-22 22:12:00,861 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;128;151;162;123;156;144;125;161;124 22:12:00 INFO - 2015-11-22 22:12:00,861 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;163;161;160;161;160;160;163;160;161 22:12:00 INFO - 2015-11-22 22:12:00,861 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;81;92;72;72;72;105;103;71 22:12:00 INFO - 2015-11-22 22:12:00,861 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;147;90;90;90;136;89;90;134 22:12:00 INFO - 2015-11-22 22:12:00,861 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;109;109 22:12:00 INFO - 2015-11-22 22:12:00,861 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;145;145;147;145;146;145;145 22:12:00 INFO - 2015-11-22 22:12:00,861 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;96;96;96;96;95;96 22:12:00 INFO - 2015-11-22 22:12:00,862 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;57;57;57;58;58;69;54;56 22:12:00 INFO - 2015-11-22 22:12:00,862 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;70;69;69;69;69;68 22:12:00 INFO - 2015-11-22 22:12:00,862 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;84;86;84;84;84;94;84;84;92 22:12:00 INFO - 2015-11-22 22:12:00,862 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;118;124;114;120;122;115;121;116;121 22:12:00 INFO - 2015-11-22 22:12:00,862 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;149;160;149;150;139;151;137;139;136 22:12:00 INFO - 2015-11-22 22:12:00,862 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;65;67;67;66;66;66;65;66 22:12:00 INFO - 2015-11-22 22:12:00,862 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:12:00 INFO - 2015-11-22 22:12:00,862 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:12:00 INFO - 2015-11-22 22:12:00,862 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,893 22:12:00 INFO - 2015-11-22 22:12:00,862 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:12:00 INFO - 2015-11-22 22:12:00,862 DEBUG : BROWSER_OUTPUT: __startTimestamp1448259120859__endTimestamp 22:12:00 INFO - 2015-11-22 22:12:00,862 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,866 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:12:00 INFO - 2015-11-22 22:12:00,866 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:12:00 INFO - 2015-11-22 22:12:00,866 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,866 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.40 Median:111.00 stddev:4.14 (3.7%) stddev-sans-first:4.35 22:12:00 INFO - 2015-11-22 22:12:00,866 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 103.0 111.0 111.0 112.0 99.0 109.0 109.0 109.0 22:12:00 INFO - 2015-11-22 22:12:00,866 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,866 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.50 Median:151.00 stddev:15.95 (10.6%) stddev-sans-first:16.62 22:12:00 INFO - 2015-11-22 22:12:00,866 DEBUG : BROWSER_OUTPUT: Values: 151.0 128.0 151.0 162.0 123.0 156.0 144.0 125.0 161.0 124.0 22:12:00 INFO - 2015-11-22 22:12:00,866 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,866 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.15 (0.7%) stddev-sans-first:1.22 22:12:00 INFO - 2015-11-22 22:12:00,866 DEBUG : BROWSER_OUTPUT: Values: 161.0 163.0 161.0 160.0 161.0 160.0 160.0 163.0 160.0 161.0 22:12:00 INFO - 2015-11-22 22:12:00,866 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,866 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.00 Median:72.00 stddev:13.84 (19.2%) stddev-sans-first:14.20 22:12:00 INFO - 2015-11-22 22:12:00,866 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 81.0 92.0 72.0 72.0 72.0 105.0 103.0 71.0 22:12:00 INFO - 2015-11-22 22:12:00,866 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,867 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.70 Median:90.00 stddev:23.90 (26.6%) stddev-sans-first:24.83 22:12:00 INFO - 2015-11-22 22:12:00,867 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 147.0 90.0 90.0 90.0 136.0 89.0 90.0 134.0 22:12:00 INFO - 2015-11-22 22:12:00,867 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,867 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:12:00 INFO - 2015-11-22 22:12:00,867 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 109.0 22:12:00 INFO - 2015-11-22 22:12:00,867 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,867 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 22:12:00 INFO - 2015-11-22 22:12:00,867 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 145.0 145.0 147.0 145.0 146.0 145.0 145.0 22:12:00 INFO - 2015-11-22 22:12:00,868 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,868 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:12:00 INFO - 2015-11-22 22:12:00,868 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 22:12:00 INFO - 2015-11-22 22:12:00,868 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,868 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:3.99 (6.9%) stddev-sans-first:4.24 22:12:00 INFO - 2015-11-22 22:12:00,868 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 57.0 57.0 57.0 58.0 58.0 69.0 54.0 56.0 22:12:00 INFO - 2015-11-22 22:12:00,868 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,868 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 22:12:00 INFO - 2015-11-22 22:12:00,868 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 70.0 69.0 69.0 69.0 69.0 68.0 22:12:00 INFO - 2015-11-22 22:12:00,868 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,868 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:84.50 stddev:3.73 (4.4%) stddev-sans-first:3.93 22:12:00 INFO - 2015-11-22 22:12:00,868 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 86.0 84.0 84.0 84.0 94.0 84.0 84.0 92.0 22:12:00 INFO - 2015-11-22 22:12:00,869 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,869 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:121.00 stddev:3.47 (2.9%) stddev-sans-first:3.43 22:12:00 INFO - 2015-11-22 22:12:00,869 DEBUG : BROWSER_OUTPUT: Values: 123.0 118.0 124.0 114.0 120.0 122.0 115.0 121.0 116.0 121.0 22:12:00 INFO - 2015-11-22 22:12:00,869 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,869 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.70 Median:149.00 stddev:8.15 (5.5%) stddev-sans-first:8.16 22:12:00 INFO - 2015-11-22 22:12:00,869 DEBUG : BROWSER_OUTPUT: Values: 137.0 149.0 160.0 149.0 150.0 139.0 151.0 137.0 139.0 136.0 22:12:00 INFO - 2015-11-22 22:12:00,869 DEBUG : BROWSER_OUTPUT: 22:12:00 INFO - 2015-11-22 22:12:00,869 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 22:12:00 INFO - 2015-11-22 22:12:00,869 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 65.0 67.0 67.0 66.0 66.0 66.0 65.0 66.0 22:12:00 INFO - 2015-11-22 22:12:00,869 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:12:00 INFO - 2015-11-22 22:12:00,869 DEBUG : BROWSER_OUTPUT: 22:12:01 INFO - 2015-11-22 22:12:01,673 INFO : Browser exited with error code: 0 22:12:01 INFO - 2015-11-22 22:12:01,729 INFO : Completed test kraken (00:00:58) 22:12:01 INFO - 2015-11-22 22:12:01,730 INFO : Starting test v8_7 22:12:01 INFO - 2015-11-22 22:12:01,730 DEBUG : operating with platform_type : linux_ 22:12:01 INFO - 2015-11-22 22:12:01,730 INFO : Initialising browser for v8_7 test... 22:12:01 INFO - 2015-11-22 22:12:01,736 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEkyb8Z/profile http://localhost:54163/getInfo.html 22:12:05 INFO - 2015-11-22 22:12:05,864 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:12:05 INFO - 2015-11-22 22:12:05,864 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:12:05 INFO - 2015-11-22 22:12:05,864 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:12:05 INFO - 2015-11-22 22:12:05,864 DEBUG : BROWSER_OUTPUT: __metrics 22:12:06 INFO - 2015-11-22 22:12:06,041 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:12:07 INFO - 2015-11-22 22:12:07,256 INFO : Browser initialized. 22:12:07 INFO - 2015-11-22 22:12:07,256 INFO : Running cycle 1/1 for v8_7 test... 22:12:07 INFO - 2015-11-22 22:12:07,256 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEkyb8Z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:12:19 INFO - 2015-11-22 22:12:19,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 141524992 22:12:19 INFO - 2015-11-22 22:12:19,072 DEBUG : BROWSER_OUTPUT: 22:12:40 INFO - 2015-11-22 22:12:40,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54163/tests/v8_7/run.html (next: http://localhost:54163/tests/v8_7/run.html) 22:12:40 INFO - 2015-11-22 22:12:40,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 542736384 22:12:40 INFO - 2015-11-22 22:12:40,706 DEBUG : BROWSER_OUTPUT: 22:12:40 INFO - 2015-11-22 22:12:40,707 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:12:40 INFO - 2015-11-22 22:12:40,707 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:12:40 INFO - 2015-11-22 22:12:40,707 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:12:40 INFO - 2015-11-22 22:12:40,707 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:12:40 INFO - 2015-11-22 22:12:40,707 DEBUG : BROWSER_OUTPUT: |0;Richards;162.5487646293888 22:12:40 INFO - 2015-11-22 22:12:40,707 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.19938176197837 22:12:40 INFO - 2015-11-22 22:12:40,707 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.7380410022779 22:12:40 INFO - 2015-11-22 22:12:40,707 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025.125628140703 22:12:40 INFO - 2015-11-22 22:12:40,707 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1956.9471624266146 22:12:40 INFO - 2015-11-22 22:12:40,707 DEBUG : BROWSER_OUTPUT: |5;Earley;785.5459544383347 22:12:40 INFO - 2015-11-22 22:12:40,707 DEBUG : BROWSER_OUTPUT: |6;Boyer;12048.192771084337 22:12:40 INFO - 2015-11-22 22:12:40,707 DEBUG : BROWSER_OUTPUT: |7;RegExp;26076.923076923078 22:12:40 INFO - 2015-11-22 22:12:40,707 DEBUG : BROWSER_OUTPUT: |8;Splay;585.480093676815 22:12:40 INFO - 2015-11-22 22:12:40,707 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 22:12:40 INFO - 2015-11-22 22:12:40,707 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:12:40 INFO - 2015-11-22 22:12:40,708 DEBUG : BROWSER_OUTPUT: __startTimestamp1448259160700__endTimestamp 22:12:40 INFO - 2015-11-22 22:12:40,708 DEBUG : BROWSER_OUTPUT: 22:12:40 INFO - 2015-11-22 22:12:40,708 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:12:40 INFO - 2015-11-22 22:12:40,708 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:12:40 INFO - 2015-11-22 22:12:40,708 DEBUG : BROWSER_OUTPUT: 22:12:40 INFO - 2015-11-22 22:12:40,708 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.55 Median:162.55 stddev:0.00 (0.0%) 22:12:40 INFO - 2015-11-22 22:12:40,708 DEBUG : BROWSER_OUTPUT: Values: 162.5 22:12:40 INFO - 2015-11-22 22:12:40,708 DEBUG : BROWSER_OUTPUT: 22:12:40 INFO - 2015-11-22 22:12:40,708 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.20 Median:193.20 stddev:0.00 (0.0%) 22:12:40 INFO - 2015-11-22 22:12:40,708 DEBUG : BROWSER_OUTPUT: Values: 193.2 22:12:40 INFO - 2015-11-22 22:12:40,708 DEBUG : BROWSER_OUTPUT: 22:12:40 INFO - 2015-11-22 22:12:40,708 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.74 Median:284.74 stddev:0.00 (0.0%) 22:12:40 INFO - 2015-11-22 22:12:40,708 DEBUG : BROWSER_OUTPUT: Values: 284.7 22:12:40 INFO - 2015-11-22 22:12:40,708 DEBUG : BROWSER_OUTPUT: 22:12:40 INFO - 2015-11-22 22:12:40,708 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.13 Median:5025.13 stddev:0.00 (0.0%) 22:12:40 INFO - 2015-11-22 22:12:40,709 DEBUG : BROWSER_OUTPUT: Values: 5025.1 22:12:40 INFO - 2015-11-22 22:12:40,709 DEBUG : BROWSER_OUTPUT: 22:12:40 INFO - 2015-11-22 22:12:40,709 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1956.95 Median:1956.95 stddev:0.00 (0.0%) 22:12:40 INFO - 2015-11-22 22:12:40,709 DEBUG : BROWSER_OUTPUT: Values: 1956.9 22:12:40 INFO - 2015-11-22 22:12:40,709 DEBUG : BROWSER_OUTPUT: 22:12:40 INFO - 2015-11-22 22:12:40,709 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:785.55 Median:785.55 stddev:0.00 (0.0%) 22:12:40 INFO - 2015-11-22 22:12:40,709 DEBUG : BROWSER_OUTPUT: Values: 785.5 22:12:40 INFO - 2015-11-22 22:12:40,709 DEBUG : BROWSER_OUTPUT: 22:12:40 INFO - 2015-11-22 22:12:40,709 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 22:12:40 INFO - 2015-11-22 22:12:40,710 DEBUG : BROWSER_OUTPUT: Values: 12048.2 22:12:40 INFO - 2015-11-22 22:12:40,710 DEBUG : BROWSER_OUTPUT: 22:12:40 INFO - 2015-11-22 22:12:40,710 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26076.92 Median:26076.92 stddev:0.00 (0.0%) 22:12:40 INFO - 2015-11-22 22:12:40,710 DEBUG : BROWSER_OUTPUT: Values: 26076.9 22:12:40 INFO - 2015-11-22 22:12:40,710 DEBUG : BROWSER_OUTPUT: 22:12:40 INFO - 2015-11-22 22:12:40,710 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:585.48 Median:585.48 stddev:0.00 (0.0%) 22:12:40 INFO - 2015-11-22 22:12:40,710 DEBUG : BROWSER_OUTPUT: Values: 585.5 22:12:40 INFO - 2015-11-22 22:12:40,711 DEBUG : BROWSER_OUTPUT: 22:12:40 INFO - 2015-11-22 22:12:40,711 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 22:12:40 INFO - 2015-11-22 22:12:40,711 DEBUG : BROWSER_OUTPUT: Values: 4840.6 22:12:40 INFO - 2015-11-22 22:12:40,711 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:12:40 INFO - 2015-11-22 22:12:40,711 DEBUG : BROWSER_OUTPUT: 22:12:41 INFO - 2015-11-22 22:12:41,573 INFO : Browser exited with error code: 0 22:12:41 INFO - 2015-11-22 22:12:41,590 INFO : Completed test v8_7 (00:00:39) 22:12:41 INFO - 2015-11-22 22:12:41,729 INFO : Completed test suite (00:20:13) 22:12:41 INFO - 2015-11-22 22:12:41,729 DEBUG : Working with test: dromaeo_css 22:12:41 INFO - 2015-11-22 22:12:41,729 DEBUG : Generating results file: dromaeo_css 22:12:41 INFO - 2015-11-22 22:12:41,730 DEBUG : Working with test: kraken 22:12:41 INFO - 2015-11-22 22:12:41,730 DEBUG : Generating results file: kraken 22:12:41 INFO - 2015-11-22 22:12:41,730 INFO : javascript benchmark 22:12:41 INFO - 2015-11-22 22:12:41,731 DEBUG : Working with test: v8_7 22:12:41 INFO - 2015-11-22 22:12:41,731 DEBUG : Generating results file: v8_7 22:12:41 INFO - 2015-11-22 22:12:41,731 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:12:41 INFO - 2015-11-22 22:12:41,796 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 22:12:41 INFO - 2015-11-22 22:12:41,796 DEBUG : process_Request line: dromaeo_css 7109.27 graph.html#tests=[[72,201,35]] 22:12:41 INFO - 2015-11-22 22:12:41,796 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:12:41 INFO - 2015-11-22 22:12:41,828 DEBUG : process_Request line: kraken 1492.20 graph.html#tests=[[232,201,35]] 22:12:41 INFO - 2015-11-22 22:12:41,828 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:12:41 INFO - 2015-11-22 22:12:41,861 DEBUG : process_Request line: v8_7 19974.53 graph.html#tests=[[230,201,35]] 22:12:41 INFO - 2015-11-22 22:12:41,863 INFO : javascript benchmark 22:12:41 INFO - 2015-11-22 22:12:41,865 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3224.161717953332, 3307.603087629485, 3337.899863004109, 3345.5149003394495, 3367.040393487856, 5290.153575427932, 5376.865578360533, 5416.350037995441, 5531.668099914003, 5569.832905012851, 5428.511433970942, 5451.536619387347, 5497.532709719669, 5513.365962914266, 5593.692346920918, 5074.873128171788, 5077.035363280974, 5095.79616815327, 5134.204198349262, 5163.173892177252, 4926.802927882881, 5160.096983027974, 5180.093483640367, 5213.635045546814, 5244.318238628973, 4904.656674032837, 5011.0, 5025.0954828130925, 5027.296178535008, 5027.874303142414, 5080.79676812927, 5087.389513258396, 5092.719900405476, 5102.9489705103215, 5130.666506677091, 4916.729579873106, 5009.398872135331, 5026.0, 5029.547340739315, 5031.798728050873, 5292.523672869422, 5310.7610157543, 5377.381601115882, 5383.75773090208, 5421.701806400646, 5994.760209591611, 6015.518758499309, 6018.127371531104, 6018.6689732064715, 6019.729112189962, 5783.392743761887, 5905.527557795366, 6043.788467403664, 6060.0, 6063.666498342589, 5468.7265636718, 5507.889842203133, 5516.834494965157, 5531.917021244644, 5570.610057295991, 6035.818925432244, 6039.1545183674325, 6089.905260371706, 6091.0558863376245, 6091.208142941389, 5760.884782304331, 5882.852928676817, 5935.228420305419, 5942.0, 5955.612885162451, 5913.9112913306335, 5915.852103697356, 5988.760449581968, 6006.699665016732, 6046.909296360558, 5975.19334889793, 5982.252218472691, 5982.73077711504, 5983.042713165873, 5984.8803023940145, 5819.592628516048, 5923.526117910556, 5973.133895585116, 5977.0, 5981.162637230791, 4519.5480451954545, 4551.385562949025, 4551.590356867898, 4565.474970378383, 4622.722636641813, 4058.817353219112, 4068.6948478864206, 4071.145059537471, 4101.958980410217, 4119.8352065917625, 5532.0, 5600.35595906476, 5616.1014237721765, 5621.7189140542805, 5630.915536266959, 5791.7683292667825, 5844.970775146182, 5848.152017957373, 5859.384764599741, 5979.0, 5529.723513824292, 5610.186522954149, 5686.886262274731, 5718.771249149988, 5722.7424765885635, 5102.438731739506, 5216.400113986864, 5236.162214045735, 5266.420693723688, 5270.288511051036, 6100.115483254903, 6162.907556386658, 6170.722317495633, 6174.567780255429, 6183.567150299616, 5954.434328738763, 6094.847628809315, 6105.0, 6107.175531303217, 6111.480524155497, 5917.733701983507, 5974.044152935509, 6039.6678182698615, 6208.140005294085, 6296.811095667137, 5942.6731529766275, 5982.0727787193055, 5982.790602328898, 5990.760369585342, 6013.428724271187, 6013.098035294741, 6071.089336599545, 6080.665563394055, 6082.574219804571, 6086.513078953762, 5769.22115514417, 5780.479756821738, 5876.471117599436, 5896.9115463268945, 5929.140274660236, 5855.238818953509, 5858.179854820414, 5860.38465961085, 5864.530837532901, 5920.200772895604, 5799.884002319845, 5804.883902322014, 5807.303123625192, 5811.62224455426, 5813.447722466359, 5754.884902302014, 5809.186713860147, 5875.823725288248, 5881.0, 6005.429484198994, 5782.45066718661, 5804.82585522435, 5810.157527158453, 5810.477057064884, 5820.883582328414], "unit": "ms", "name": "dojo.html", "value": 5500.607600763786}, {"lowerIsBetter": false, "replicates": [569.115026134361, 596.9611975221611, 600.807741522713, 609.0650850943803, 615.0221148374085, 30110.0, 39844.2031159377, 40238.0, 40323.59676403235, 40405.19189616206, 43549.0, 43589.56410435895, 43715.78142109293, 43935.78032109835, 44132.0, 7569.545827250383, 7683.807904802369, 8798.956005219981, 8924.107589241088, 8984.865227021568, 10491.213159013105, 10751.62369317074, 10767.954088723156, 10772.946135269352, 10779.46102694866, 10443.84334234987, 10541.6310429135, 10543.47282635869, 10545.314554553968, 10552.419616921066, 7729.884051739228, 7899.210078992083, 7905.288524032865, 10352.0, 10436.895631043706, 10290.43402612856, 10395.740106497322, 10428.634997775118, 10442.895571044344, 10453.947730261376, 39597.60402395997, 40064.39903401451, 40098.79950600257, 40101.79949100265, 40136.799316003235, 3280.327532855759, 3324.9501257481156, 3442.0, 3669.522962014921, 3745.793981331026, 30573.541396879064, 30664.540031899316, 30883.22791930197, 31306.904258351075, 32047.0, 3922.0979174789672, 3994.6404823566018, 4020.2562525932794, 4114.979425102885, 4217.072244106292, 288513.0, 291497.0, 292162.0, 292230.0, 292412.99999999785, 54490.18264726032, 55153.72423137858, 55161.72419137879, 65606.67196663986, 66910.66544667343, 64484.0, 64529.0, 64833.35166648273, 64918.0, 65006.0, 14745.926270368795, 15024.774628380583, 15027.624309392353, 15035.54893353201, 15043.774343384857, 10413.895861041445, 10436.947815260875, 10437.582496700199, 10479.109275711497, 10519.684409467729, 20830.27094051701, 20880.47798805042, 21097.0, 21110.261140860304, 21141.471463213544, 8070.063184835597, 8101.797455063553, 8228.876566851503, 8270.214329638675, 8281.710140145065, 948.1040416806052, 962.7448726087592, 985.2315194148432, 1010.934289271195, 1081.3728037738092, 28000.439991200063, 28098.2975425616, 28438.0, 28491.57262641062, 28593.0, 1029.459533744775, 1066.338869900651, 1080.6109800471825, 1119.0096764363598, 1165.7668466306773, 14643.0, 14701.26493675312, 14892.106473611619, 15078.396864125532, 15118.168500732565, 413382.0, 417600.0, 419162.0, 419213.0, 419690.0, 55273.72363138159, 55521.167182492296, 55533.44466555364, 55736.72131639316, 55809.0, 1354.4108312883927, 1356.2337279437086, 1366.9521566745116, 1370.04097132006, 1377.407714682676, 27670.723292766816, 28100.297492562848, 28624.42751145007, 28693.426131476837, 28767.136985890458, 45210.32184517169, 45684.314735278334, 45690.54309456863, 45737.77131114323, 45811.54188458073, 292341.0, 292744.0, 292958.0, 294782.0, 295253.0, 32199.51700724444, 32566.837165814966, 32841.83579082089, 33013.17467063342, 33016.50475242825, 43566.0, 43697.0, 44372.0, 44550.10899781921, 44621.77689111534, 37345.813270933475, 37517.62482375251, 42090.368644469745, 43312.78343608262, 45405.0, 39730.801345994245, 41131.7943410281, 41210.0, 41400.79299603483, 44003.77998110117, 38525.80737096297, 39613.80193099016, 39628.0, 40180.0, 40236.798816005736, 36309.45535817018, 37931.2413751729, 38716.61283387243, 39282.410763839136, 40660.18679626332, 27304.0, 29052.128436146948, 29669.25826854346, 29685.85157074201, 30014.84992575023], "unit": "ms", "name": "ext.html", "value": 19515.11964643017}, {"lowerIsBetter": false, "replicates": [346.15192777694654, 355.92347645256274, 359.99100022499437, 362.7098321342925, 365.91035196376885, 13498.865011349884, 17130.571735706613, 17620.82379176208, 18094.276228950825, 18153.364632237874, 10690.839637405445, 13192.944564434822, 14883.181425021647, 15643.92178039111, 15671.921640391782, 3704.666580007799, 3826.9043273918096, 4801.639877009212, 4918.409790825106, 5268.473152684739, 5373.059714549958, 5377.516023557879, 5402.405735369126, 5418.160185171305, 5419.241306217133, 5359.249705041298, 5374.7850085996515, 5463.0, 5658.830235092933, 5665.065264231417, 5631.662100273997, 5649.830505084834, 5663.830085097454, 5664.178694089354, 5892.941070589325, 5234.607404444644, 5240.947590524084, 5241.056609810271, 5243.161094224905, 5244.108501554745, 12446.875531244663, 15226.619334516616, 19956.800431995638, 20327.89836050825, 20389.694154587545, 1999.5201151723627, 2114.3551216878845, 2156.827453803692, 2179.3570896585547, 2189.79196976287, 8721.738347849574, 9181.357304988653, 9358.391704539252, 11586.594469193538, 13183.736325273441, 1600.063962581891, 1749.80752117267, 1785.6071664233848, 1805.3951926104771, 1805.882617629863, 36867.0, 36919.0, 36951.0, 46808.76595617034, 48213.071477140875, 10297.17622590191, 10322.948385258025, 10336.224783141144, 10372.533236004398, 10404.843927341097, 13486.595402137951, 13490.865091349157, 13524.256165910772, 13529.391177397041, 13563.982701297442, 6661.100751398596, 6681.465482761368, 6681.766138185238, 6686.364795344434, 6766.729330826712, 5930.703464826742, 5996.670183139882, 6017.819465416044, 6119.357467465941, 6134.202553667995, 3853.9807300963316, 3975.1652153048185, 4315.78421078951, 4445.622122119591, 4490.618297444688, 1805.1370068054375, 1808.3038030358143, 1822.6992546229724, 1832.3495159218285, 1840.2885316655372, 932.2681694869631, 951.1439704266078, 957.5738796235747, 968.9273304502191, 985.2708995343394, 13559.389827457788, 15563.22183890801, 15899.920500397655, 16676.24956876919, 18269.63460730778, 900.2123142250531, 946.3375637053952, 950.8589692369185, 984.2126298960802, 991.2317953585884, 8537.701180458778, 9589.568469418893, 9829.164521015651, 10104.393736375841, 10230.386176829265, 587630.0, 589629.0, 594987.0, 618057.0, 620156.0, 77555.0, 80986.0, 81092.18907810964, 82368.0, 82629.58685206536, 1153.2042890405594, 1159.3449700918954, 1187.631834131422, 1188.1600889382962, 1198.3049831097942, 15787.921060394625, 15896.284667190235, 15909.0, 16064.919675401548, 16214.67570648604, 34538.48192277168, 34876.825615872775, 35329.57060095954, 36107.27785444224, 36310.8184459076, 45156.0, 46383.0, 46858.53141468678, 47014.294785578924, 49639.255411169586, 9415.717528474157, 9500.95249523748, 9794.118529332394, 9794.412335259907, 9799.216062715108, 17059.317627295266, 17350.47948561545, 17478.73781893298, 17511.912440437718, 17681.646367072844, 14283.928705346932, 14363.56909292723, 14505.927470362582, 14556.636084097981, 15039.849601503845, 11139.275947063416, 11640.185187037165, 11775.646730598095, 13986.300684965507, 14645.510263255059, 12118.394080296126, 14028.438862445388, 14239.928800355932, 14263.144211347353, 14855.92572037133, 9723.124918757347, 9777.755556111155, 9792.314537982273, 9799.167070799062, 9841.60633574649, 14442.205678687773, 14580.489682861049, 14643.414263429344, 14968.625784355043, 15046.097234165985], "unit": "ms", "name": "jquery.html", "value": 8658.238414292102}, {"lowerIsBetter": false, "replicates": [1317.02540120311, 1705.8208888066752, 1740.3299729604098, 1784.4825000749784, 1807.4487281379181, 6957.443404527632, 7449.962750186248, 7799.92200077999, 7801.492902961318, 7817.726379576702, 7662.578558179298, 7837.686492540306, 7846.372290216783, 7864.292213700765, 7882.330001949841, 2019.0712272354735, 2063.3294179391683, 2246.2250523569382, 2256.593813113639, 2269.4780200553882, 2296.2996286132725, 2301.0450662974845, 2304.7003889494426, 2305.8616483010987, 2306.308107567723, 2105.200023990881, 2181.7490988536365, 2183.3340831046526, 2186.5517568898335, 2187.0923566719794, 1994.311962372979, 2042.0810635214139, 2213.3802535290224, 2263.7736226377397, 2265.29775769512, 2256.8420210585264, 2271.738750043733, 2294.5181511882524, 2296.1504243430036, 2300.7354154272307, 7755.379569634416, 7811.179826118289, 7816.257455541714, 7821.413393995416, 7821.452498325119, 4487.19230538503, 4576.633869290449, 4581.244094724367, 4584.35818985339, 4592.2193227151465, 3186.8725250989933, 3187.10760986924, 3202.055393658853, 3223.6615155408813, 3256.1696767324415, 982.4841957972051, 983.6458874805064, 1015.3146626027476, 1063.6011495689118, 1078.6710053433699, 10996.06533444658, 11009.944950275278, 11042.116630669527, 11043.447827608587, 11057.723556911062, 4037.858674946363, 4176.436181115571, 4180.749155050707, 4211.473565804275, 4247.51153617338, 9424.434533927986, 9437.056294370645, 9452.90547094534, 9454.101860323259, 9466.100720431687, 4695.600873925686, 4699.6240300776535, 4700.388949436551, 4701.412323459567, 4701.976490117596, 4206.3480160574545, 4214.05183833635, 4227.894302642397, 4237.449131612871, 4240.448741663564, 3620.5293311869286, 3651.068977410743, 3669.5779985301497, 3681.4661874028116, 3688.9631103689157, 1147.1281825812275, 1168.818833080874, 1169.4386694386742, 1172.7068232941765, 1175.1949914308725, 1280.705437749323, 1281.5706738242607, 1284.5054653958293, 1313.947442102305, 1327.6349004023778, 6915.135608048994, 6918.965405172942, 7605.923940760522, 7661.272179142972, 7670.693172273047, 620.9937900621027, 629.0969816305712, 631.7946667333043, 634.0837489827247, 640.6668532363145, 5665.915011274834, 5910.320313164041, 5913.58604897653, 5952.553558483131, 5958.612690175125, 9528.809423811485, 9722.0, 9729.054189162196, 9737.756556086013, 9750.122488976027, 9412.576434060484, 9511.096445837635, 9562.856557151648, 9613.327067105376, 9635.084666956627, 7358.484906056632, 7396.445266604918, 7418.888716669254, 7444.553326800409, 7487.363574096154, 7079.68141433647, 7133.429325654039, 7171.8565628688175, 7202.099737532809, 7332.266773322625, 8116.918830811616, 8424.241818236389, 8452.873206901779, 8528.701495447629, 8536.871946920677, 8446.619902104298, 8499.617517211616, 8604.956975215084, 8632.438891472035, 8834.558272086499, 7070.646467676698, 7191.748288809867, 7197.8920316196345, 7199.424046076406, 7206.522662854207, 7645.273698998586, 7676.692932282869, 7710.614469276402, 7832.921670783219, 7863.292303692695, 6937.514373993772, 6988.0, 7304.598247096461, 7407.518511296748, 7502.174760776201, 7076.32774886385, 7108.147022357351, 7238.059052323164, 7277.708891644275, 7381.889271660822, 6365.172527571386, 6508.674566271573, 7341.375983041501, 7391.482596218213, 7398.223186565333, 6521.967390163209, 6676.766313179015, 6693.966530167318, 6715.865682686222, 6728.259891412039, 6588.901166482602, 6645.734170633121, 6668.499862510234, 6685.866282674417, 6694.062831203538], "unit": "ms", "name": "mootools.html", "value": 4471.42386122349}, {"lowerIsBetter": false, "replicates": [317.26553029736147, 318.1267420929547, 321.92595702988314, 323.12594432061275, 324.5602209006795, 6026.608270462417, 6067.817965461038, 6104.664243466607, 6127.479164271037, 6152.077188421739, 5994.970025149879, 6008.519318454524, 6014.759409623621, 6015.518758499321, 6026.9809613779325, 4614.054118905617, 4616.699914505546, 4618.584327410533, 4624.491305956342, 4627.467841198271, 4432.844850430236, 4576.931346029813, 4631.513691062441, 4632.166210082184, 4637.837675681352, 4552.408186935694, 4569.109023740372, 4574.473935497411, 4575.062112266977, 4577.542245775412, 4553.0, 4556.088782243548, 4560.794764235618, 4563.406757121569, 4583.449986001668, 3833.4824798652103, 3869.0520822398694, 3897.2984862724697, 3903.258380907647, 3905.5899130591447, 5770.451807078321, 5804.564657650693, 5833.766649334021, 5874.9118763218585, 5878.470937615635, 5307.2835167252315, 5322.467753224685, 5322.520973112439, 5327.360716714019, 5328.227407025959, 5975.940240597625, 6185.56701030928, 6287.276963149205, 6298.118263443122, 6420.807375778734, 4370.0, 4406.625436837872, 4416.425864637608, 4418.182636212279, 4420.248557745191, 6588.769393071219, 6654.86690266192, 6670.4663626910215, 6674.399304062657, 6680.83297917551, 4494.887627809331, 4496.078303947683, 4497.370368148462, 4497.8425755098415, 4500.167469018242, 4440.755758433317, 4521.728696278234, 4550.97724511382, 4551.431071116111, 4557.567031132037, 5331.093714068617, 5340.599455040888, 5343.091674415358, 5344.0, 5344.064788661969, 6514.348565143542, 6522.315156908551, 6526.641034743135, 6526.934730652728, 6532.934670653328, 1589.3960295087793, 1609.2677831586834, 1610.3397606981082, 1612.0, 1612.3389410341938, 1053.6039747334812, 1060.6446840308429, 1062.4687656171914, 1070.6734445994045, 1084.1272775415866, 6274.309825919146, 6274.341194174637, 6278.0, 6278.089676996809, 6281.59169653971, 6704.094947182166, 6707.5975441473665, 6708.228553716288, 6710.83222919431, 6724.125863637696, 6112.816615501453, 6263.0, 6266.874662506815, 6273.654948977759, 6274.05889116627, 3588.4796704477703, 3604.062943634621, 3606.170580766386, 3610.476480910306, 3618.2944325856206, 6686.866262674719, 6870.690818913161, 6898.689558969859, 6900.102986611709, 7033.507654464241, 6890.1731792184255, 6905.205901321312, 6913.2049814270995, 6925.203601585781, 6946.0622815919205, 6821.181458224945, 6975.825604359931, 6978.685959131852, 6979.89530157048, 6988.44092472601, 6784.185897692309, 6785.728570857111, 6786.558873673195, 6786.8642627148165, 6802.897956530557, 6694.163229596301, 6698.66506674674, 6705.362990515893, 6707.765228216989, 6709.865802684017, 6810.421114205348, 6982.79051628452, 6990.510664253454, 6997.160340759141, 6999.895001574879, 4481.350204220435, 4522.638188944942, 4534.387857639176, 4537.4328208973875, 4538.773061346853, 6714.0, 6753.527253092237, 6757.493188010821, 6767.830804229934, 6770.0, 6416.550841441054, 6571.145751052332, 6578.210614726264, 6581.44057755077, 6593.538452308292, 6527.738890444329, 6571.145751052524, 6576.638284894377, 6578.210614726264, 6588.538802283794, 6388.840278992877, 6407.935920640921, 6427.710753016032, 6438.0, 6446.484281257582, 6421.229452465734, 6586.242582102927, 6589.143411356493, 6590.044443555754, 6595.274519802721, 6385.840353991001, 6393.1688880445245, 6402.967985160044, 6417.0, 6418.037294405876], "unit": "ms", "name": "prototype.html", "value": 4850.8946803164645}, {"lowerIsBetter": false, "replicates": [736.2269616902252, 780.6448066129909, 808.2967817998342, 834.6202477872569, 856.216561845911, 15229.314680839361, 15233.92383038086, 15285.923570382132, 15301.617459563502, 15345.232738363078, 14797.112173269612, 15114.546563603082, 15119.319630616621, 15148.924255378708, 15155.469558565452, 703.1702590942685, 719.8812195987682, 826.0995514888755, 837.623069618671, 838.3921656798833, 827.6275675945849, 835.8244768598602, 841.9663213471454, 843.0305149078578, 843.3801156150224, 888.0276097673037, 888.4935586715575, 888.6001299415257, 889.257470012537, 889.5685592487638, 722.5628494760647, 738.2949283434334, 879.0945326313907, 888.9687961964155, 889.5996801439346, 655.2235600813052, 655.3642966322659, 655.6688872119549, 657.6777379084263, 659.5877576514679, 13992.370343334574, 14131.78802317966, 14137.646558836008, 14137.717245655133, 14145.575632731034, 12220.877791222063, 12249.448774805156, 12630.179038362478, 12788.168769029984, 13027.413766380536, 9928.0, 10202.846957295647, 10427.582896684124, 11763.647090587296, 11949.462274197682, 3701.444783282502, 3709.573399059089, 3713.3316003119426, 3744.7753134811996, 3870.0711829161082, 48591.27113093306, 48954.51045489571, 49223.26165107491, 49556.25665615019, 49834.0, 10002.449865257335, 10222.080012798735, 10364.326318789255, 10529.0, 10599.311044782064, 19132.713009304873, 19159.425217243504, 19166.233350666094, 19286.903565482084, 19302.32441864556, 7421.0, 7624.8475030500185, 7800.687972481037, 7874.803129921798, 7940.523568585903, 4349.151915376535, 4369.388285640013, 4424.557544245549, 4432.15789000089, 4493.213687604656, 3100.224943764059, 3120.329129237225, 3139.764517661139, 3145.3394787094508, 3151.023182813289, 562.2550121089573, 567.7104676614956, 571.7398583644432, 576.0380165124252, 579.5247896724729, 586.357938057826, 611.9020956646915, 638.8051644248549, 659.6009414304277, 670.9060731497594, 7122.430205583644, 7582.582957937367, 8817.603207855662, 9011.234045106108, 9181.0, 461.4093959731549, 583.8569550460164, 585.0931056861847, 646.0793369448611, 647.760328678392, 3818.1218319786603, 4067.8169482373364, 4073.124278280184, 4197.496300443966, 4242.7242229255, 58189.127163092584, 58632.70683646554, 58867.0, 58940.7052964741, 58961.70519147377, 48858.0, 49073.263901041515, 50096.0, 50915.74542127266, 51096.233556496685, 44815.32777008347, 44983.32525012193, 45418.091638167054, 45420.77289613597, 45646.0, 8475.533845638303, 8519.48883067018, 8819.250363718898, 8903.376763626484, 8962.32782541299, 35124.648753512134, 35196.0, 35701.82149089342, 36019.0, 36087.63912360843, 41959.370609441496, 43942.34086488641, 44396.0, 45381.77309113433, 46523.76738116288, 10886.292390994877, 11002.284851484628, 11046.061084807881, 11233.775324493301, 11376.715582110513, 12533.0, 12583.119181657195, 12590.496380145058, 12745.61763147107, 13161.341932903126, 9947.850782238127, 10039.24705647094, 10758.569657213937, 10856.565737370416, 10891.836622450828, 11576.572547382502, 11919.018538821283, 11931.332617006852, 11952.64142075739, 12053.75892482163, 10521.158307335241, 10855.45722713877, 10914.563417463212, 10990.450477475933, 11214.327140371604, 9697.854532182164, 9814.705558833246, 9964.750881228027, 9977.151942085004, 10082.69751907444, 9257.583408746757, 9347.875572798494, 9360.297977651839, 9814.65648702292, 10000.749981250527], "unit": "ms", "name": "yui.html", "value": 6403.7194227216905}], "name": "dromaeo_css", "value": 7109.27178659824}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 103.0, 111.0, 111.0, 112.0, 99.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [151.0, 128.0, 151.0, 162.0, 123.0, 156.0, 144.0, 125.0, 161.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 161.0, 160.0, 161.0, 160.0, 160.0, 163.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 81.0, 92.0, 72.0, 72.0, 72.0, 105.0, 103.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 147.0, 90.0, 90.0, 90.0, 136.0, 89.0, 90.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 104.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 147.0, 145.0, 146.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 57.0, 57.0, 57.0, 58.0, 58.0, 69.0, 54.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 86.0, 84.0, 84.0, 84.0, 94.0, 84.0, 84.0, 92.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [123.0, 118.0, 124.0, 114.0, 120.0, 122.0, 115.0, 121.0, 116.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [137.0, 149.0, 160.0, 149.0, 150.0, 139.0, 151.0, 137.0, 139.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 67.0, 67.0, 66.0, 66.0, 66.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1492.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.5487646293888], "unit": "score", "name": "Richards", "value": 217.177904}, {"lowerIsBetter": false, "replicates": [193.19938176197837], "unit": "score", "name": "DeltaBlue", "value": 342.226768}, {"lowerIsBetter": false, "replicates": [284.7380410022779], "unit": "score", "name": "Encrypt", "value": 934.8276720000003}, {"lowerIsBetter": false, "replicates": [5025.125628140703], "unit": "score", "name": "Decrypt", "value": 52.970019}, {"lowerIsBetter": false, "replicates": [1956.9471624266146], "unit": "score", "name": "RayTrace", "value": 378.13437900000014}, {"lowerIsBetter": false, "replicates": [785.5459544383347], "unit": "score", "name": "Earley", "value": 848.4073989999999}, {"lowerIsBetter": false, "replicates": [12048.192771084337], "unit": "score", "name": "Boyer", "value": 55.31642899999996}, {"lowerIsBetter": false, "replicates": [26076.923076923078], "unit": "score", "name": "RegExp", "value": 34.934528023598794}, {"lowerIsBetter": false, "replicates": [585.480093676815], "unit": "score", "name": "Splay", "value": 139.18662800000004}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19974.53083520987}]} 22:12:41 INFO - RETURN: dromaeo_css: 7109.27 22:12:41 INFO - RETURN: kraken: 1492.20 22:12:41 INFO - RETURN: v8_7: 19974.53 22:12:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19974.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1492.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "7109.27"}}} 22:12:41 INFO - Return code: 0 22:12:41 INFO - # TBPL SUCCESS # 22:12:41 INFO - Running post-action listener: _resource_record_post_action 22:12:41 INFO - Running post-run listener: _resource_record_post_run 22:12:43 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 12288; Write bytes: 513998848; Read time: 488; Write time: 596252 22:12:43 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 139448320; Read time: 0; Write time: 156064 22:12:43 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 12288; Write bytes: 364281856; Read time: 488; Write time: 439588 22:12:43 INFO - Running post-run listener: _upload_blobber_files 22:12:43 INFO - Blob upload gear active. 22:12:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:12:43 INFO - Copying logs to upload dir... 22:12:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.204713 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-22 22:12:42.826372) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-22 22:12:42.829626) ========= 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-1448248495.688507-780482988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009944 build_url: 'https://queue.taskcluster.net/v1/task/vTPL64ALRyidwSX-J6wZRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-22 22:12:42.880145) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 22:12:42.880475) ========= 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-1448248495.688507-780482988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004639 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 22:12:42.929906) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-22 22:12:42.930217) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-22 22:12:42.930498) ========= ========= Total master_lag: 0.24 =========