builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1447218467.08 results: success (0) buildid: 20151110193458 builduid: 7ddd11f6e3444644b78bec83bf329e8f revision: 42359222aacee1512a68e70a92ff2fc5b4c00467 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:47.082610) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:47.083148) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:47.083507) ========= 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=01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.003012 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:47.123790) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:47.124175) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:47.327018) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:47.327348) ========= 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=01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.041932 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:47.386895) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:47.387238) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:47.387674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:47.388015) ========= 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=01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-10 21:07:47-- 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% 226M=0s 2015-11-10 21:07:47 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.282938 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:47.684093) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:47.684471) ========= 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=01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.223703 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:47.921572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:47.922003) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 42359222aacee1512a68e70a92ff2fc5b4c00467 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 42359222aacee1512a68e70a92ff2fc5b4c00467 --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=01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-10 21:07:48,040 truncating revision to first 12 chars 2015-11-10 21:07:48,040 Setting DEBUG logging. 2015-11-10 21:07:48,040 attempt 1/10 2015-11-10 21:07:48,040 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/42359222aace?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-10 21:07:48,263 unpacking tar archive at: mozilla-inbound-42359222aace/testing/mozharness/ program finished with exit code 0 elapsedTime=0.520927 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:48.458776) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:48.459163) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:48.470292) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:48.470698) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-10 21:07:48.471321) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-11-10 21:07:48.471672) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:07:48 INFO - MultiFileLogger online at 20151110 21:07:48 in /builds/slave/test-pgo 21:07:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:07:48 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:07:48 INFO - {'append_to_log': False, 21:07:48 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:07:48 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:07:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:07:48 INFO - 'branch': 'Mozilla-Inbound', 21:07:48 INFO - 'buildbot_json_path': 'buildprops.json', 21:07:48 INFO - 'config_files': ('talos/linux_config.py',), 21:07:48 INFO - 'default_actions': ('clobber', 21:07:48 INFO - 'read-buildbot-config', 21:07:48 INFO - 'download-and-extract', 21:07:48 INFO - 'populate-webroot', 21:07:48 INFO - 'create-virtualenv', 21:07:48 INFO - 'install', 21:07:48 INFO - 'run-tests'), 21:07:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:07:48 INFO - 'download_minidump_stackwalk': True, 21:07:48 INFO - 'download_symbols': 'ondemand', 21:07:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:07:48 INFO - 'tooltool.py': '/tools/tooltool.py', 21:07:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:07:48 INFO - '/tools/misc-python/virtualenv.py')}, 21:07:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:07:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:07:48 INFO - 'installer_path': 'installer.exe', 21:07:48 INFO - 'log_level': 'info', 21:07:48 INFO - 'log_name': 'talos', 21:07:48 INFO - 'log_to_console': True, 21:07:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:07:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:07:48 INFO - 'opt_config_files': (), 21:07:48 INFO - 'pip_index': False, 21:07:48 INFO - 'sps_profile': False, 21:07:48 INFO - 'sps_profile_interval': 0, 21:07:48 INFO - 'suite': 'dromaeojs-e10s', 21:07:48 INFO - 'system_bits': '64', 21:07:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:07:48 INFO - 'title': 'talos-linux64-ix-014', 21:07:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:07:48 INFO - 'use_talos_json': True, 21:07:48 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:07:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:07:48 INFO - 'work_dir': 'build'} 21:07:48 INFO - ##### 21:07:48 INFO - ##### Running clobber step. 21:07:48 INFO - ##### 21:07:48 INFO - Running pre-action listener: _resource_record_pre_action 21:07:48 INFO - Running main action method: clobber 21:07:48 INFO - rmtree: /builds/slave/test-pgo/build 21:07:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:07:55 INFO - Running post-action listener: _resource_record_post_action 21:07:55 INFO - ##### 21:07:55 INFO - ##### Running read-buildbot-config step. 21:07:55 INFO - ##### 21:07:55 INFO - Running pre-action listener: _resource_record_pre_action 21:07:55 INFO - Running main action method: read_buildbot_config 21:07:55 INFO - Using buildbot properties: 21:07:55 INFO - { 21:07:55 INFO - "properties": { 21:07:55 INFO - "buildnumber": 408, 21:07:55 INFO - "product": "firefox", 21:07:55 INFO - "script_repo_revision": "production", 21:07:55 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 21:07:55 INFO - "repository": "", 21:07:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 21:07:55 INFO - "buildid": "20151110193458", 21:07:55 INFO - "slavename": "talos-linux64-ix-014", 21:07:55 INFO - "pgo_build": "True", 21:07:55 INFO - "basedir": "/builds/slave/test-pgo", 21:07:55 INFO - "project": "", 21:07:55 INFO - "platform": "ubuntu64_hw", 21:07:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:07:55 INFO - "slavebuilddir": "test", 21:07:55 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:07:55 INFO - "branch": "mozilla-inbound", 21:07:55 INFO - "repo_path": "integration/mozilla-inbound", 21:07:55 INFO - "stage_platform": "linux64-pgo", 21:07:55 INFO - "builduid": "7ddd11f6e3444644b78bec83bf329e8f", 21:07:55 INFO - "revision": "42359222aacee1512a68e70a92ff2fc5b4c00467" 21:07:55 INFO - }, 21:07:55 INFO - "sourcestamp": { 21:07:55 INFO - "repository": "", 21:07:55 INFO - "hasPatch": false, 21:07:55 INFO - "project": "", 21:07:55 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 21:07:55 INFO - "changes": [ 21:07:55 INFO - { 21:07:55 INFO - "category": null, 21:07:55 INFO - "files": [ 21:07:55 INFO - { 21:07:55 INFO - "url": null, 21:07:55 INFO - "name": "https://queue.taskcluster.net/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:07:55 INFO - } 21:07:55 INFO - ], 21:07:55 INFO - "repository": "", 21:07:55 INFO - "rev": "42359222aacee1512a68e70a92ff2fc5b4c00467", 21:07:55 INFO - "who": "sendchange", 21:07:55 INFO - "when": 1447218196, 21:07:55 INFO - "number": 6646205, 21:07:55 INFO - "comments": "", 21:07:55 INFO - "project": "", 21:07:55 INFO - "at": "Tue 10 Nov 2015 21:03:16", 21:07:55 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 21:07:55 INFO - "revlink": "", 21:07:55 INFO - "properties": [ 21:07:55 INFO - [ 21:07:55 INFO - "buildid", 21:07:55 INFO - "20151110193458", 21:07:55 INFO - "Change" 21:07:55 INFO - ], 21:07:55 INFO - [ 21:07:55 INFO - "builduid", 21:07:55 INFO - "7ddd11f6e3444644b78bec83bf329e8f", 21:07:55 INFO - "Change" 21:07:55 INFO - ], 21:07:55 INFO - [ 21:07:55 INFO - "pgo_build", 21:07:55 INFO - "True", 21:07:55 INFO - "Change" 21:07:55 INFO - ] 21:07:55 INFO - ], 21:07:55 INFO - "revision": "42359222aacee1512a68e70a92ff2fc5b4c00467" 21:07:55 INFO - } 21:07:55 INFO - ], 21:07:55 INFO - "revision": "42359222aacee1512a68e70a92ff2fc5b4c00467" 21:07:55 INFO - } 21:07:55 INFO - } 21:07:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:07:55 INFO - Running post-action listener: _resource_record_post_action 21:07:55 INFO - ##### 21:07:55 INFO - ##### Running download-and-extract step. 21:07:55 INFO - ##### 21:07:55 INFO - Running pre-action listener: _resource_record_pre_action 21:07:55 INFO - Running main action method: download_and_extract 21:07:55 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:55 INFO - https://queue.taskcluster.net/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:07:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/test_packages.json 21:07:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/test_packages.json 21:07:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:07:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:07:56 INFO - Downloaded 1302 bytes. 21:07:56 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:07:56 INFO - Using the following test package requirements: 21:07:56 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:07:56 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:07:56 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:56 INFO - u'jsshell-linux-x86_64.zip'], 21:07:56 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:07:56 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:07:56 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:07:56 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:07:56 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:07:56 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:07:56 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:07:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:07:56 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:07:56 INFO - https://queue.taskcluster.net/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:07:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:07:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:07:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/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:07:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/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:07:58 INFO - Downloaded 22427708 bytes. 21:07:58 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:07:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:07:58 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:07:59 INFO - Return code: 0 21:07:59 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:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:59 INFO - https://queue.taskcluster.net/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:07:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:07:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:07:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/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:07:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/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:08:03 INFO - Downloaded 22427708 bytes. 21:08:03 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:08:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:08:03 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:08:05 INFO - Return code: 0 21:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:05 INFO - https://queue.taskcluster.net/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:08:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:08:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:08:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/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:08:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/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:08:06 INFO - Downloaded 11131693 bytes. 21:08:06 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:08:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:08:06 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:08:06 INFO - Return code: 0 21:08: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:08:06 INFO - https://queue.taskcluster.net/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:08:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:08:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:08:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/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:08:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6DEdsIBRVKC13ZqHDCEBA/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:08:07 INFO - Downloaded 57149737 bytes. 21:08:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:08:07 INFO - mkdir: /builds/slave/test-pgo/properties 21:08:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:08:07 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:08:07 INFO - Contents: 21:08:07 INFO - build_url:https://queue.taskcluster.net/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:08:07 INFO - Running post-action listener: _resource_record_post_action 21:08:07 INFO - Running post-action listener: set_extra_try_arguments 21:08:07 INFO - ##### 21:08:07 INFO - ##### Running populate-webroot step. 21:08:07 INFO - ##### 21:08:07 INFO - Running pre-action listener: _resource_record_pre_action 21:08:07 INFO - Running main action method: populate_webroot 21:08:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:08:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:08:07 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:08:07 INFO - '../fennec_ids.txt'], 21:08:07 INFO - 'tests': ['tcheck2']}, 21:08:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:08:07 INFO - '--tppagecycles', 21:08:07 INFO - '7'], 21:08:07 INFO - 'tests': ['tsvgm']}}, 21:08:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:08:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:08:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:08:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:08:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:08:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:08:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:08:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:07 INFO - 'talos_options': ['--e10s'], 21:08:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:08:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:07 INFO - 'tests': ['damp', 'tps']}, 21:08:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:07 INFO - 'talos_options': ['--e10s'], 21:08:07 INFO - 'tests': ['damp', 'tps']}, 21:08:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:08:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:08:07 INFO - 'other': {'tests': ['a11yr', 21:08:07 INFO - 'ts_paint', 21:08:07 INFO - 'tpaint', 21:08:07 INFO - 'sessionrestore', 21:08:07 INFO - 'sessionrestore_no_auto_restore']}, 21:08:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:08:07 INFO - 'tests': ['a11yr', 21:08:07 INFO - 'ts_paint', 21:08:07 INFO - 'tpaint', 21:08:07 INFO - 'sessionrestore', 21:08:07 INFO - 'sessionrestore_no_auto_restore']}, 21:08:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:08:07 INFO - 'tests': ['a11yr', 21:08:07 INFO - 'ts_paint', 21:08:07 INFO - 'tpaint', 21:08:07 INFO - 'sessionrestore', 21:08:07 INFO - 'sessionrestore_no_auto_restore']}, 21:08:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:08:07 INFO - 'tests': ['a11yr', 21:08:07 INFO - 'ts_paint', 21:08:07 INFO - 'tpaint', 21:08:07 INFO - 'sessionrestore', 21:08:07 INFO - 'sessionrestore_no_auto_restore']}, 21:08:07 INFO - 'other_l64': {'tests': ['a11yr', 21:08:07 INFO - 'ts_paint', 21:08:07 INFO - 'tpaint', 21:08:07 INFO - 'sessionrestore', 21:08:07 INFO - 'sessionrestore_no_auto_restore']}, 21:08:07 INFO - 'other_nol64': {'tests': ['a11yr', 21:08:07 INFO - 'ts_paint', 21:08:07 INFO - 'tpaint', 21:08:07 INFO - 'sessionrestore', 21:08:07 INFO - 'sessionrestore_no_auto_restore']}, 21:08:07 INFO - 'svgr': {'tests': ['tsvgx', 21:08:07 INFO - 'tsvgr_opacity', 21:08:07 INFO - 'tart', 21:08:07 INFO - 'tscrollx', 21:08:07 INFO - 'cart']}, 21:08:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:08:07 INFO - 'tests': ['tsvgx', 21:08:07 INFO - 'tsvgr_opacity', 21:08:07 INFO - 'tart', 21:08:07 INFO - 'tscrollx', 21:08:07 INFO - 'cart']}, 21:08:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:07 INFO - 'tests': ['tp5o']}, 21:08:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:07 INFO - 'talos_options': ['--e10s'], 21:08:07 INFO - 'tests': ['tp5o']}, 21:08:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:07 INFO - 'talos_options': ['--xperf_path', 21:08:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:08:07 INFO - 'tests': ['tp5n']}, 21:08:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:07 INFO - 'talos_options': ['--e10s', 21:08:07 INFO - '--xperf_path', 21:08:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:08:07 INFO - 'tests': ['tp5n']}}, 21:08:07 INFO - 'talos.zip': {'path': '', 21:08:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:08:07 INFO - Running post-action listener: _resource_record_post_action 21:08:07 INFO - ##### 21:08:07 INFO - ##### Running create-virtualenv step. 21:08:07 INFO - ##### 21:08:07 INFO - Running pre-action listener: _resource_record_pre_action 21:08:07 INFO - Running main action method: create_virtualenv 21:08:07 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:08:07 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:08:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:08:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:08:07 INFO - Using real prefix '/usr' 21:08:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:08:08 INFO - Installing distribute.............................................................................................................................................................................................done. 21:08:12 INFO - Installing pip.................done. 21:08:12 INFO - Return code: 0 21:08:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:08:12 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:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:12 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:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:12 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 0x7f154f442c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a336c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af46e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2aa90>, '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 0x1b7cf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d2e0>, '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': '01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391', '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:08:12 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:08:12 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:08:12 INFO - Using env: {'DISPLAY': ':0', 21:08:12 INFO - 'HOME': '/home/cltbld', 21:08:12 INFO - 'LANG': 'en_US.UTF-8', 21:08:12 INFO - 'LANGUAGE': 'en_US:en', 21:08:12 INFO - 'LOGNAME': 'cltbld', 21:08:12 INFO - 'MAIL': '/var/mail/cltbld', 21:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:12 INFO - 'MOZ_NO_REMOTE': '1', 21:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:12 INFO - 'NO_EM_RESTART': '1', 21:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:08:12 INFO - 'PWD': '/builds/slave/test-pgo', 21:08:12 INFO - 'SHELL': '/bin/bash', 21:08:12 INFO - 'SHLVL': '1', 21:08:12 INFO - 'TERM': 'linux', 21:08:12 INFO - 'TMOUT': '86400', 21:08:12 INFO - 'USER': 'cltbld', 21:08:12 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391', 21:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:12 INFO - '_': '/tools/buildbot/bin/python'} 21:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:13 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:08:13 INFO - Cleaning up... 21:08:13 INFO - Return code: 0 21:08:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:08: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:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08: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:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08: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', '--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 0x7f154f442c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a336c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af46e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2aa90>, '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 0x1b7cf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d2e0>, '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': '01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391', '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:08:13 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:08:13 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:08:13 INFO - Using env: {'DISPLAY': ':0', 21:08:13 INFO - 'HOME': '/home/cltbld', 21:08:13 INFO - 'LANG': 'en_US.UTF-8', 21:08:13 INFO - 'LANGUAGE': 'en_US:en', 21:08:13 INFO - 'LOGNAME': 'cltbld', 21:08:13 INFO - 'MAIL': '/var/mail/cltbld', 21:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:13 INFO - 'MOZ_NO_REMOTE': '1', 21:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:13 INFO - 'NO_EM_RESTART': '1', 21:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:08:13 INFO - 'PWD': '/builds/slave/test-pgo', 21:08:13 INFO - 'SHELL': '/bin/bash', 21:08:13 INFO - 'SHLVL': '1', 21:08:13 INFO - 'TERM': 'linux', 21:08:13 INFO - 'TMOUT': '86400', 21:08:13 INFO - 'USER': 'cltbld', 21:08:13 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391', 21:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:13 INFO - '_': '/tools/buildbot/bin/python'} 21:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:13 INFO - Downloading/unpacking psutil>=0.7.1 21:08:13 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:08:13 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:08:13 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:08:13 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:08:13 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:08:13 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:08:15 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:08:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:08:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:08:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:08:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:08:15 INFO - Installing collected packages: psutil 21:08:15 INFO - Running setup.py install for psutil 21:08:15 INFO - building 'psutil._psutil_linux' extension 21:08:15 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:08:16 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:08:16 INFO - building 'psutil._psutil_posix' extension 21:08:16 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:08:17 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:08:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:08:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:08:17 INFO - Successfully installed psutil 21:08:17 INFO - Cleaning up... 21:08:17 INFO - Return code: 0 21:08:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:08:17 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:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:17 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:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:17 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 0x7f154f442c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a336c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af46e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2aa90>, '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 0x1b7cf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d2e0>, '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': '01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391', '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:08:17 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:08:17 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:08:17 INFO - Using env: {'DISPLAY': ':0', 21:08:17 INFO - 'HOME': '/home/cltbld', 21:08:17 INFO - 'LANG': 'en_US.UTF-8', 21:08:17 INFO - 'LANGUAGE': 'en_US:en', 21:08:17 INFO - 'LOGNAME': 'cltbld', 21:08:17 INFO - 'MAIL': '/var/mail/cltbld', 21:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:17 INFO - 'MOZ_NO_REMOTE': '1', 21:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:17 INFO - 'NO_EM_RESTART': '1', 21:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:08:17 INFO - 'PWD': '/builds/slave/test-pgo', 21:08:17 INFO - 'SHELL': '/bin/bash', 21:08:17 INFO - 'SHLVL': '1', 21:08:17 INFO - 'TERM': 'linux', 21:08:17 INFO - 'TMOUT': '86400', 21:08:17 INFO - 'USER': 'cltbld', 21:08:17 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391', 21:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:17 INFO - '_': '/tools/buildbot/bin/python'} 21:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:08:17 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:08:17 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:08:17 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:08:17 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:08:17 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:08:17 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:08:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:08:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:08:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:08:19 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:08:19 INFO - Installing collected packages: mozsystemmonitor 21:08:19 INFO - Running setup.py install for mozsystemmonitor 21:08:19 INFO - Successfully installed mozsystemmonitor 21:08:19 INFO - Cleaning up... 21:08:19 INFO - Return code: 0 21:08:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:08:19 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:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:19 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:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:19 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 0x7f154f442c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a336c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af46e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2aa90>, '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 0x1b7cf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d2e0>, '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': '01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391', '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:08:19 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:08:19 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:08:19 INFO - Using env: {'DISPLAY': ':0', 21:08:19 INFO - 'HOME': '/home/cltbld', 21:08:19 INFO - 'LANG': 'en_US.UTF-8', 21:08:19 INFO - 'LANGUAGE': 'en_US:en', 21:08:19 INFO - 'LOGNAME': 'cltbld', 21:08:19 INFO - 'MAIL': '/var/mail/cltbld', 21:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:19 INFO - 'MOZ_NO_REMOTE': '1', 21:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:19 INFO - 'NO_EM_RESTART': '1', 21:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:08:19 INFO - 'PWD': '/builds/slave/test-pgo', 21:08:19 INFO - 'SHELL': '/bin/bash', 21:08:19 INFO - 'SHLVL': '1', 21:08:19 INFO - 'TERM': 'linux', 21:08:19 INFO - 'TMOUT': '86400', 21:08:19 INFO - 'USER': 'cltbld', 21:08:19 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391', 21:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:19 INFO - '_': '/tools/buildbot/bin/python'} 21:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:19 INFO - Downloading/unpacking blobuploader==1.2.4 21:08:19 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:08:19 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:08:19 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:08:19 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:08:19 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:08:19 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:08:21 INFO - Downloading blobuploader-1.2.4.tar.gz 21:08:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:08:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:08:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:08:21 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:08:21 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:08:21 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:08:21 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:08:21 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:08:21 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:08:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:08:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:08:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:08:21 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:08:21 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:08:21 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:08:21 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:08:21 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:08:21 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:08:22 INFO - Downloading docopt-0.6.1.tar.gz 21:08:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:08:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:08:22 INFO - Installing collected packages: blobuploader, requests, docopt 21:08:22 INFO - Running setup.py install for blobuploader 21:08:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:08:22 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:08:22 INFO - Running setup.py install for requests 21:08:22 INFO - Running setup.py install for docopt 21:08:22 INFO - Successfully installed blobuploader requests docopt 21:08:22 INFO - Cleaning up... 21:08:22 INFO - Return code: 0 21:08:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:22 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 0x7f154f442c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a336c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af46e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2aa90>, '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 0x1b7cf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d2e0>, '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': '01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391', '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:08:22 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:08:22 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:08:22 INFO - Using env: {'DISPLAY': ':0', 21:08:22 INFO - 'HOME': '/home/cltbld', 21:08:22 INFO - 'LANG': 'en_US.UTF-8', 21:08:22 INFO - 'LANGUAGE': 'en_US:en', 21:08:22 INFO - 'LOGNAME': 'cltbld', 21:08:22 INFO - 'MAIL': '/var/mail/cltbld', 21:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:22 INFO - 'MOZ_NO_REMOTE': '1', 21:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:22 INFO - 'NO_EM_RESTART': '1', 21:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:08:22 INFO - 'PWD': '/builds/slave/test-pgo', 21:08:22 INFO - 'SHELL': '/bin/bash', 21:08:22 INFO - 'SHLVL': '1', 21:08:22 INFO - 'TERM': 'linux', 21:08:22 INFO - 'TMOUT': '86400', 21:08:22 INFO - 'USER': 'cltbld', 21:08:22 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391', 21:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:22 INFO - '_': '/tools/buildbot/bin/python'} 21:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:08:22 INFO - Running setup.py (path:/tmp/pip-gKB0T0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:08:23 INFO - Running setup.py (path:/tmp/pip-Z8ULIn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:08:23 INFO - Running setup.py (path:/tmp/pip-RLhG33-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:08:23 INFO - Running setup.py (path:/tmp/pip-J3SPAS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:08:23 INFO - Running setup.py (path:/tmp/pip-3KRloj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:08:23 INFO - Running setup.py (path:/tmp/pip-6fcIKs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:08:23 INFO - Running setup.py (path:/tmp/pip-DLcZeP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:08:23 INFO - Running setup.py (path:/tmp/pip-m0KhUV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:08:23 INFO - Running setup.py (path:/tmp/pip-hpTyd8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:08:23 INFO - Running setup.py (path:/tmp/pip-QnaKB1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:08:23 INFO - Running setup.py (path:/tmp/pip-Dzzkt6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:08:23 INFO - Running setup.py (path:/tmp/pip-QoXtsR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:08:23 INFO - Running setup.py (path:/tmp/pip-ibVoTo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:08:23 INFO - Running setup.py (path:/tmp/pip-f2bcc8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:08:23 INFO - Running setup.py (path:/tmp/pip-tZEyGL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:08:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:08:24 INFO - Running setup.py (path:/tmp/pip-PWK_IV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:08:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:08:24 INFO - Running setup.py (path:/tmp/pip-MPzpPW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:08:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:08:24 INFO - Running setup.py install for manifestparser 21:08:24 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:08:24 INFO - Running setup.py install for mozcrash 21:08:24 INFO - Running setup.py install for mozdebug 21:08:24 INFO - Running setup.py install for mozdevice 21:08:24 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:08:24 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:08:24 INFO - Running setup.py install for mozfile 21:08:24 INFO - Running setup.py install for mozhttpd 21:08:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:08:24 INFO - Running setup.py install for mozinfo 21:08:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:08:24 INFO - Running setup.py install for mozInstall 21:08:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:08:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:08:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:08:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:08:24 INFO - Running setup.py install for mozleak 21:08:25 INFO - Running setup.py install for mozlog 21:08:25 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:08:25 INFO - Running setup.py install for moznetwork 21:08:25 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:08:25 INFO - Running setup.py install for mozprocess 21:08:25 INFO - Running setup.py install for mozprofile 21:08:25 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:08:25 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:08:25 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:08:25 INFO - Running setup.py install for mozrunner 21:08:25 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:08:25 INFO - Running setup.py install for mozscreenshot 21:08:25 INFO - Running setup.py install for moztest 21:08:25 INFO - Running setup.py install for mozversion 21:08:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:08:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:08:25 INFO - Cleaning up... 21:08:25 INFO - Return code: 0 21:08:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:25 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 0x7f154f442c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a336c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af46e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2aa90>, '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 0x1b7cf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d2e0>, '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': '01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391', '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:08:25 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:08:25 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:08:25 INFO - Using env: {'DISPLAY': ':0', 21:08:25 INFO - 'HOME': '/home/cltbld', 21:08:25 INFO - 'LANG': 'en_US.UTF-8', 21:08:25 INFO - 'LANGUAGE': 'en_US:en', 21:08:25 INFO - 'LOGNAME': 'cltbld', 21:08:25 INFO - 'MAIL': '/var/mail/cltbld', 21:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:25 INFO - 'MOZ_NO_REMOTE': '1', 21:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:25 INFO - 'NO_EM_RESTART': '1', 21:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:08:25 INFO - 'PWD': '/builds/slave/test-pgo', 21:08:25 INFO - 'SHELL': '/bin/bash', 21:08:25 INFO - 'SHLVL': '1', 21:08:25 INFO - 'TERM': 'linux', 21:08:25 INFO - 'TMOUT': '86400', 21:08:25 INFO - 'USER': 'cltbld', 21:08:25 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391', 21:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:25 INFO - '_': '/tools/buildbot/bin/python'} 21:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:08:26 INFO - Running setup.py (path:/tmp/pip-lQ63rO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:08:26 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:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:08:26 INFO - Running setup.py (path:/tmp/pip-EtWf9B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:08:26 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:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:08:26 INFO - Running setup.py (path:/tmp/pip-un3Hwq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:08:26 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:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:08:26 INFO - Running setup.py (path:/tmp/pip-3F1c_I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:08:26 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:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:08:26 INFO - Running setup.py (path:/tmp/pip-RA7tkP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:08:26 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:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:08:26 INFO - Running setup.py (path:/tmp/pip-nl9OIq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:08:26 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:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:08:26 INFO - Running setup.py (path:/tmp/pip-5tOjXI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:08:26 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:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:08:26 INFO - Running setup.py (path:/tmp/pip-oDDkhW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:08:26 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:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:08:26 INFO - Running setup.py (path:/tmp/pip-lNJV3c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:08:26 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:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:08:26 INFO - Running setup.py (path:/tmp/pip-UdO7Gd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:08:26 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:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:08:26 INFO - Running setup.py (path:/tmp/pip-7gr679-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:08:26 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:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:08:26 INFO - Running setup.py (path:/tmp/pip-tfPSmX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:08:27 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:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:08:27 INFO - Running setup.py (path:/tmp/pip-ArWCl9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:08:27 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:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:08:27 INFO - Running setup.py (path:/tmp/pip-KjjXrD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:08:27 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:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:08:27 INFO - Running setup.py (path:/tmp/pip-JHKgps-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:08:27 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:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:08:27 INFO - Running setup.py (path:/tmp/pip-jQq5CS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:08:27 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:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:08:27 INFO - Running setup.py (path:/tmp/pip-wZDQCx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:08:27 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:08:27 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:08:27 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:08:27 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:08:27 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:08:27 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:08:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:08:27 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:08:27 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:08:27 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:08:27 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:08:27 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:08:27 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:08:29 INFO - Downloading blessings-1.5.1.tar.gz 21:08:29 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:08:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:08:29 INFO - Installing collected packages: blessings 21:08:29 INFO - Running setup.py install for blessings 21:08:29 INFO - Successfully installed blessings 21:08:29 INFO - Cleaning up... 21:08:29 INFO - Return code: 0 21:08:29 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:08:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:08:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:08:29 INFO - Reading from file tmpfile_stdout 21:08:29 INFO - Current package versions: 21:08:29 INFO - argparse == 1.2.1 21:08:29 INFO - blessings == 1.5.1 21:08:29 INFO - blobuploader == 1.2.4 21:08:29 INFO - docopt == 0.6.1 21:08:29 INFO - manifestparser == 1.1 21:08:29 INFO - mozInstall == 1.12 21:08:29 INFO - mozcrash == 0.16 21:08:29 INFO - mozdebug == 0.1 21:08:29 INFO - mozdevice == 0.47 21:08:29 INFO - mozfile == 1.2 21:08:29 INFO - mozhttpd == 0.7 21:08:29 INFO - mozinfo == 0.9 21:08:29 INFO - mozleak == 0.1 21:08:29 INFO - mozlog == 3.0 21:08:29 INFO - moznetwork == 0.27 21:08:29 INFO - mozprocess == 0.22 21:08:29 INFO - mozprofile == 0.27 21:08:29 INFO - mozrunner == 6.11 21:08:29 INFO - mozscreenshot == 0.1 21:08:29 INFO - mozsystemmonitor == 0.0 21:08:29 INFO - moztest == 0.7 21:08:29 INFO - mozversion == 1.4 21:08:29 INFO - psutil == 3.1.1 21:08:29 INFO - requests == 1.2.3 21:08:29 INFO - wsgiref == 0.1.2 21:08:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f154f442c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a336c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af46e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2aa90>, '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 0x1b7cf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d2e0>, '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': '01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391', '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:08:29 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:08:29 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:08:29 INFO - Using env: {'DISPLAY': ':0', 21:08:29 INFO - 'HOME': '/home/cltbld', 21:08:29 INFO - 'LANG': 'en_US.UTF-8', 21:08:29 INFO - 'LANGUAGE': 'en_US:en', 21:08:29 INFO - 'LOGNAME': 'cltbld', 21:08:29 INFO - 'MAIL': '/var/mail/cltbld', 21:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:29 INFO - 'MOZ_NO_REMOTE': '1', 21:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:29 INFO - 'NO_EM_RESTART': '1', 21:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:08:29 INFO - 'PWD': '/builds/slave/test-pgo', 21:08:29 INFO - 'SHELL': '/bin/bash', 21:08:29 INFO - 'SHLVL': '1', 21:08:29 INFO - 'TERM': 'linux', 21:08:29 INFO - 'TMOUT': '86400', 21:08:29 INFO - 'USER': 'cltbld', 21:08:29 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391', 21:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:29 INFO - '_': '/tools/buildbot/bin/python'} 21:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:29 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:08:29 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:08:29 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:08:29 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:08:29 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:08:29 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:08:29 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:08:29 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:08:29 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:08:29 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:08:29 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:08:29 INFO - Cleaning up... 21:08:29 INFO - Return code: 0 21:08:29 INFO - Running post-action listener: _resource_record_post_action 21:08:29 INFO - Running post-action listener: _start_resource_monitoring 21:08:29 INFO - Starting resource monitoring. 21:08:29 INFO - ##### 21:08:29 INFO - ##### Running install step. 21:08:29 INFO - ##### 21:08:29 INFO - Running pre-action listener: _resource_record_pre_action 21:08:29 INFO - Running main action method: install 21:08:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:08:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:08:30 INFO - Reading from file tmpfile_stdout 21:08:30 INFO - Detecting whether we're running mozinstall >=1.0... 21:08:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:08:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:08:30 INFO - Reading from file tmpfile_stdout 21:08:30 INFO - Output received: 21:08:30 INFO - Usage: mozinstall [options] installer 21:08:30 INFO - Options: 21:08:30 INFO - -h, --help show this help message and exit 21:08:30 INFO - -d DEST, --destination=DEST 21:08:30 INFO - Directory to install application into. [default: 21:08:30 INFO - "/builds/slave/test-pgo"] 21:08:30 INFO - --app=APP Application being installed. [default: firefox] 21:08:30 INFO - mkdir: /builds/slave/test-pgo/build/application 21:08:30 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:08:30 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:08:44 INFO - Reading from file tmpfile_stdout 21:08:44 INFO - Output received: 21:08:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:08:44 INFO - Running post-action listener: _resource_record_post_action 21:08:44 INFO - ##### 21:08:44 INFO - ##### Running run-tests step. 21:08:44 INFO - ##### 21:08:44 INFO - Running pre-action listener: _resource_record_pre_action 21:08:44 INFO - Running main action method: run_tests 21:08:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:08:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:08:44 INFO - Python 2.7.3 21:08:44 INFO - Return code: 0 21:08:44 INFO - grabbing minidump binary from tooltool 21:08: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:08:44 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 0x1b2aa90>, '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 0x1b7cf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:08:44 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:08:44 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:08:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:08:44 INFO - Return code: 0 21:08:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:08:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:08:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:08:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:08:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:08:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 21:08:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost 21:08:44 INFO - Using env: {'DISPLAY': ':0', 21:08:44 INFO - 'HOME': '/home/cltbld', 21:08:44 INFO - 'LANG': 'en_US.UTF-8', 21:08:44 INFO - 'LANGUAGE': 'en_US:en', 21:08:44 INFO - 'LOGNAME': 'cltbld', 21:08:44 INFO - 'MAIL': '/var/mail/cltbld', 21:08:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:08:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:44 INFO - 'MOZ_NO_REMOTE': '1', 21:08:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:44 INFO - 'NO_EM_RESTART': '1', 21:08:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:08:44 INFO - 'PWD': '/builds/slave/test-pgo', 21:08:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:08:44 INFO - 'SHELL': '/bin/bash', 21:08:44 INFO - 'SHLVL': '1', 21:08:44 INFO - 'TERM': 'linux', 21:08:44 INFO - 'TMOUT': '86400', 21:08:44 INFO - 'USER': 'cltbld', 21:08:44 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391', 21:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:44 INFO - '_': '/tools/buildbot/bin/python'} 21:08:44 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] with output_timeout 3600 21:08:44 INFO - mozversion INFO | application_buildid: 20151110193458 21:08:44 INFO - mozversion INFO | application_changeset: 42359222aacee1512a68e70a92ff2fc5b4c00467 21:08:44 INFO - mozversion INFO | application_display_name: Nightly 21:08:44 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:08:44 INFO - mozversion INFO | application_name: Firefox 21:08:44 INFO - mozversion INFO | application_remotingname: firefox 21:08:44 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:08:44 INFO - mozversion INFO | application_vendor: Mozilla 21:08:44 INFO - mozversion INFO | application_version: 45.0a1 21:08:44 INFO - mozversion INFO | platform_buildid: 20151110193458 21:08:44 INFO - mozversion INFO | platform_changeset: 42359222aacee1512a68e70a92ff2fc5b4c00467 21:08:44 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:08:44 INFO - mozversion INFO | platform_version: 45.0a1 21:08:44 INFO - 2015-11-10 21:08:44,822 DEBUG : using testdate: 1447218524 21:08:44 INFO - 2015-11-10 21:08:44,822 DEBUG : actual date: 1447218524 21:08:44 INFO - 2015-11-10 21:08:44,869 INFO : starting webserver on 'localhost:44721' 21:08:44 INFO - 2015-11-10 21:08:44,870 INFO : Starting test suite talos-linux64-ix-014.e 21:08:44 INFO - 2015-11-10 21:08:44,871 INFO : Starting test dromaeo_css 21:08:44 INFO - 2015-11-10 21:08:44,871 DEBUG : operating with platform_type : linux_ 21:08:44 INFO - 2015-11-10 21:08:44,871 INFO : Initialising browser for dromaeo_css test... 21:08:44 INFO - 2015-11-10 21:08:44,898 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8X8FK4/profile http://localhost:44721/getInfo.html 21:08:52 INFO - 2015-11-10 21:08:52,261 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:08:52 INFO - 2015-11-10 21:08:52,262 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:08:52 INFO - 2015-11-10 21:08:52,262 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:08:52 INFO - 2015-11-10 21:08:52,262 DEBUG : BROWSER_OUTPUT: __metrics 21:08:53 INFO - 2015-11-10 21:08:53,249 INFO : Browser initialized. 21:08:53 INFO - 2015-11-10 21:08:53,250 INFO : Running cycle 1/1 for dromaeo_css test... 21:08:53 INFO - 2015-11-10 21:08:53,250 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8X8FK4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:09:05 INFO - 2015-11-10 21:09:05,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 141828096 21:09:05 INFO - 2015-11-10 21:09:05,012 DEBUG : BROWSER_OUTPUT: 21:09:54 INFO - 2015-11-10 21:09:54,649 DEBUG : BROWSER_OUTPUT: 1447218594647 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:12:03 INFO - 2015-11-10 21:12:03,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44721/tests/dromaeo/cssquery-ext.html) 21:12:04 INFO - 2015-11-10 21:12:04,664 DEBUG : BROWSER_OUTPUT: RSS: Main: 147374080 21:12:04 INFO - 2015-11-10 21:12:04,664 DEBUG : BROWSER_OUTPUT: 21:15:06 INFO - 2015-11-10 21:15:06,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/dromaeo/cssquery-ext.html (next: http://localhost:44721/tests/dromaeo/cssquery-jquery.html) 21:15:07 INFO - 2015-11-10 21:15:07,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 141545472 21:15:07 INFO - 2015-11-10 21:15:07,367 DEBUG : BROWSER_OUTPUT: 21:18:09 INFO - 2015-11-10 21:18:09,033 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44721/tests/dromaeo/cssquery-mootools.html) 21:18:09 INFO - 2015-11-10 21:18:09,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 141533184 21:18:09 INFO - 2015-11-10 21:18:09,619 DEBUG : BROWSER_OUTPUT: 21:21:11 INFO - 2015-11-10 21:21:11,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44721/tests/dromaeo/cssquery-prototype.html) 21:21:11 INFO - 2015-11-10 21:21:11,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 139792384 21:21:11 INFO - 2015-11-10 21:21:11,913 DEBUG : BROWSER_OUTPUT: 21:24:14 INFO - 2015-11-10 21:24:14,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44721/tests/dromaeo/cssquery-yui.html) 21:24:14 INFO - 2015-11-10 21:24:14,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 141975552 21:24:14 INFO - 2015-11-10 21:24:14,814 DEBUG : BROWSER_OUTPUT: 21:27:17 INFO - 2015-11-10 21:27:17,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/dromaeo/cssquery-yui.html (next: http://localhost:44721/tests/dromaeo/cssquery-dojo.html) 21:27:17 INFO - 2015-11-10 21:27:17,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 144228352 21:27:17 INFO - 2015-11-10 21:27:17,530 DEBUG : BROWSER_OUTPUT: 21:27:17 INFO - 2015-11-10 21:27:17,530 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:27:17 INFO - 2015-11-10 21:27:17,530 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:27:17 INFO - 2015-11-10 21:27:17,530 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:27:17 INFO - 2015-11-10 21:27:17,531 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:27:17 INFO - 2015-11-10 21:27:17,531 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3162.1778337632218;3261.9836900815494;3289.5723555937725;3312.602487701476;3324.5345651608777;5202;5306.151015837467;5426.647267927582;5427.213054107157;5434.212039254316;5331.680099194051;5335.466453354672;5393.406725260228;5430.456954304567;5434.673919564819;4694.319323698079;4956.479569645189;5084.491550844923;5093.2105523643895;5098.923516147261;4860.3195552622665;5027.220780778966;5065.316182315377;5070.797168113289;5111.05445492585;4862.051899879507;4923.606111511089;4929.4577596464715;4996;5019.824306149268;4890.608751299887;4896.167651499253;4940.580050695695;4975.203967365204;4980.053789779967;4759.714417134983;4831.975840120812;4948.554630083309;4956.603471722254;5005;5242.397124330712;5269.209618557209;5271.182966640177;5341.545968592674;5425.674459532401;5856.882862342772;5882.588218824684;5924.7926322578505;5925.496332811673;5938;5752.2234498342605;5851.4148585141575;5897.705114744289;5923.466887980103;5957.642541447483;5527.806526771584;5528.308961379827;5532.197831314437;5537.058700021006;5568.276124103881;5922.555808314393;5927.881442371128;5936.406359364029;5958.612690175125;5966.642001479925;5658.321001479849;5692.800751973661;5778.508826749773;5793.507551858139;5816.738246778905;5804.82585522435;5814.447627475383;5819.447152520504;5833.445822646841;5849.356570777211;5759.1937128802;5811.94188058114;5832.037713777179;5840.737166827503;5841.503472204825;5583.720813959286;5709;5785.595008349375;5802.535797136219;5835.708214589254;4420.8673739787855;4485.372047913294;4507.752073635916;4512.142692888341;4519.977400112978;3848.5189351331082;4023.5171779386073;4038.374052021941;4057.5130984281486;4065.9796701016307;5364.249005139283;5381;5393.5954803389905;5522.806701765499;5561.165825126263;5870;5932.851678708067;5937;5947.37552556984;5981.431763982415;5435.42927992563;5649.858753531113;5666.34836993751;5674.546036317085;5676.035074037423;5061.164907790247;5078.4413714491375;5115.974420127875;5131.79472821083;5149.716765577854;6077.878442431215;6180.66006369645;6185.134081228632;6191.288001879751;6201.503879689614;5621.55027597783;5726.914096288476;5875.3243377012195;5907.556933230111;5920.348761636131;5913.526917846476;6035.155078289131;6053.848653783691;6055.424734650377;6089.51283897296;5743.8851222976145;5745.253117094918;5746.252987111816;5750.8849823002465;5751.223584816164;5602.579806514446;5702.714864256687;5773.393793651606;5825.097109947796;5828.213191219301;5674.4892959633835;5694.231278777478;5703.973284808774;5704.201411802268;5722.7710891563875;5719.914201287067;5725.34158571753;5738;5744.454276843693;5757.481826635623;5430.13117901134;5578.3584887738425;5618.904313658797;5632.831015069554;5756.68338241384;5780.566457515787;5822.73797679097;5828.475437210502;5872.765089396547;5877;5724.885502289848;5732.885342293214;5744.569157313302;5752.7698892043845;5759.51044161251 21:27:17 INFO - 2015-11-10 21:27:17,531 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.540356907336;562.6820846221884;572.7995201679412;583.7664934026392;602.6986506746624;40921;42274.78862605686;42276.36585451221;42323.365149522746;42367.78816105923;43639;43792.343114853225;43951.560484395144;44488.777556112254;44549.331760023626;8618.353623478217;8716.694915677952;8861.246794022516;8868.645254189825;8916.910830891706;8404.20160084791;8455.53494557799;8494;8627.698030568932;8678.218960293572;8411.411201215917;8662.090480499552;8707.869381959275;8728.301735861147;8738.432001919886;8662.220400163984;8724.258438032743;8726.083761205045;8810.030896601369;8811.162939520735;8644.783880402978;8777;8778.253848422892;8810.118988101203;8812.471251724917;40917.18165636701;41332;41362.75911722653;41854;41857.37213941793;2709.7290270972944;3111.1444352802932;3131.8434078296223;3245.8052516849066;3374.0552645259368;29698.10905672833;29789.255268618243;29840.253993650116;30118.698813011808;30449.391012179854;3313.5858017747782;3318.5188147718445;3334;3404.3191361727754;3405.9489107663403;249267;251061;251164;251716;252484;41996.79001604972;58168.41831581714;58500.41499585035;58569.41430585725;58645.70677146672;41757.37363939543;41793.58206417958;41977;42323.57676423258;42692.78653606712;12585;12837.293948832903;12960.740785184244;12961.092723509264;12972.935135324264;8992.280617550581;9065.909340906506;9151.725448236564;9159.954200228956;9237.399569027992;14369.353379097965;14403.423863045571;14444.494442694455;14449.566513004627;14517.491887783877;5804.709764511757;5855.209546711139;5866.5893387462465;5949.899268635317;5960.5231581474245;826.3636999510344;871.877937088808;886.1758564534915;911.683180142027;1003.0170035736865;28974.565381519293;29002.854985724935;29144.854275728485;29576.852115739282;29594.852025740165;957.9568919398644;977.1059480575194;985.5466485416789;1020.1787561013307;1062.3254233561745;15822.841771582367;15908.284127214303;16447.753283700753;16521.6695666086;17209.65580688379;281447;286307;287312;290598;290683;57312.42687573071;58609.41390586125;58793.41206587965;58795.41204587899;58803.117953230736;1284.6659868434274;1295.6760809797552;1302.0820321673386;1311.8688131186805;1318.8813006829432;29808.85095574508;30654.386912261183;30891.845540772152;31310.37379252448;31382.68617313889;47190.76404617955;47221.76389118032;47895.281570777166;48093.75953120212;48138.518614814806;293177;296508;298072;298111;300606;33555.65777368878;43582;43609.34585981276;44172.55827441813;44650.55349446464;41057.38413923853;41497.37753933633;42698.57301426946;45358.773206135076;46722.53277467318;36833;37379.252414951006;37747.43378849374;42091;42495.15009699727;39168.216635666555;41133.382999254434;42158;42279;42464.36303455389;37346.253074937806;37613.81193094017;38379.808100959315;38403.42394864135;38490.0377490565;33340.33319333648;34528.654713452546;34739;34761.65238347685;34908.65091349054;25434.109806156695;26787.732122678524;26834.731652683222;26896.193114206606;27265.454690906467 21:27:17 INFO - 2015-11-10 21:27:17,531 DEBUG : BROWSER_OUTPUT: |2;jquery.html;339.95750531183603;344.8965310406879;346.7465113614284;348.0029714866907;348.29122735233796;13945.860541394582;14394.928025359884;16897.155142242886;17074;17930.28278868845;14552.126872387664;14832.777508337356;15002.249887505608;15010.324535395906;15057.924710376432;4822.397200349957;4983.302337672729;4984.077945580061;4986.052649996489;5173.844784656457;4808.326834243208;4934.5312195341385;4937.481564435737;4960.355153830015;5025.547700706936;4772.878373582205;4820.156472617296;4880.975595122037;4895.290182923474;4916.213405855064;4595.149897269;4788.04239152171;4799;4813.879653008667;4823.831165909211;4021.3766866135797;4160.292750232467;4161.56303588122;4202.70581059326;4370;12958.287294198815;12989.805152922714;13036.739265214643;13293.268870212134;13328;1712.760213570101;1783.2421220981032;1856.8421684156863;1899.7150427435856;1928.392556344747;9969.65106221286;10069.748256293578;10192.490375481197;10352.068313851714;10597.894021059768;1631.5839460937384;1638.983610163895;1719.0545200139873;1727.9481615551554;1778.537580229137;60256.69871650657;62381.06428403623;62779.686101569656;63309.68345158291;63362.36637633611;6888.793336199922;7001.019857219993;7002.089728335284;7002.334778196063;7142.892856607155;8110.756677299691;8171.67313307473;8175.223353781381;8247.505149691038;8301.83396332082;5212.947870521322;5222.2427747976335;5225.163973764255;5278.736063196901;5299.6290259681455;5227.18978558324;5232.005918875401;5235.764390602432;5267.499587539178;5277.261183434322;3238.109519882004;3240.724538414214;3248.951265731016;3271.820049897231;3292.160499072769;1122.4836575175511;1133.3313345126414;1135.1202817816259;1142.5258517715222;1180.7579446213506;413.28089124922417;426.720498073756;438.1980974816079;444.02314907204277;444.6154076723611;10526.157907367393;10643.25497215203;10655.094316983143;10723.571057157782;10949.124070074375;423.9936400953988;428.61210604403067;431.4132779419986;443.2641814587769;443.69385124264153;5898.941010589925;6104.633721976696;6346.555741098171;6494.805155845333;6498;517478;523602;534443.9167062485;543256;549556;77117.61441192759;78552;78695.21304786879;78866;80593.59703201447;524.753365918018;524.8136911396399;533.757140501071;536.0993530868179;536.6243629459394;10646.414447205478;10922.308313638701;10949.233553651487;10963.945180274048;11136.721581960192;32827.67172328246;33359.49960750542;34496;34600.307993840484;35229.471557927165;45367.319490208334;47114.76442617765;47282.52717472781;47623.5237647633;48133.75933120312;6432.774852880127;6541.051547525487;6604.3725846044545;6738.764143254963;6843.7604683835825;12135.211211271238;12326.260424374566;12345.876541234473;12376;12419.503219871103;10611.31026483307;10659.467026648792;10670.8399374011;10760.031597156294;10893.291936024134;10268.07587317145;10378.169746420419;10505.159587233156;10601.41692206936;10719.946400268262;10337.328073675188;10399.896001040195;10756.247062705535;10763.300385474919;10777.245592808427;6707.429868461236;6738.46092312604;6760.391564759196;6776;6793.116894803644;10383.584656613953;10431.53058112402;10682.092022178202;10911.399873007062;11023.228374013743 21:27:17 INFO - 2015-11-10 21:27:17,531 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1490.4112875414205;1688.9915550422247;1730.30787684926;1757.9384721534748;1767.2577517442674;7021.964890175542;7089.610071446068;7094.751683691072;7217.06178196835;7285.490015698903;7061.293870612936;7175.390091842187;7200.38796702281;7223.530470519412;7283.708651653941;2191.8904054797235;2227.220472834503;2231.0518029837335;2233.02863254484;2233.530958498717;2198.1427243375015;2203.7575866654656;2206.5366273082673;2207.4040009197506;2217.7116974793253;2139.81811546018;2145.9034343454505;2160.4490854832075;2167.2739632223224;2186.1146235774536;2102.096098677568;2162.945926351846;2213.1258153029626;2218.589560931217;2220.733511978565;2201.9889900550556;2202.559488102386;2209.7569267380577;2221;2244.1584405847807;7012.158540975116;7053.506254562183;7149;7204;7211.242819503981;4314.525402205755;4340.804663790137;4366.978165109186;4377.868663940087;4387.846425375096;2868.54103343464;2885.1200383882906;2888.653361596622;2935.9724096566033;2949.9852500737575;867.9045305016443;875.2604049578097;891.5007595746403;921.6681994482049;926.8980412154658;9413.529323533865;9447.763805904839;9455.810883782286;9473.573689184002;9487.762805929908;3884.747491413049;3895.337792575269;4024.859129930497;4068.044009657728;4078.8164532596106;7806.68773249075;7912.248336408032;7914.169012253746;7919.049714034353;7920.128785833554;4257.40396344512;4267.381229721673;4271.658267338606;4281.486221653359;4305.698601097955;3884.9223015539533;3887.3974533947285;3898.863539776094;3904.707146963989;3918.549366822795;3194.348690586807;3236.401265765841;3257.7393808495262;3265.4775235962134;3266.510023496447;1006.0291818395284;1037.2790910317258;1051.0750539525322;1052.231870734353;1053.4100903494068;1022.2895087913829;1025.43601019439;1059.89930956559;1162.6686394377562;1309.8100775387516;6571.112899758567;6599.109120268702;6728.327167283331;6796.694148763318;6815.829604259933;979.0992287095889;990.4008075114596;995.2386424385351;995.8605795188679;1000.7448100734266;5421.756020979065;5468.781248750085;5475.780968761284;5476.890462190734;5494.5054945055135;8299.377546684023;8323.625436855356;8497.872531912026;8511.404201705822;8570;8224.753257402288;8382.958085209657;8470.449420787629;8475.618597163142;8512.319014478826;6717.798466046026;6730.764423245163;6744.494162937799;6831.487638427137;6832.350926661959;6077.6353418795015;6357.268914074941;6424.871502570016;6488.091667166695;6511.186101737283;7412.444066694911;7531.736389226351;7636.389088872766;7648.808779780327;7673.923260767321;7442.553446793209;7683.385329173541;7738.071431428265;7756.3019328260725;7792.61036948139;5982.252218472691;6160.907586386118;6163.691815409301;6177.4749146321265;6178.073289006685;6829.282925292773;6879.140107486564;6890.276520965226;6910.689018994057;6911.5853048817235;6395.1046853441485;6407.679616019273;6435.710393032231;6448.387403196689;6593.538452308292;6224.844378890564;6364.109024736448;6419.550631455753;6438.356164383524;6444.258910225384;6476.060971159061;6516.804495865132;6527.11883895687;6542.967285163544;6565.868682626417;5988.730507127103;5993.640381577119;6010.429009244115;6038.184845045863;6117.235345581802;5989.071693887455;6054.212952316171;6072.757089716361;6106.72519736604;6113.327533971348 21:27:17 INFO - 2015-11-10 21:27:17,532 DEBUG : BROWSER_OUTPUT: |4;prototype.html;308.82860012692953;312.6998081841432;315.39129480103406;316.10069352691596;319.0190165241882;5875.206847075643;5904.940950590498;6010.8797824043495;6035.969820150893;6068.6055406398555;5914.674692891889;5929.169916211734;5942.049272116462;5975.850603734909;5994.7002649867445;4466.5980061794435;4468.374427580134;4507.932381014288;4510.165619360412;4521.660875434339;4450.332450132473;4502.8874278142985;4511.323301504768;4512.300593408027;4532.9320060199125;4436.378906953029;4484.8206071757095;4494.775261236941;4553.635709143277;4560.247559152735;4534.206513860077;4536.523665015159;4537.296719008559;4544.750038747868;4551.45382554094;3881.068543549556;3909.530856297234;3914.080191155105;3926.70549708773;3927.214557088565;5738.741756620962;5741.971290143564;5755.251817263771;5755.856103597402;5761.48146666802;5143.434222235551;5220.29526013987;5243.397009343936;5249.632525723201;5255.106631872591;6259.186305780265;6264.87470250597;6267.592606480564;6276.403741644536;6305.3379395163765;4327.653787696977;4357.956420435787;4358.5205627380965;4361.542038086019;4390.780460976938;6501.609903405763;6561.3438656134485;6614.570052946543;6634.038064480672;6645.60126392418;4381.364702118175;4383.561643835591;4391.275439552502;4419.071994881111;4471.217536931024;4436.645068394585;4444.755538445416;4449.221386257392;4450.531324662854;4451.666125040635;5141.3830340358645;5144.099782538041;5144.30551875492;5191.402988656278;5253.159494480941;6304.464120549805;6430.549861509649;6434.292227854932;6454.548181627335;6464.806055818333;1556.2685537797443;1610.066161626254;1614.685136398391;1614.8546630803048;1617.3368918743258;1001.3541265883464;1029.0789743179812;1033.5968972100886;1033.963811266602;1041.9739506512246;6096.451319381277;6113.388661133851;6134.8159555213415;6191.845203869849;6192.783252586138;6495.967520162369;6502.869942601122;6506.577072490273;6534.7386104556235;6562.967185164139;6037.426444487766;6063.090536419572;6168.228971378578;6170.259568851767;6191.040388739752;3586.4082426399873;3658.3963645998642;3662.1943172502006;3673.6142705015586;3675.209829886587;6841.93158068413;6857.074294970215;6869.553479023847;6875.724971001204;6911.550749201286;6847.246802851682;6851.2806155353965;6858.759943401957;6871.587704737632;6896.862062758717;6733.764318248838;6875.828104297332;6877.312268773083;6893.20728116273;6908.343707347693;6547.279799221987;6606.240282367397;6607.47140228771;6625.602463852184;6630.5027122965;6366.29970703213;6545.607263564201;6582.703778330082;6588.308227636221;6588.538802283986;6874.793756187322;6909.7581584644295;6935.3411425914455;6940.340667636567;7011.684474198775;4350.521442641244;4358.694891357574;4369.388285640077;4391.5388884166705;4404.625606823456;6531.542792004514;6643.56816806906;6664.233613134552;6667.53327267106;6691.464682825265;6381.776637817654;6445.742170313322;6477.060826180272;6502.707378167899;6510.44661203803;6371.649559274284;6395.264544577433;6403.4877209824035;6469.676516174079;6471.514636402195;6153.66154861469;6277;6293.213348331458;6297.338779428277;6324.367563243823;6449.355064493513;6493.383128602775;6523.282438931808;6542.54202205841;6545.21457425112;6232.8130156095385;6356.745730170926;6362.745490180341;6364.140840986408;6378.043293506012 21:27:17 INFO - 2015-11-10 21:27:17,536 DEBUG : BROWSER_OUTPUT: |5;yui.html;755.6070843161556;757.6287619066659;788.5623478969171;823.3989187892838;864.8270345930815;13419.597412077641;14006.159630422182;14062.4375024999;15396;15634.687306253869;14086.366113524891;14118.08232464889;14187;14201.289935503235;14236.074655147435;804.7786858613899;807.6930766308794;812.6708682983401;813.6826637611337;827.9296259817922;823.2014945502882;827.0571548434759;829.6598394658191;832.6627715775121;836.6820608168887;832.2800777327599;859.5659192107977;870.6299822575412;872.4459967920353;873.1792115411524;843.5866425451546;856.9014563325204;857.3569822633025;860.0281681699639;862.965481380744;628.3151365012159;629.5781826176427;631.198378059866;631.3150231998287;634.6065439427584;13411.329433528284;13664.043516953818;13715.725685486334;13829;13840.169589824542;10184.439855807928;10502.78994420115;10741.677749667522;10800.081993030602;11051.834222486668;9406.764830879214;9450.33847630666;9591.520423978773;9680.612775488971;10103.141232995204;3173.1115287719476;3177.7140057394945;3212.3093534889877;3232.143481977278;3283.3925723740945;47789.5221047792;48427.27359089616;48461.75769121132;48688.26967595489;48723.75638121822;7326.633668316669;7392.1499027611435;7395.519291246052;7445.813854653677;7462.962685186648;11823.586174483851;11893.821592676117;12002.099842511672;12216.877831221575;12219.083568732382;6323.241211054703;6421.967890160519;6435.742570297136;6491.318411566812;6578;3972.3644216925154;3974.955596789029;4034.7542223593296;4043.4945631796027;4053.9797301013305;2647.8940842366474;2686.194141757504;2688.0994866719475;2691.905783297575;2702.2028501592076;414.34119749598284;419.5741322557607;420.6487582868278;430.53932292447405;431.8596456151763;525.4561528817655;566.498648695907;617.2038070888503;631.5137344244997;637.0698779781478;8731.170538798804;8976.102389760972;9028.909710902806;9509.619615215452;9767;551.4387403040382;569.2116418759964;607.9270487541435;642.1010585180784;669.9162604674416;3910.2570511602703;4018.3570628699854;4130.442390277334;4131.215069136854;4218.578142185757;57668.42331576715;58165.41834581685;58295.125573116435;58585;58623.41376586265;51977.7401112992;52570;52615;53136.202956955676;53154;45884;46154.76922615433;46509.30236046462;47039.5296047042;47473.76263118732;7802.102758182881;8031.477953932976;8069.757907262791;8079.1516890725625;8349.95825020871;33252.83373583214;34685.306293874484;34706;34823;35239.64760352466;40750;40831.59168408278;43390;44523;44623.55376446194;7342.045534080536;7443.255674432514;7455.888161677688;7605.771826845204;7639.312461878458;11810.822837657613;12107.636770896886;12365.258084514959;12375;12673.049521286124;11518.596849110576;11824.23142495735;11938.164328496921;12195.695107622381;12232.816507752214;11070.114390848874;11386.772264554827;11450.427478626201;11849;11854;9679.516024198621;9836.60653573849;11770.52917883275;11790.23363481371;11965.461554230254;9513.95763215194;9569.3779904306;9588.520573971413;9871.950640246752;9891.109800118023;9204.815903682023;9371.859422108537;9557.378770379903;9662.549878394126;10192.592296308065 21:27:17 INFO - 2015-11-10 21:27:17,536 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:27:17 INFO - 2015-11-10 21:27:17,536 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:27:17 INFO - 2015-11-10 21:27:17,536 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,290 21:27:17 INFO - 2015-11-10 21:27:17,537 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:27:17 INFO - 2015-11-10 21:27:17,537 DEBUG : BROWSER_OUTPUT: __startTimestamp1447219637523__endTimestamp 21:27:17 INFO - 2015-11-10 21:27:17,537 DEBUG : BROWSER_OUTPUT: 21:27:17 INFO - 2015-11-10 21:27:17,537 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:27:17 INFO - 2015-11-10 21:27:17,537 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:27:17 INFO - 2015-11-10 21:27:17,537 DEBUG : BROWSER_OUTPUT: 21:27:17 INFO - 2015-11-10 21:27:17,537 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5431.48 Median:5674.55 stddev:609.12 (10.7%) stddev-sans-first:584.39 21:27:17 INFO - 2015-11-10 21:27:17,537 DEBUG : BROWSER_OUTPUT: Values: 3162.2 3262.0 3289.6 3312.6 3324.5 5202.0 5306.2 5426.6 5427.2 5434.2 5331.7 5335.5 5393.4 5430.5 5434.7 4694.3 4956.5 5084.5 5093.2 5098.9 4860.3 5027.2 5065.3 5070.8 5111.1 4862.1 4923.6 4929.5 4996.0 5019.8 4890.6 4896.2 4940.6 4975.2 4980.1 4759.7 4832.0 4948.6 4956.6 5005.0 5242.4 5269.2 5271.2 5341.5 5425.7 5856.9 5882.6 5924.8 5925.5 5938.0 5752.2 5851.4 5897.7 5923.5 5957.6 5527.8 5528.3 5532.2 5537.1 5568.3 5922.6 5927.9 5936.4 5958.6 5966.6 5658.3 5692.8 5778.5 5793.5 5816.7 5804.8 5814.4 5819.4 5833.4 5849.4 5759.2 5811.9 5832.0 5840.7 5841.5 5583.7 5709.0 5785.6 5802.5 5835.7 4420.9 4485.4 4507.8 4512.1 4520.0 3848.5 4023.5 4038.4 4057.5 4066.0 5364.2 5381.0 5393.6 5522.8 5561.2 5870.0 5932.9 5937.0 5947.4 5981.4 5435.4 5649.9 5666.3 5674.5 5676.0 5061.2 5078.4 5116.0 5131.8 5149.7 6077.9 6180.7 6185.1 6191.3 6201.5 5621.6 5726.9 5875.3 5907.6 5920.3 5913.5 6035.2 6053.8 6055.4 6089.5 5743.9 5745.3 5746.3 5750.9 5751.2 5602.6 5702.7 5773.4 5825.1 5828.2 5674.5 5694.2 5704.0 5704.2 5722.8 5719.9 5725.3 5738.0 5744.5 5757.5 5430.1 5578.4 5618.9 5632.8 5756.7 5780.6 5822.7 5828.5 5872.8 5877.0 5724.9 5732.9 5744.6 5752.8 5759.5 21:27:17 INFO - 2015-11-10 21:27:17,538 DEBUG : BROWSER_OUTPUT: 21:27:17 INFO - 2015-11-10 21:27:17,538 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45402.61 Median:41775.48 stddev:72836.55 (174.4%) stddev-sans-first:72963.06 21:27:17 INFO - 2015-11-10 21:27:17,539 DEBUG : BROWSER_OUTPUT: Values: 560.5 562.7 572.8 583.8 602.7 40921.0 42274.8 42276.4 42323.4 42367.8 43639.0 43792.3 43951.6 44488.8 44549.3 8618.4 8716.7 8861.2 8868.6 8916.9 8404.2 8455.5 8494.0 8627.7 8678.2 8411.4 8662.1 8707.9 8728.3 8738.4 8662.2 8724.3 8726.1 8810.0 8811.2 8644.8 8777.0 8778.3 8810.1 8812.5 40917.2 41332.0 41362.8 41854.0 41857.4 2709.7 3111.1 3131.8 3245.8 3374.1 29698.1 29789.3 29840.3 30118.7 30449.4 3313.6 3318.5 3334.0 3404.3 3405.9 249267.0 251061.0 251164.0 251716.0 252484.0 41996.8 58168.4 58500.4 58569.4 58645.7 41757.4 41793.6 41977.0 42323.6 42692.8 12585.0 12837.3 12960.7 12961.1 12972.9 8992.3 9065.9 9151.7 9160.0 9237.4 14369.4 14403.4 14444.5 14449.6 14517.5 5804.7 5855.2 5866.6 5949.9 5960.5 826.4 871.9 886.2 911.7 1003.0 28974.6 29002.9 29144.9 29576.9 29594.9 958.0 977.1 985.5 1020.2 1062.3 15822.8 15908.3 16447.8 16521.7 17209.7 281447.0 286307.0 287312.0 290598.0 290683.0 57312.4 58609.4 58793.4 58795.4 58803.1 1284.7 1295.7 1302.1 1311.9 1318.9 29808.9 30654.4 30891.8 31310.4 31382.7 47190.8 47221.8 47895.3 48093.8 48138.5 293177.0 296508.0 298072.0 298111.0 300606.0 33555.7 43582.0 43609.3 44172.6 44650.6 41057.4 41497.4 42698.6 45358.8 46722.5 36833.0 37379.3 37747.4 42091.0 42495.2 39168.2 41133.4 42158.0 42279.0 42464.4 37346.3 37613.8 38379.8 38403.4 38490.0 33340.3 34528.7 34739.0 34761.7 34908.7 25434.1 26787.7 26834.7 26896.2 27265.5 21:27:17 INFO - 2015-11-10 21:27:17,539 DEBUG : BROWSER_OUTPUT: 21:27:17 INFO - 2015-11-10 21:27:17,539 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26821.48 Median:427.67 stddev:87574.23 (20477.2%) stddev-sans-first:87797.32 21:27:17 INFO - 2015-11-10 21:27:17,539 DEBUG : BROWSER_OUTPUT: Values: 340.0 344.9 346.7 348.0 348.3 13945.9 14394.9 16897.2 17074.0 17930.3 14552.1 14832.8 15002.2 15010.3 15057.9 4822.4 4983.3 4984.1 4986.1 5173.8 4808.3 4934.5 4937.5 4960.4 5025.5 4772.9 4820.2 4881.0 4895.3 4916.2 4595.1 4788.0 4799.0 4813.9 4823.8 4021.4 4160.3 4161.6 4202.7 4370.0 12958.3 12989.8 13036.7 13293.3 13328.0 1712.8 1783.2 1856.8 1899.7 1928.4 9969.7 10069.7 10192.5 10352.1 10597.9 1631.6 1639.0 1719.1 1727.9 1778.5 60256.7 62381.1 62779.7 63309.7 63362.4 6888.8 7001.0 7002.1 7002.3 7142.9 8110.8 8171.7 8175.2 8247.5 8301.8 5212.9 5222.2 5225.2 5278.7 5299.6 5227.2 5232.0 5235.8 5267.5 5277.3 3238.1 3240.7 3249.0 3271.8 3292.2 1122.5 1133.3 1135.1 1142.5 1180.8 413.3 426.7 438.2 444.0 444.6 10526.2 10643.3 10655.1 10723.6 10949.1 424.0 428.6 431.4 443.3 443.7 5898.9 6104.6 6346.6 6494.8 6498.0 517478.0 523602.0 534443.9 543256.0 549556.0 77117.6 78552.0 78695.2 78866.0 80593.6 524.8 524.8 533.8 536.1 536.6 10646.4 10922.3 10949.2 10963.9 11136.7 32827.7 33359.5 34496.0 34600.3 35229.5 45367.3 47114.8 47282.5 47623.5 48133.8 6432.8 6541.1 6604.4 6738.8 6843.8 12135.2 12326.3 12345.9 12376.0 12419.5 10611.3 10659.5 10670.8 10760.0 10893.3 10268.1 10378.2 10505.2 10601.4 10719.9 10337.3 10399.9 10756.2 10763.3 10777.2 6707.4 6738.5 6760.4 6776.0 6793.1 10383.6 10431.5 10682.1 10911.4 11023.2 21:27:17 INFO - 2015-11-10 21:27:17,539 DEBUG : BROWSER_OUTPUT: 21:27:17 INFO - 2015-11-10 21:27:17,539 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5002.91 Median:6177.77 stddev:2510.85 (40.6%) stddev-sans-first:2504.02 21:27:17 INFO - 2015-11-10 21:27:17,540 DEBUG : BROWSER_OUTPUT: Values: 1490.4 1689.0 1730.3 1757.9 1767.3 7022.0 7089.6 7094.8 7217.1 7285.5 7061.3 7175.4 7200.4 7223.5 7283.7 2191.9 2227.2 2231.1 2233.0 2233.5 2198.1 2203.8 2206.5 2207.4 2217.7 2139.8 2145.9 2160.4 2167.3 2186.1 2102.1 2162.9 2213.1 2218.6 2220.7 2202.0 2202.6 2209.8 2221.0 2244.2 7012.2 7053.5 7149.0 7204.0 7211.2 4314.5 4340.8 4367.0 4377.9 4387.8 2868.5 2885.1 2888.7 2936.0 2950.0 867.9 875.3 891.5 921.7 926.9 9413.5 9447.8 9455.8 9473.6 9487.8 3884.7 3895.3 4024.9 4068.0 4078.8 7806.7 7912.2 7914.2 7919.0 7920.1 4257.4 4267.4 4271.7 4281.5 4305.7 3884.9 3887.4 3898.9 3904.7 3918.5 3194.3 3236.4 3257.7 3265.5 3266.5 1006.0 1037.3 1051.1 1052.2 1053.4 1022.3 1025.4 1059.9 1162.7 1309.8 6571.1 6599.1 6728.3 6796.7 6815.8 979.1 990.4 995.2 995.9 1000.7 5421.8 5468.8 5475.8 5476.9 5494.5 8299.4 8323.6 8497.9 8511.4 8570.0 8224.8 8383.0 8470.4 8475.6 8512.3 6717.8 6730.8 6744.5 6831.5 6832.4 6077.6 6357.3 6424.9 6488.1 6511.2 7412.4 7531.7 7636.4 7648.8 7673.9 7442.6 7683.4 7738.1 7756.3 7792.6 5982.3 6160.9 6163.7 6177.5 6178.1 6829.3 6879.1 6890.3 6910.7 6911.6 6395.1 6407.7 6435.7 6448.4 6593.5 6224.8 6364.1 6419.6 6438.4 6444.3 6476.1 6516.8 6527.1 6543.0 6565.9 5988.7 5993.6 6010.4 6038.2 6117.2 5989.1 6054.2 6072.8 6106.7 6113.3 21:27:17 INFO - 2015-11-10 21:27:17,540 DEBUG : BROWSER_OUTPUT: 21:27:17 INFO - 2015-11-10 21:27:17,540 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5322.41 Median:6065.85 stddev:1639.38 (27.0%) stddev-sans-first:1600.21 21:27:17 INFO - 2015-11-10 21:27:17,541 DEBUG : BROWSER_OUTPUT: Values: 308.8 312.7 315.4 316.1 319.0 5875.2 5904.9 6010.9 6036.0 6068.6 5914.7 5929.2 5942.0 5975.9 5994.7 4466.6 4468.4 4507.9 4510.2 4521.7 4450.3 4502.9 4511.3 4512.3 4532.9 4436.4 4484.8 4494.8 4553.6 4560.2 4534.2 4536.5 4537.3 4544.8 4551.5 3881.1 3909.5 3914.1 3926.7 3927.2 5738.7 5742.0 5755.3 5755.9 5761.5 5143.4 5220.3 5243.4 5249.6 5255.1 6259.2 6264.9 6267.6 6276.4 6305.3 4327.7 4358.0 4358.5 4361.5 4390.8 6501.6 6561.3 6614.6 6634.0 6645.6 4381.4 4383.6 4391.3 4419.1 4471.2 4436.6 4444.8 4449.2 4450.5 4451.7 5141.4 5144.1 5144.3 5191.4 5253.2 6304.5 6430.5 6434.3 6454.5 6464.8 1556.3 1610.1 1614.7 1614.9 1617.3 1001.4 1029.1 1033.6 1034.0 1042.0 6096.5 6113.4 6134.8 6191.8 6192.8 6496.0 6502.9 6506.6 6534.7 6563.0 6037.4 6063.1 6168.2 6170.3 6191.0 3586.4 3658.4 3662.2 3673.6 3675.2 6841.9 6857.1 6869.6 6875.7 6911.6 6847.2 6851.3 6858.8 6871.6 6896.9 6733.8 6875.8 6877.3 6893.2 6908.3 6547.3 6606.2 6607.5 6625.6 6630.5 6366.3 6545.6 6582.7 6588.3 6588.5 6874.8 6909.8 6935.3 6940.3 7011.7 4350.5 4358.7 4369.4 4391.5 4404.6 6531.5 6643.6 6664.2 6667.5 6691.5 6381.8 6445.7 6477.1 6502.7 6510.4 6371.6 6395.3 6403.5 6469.7 6471.5 6153.7 6277.0 6293.2 6297.3 6324.4 6449.4 6493.4 6523.3 6542.5 6545.2 6232.8 6356.7 6362.7 6364.1 6378.0 21:27:17 INFO - 2015-11-10 21:27:17,541 DEBUG : BROWSER_OUTPUT: 21:27:17 INFO - 2015-11-10 21:27:17,541 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13419.64 Median:26251.60 stddev:16099.65 (61.3%) stddev-sans-first:16116.73 21:27:17 INFO - 2015-11-10 21:27:17,541 DEBUG : BROWSER_OUTPUT: Values: 755.6 757.6 788.6 823.4 864.8 13419.6 14006.2 14062.4 15396.0 15634.7 14086.4 14118.1 14187.0 14201.3 14236.1 804.8 807.7 812.7 813.7 827.9 823.2 827.1 829.7 832.7 836.7 832.3 859.6 870.6 872.4 873.2 843.6 856.9 857.4 860.0 863.0 628.3 629.6 631.2 631.3 634.6 13411.3 13664.0 13715.7 13829.0 13840.2 10184.4 10502.8 10741.7 10800.1 11051.8 9406.8 9450.3 9591.5 9680.6 10103.1 3173.1 3177.7 3212.3 3232.1 3283.4 47789.5 48427.3 48461.8 48688.3 48723.8 7326.6 7392.1 7395.5 7445.8 7463.0 11823.6 11893.8 12002.1 12216.9 12219.1 6323.2 6422.0 6435.7 6491.3 6578.0 3972.4 3975.0 4034.8 4043.5 4054.0 2647.9 2686.2 2688.1 2691.9 2702.2 414.3 419.6 420.6 430.5 431.9 525.5 566.5 617.2 631.5 637.1 8731.2 8976.1 9028.9 9509.6 9767.0 551.4 569.2 607.9 642.1 669.9 3910.3 4018.4 4130.4 4131.2 4218.6 57668.4 58165.4 58295.1 58585.0 58623.4 51977.7 52570.0 52615.0 53136.2 53154.0 45884.0 46154.8 46509.3 47039.5 47473.8 7802.1 8031.5 8069.8 8079.2 8350.0 33252.8 34685.3 34706.0 34823.0 35239.6 40750.0 40831.6 43390.0 44523.0 44623.6 7342.0 7443.3 7455.9 7605.8 7639.3 11810.8 12107.6 12365.3 12375.0 12673.0 11518.6 11824.2 11938.2 12195.7 12232.8 11070.1 11386.8 11450.4 11849.0 11854.0 9679.5 9836.6 11770.5 11790.2 11965.5 9514.0 9569.4 9588.5 9872.0 9891.1 9204.8 9371.9 9557.4 9662.5 10192.6 21:27:17 INFO - 2015-11-10 21:27:17,542 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:27:17 INFO - 2015-11-10 21:27:17,542 DEBUG : BROWSER_OUTPUT: 21:27:18 INFO - 2015-11-10 21:27:18,202 INFO : Browser exited with error code: 0 21:27:18 INFO - 2015-11-10 21:27:18,218 INFO : Completed test dromaeo_css (00:18:33) 21:27:18 INFO - 2015-11-10 21:27:18,218 INFO : Starting test kraken 21:27:18 INFO - 2015-11-10 21:27:18,218 DEBUG : operating with platform_type : linux_ 21:27:18 INFO - 2015-11-10 21:27:18,218 INFO : Initialising browser for kraken test... 21:27:18 INFO - 2015-11-10 21:27:18,224 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpF0dTd6/profile http://localhost:44721/getInfo.html 21:27:23 INFO - 2015-11-10 21:27:23,011 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:27:23 INFO - 2015-11-10 21:27:23,012 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:27:23 INFO - 2015-11-10 21:27:23,012 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:27:23 INFO - 2015-11-10 21:27:23,012 DEBUG : BROWSER_OUTPUT: __metrics 21:27:24 INFO - 2015-11-10 21:27:24,065 INFO : Browser initialized. 21:27:24 INFO - 2015-11-10 21:27:24,066 INFO : Running cycle 1/1 for kraken test... 21:27:24 INFO - 2015-11-10 21:27:24,066 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpF0dTd6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:27:35 INFO - 2015-11-10 21:27:35,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 139137024 21:27:35 INFO - 2015-11-10 21:27:35,846 DEBUG : BROWSER_OUTPUT: 21:27:38 INFO - 2015-11-10 21:27:38,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44721/tests/kraken/driver.html?testName=audio-beat-detection) 21:27:38 INFO - 2015-11-10 21:27:38,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 141332480 21:27:38 INFO - 2015-11-10 21:27:38,956 DEBUG : BROWSER_OUTPUT: 21:27:41 INFO - 2015-11-10 21:27:41,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44721/tests/kraken/driver.html?testName=audio-dft) 21:27:42 INFO - 2015-11-10 21:27:42,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 141131776 21:27:42 INFO - 2015-11-10 21:27:42,175 DEBUG : BROWSER_OUTPUT: 21:27:44 INFO - 2015-11-10 21:27:44,998 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44721/tests/kraken/driver.html?testName=audio-fft) 21:27:45 INFO - 2015-11-10 21:27:45,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 136605696 21:27:45 INFO - 2015-11-10 21:27:45,571 DEBUG : BROWSER_OUTPUT: 21:27:47 INFO - 2015-11-10 21:27:47,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44721/tests/kraken/driver.html?testName=audio-oscillator) 21:27:48 INFO - 2015-11-10 21:27:48,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 137072640 21:27:48 INFO - 2015-11-10 21:27:48,187 DEBUG : BROWSER_OUTPUT: 21:27:50 INFO - 2015-11-10 21:27:50,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44721/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:27:50 INFO - 2015-11-10 21:27:50,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 137457664 21:27:50 INFO - 2015-11-10 21:27:50,934 DEBUG : BROWSER_OUTPUT: 21:27:53 INFO - 2015-11-10 21:27:53,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44721/tests/kraken/driver.html?testName=imaging-darkroom) 21:27:54 INFO - 2015-11-10 21:27:54,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 136249344 21:27:54 INFO - 2015-11-10 21:27:54,502 DEBUG : BROWSER_OUTPUT: 21:27:57 INFO - 2015-11-10 21:27:57,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44721/tests/kraken/driver.html?testName=imaging-desaturate) 21:27:58 INFO - 2015-11-10 21:27:58,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 137662464 21:27:58 INFO - 2015-11-10 21:27:58,497 DEBUG : BROWSER_OUTPUT: 21:28:01 INFO - 2015-11-10 21:28:01,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44721/tests/kraken/driver.html?testName=json-parse-financial) 21:28:01 INFO - 2015-11-10 21:28:01,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 138072064 21:28:01 INFO - 2015-11-10 21:28:01,929 DEBUG : BROWSER_OUTPUT: 21:28:03 INFO - 2015-11-10 21:28:03,502 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44721/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:28:04 INFO - 2015-11-10 21:28:04,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 138313728 21:28:04 INFO - 2015-11-10 21:28:04,084 DEBUG : BROWSER_OUTPUT: 21:28:05 INFO - 2015-11-10 21:28:05,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44721/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:28:06 INFO - 2015-11-10 21:28:06,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 137457664 21:28:06 INFO - 2015-11-10 21:28:06,487 DEBUG : BROWSER_OUTPUT: 21:28:08 INFO - 2015-11-10 21:28:08,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44721/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:28:09 INFO - 2015-11-10 21:28:09,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 138440704 21:28:09 INFO - 2015-11-10 21:28:09,187 DEBUG : BROWSER_OUTPUT: 21:28:11 INFO - 2015-11-10 21:28:11,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44721/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:28:12 INFO - 2015-11-10 21:28:12,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 139784192 21:28:12 INFO - 2015-11-10 21:28:12,228 DEBUG : BROWSER_OUTPUT: 21:28:14 INFO - 2015-11-10 21:28:14,771 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44721/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:28:15 INFO - 2015-11-10 21:28:15,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 138416128 21:28:15 INFO - 2015-11-10 21:28:15,355 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44721/tests/kraken/driver.html?testName=ai-astar) 21:28:17 INFO - 2015-11-10 21:28:17,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 138350592 21:28:17 INFO - 2015-11-10 21:28:17,275 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,276 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:28:17 INFO - 2015-11-10 21:28:17,277 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:28:17 INFO - 2015-11-10 21:28:17,277 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:28:17 INFO - 2015-11-10 21:28:17,277 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:28:17 INFO - 2015-11-10 21:28:17,277 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;108;112;111;110;121;122;111;111;112 21:28:17 INFO - 2015-11-10 21:28:17,277 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;126;150;163;125;148;148;140;170;125 21:28:17 INFO - 2015-11-10 21:28:17,277 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;161;163;163;160;160;166;172;163 21:28:17 INFO - 2015-11-10 21:28:17,278 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;71;72;83;71;145;75;73;87 21:28:17 INFO - 2015-11-10 21:28:17,278 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;92;136;91;91;92;137;92;91;135 21:28:17 INFO - 2015-11-10 21:28:17,278 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;111;110;110;110;110;110;112 21:28:17 INFO - 2015-11-10 21:28:17,278 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;148;149;147;148;147;146;147;146 21:28:17 INFO - 2015-11-10 21:28:17,278 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;97;96;96;97;97;97;97;96 21:28:17 INFO - 2015-11-10 21:28:17,279 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;62;62;61;62;64;62;59;58;61 21:28:17 INFO - 2015-11-10 21:28:17,279 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;67;67;68;66;68;67;66;67 21:28:17 INFO - 2015-11-10 21:28:17,279 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;87;93;86;87;86;99;86;90;86 21:28:17 INFO - 2015-11-10 21:28:17,280 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;127;127;117;121;119;118;121;130;123 21:28:17 INFO - 2015-11-10 21:28:17,280 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;152;140;147;150;139;150;146;147;148 21:28:17 INFO - 2015-11-10 21:28:17,280 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;67;67;69;67;66;68;67;69;65 21:28:17 INFO - 2015-11-10 21:28:17,281 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:28:17 INFO - 2015-11-10 21:28:17,281 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:28:17 INFO - 2015-11-10 21:28:17,281 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,693 21:28:17 INFO - 2015-11-10 21:28:17,281 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:28:17 INFO - 2015-11-10 21:28:17,281 DEBUG : BROWSER_OUTPUT: __startTimestamp1447219697276__endTimestamp 21:28:17 INFO - 2015-11-10 21:28:17,281 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,285 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:28:17 INFO - 2015-11-10 21:28:17,285 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:28:17 INFO - 2015-11-10 21:28:17,285 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,285 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.20 Median:112.00 stddev:4.64 (4.1%) stddev-sans-first:4.91 21:28:17 INFO - 2015-11-10 21:28:17,285 DEBUG : BROWSER_OUTPUT: Values: 114.0 108.0 112.0 111.0 110.0 121.0 122.0 111.0 111.0 112.0 21:28:17 INFO - 2015-11-10 21:28:17,285 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,285 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.20 Median:149.00 stddev:16.06 (10.8%) stddev-sans-first:16.46 21:28:17 INFO - 2015-11-10 21:28:17,285 DEBUG : BROWSER_OUTPUT: Values: 157.0 126.0 150.0 163.0 125.0 148.0 148.0 140.0 170.0 125.0 21:28:17 INFO - 2015-11-10 21:28:17,286 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,286 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:3.58 (2.2%) stddev-sans-first:3.80 21:28:17 INFO - 2015-11-10 21:28:17,286 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 161.0 163.0 163.0 160.0 160.0 166.0 172.0 163.0 21:28:17 INFO - 2015-11-10 21:28:17,286 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,286 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.00 Median:72.50 stddev:22.82 (31.5%) stddev-sans-first:23.92 21:28:17 INFO - 2015-11-10 21:28:17,286 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 72.0 83.0 71.0 145.0 75.0 73.0 87.0 21:28:17 INFO - 2015-11-10 21:28:17,286 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,286 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.60 Median:91.00 stddev:21.69 (23.8%) stddev-sans-first:22.26 21:28:17 INFO - 2015-11-10 21:28:17,286 DEBUG : BROWSER_OUTPUT: Values: 89.0 92.0 136.0 91.0 91.0 92.0 137.0 92.0 91.0 135.0 21:28:17 INFO - 2015-11-10 21:28:17,286 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,287 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 21:28:17 INFO - 2015-11-10 21:28:17,287 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 112.0 21:28:17 INFO - 2015-11-10 21:28:17,287 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,287 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 21:28:17 INFO - 2015-11-10 21:28:17,287 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 148.0 149.0 147.0 148.0 147.0 146.0 147.0 146.0 21:28:17 INFO - 2015-11-10 21:28:17,287 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,287 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 21:28:17 INFO - 2015-11-10 21:28:17,287 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 97.0 96.0 96.0 97.0 97.0 97.0 97.0 96.0 21:28:17 INFO - 2015-11-10 21:28:17,288 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,288 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.30 Median:62.00 stddev:1.70 (2.7%) stddev-sans-first:1.79 21:28:17 INFO - 2015-11-10 21:28:17,288 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 62.0 61.0 62.0 64.0 62.0 59.0 58.0 61.0 21:28:17 INFO - 2015-11-10 21:28:17,288 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,288 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 21:28:17 INFO - 2015-11-10 21:28:17,288 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 67.0 68.0 66.0 68.0 67.0 66.0 67.0 21:28:17 INFO - 2015-11-10 21:28:17,288 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,288 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:87.00 stddev:4.40 (5.1%) stddev-sans-first:4.48 21:28:17 INFO - 2015-11-10 21:28:17,288 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 93.0 86.0 87.0 86.0 99.0 86.0 90.0 86.0 21:28:17 INFO - 2015-11-10 21:28:17,288 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,288 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:122.00 stddev:4.51 (3.7%) stddev-sans-first:4.53 21:28:17 INFO - 2015-11-10 21:28:17,289 DEBUG : BROWSER_OUTPUT: Values: 118.0 127.0 127.0 117.0 121.0 119.0 118.0 121.0 130.0 123.0 21:28:17 INFO - 2015-11-10 21:28:17,289 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,289 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:147.50 stddev:4.80 (3.3%) stddev-sans-first:4.42 21:28:17 INFO - 2015-11-10 21:28:17,289 DEBUG : BROWSER_OUTPUT: Values: 139.0 152.0 140.0 147.0 150.0 139.0 150.0 146.0 147.0 148.0 21:28:17 INFO - 2015-11-10 21:28:17,289 DEBUG : BROWSER_OUTPUT: 21:28:17 INFO - 2015-11-10 21:28:17,289 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.35 (2.0%) stddev-sans-first:1.30 21:28:17 INFO - 2015-11-10 21:28:17,289 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 67.0 69.0 67.0 66.0 68.0 67.0 69.0 65.0 21:28:17 INFO - 2015-11-10 21:28:17,289 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:28:17 INFO - 2015-11-10 21:28:17,289 DEBUG : BROWSER_OUTPUT: 21:28:18 INFO - 2015-11-10 21:28:18,113 INFO : Browser exited with error code: 0 21:28:18 INFO - 2015-11-10 21:28:18,164 INFO : Completed test kraken (00:00:59) 21:28:18 INFO - 2015-11-10 21:28:18,164 INFO : Starting test v8_7 21:28:18 INFO - 2015-11-10 21:28:18,164 DEBUG : operating with platform_type : linux_ 21:28:18 INFO - 2015-11-10 21:28:18,164 INFO : Initialising browser for v8_7 test... 21:28:18 INFO - 2015-11-10 21:28:18,170 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdkZ0WG/profile http://localhost:44721/getInfo.html 21:28:23 INFO - 2015-11-10 21:28:23,019 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:28:23 INFO - 2015-11-10 21:28:23,019 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:28:23 INFO - 2015-11-10 21:28:23,019 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:28:23 INFO - 2015-11-10 21:28:23,019 DEBUG : BROWSER_OUTPUT: __metrics 21:28:24 INFO - 2015-11-10 21:28:24,057 INFO : Browser initialized. 21:28:24 INFO - 2015-11-10 21:28:24,058 INFO : Running cycle 1/1 for v8_7 test... 21:28:24 INFO - 2015-11-10 21:28:24,058 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdkZ0WG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:28:35 INFO - 2015-11-10 21:28:35,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 139399168 21:28:35 INFO - 2015-11-10 21:28:35,755 DEBUG : BROWSER_OUTPUT: 21:28:57 INFO - 2015-11-10 21:28:57,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44721/tests/v8_7/run.html (next: http://localhost:44721/tests/v8_7/run.html) 21:28:57 INFO - 2015-11-10 21:28:57,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 138039296 21:28:57 INFO - 2015-11-10 21:28:57,416 DEBUG : BROWSER_OUTPUT: 21:28:57 INFO - 2015-11-10 21:28:57,416 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:28:57 INFO - 2015-11-10 21:28:57,416 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:28:57 INFO - 2015-11-10 21:28:57,416 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:28:57 INFO - 2015-11-10 21:28:57,416 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:28:57 INFO - 2015-11-10 21:28:57,416 DEBUG : BROWSER_OUTPUT: |0;Richards;162.2849724115547 21:28:57 INFO - 2015-11-10 21:28:57,417 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.28793471925394 21:28:57 INFO - 2015-11-10 21:28:57,417 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.08744710860367 21:28:57 INFO - 2015-11-10 21:28:57,417 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 21:28:57 INFO - 2015-11-10 21:28:57,417 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1060.4453870625662 21:28:57 INFO - 2015-11-10 21:28:57,417 DEBUG : BROWSER_OUTPUT: |5;Earley;722.0216606498195 21:28:57 INFO - 2015-11-10 21:28:57,417 DEBUG : BROWSER_OUTPUT: |6;Boyer;11686.046511627907 21:28:57 INFO - 2015-11-10 21:28:57,418 DEBUG : BROWSER_OUTPUT: |7;RegExp;24780.48780487805 21:28:57 INFO - 2015-11-10 21:28:57,418 DEBUG : BROWSER_OUTPUT: |8;Splay;637.4603174603175 21:28:57 INFO - 2015-11-10 21:28:57,418 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 21:28:57 INFO - 2015-11-10 21:28:57,418 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:28:57 INFO - 2015-11-10 21:28:57,419 DEBUG : BROWSER_OUTPUT: __startTimestamp1447219737414__endTimestamp 21:28:57 INFO - 2015-11-10 21:28:57,419 DEBUG : BROWSER_OUTPUT: 21:28:57 INFO - 2015-11-10 21:28:57,419 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:28:57 INFO - 2015-11-10 21:28:57,419 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:28:57 INFO - 2015-11-10 21:28:57,420 DEBUG : BROWSER_OUTPUT: 21:28:57 INFO - 2015-11-10 21:28:57,420 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.28 Median:162.28 stddev:0.00 (0.0%) 21:28:57 INFO - 2015-11-10 21:28:57,420 DEBUG : BROWSER_OUTPUT: Values: 162.3 21:28:57 INFO - 2015-11-10 21:28:57,420 DEBUG : BROWSER_OUTPUT: 21:28:57 INFO - 2015-11-10 21:28:57,421 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.29 Median:194.29 stddev:0.00 (0.0%) 21:28:57 INFO - 2015-11-10 21:28:57,421 DEBUG : BROWSER_OUTPUT: Values: 194.3 21:28:57 INFO - 2015-11-10 21:28:57,421 DEBUG : BROWSER_OUTPUT: 21:28:57 INFO - 2015-11-10 21:28:57,421 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.09 Median:282.09 stddev:0.00 (0.0%) 21:28:57 INFO - 2015-11-10 21:28:57,422 DEBUG : BROWSER_OUTPUT: Values: 282.1 21:28:57 INFO - 2015-11-10 21:28:57,422 DEBUG : BROWSER_OUTPUT: 21:28:57 INFO - 2015-11-10 21:28:57,422 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 21:28:57 INFO - 2015-11-10 21:28:57,422 DEBUG : BROWSER_OUTPUT: Values: 5040.2 21:28:57 INFO - 2015-11-10 21:28:57,423 DEBUG : BROWSER_OUTPUT: 21:28:57 INFO - 2015-11-10 21:28:57,423 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1060.45 Median:1060.45 stddev:0.00 (0.0%) 21:28:57 INFO - 2015-11-10 21:28:57,423 DEBUG : BROWSER_OUTPUT: Values: 1060.4 21:28:57 INFO - 2015-11-10 21:28:57,423 DEBUG : BROWSER_OUTPUT: 21:28:57 INFO - 2015-11-10 21:28:57,424 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:722.02 Median:722.02 stddev:0.00 (0.0%) 21:28:57 INFO - 2015-11-10 21:28:57,424 DEBUG : BROWSER_OUTPUT: Values: 722.0 21:28:57 INFO - 2015-11-10 21:28:57,424 DEBUG : BROWSER_OUTPUT: 21:28:57 INFO - 2015-11-10 21:28:57,424 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11686.05 Median:11686.05 stddev:0.00 (0.0%) 21:28:57 INFO - 2015-11-10 21:28:57,424 DEBUG : BROWSER_OUTPUT: Values: 11686.0 21:28:57 INFO - 2015-11-10 21:28:57,424 DEBUG : BROWSER_OUTPUT: 21:28:57 INFO - 2015-11-10 21:28:57,424 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24780.49 Median:24780.49 stddev:0.00 (0.0%) 21:28:57 INFO - 2015-11-10 21:28:57,425 DEBUG : BROWSER_OUTPUT: Values: 24780.5 21:28:57 INFO - 2015-11-10 21:28:57,425 DEBUG : BROWSER_OUTPUT: 21:28:57 INFO - 2015-11-10 21:28:57,425 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:637.46 Median:637.46 stddev:0.00 (0.0%) 21:28:57 INFO - 2015-11-10 21:28:57,425 DEBUG : BROWSER_OUTPUT: Values: 637.5 21:28:57 INFO - 2015-11-10 21:28:57,425 DEBUG : BROWSER_OUTPUT: 21:28:57 INFO - 2015-11-10 21:28:57,425 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 21:28:57 INFO - 2015-11-10 21:28:57,425 DEBUG : BROWSER_OUTPUT: Values: 4830.9 21:28:57 INFO - 2015-11-10 21:28:57,425 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:28:57 INFO - 2015-11-10 21:28:57,425 DEBUG : BROWSER_OUTPUT: 21:28:58 INFO - 2015-11-10 21:28:58,261 INFO : Browser exited with error code: 0 21:28:58 INFO - 2015-11-10 21:28:58,280 INFO : Completed test v8_7 (00:00:40) 21:28:58 INFO - 2015-11-10 21:28:58,498 INFO : Completed test suite (00:20:13) 21:28:58 INFO - 2015-11-10 21:28:58,498 DEBUG : Working with test: dromaeo_css 21:28:58 INFO - 2015-11-10 21:28:58,498 DEBUG : Generating results file: dromaeo_css 21:28:58 INFO - 2015-11-10 21:28:58,499 DEBUG : Working with test: kraken 21:28:58 INFO - 2015-11-10 21:28:58,499 DEBUG : Generating results file: kraken 21:28:58 INFO - 2015-11-10 21:28:58,500 INFO : javascript benchmark 21:28:58 INFO - 2015-11-10 21:28:58,500 DEBUG : Working with test: v8_7 21:28:58 INFO - 2015-11-10 21:28:58,500 DEBUG : Generating results file: v8_7 21:28:58 INFO - 2015-11-10 21:28:58,500 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:28:58 INFO - 2015-11-10 21:28:58,555 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 21:28:58 INFO - 2015-11-10 21:28:58,555 DEBUG : process_Request line: dromaeo_css 6547.87 graph.html#tests=[[72,63,43]] 21:28:58 INFO - 2015-11-10 21:28:58,555 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:28:58 INFO - 2015-11-10 21:28:58,596 DEBUG : process_Request line: kraken 1515.00 graph.html#tests=[[232,63,43]] 21:28:58 INFO - 2015-11-10 21:28:58,596 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:28:58 INFO - 2015-11-10 21:28:58,623 DEBUG : process_Request line: v8_7 21419.97 graph.html#tests=[[230,63,43]] 21:28:58 INFO - 2015-11-10 21:28:58,624 INFO : javascript benchmark 21:28:58 INFO - 2015-11-10 21:28:58,628 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [339.95750531183603, 344.8965310406879, 346.7465113614284, 348.0029714866907, 348.29122735233796, 13945.860541394582, 14394.928025359884, 16897.155142242886, 17074.0, 17930.28278868845, 14552.126872387664, 14832.777508337356, 15002.249887505608, 15010.324535395906, 15057.924710376432, 4822.397200349957, 4983.302337672729, 4984.077945580061, 4986.052649996489, 5173.844784656457, 4808.326834243208, 4934.5312195341385, 4937.481564435737, 4960.355153830015, 5025.547700706936, 4772.878373582205, 4820.156472617296, 4880.975595122037, 4895.290182923474, 4916.213405855064, 4595.149897269, 4788.04239152171, 4799.0, 4813.879653008667, 4823.831165909211, 4021.3766866135797, 4160.292750232467, 4161.56303588122, 4202.70581059326, 4370.0, 12958.287294198815, 12989.805152922714, 13036.739265214643, 13293.268870212134, 13328.0, 1712.760213570101, 1783.2421220981032, 1856.8421684156863, 1899.7150427435856, 1928.392556344747, 9969.65106221286, 10069.748256293578, 10192.490375481197, 10352.068313851714, 10597.894021059768, 1631.5839460937384, 1638.983610163895, 1719.0545200139873, 1727.9481615551554, 1778.537580229137, 60256.69871650657, 62381.06428403623, 62779.686101569656, 63309.68345158291, 63362.36637633611, 6888.793336199922, 7001.019857219993, 7002.089728335284, 7002.334778196063, 7142.892856607155, 8110.756677299691, 8171.67313307473, 8175.223353781381, 8247.505149691038, 8301.83396332082, 5212.947870521322, 5222.2427747976335, 5225.163973764255, 5278.736063196901, 5299.6290259681455, 5227.18978558324, 5232.005918875401, 5235.764390602432, 5267.499587539178, 5277.261183434322, 3238.109519882004, 3240.724538414214, 3248.951265731016, 3271.820049897231, 3292.160499072769, 1122.4836575175511, 1133.3313345126414, 1135.1202817816259, 1142.5258517715222, 1180.7579446213506, 413.28089124922417, 426.720498073756, 438.1980974816079, 444.02314907204277, 444.6154076723611, 10526.157907367393, 10643.25497215203, 10655.094316983143, 10723.571057157782, 10949.124070074375, 423.9936400953988, 428.61210604403067, 431.4132779419986, 443.2641814587769, 443.69385124264153, 5898.941010589925, 6104.633721976696, 6346.555741098171, 6494.805155845333, 6498.0, 517478.0, 523602.0, 534443.9167062485, 543256.0, 549556.0, 77117.61441192759, 78552.0, 78695.21304786879, 78866.0, 80593.59703201447, 524.753365918018, 524.8136911396399, 533.757140501071, 536.0993530868179, 536.6243629459394, 10646.414447205478, 10922.308313638701, 10949.233553651487, 10963.945180274048, 11136.721581960192, 32827.67172328246, 33359.49960750542, 34496.0, 34600.307993840484, 35229.471557927165, 45367.319490208334, 47114.76442617765, 47282.52717472781, 47623.5237647633, 48133.75933120312, 6432.774852880127, 6541.051547525487, 6604.3725846044545, 6738.764143254963, 6843.7604683835825, 12135.211211271238, 12326.260424374566, 12345.876541234473, 12376.0, 12419.503219871103, 10611.31026483307, 10659.467026648792, 10670.8399374011, 10760.031597156294, 10893.291936024134, 10268.07587317145, 10378.169746420419, 10505.159587233156, 10601.41692206936, 10719.946400268262, 10337.328073675188, 10399.896001040195, 10756.247062705535, 10763.300385474919, 10777.245592808427, 6707.429868461236, 6738.46092312604, 6760.391564759196, 6776.0, 6793.116894803644, 10383.584656613953, 10431.53058112402, 10682.092022178202, 10911.399873007062, 11023.228374013743], "dojo.html": [3162.1778337632218, 3261.9836900815494, 3289.5723555937725, 3312.602487701476, 3324.5345651608777, 5202.0, 5306.151015837467, 5426.647267927582, 5427.213054107157, 5434.212039254316, 5331.680099194051, 5335.466453354672, 5393.406725260228, 5430.456954304567, 5434.673919564819, 4694.319323698079, 4956.479569645189, 5084.491550844923, 5093.2105523643895, 5098.923516147261, 4860.3195552622665, 5027.220780778966, 5065.316182315377, 5070.797168113289, 5111.05445492585, 4862.051899879507, 4923.606111511089, 4929.4577596464715, 4996.0, 5019.824306149268, 4890.608751299887, 4896.167651499253, 4940.580050695695, 4975.203967365204, 4980.053789779967, 4759.714417134983, 4831.975840120812, 4948.554630083309, 4956.603471722254, 5005.0, 5242.397124330712, 5269.209618557209, 5271.182966640177, 5341.545968592674, 5425.674459532401, 5856.882862342772, 5882.588218824684, 5924.7926322578505, 5925.496332811673, 5938.0, 5752.2234498342605, 5851.4148585141575, 5897.705114744289, 5923.466887980103, 5957.642541447483, 5527.806526771584, 5528.308961379827, 5532.197831314437, 5537.058700021006, 5568.276124103881, 5922.555808314393, 5927.881442371128, 5936.406359364029, 5958.612690175125, 5966.642001479925, 5658.321001479849, 5692.800751973661, 5778.508826749773, 5793.507551858139, 5816.738246778905, 5804.82585522435, 5814.447627475383, 5819.447152520504, 5833.445822646841, 5849.356570777211, 5759.1937128802, 5811.94188058114, 5832.037713777179, 5840.737166827503, 5841.503472204825, 5583.720813959286, 5709.0, 5785.595008349375, 5802.535797136219, 5835.708214589254, 4420.8673739787855, 4485.372047913294, 4507.752073635916, 4512.142692888341, 4519.977400112978, 3848.5189351331082, 4023.5171779386073, 4038.374052021941, 4057.5130984281486, 4065.9796701016307, 5364.249005139283, 5381.0, 5393.5954803389905, 5522.806701765499, 5561.165825126263, 5870.0, 5932.851678708067, 5937.0, 5947.37552556984, 5981.431763982415, 5435.42927992563, 5649.858753531113, 5666.34836993751, 5674.546036317085, 5676.035074037423, 5061.164907790247, 5078.4413714491375, 5115.974420127875, 5131.79472821083, 5149.716765577854, 6077.878442431215, 6180.66006369645, 6185.134081228632, 6191.288001879751, 6201.503879689614, 5621.55027597783, 5726.914096288476, 5875.3243377012195, 5907.556933230111, 5920.348761636131, 5913.526917846476, 6035.155078289131, 6053.848653783691, 6055.424734650377, 6089.51283897296, 5743.8851222976145, 5745.253117094918, 5746.252987111816, 5750.8849823002465, 5751.223584816164, 5602.579806514446, 5702.714864256687, 5773.393793651606, 5825.097109947796, 5828.213191219301, 5674.4892959633835, 5694.231278777478, 5703.973284808774, 5704.201411802268, 5722.7710891563875, 5719.914201287067, 5725.34158571753, 5738.0, 5744.454276843693, 5757.481826635623, 5430.13117901134, 5578.3584887738425, 5618.904313658797, 5632.831015069554, 5756.68338241384, 5780.566457515787, 5822.73797679097, 5828.475437210502, 5872.765089396547, 5877.0, 5724.885502289848, 5732.885342293214, 5744.569157313302, 5752.7698892043845, 5759.51044161251], "mootools.html": [1490.4112875414205, 1688.9915550422247, 1730.30787684926, 1757.9384721534748, 1767.2577517442674, 7021.964890175542, 7089.610071446068, 7094.751683691072, 7217.06178196835, 7285.490015698903, 7061.293870612936, 7175.390091842187, 7200.38796702281, 7223.530470519412, 7283.708651653941, 2191.8904054797235, 2227.220472834503, 2231.0518029837335, 2233.02863254484, 2233.530958498717, 2198.1427243375015, 2203.7575866654656, 2206.5366273082673, 2207.4040009197506, 2217.7116974793253, 2139.81811546018, 2145.9034343454505, 2160.4490854832075, 2167.2739632223224, 2186.1146235774536, 2102.096098677568, 2162.945926351846, 2213.1258153029626, 2218.589560931217, 2220.733511978565, 2201.9889900550556, 2202.559488102386, 2209.7569267380577, 2221.0, 2244.1584405847807, 7012.158540975116, 7053.506254562183, 7149.0, 7204.0, 7211.242819503981, 4314.525402205755, 4340.804663790137, 4366.978165109186, 4377.868663940087, 4387.846425375096, 2868.54103343464, 2885.1200383882906, 2888.653361596622, 2935.9724096566033, 2949.9852500737575, 867.9045305016443, 875.2604049578097, 891.5007595746403, 921.6681994482049, 926.8980412154658, 9413.529323533865, 9447.763805904839, 9455.810883782286, 9473.573689184002, 9487.762805929908, 3884.747491413049, 3895.337792575269, 4024.859129930497, 4068.044009657728, 4078.8164532596106, 7806.68773249075, 7912.248336408032, 7914.169012253746, 7919.049714034353, 7920.128785833554, 4257.40396344512, 4267.381229721673, 4271.658267338606, 4281.486221653359, 4305.698601097955, 3884.9223015539533, 3887.3974533947285, 3898.863539776094, 3904.707146963989, 3918.549366822795, 3194.348690586807, 3236.401265765841, 3257.7393808495262, 3265.4775235962134, 3266.510023496447, 1006.0291818395284, 1037.2790910317258, 1051.0750539525322, 1052.231870734353, 1053.4100903494068, 1022.2895087913829, 1025.43601019439, 1059.89930956559, 1162.6686394377562, 1309.8100775387516, 6571.112899758567, 6599.109120268702, 6728.327167283331, 6796.694148763318, 6815.829604259933, 979.0992287095889, 990.4008075114596, 995.2386424385351, 995.8605795188679, 1000.7448100734266, 5421.756020979065, 5468.781248750085, 5475.780968761284, 5476.890462190734, 5494.5054945055135, 8299.377546684023, 8323.625436855356, 8497.872531912026, 8511.404201705822, 8570.0, 8224.753257402288, 8382.958085209657, 8470.449420787629, 8475.618597163142, 8512.319014478826, 6717.798466046026, 6730.764423245163, 6744.494162937799, 6831.487638427137, 6832.350926661959, 6077.6353418795015, 6357.268914074941, 6424.871502570016, 6488.091667166695, 6511.186101737283, 7412.444066694911, 7531.736389226351, 7636.389088872766, 7648.808779780327, 7673.923260767321, 7442.553446793209, 7683.385329173541, 7738.071431428265, 7756.3019328260725, 7792.61036948139, 5982.252218472691, 6160.907586386118, 6163.691815409301, 6177.4749146321265, 6178.073289006685, 6829.282925292773, 6879.140107486564, 6890.276520965226, 6910.689018994057, 6911.5853048817235, 6395.1046853441485, 6407.679616019273, 6435.710393032231, 6448.387403196689, 6593.538452308292, 6224.844378890564, 6364.109024736448, 6419.550631455753, 6438.356164383524, 6444.258910225384, 6476.060971159061, 6516.804495865132, 6527.11883895687, 6542.967285163544, 6565.868682626417, 5988.730507127103, 5993.640381577119, 6010.429009244115, 6038.184845045863, 6117.235345581802, 5989.071693887455, 6054.212952316171, 6072.757089716361, 6106.72519736604, 6113.327533971348], "ext.html": [560.540356907336, 562.6820846221884, 572.7995201679412, 583.7664934026392, 602.6986506746624, 40921.0, 42274.78862605686, 42276.36585451221, 42323.365149522746, 42367.78816105923, 43639.0, 43792.343114853225, 43951.560484395144, 44488.777556112254, 44549.331760023626, 8618.353623478217, 8716.694915677952, 8861.246794022516, 8868.645254189825, 8916.910830891706, 8404.20160084791, 8455.53494557799, 8494.0, 8627.698030568932, 8678.218960293572, 8411.411201215917, 8662.090480499552, 8707.869381959275, 8728.301735861147, 8738.432001919886, 8662.220400163984, 8724.258438032743, 8726.083761205045, 8810.030896601369, 8811.162939520735, 8644.783880402978, 8777.0, 8778.253848422892, 8810.118988101203, 8812.471251724917, 40917.18165636701, 41332.0, 41362.75911722653, 41854.0, 41857.37213941793, 2709.7290270972944, 3111.1444352802932, 3131.8434078296223, 3245.8052516849066, 3374.0552645259368, 29698.10905672833, 29789.255268618243, 29840.253993650116, 30118.698813011808, 30449.391012179854, 3313.5858017747782, 3318.5188147718445, 3334.0, 3404.3191361727754, 3405.9489107663403, 249267.0, 251061.0, 251164.0, 251716.0, 252484.0, 41996.79001604972, 58168.41831581714, 58500.41499585035, 58569.41430585725, 58645.70677146672, 41757.37363939543, 41793.58206417958, 41977.0, 42323.57676423258, 42692.78653606712, 12585.0, 12837.293948832903, 12960.740785184244, 12961.092723509264, 12972.935135324264, 8992.280617550581, 9065.909340906506, 9151.725448236564, 9159.954200228956, 9237.399569027992, 14369.353379097965, 14403.423863045571, 14444.494442694455, 14449.566513004627, 14517.491887783877, 5804.709764511757, 5855.209546711139, 5866.5893387462465, 5949.899268635317, 5960.5231581474245, 826.3636999510344, 871.877937088808, 886.1758564534915, 911.683180142027, 1003.0170035736865, 28974.565381519293, 29002.854985724935, 29144.854275728485, 29576.852115739282, 29594.852025740165, 957.9568919398644, 977.1059480575194, 985.5466485416789, 1020.1787561013307, 1062.3254233561745, 15822.841771582367, 15908.284127214303, 16447.753283700753, 16521.6695666086, 17209.65580688379, 281447.0, 286307.0, 287312.0, 290598.0, 290683.0, 57312.42687573071, 58609.41390586125, 58793.41206587965, 58795.41204587899, 58803.117953230736, 1284.6659868434274, 1295.6760809797552, 1302.0820321673386, 1311.8688131186805, 1318.8813006829432, 29808.85095574508, 30654.386912261183, 30891.845540772152, 31310.37379252448, 31382.68617313889, 47190.76404617955, 47221.76389118032, 47895.281570777166, 48093.75953120212, 48138.518614814806, 293177.0, 296508.0, 298072.0, 298111.0, 300606.0, 33555.65777368878, 43582.0, 43609.34585981276, 44172.55827441813, 44650.55349446464, 41057.38413923853, 41497.37753933633, 42698.57301426946, 45358.773206135076, 46722.53277467318, 36833.0, 37379.252414951006, 37747.43378849374, 42091.0, 42495.15009699727, 39168.216635666555, 41133.382999254434, 42158.0, 42279.0, 42464.36303455389, 37346.253074937806, 37613.81193094017, 38379.808100959315, 38403.42394864135, 38490.0377490565, 33340.33319333648, 34528.654713452546, 34739.0, 34761.65238347685, 34908.65091349054, 25434.109806156695, 26787.732122678524, 26834.731652683222, 26896.193114206606, 27265.454690906467], "prototype.html": [308.82860012692953, 312.6998081841432, 315.39129480103406, 316.10069352691596, 319.0190165241882, 5875.206847075643, 5904.940950590498, 6010.8797824043495, 6035.969820150893, 6068.6055406398555, 5914.674692891889, 5929.169916211734, 5942.049272116462, 5975.850603734909, 5994.7002649867445, 4466.5980061794435, 4468.374427580134, 4507.932381014288, 4510.165619360412, 4521.660875434339, 4450.332450132473, 4502.8874278142985, 4511.323301504768, 4512.300593408027, 4532.9320060199125, 4436.378906953029, 4484.8206071757095, 4494.775261236941, 4553.635709143277, 4560.247559152735, 4534.206513860077, 4536.523665015159, 4537.296719008559, 4544.750038747868, 4551.45382554094, 3881.068543549556, 3909.530856297234, 3914.080191155105, 3926.70549708773, 3927.214557088565, 5738.741756620962, 5741.971290143564, 5755.251817263771, 5755.856103597402, 5761.48146666802, 5143.434222235551, 5220.29526013987, 5243.397009343936, 5249.632525723201, 5255.106631872591, 6259.186305780265, 6264.87470250597, 6267.592606480564, 6276.403741644536, 6305.3379395163765, 4327.653787696977, 4357.956420435787, 4358.5205627380965, 4361.542038086019, 4390.780460976938, 6501.609903405763, 6561.3438656134485, 6614.570052946543, 6634.038064480672, 6645.60126392418, 4381.364702118175, 4383.561643835591, 4391.275439552502, 4419.071994881111, 4471.217536931024, 4436.645068394585, 4444.755538445416, 4449.221386257392, 4450.531324662854, 4451.666125040635, 5141.3830340358645, 5144.099782538041, 5144.30551875492, 5191.402988656278, 5253.159494480941, 6304.464120549805, 6430.549861509649, 6434.292227854932, 6454.548181627335, 6464.806055818333, 1556.2685537797443, 1610.066161626254, 1614.685136398391, 1614.8546630803048, 1617.3368918743258, 1001.3541265883464, 1029.0789743179812, 1033.5968972100886, 1033.963811266602, 1041.9739506512246, 6096.451319381277, 6113.388661133851, 6134.8159555213415, 6191.845203869849, 6192.783252586138, 6495.967520162369, 6502.869942601122, 6506.577072490273, 6534.7386104556235, 6562.967185164139, 6037.426444487766, 6063.090536419572, 6168.228971378578, 6170.259568851767, 6191.040388739752, 3586.4082426399873, 3658.3963645998642, 3662.1943172502006, 3673.6142705015586, 3675.209829886587, 6841.93158068413, 6857.074294970215, 6869.553479023847, 6875.724971001204, 6911.550749201286, 6847.246802851682, 6851.2806155353965, 6858.759943401957, 6871.587704737632, 6896.862062758717, 6733.764318248838, 6875.828104297332, 6877.312268773083, 6893.20728116273, 6908.343707347693, 6547.279799221987, 6606.240282367397, 6607.47140228771, 6625.602463852184, 6630.5027122965, 6366.29970703213, 6545.607263564201, 6582.703778330082, 6588.308227636221, 6588.538802283986, 6874.793756187322, 6909.7581584644295, 6935.3411425914455, 6940.340667636567, 7011.684474198775, 4350.521442641244, 4358.694891357574, 4369.388285640077, 4391.5388884166705, 4404.625606823456, 6531.542792004514, 6643.56816806906, 6664.233613134552, 6667.53327267106, 6691.464682825265, 6381.776637817654, 6445.742170313322, 6477.060826180272, 6502.707378167899, 6510.44661203803, 6371.649559274284, 6395.264544577433, 6403.4877209824035, 6469.676516174079, 6471.514636402195, 6153.66154861469, 6277.0, 6293.213348331458, 6297.338779428277, 6324.367563243823, 6449.355064493513, 6493.383128602775, 6523.282438931808, 6542.54202205841, 6545.21457425112, 6232.8130156095385, 6356.745730170926, 6362.745490180341, 6364.140840986408, 6378.043293506012], "yui.html": [755.6070843161556, 757.6287619066659, 788.5623478969171, 823.3989187892838, 864.8270345930815, 13419.597412077641, 14006.159630422182, 14062.4375024999, 15396.0, 15634.687306253869, 14086.366113524891, 14118.08232464889, 14187.0, 14201.289935503235, 14236.074655147435, 804.7786858613899, 807.6930766308794, 812.6708682983401, 813.6826637611337, 827.9296259817922, 823.2014945502882, 827.0571548434759, 829.6598394658191, 832.6627715775121, 836.6820608168887, 832.2800777327599, 859.5659192107977, 870.6299822575412, 872.4459967920353, 873.1792115411524, 843.5866425451546, 856.9014563325204, 857.3569822633025, 860.0281681699639, 862.965481380744, 628.3151365012159, 629.5781826176427, 631.198378059866, 631.3150231998287, 634.6065439427584, 13411.329433528284, 13664.043516953818, 13715.725685486334, 13829.0, 13840.169589824542, 10184.439855807928, 10502.78994420115, 10741.677749667522, 10800.081993030602, 11051.834222486668, 9406.764830879214, 9450.33847630666, 9591.520423978773, 9680.612775488971, 10103.141232995204, 3173.1115287719476, 3177.7140057394945, 3212.3093534889877, 3232.143481977278, 3283.3925723740945, 47789.5221047792, 48427.27359089616, 48461.75769121132, 48688.26967595489, 48723.75638121822, 7326.633668316669, 7392.1499027611435, 7395.519291246052, 7445.813854653677, 7462.962685186648, 11823.586174483851, 11893.821592676117, 12002.099842511672, 12216.877831221575, 12219.083568732382, 6323.241211054703, 6421.967890160519, 6435.742570297136, 6491.318411566812, 6578.0, 3972.3644216925154, 3974.955596789029, 4034.7542223593296, 4043.4945631796027, 4053.9797301013305, 2647.8940842366474, 2686.194141757504, 2688.0994866719475, 2691.905783297575, 2702.2028501592076, 414.34119749598284, 419.5741322557607, 420.6487582868278, 430.53932292447405, 431.8596456151763, 525.4561528817655, 566.498648695907, 617.2038070888503, 631.5137344244997, 637.0698779781478, 8731.170538798804, 8976.102389760972, 9028.909710902806, 9509.619615215452, 9767.0, 551.4387403040382, 569.2116418759964, 607.9270487541435, 642.1010585180784, 669.9162604674416, 3910.2570511602703, 4018.3570628699854, 4130.442390277334, 4131.215069136854, 4218.578142185757, 57668.42331576715, 58165.41834581685, 58295.125573116435, 58585.0, 58623.41376586265, 51977.7401112992, 52570.0, 52615.0, 53136.202956955676, 53154.0, 45884.0, 46154.76922615433, 46509.30236046462, 47039.5296047042, 47473.76263118732, 7802.102758182881, 8031.477953932976, 8069.757907262791, 8079.1516890725625, 8349.95825020871, 33252.83373583214, 34685.306293874484, 34706.0, 34823.0, 35239.64760352466, 40750.0, 40831.59168408278, 43390.0, 44523.0, 44623.55376446194, 7342.045534080536, 7443.255674432514, 7455.888161677688, 7605.771826845204, 7639.312461878458, 11810.822837657613, 12107.636770896886, 12365.258084514959, 12375.0, 12673.049521286124, 11518.596849110576, 11824.23142495735, 11938.164328496921, 12195.695107622381, 12232.816507752214, 11070.114390848874, 11386.772264554827, 11450.427478626201, 11849.0, 11854.0, 9679.516024198621, 9836.60653573849, 11770.52917883275, 11790.23363481371, 11965.461554230254, 9513.95763215194, 9569.3779904306, 9588.520573971413, 9871.950640246752, 9891.109800118023, 9204.815903682023, 9371.859422108537, 9557.378770379903, 9662.549878394126, 10192.592296308065]}, "summary": {"lowerIsBetter": false, "suite": 6547.868729262095, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6825.027693041021, "unit": "ms", "value": 6825.027693041021}, "dojo.html": {"lowerIsBetter": false, "filtered": 5391.817277376852, "unit": "ms", "value": 5391.817277376852}, "mootools.html": {"lowerIsBetter": false, "filtered": 4152.372576072349, "unit": "ms", "value": 4152.372576072349}, "ext.html": {"lowerIsBetter": false, "filtered": 18054.68810271278, "unit": "ms", "value": 18054.68810271278}, "prototype.html": {"lowerIsBetter": false, "filtered": 4778.984696632804, "unit": "ms", "value": 4778.984696632804}, "yui.html": {"lowerIsBetter": false, "filtered": 5977.228606670123, "unit": "ms", "value": 5977.228606670123}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-014.e"}, "testrun": {"date": 1447218524, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151110193458", "branch": "Mozilla-Inbound", "revision": "42359222aacee1512a68e70a92ff2fc5b4c00467"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 161.0, 161.0, 163.0, 163.0, 160.0, 160.0, 166.0, 172.0, 163.0], "ai-astar": [114.0, 108.0, 112.0, 111.0, 110.0, 121.0, 122.0, 111.0, 111.0, 112.0], "imaging-gaussian-blur": [111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 112.0], "audio-beat-detection": [157.0, 126.0, 150.0, 163.0, 125.0, 148.0, 148.0, 140.0, 170.0, 125.0], "json-stringify-tinderbox": [68.0, 68.0, 67.0, 67.0, 68.0, 66.0, 68.0, 67.0, 66.0, 67.0], "stanford-crypto-pbkdf2": [139.0, 152.0, 140.0, 147.0, 150.0, 139.0, 150.0, 146.0, 147.0, 148.0], "json-parse-financial": [62.0, 62.0, 62.0, 61.0, 62.0, 64.0, 62.0, 59.0, 58.0, 61.0], "stanford-crypto-sha256-iterative": [69.0, 67.0, 67.0, 69.0, 67.0, 66.0, 68.0, 67.0, 69.0, 65.0], "audio-fft": [72.0, 71.0, 71.0, 72.0, 83.0, 71.0, 145.0, 75.0, 73.0, 87.0], "imaging-darkroom": [148.0, 148.0, 148.0, 149.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0], "stanford-crypto-ccm": [118.0, 127.0, 127.0, 117.0, 121.0, 119.0, 118.0, 121.0, 130.0, 123.0], "audio-oscillator": [89.0, 92.0, 136.0, 91.0, 91.0, 92.0, 137.0, 92.0, 91.0, 135.0], "stanford-crypto-aes": [85.0, 87.0, 93.0, 86.0, 87.0, 86.0, 99.0, 86.0, 90.0, 86.0], "imaging-desaturate": [97.0, 97.0, 97.0, 96.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1514.9999999999998, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 82.0, "unit": "ms", "value": 82.0}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 145.8, "unit": "ms", "value": 145.8}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.2, "unit": "ms", "value": 145.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 122.1, "unit": "ms", "value": 122.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.4, "unit": "ms", "value": 147.4}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 61.3, "unit": "ms", "value": 61.3}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.6, "unit": "ms", "value": 104.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 113.2, "unit": "ms", "value": 113.2}, "audio-dft": {"lowerIsBetter": true, "filtered": 163.2, "unit": "ms", "value": 163.2}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.4, "unit": "ms", "value": 67.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.2, "unit": "ms", "value": 67.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.4, "unit": "ms", "value": 110.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 88.5, "unit": "ms", "value": 88.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.7, "unit": "ms", "value": 96.7}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-014.e"}, "testrun": {"date": 1447218524, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151110193458", "branch": "Mozilla-Inbound", "revision": "42359222aacee1512a68e70a92ff2fc5b4c00467"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.28793471925394], "Encrypt": [282.08744710860367], "NavierStokes": [4830.917874396136], "Decrypt": [5040.201005025126], "Splay": [637.4603174603175], "Richards": [162.2849724115547], "RegExp": [24780.48780487805], "Earley": [722.0216606498195], "Boyer": [11686.046511627907], "RayTrace": [1060.4453870625662]}, "summary": {"lowerIsBetter": false, "suite": 21419.967271154776, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.309346, "unit": "score", "value": 340.309346}, "Encrypt": {"lowerIsBetter": false, "filtered": 943.6116450000002, "unit": "score", "value": 943.6116450000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.81158424725827, "unit": "score", "value": 52.81158424725827}, "Splay": {"lowerIsBetter": false, "filtered": 127.83697709163341, "unit": "score", "value": 127.83697709163341}, "RegExp": {"lowerIsBetter": false, "filtered": 36.7621899606299, "unit": "score", "value": 36.7621899606299}, "Richards": {"lowerIsBetter": false, "filtered": 217.53092400000003, "unit": "score", "value": 217.53092400000003}, "Earley": {"lowerIsBetter": false, "filtered": 923.0512549999999, "unit": "score", "value": 923.0512549999999}, "Boyer": {"lowerIsBetter": false, "filtered": 57.0306646766169, "unit": "score", "value": 57.0306646766169}, "RayTrace": {"lowerIsBetter": false, "filtered": 697.809627, "unit": "score", "value": 697.809627}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-014.e"}, "testrun": {"date": 1447218524, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151110193458", "branch": "Mozilla-Inbound", "revision": "42359222aacee1512a68e70a92ff2fc5b4c00467"}}] 21:28:58 INFO - RETURN: dromaeo_css: 6547.87 21:28:58 INFO - RETURN: kraken: 1515.00 21:28:58 INFO - RETURN: v8_7: 21419.97 21:28:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21419.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1515.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6547.87"}}} 21:28:58 INFO - Return code: 0 21:28:58 INFO - # TBPL SUCCESS # 21:28:58 INFO - Running post-action listener: _resource_record_post_action 21:28:58 INFO - Running post-run listener: _resource_record_post_run 21:28:59 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 10379264; Write bytes: 399691776; Read time: 3516; Write time: 375912 21:28:59 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 4648960; Read time: 0; Write time: 608 21:28:59 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8101888; Write bytes: 395042816; Read time: 3124; Write time: 375304 21:28:59 INFO - Running post-run listener: _upload_blobber_files 21:28:59 INFO - Blob upload gear active. 21:28:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:28:59 INFO - Copying logs to upload dir... 21:28:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.287722 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-11-10 21:28:59.777772) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-10 21:28:59.781509) ========= 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=01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009751 build_url: 'https://queue.taskcluster.net/v1/task/R6DEdsIBRVKC13ZqHDCEBA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-10 21:28:59.833873) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 21:28:59.834243) ========= 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=01deea79d00cc2c334834894000001d2-1447215971.945864-1609166391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 21:28:59.884504) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-10 21:28:59.884888) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-10 21:28:59.885251) ========= ========= Total master_lag: 0.20 =========