builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1450763609.08 results: success (0) buildid: 20151221193326 builduid: d76670e503ee462a86dbe4dec1f9a5fb revision: 6432606228940213ff615cb381597e96ff227483 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:29.083604) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:29.084126) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:29.084443) ========= 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=7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006387 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:29.128613) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:29.129015) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:29.200223) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:29.203724) ========= 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=7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018952 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:29.269147) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:29.272523) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:29.273006) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:29.273291) ========= 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=7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 21:53:29-- 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% 46.6M=0s 2015-12-21 21:53:29 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:29.469223) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:29.469566) ========= 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=7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.105007 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:29.587254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:29.590802) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6432606228940213ff615cb381597e96ff227483 --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 6432606228940213ff615cb381597e96ff227483 --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=7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 21:53:30,010 truncating revision to first 12 chars 2015-12-21 21:53:30,011 Setting DEBUG logging. 2015-12-21 21:53:30,011 attempt 1/10 2015-12-21 21:53:30,011 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/643260622894?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 21:53:30,251 unpacking tar archive at: mozilla-inbound-643260622894/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542231 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:30.149721) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:30.150165) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:30.164986) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:30.165629) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:30.166411) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-21 21:53:30.166936) ========= /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=7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:53:30 INFO - MultiFileLogger online at 20151221 21:53:30 in /builds/slave/test-pgo 21:53:30 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:53:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:53:30 INFO - {'append_to_log': False, 21:53:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:53:30 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:53:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:53:30 INFO - 'branch': 'Mozilla-Inbound', 21:53:30 INFO - 'buildbot_json_path': 'buildprops.json', 21:53:30 INFO - 'config_files': ('talos/linux_config.py',), 21:53:30 INFO - 'default_actions': ('clobber', 21:53:30 INFO - 'read-buildbot-config', 21:53:30 INFO - 'download-and-extract', 21:53:30 INFO - 'populate-webroot', 21:53:30 INFO - 'create-virtualenv', 21:53:30 INFO - 'install', 21:53:30 INFO - 'run-tests'), 21:53:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:53:30 INFO - 'download_minidump_stackwalk': True, 21:53:30 INFO - 'download_symbols': 'ondemand', 21:53:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:53:30 INFO - 'tooltool.py': '/tools/tooltool.py', 21:53:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:53:30 INFO - '/tools/misc-python/virtualenv.py')}, 21:53:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:53:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:53:30 INFO - 'installer_path': 'installer.exe', 21:53:30 INFO - 'log_level': 'info', 21:53:30 INFO - 'log_name': 'talos', 21:53:30 INFO - 'log_to_console': True, 21:53:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:53:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:53:30 INFO - 'opt_config_files': (), 21:53:30 INFO - 'pip_index': False, 21:53:30 INFO - 'sps_profile': False, 21:53:30 INFO - 'sps_profile_interval': 0, 21:53:30 INFO - 'suite': 'dromaeojs-e10s', 21:53:30 INFO - 'system_bits': '64', 21:53:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:53:30 INFO - 'title': 'talos-linux64-ix-008', 21:53:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:53:30 INFO - 'use_talos_json': True, 21:53:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:53:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:53:30 INFO - 'work_dir': 'build'} 21:53:30 INFO - ##### 21:53:30 INFO - ##### Running clobber step. 21:53:30 INFO - ##### 21:53:30 INFO - Running pre-action listener: _resource_record_pre_action 21:53:30 INFO - Running main action method: clobber 21:53:30 INFO - rmtree: /builds/slave/test-pgo/build 21:53:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:53:31 INFO - Running post-action listener: _resource_record_post_action 21:53:31 INFO - ##### 21:53:31 INFO - ##### Running read-buildbot-config step. 21:53:31 INFO - ##### 21:53:31 INFO - Running pre-action listener: _resource_record_pre_action 21:53:31 INFO - Running main action method: read_buildbot_config 21:53:31 INFO - Using buildbot properties: 21:53:31 INFO - { 21:53:31 INFO - "project": "", 21:53:31 INFO - "product": "firefox", 21:53:31 INFO - "script_repo_revision": "production", 21:53:31 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 21:53:31 INFO - "repository": "", 21:53:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 21:53:31 INFO - "buildid": "20151221193326", 21:53:31 INFO - "pgo_build": "True", 21:53:31 INFO - "basedir": "/builds/slave/test-pgo", 21:53:31 INFO - "buildnumber": 261, 21:53:31 INFO - "slavename": "talos-linux64-ix-008", 21:53:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:53:31 INFO - "platform": "ubuntu64_hw", 21:53:31 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:53:31 INFO - "branch": "mozilla-inbound", 21:53:31 INFO - "repo_path": "integration/mozilla-inbound", 21:53:31 INFO - "revision": "6432606228940213ff615cb381597e96ff227483", 21:53:31 INFO - "stage_platform": "linux64-pgo", 21:53:31 INFO - "builduid": "d76670e503ee462a86dbe4dec1f9a5fb", 21:53:31 INFO - "slavebuilddir": "test" 21:53:31 INFO - } 21:53:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:53:31 INFO - Running post-action listener: _resource_record_post_action 21:53:31 INFO - ##### 21:53:31 INFO - ##### Running download-and-extract step. 21:53:31 INFO - ##### 21:53:31 INFO - Running pre-action listener: _resource_record_pre_action 21:53:31 INFO - Running main action method: download_and_extract 21:53:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:53:31 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:53:31 INFO - https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:53:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/test_packages.json 21:53:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/test_packages.json 21:53:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:53:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:53:37 INFO - Downloaded 1302 bytes. 21:53:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:53:37 INFO - Using the following test package requirements: 21:53:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:53:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:53:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:37 INFO - u'jsshell-linux-x86_64.zip'], 21:53:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:53:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:53:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:53:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:53:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:53:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:53:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:53:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:37 INFO - https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:53:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:53:40 INFO - Downloaded 23175545 bytes. 21:53:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:53:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:53:42 INFO - Return code: 0 21:53:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:53:42 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:53:42 INFO - https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:53:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:53:43 INFO - Downloaded 23175545 bytes. 21:53:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:53:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:53:45 INFO - Return code: 0 21:53:45 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:53:45 INFO - https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:53:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:53:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:53:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:53:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:53:46 INFO - Downloaded 11132277 bytes. 21:53:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 21:53:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:53:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 21:53:46 INFO - Return code: 0 21:53:46 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:53:46 INFO - https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:53:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:53:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:53:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:53:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:53:47 INFO - Downloaded 54940200 bytes. 21:53:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:53:47 INFO - mkdir: /builds/slave/test-pgo/properties 21:53:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:53:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:53:47 INFO - Contents: 21:53:47 INFO - build_url:https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:53:47 INFO - Running post-action listener: _resource_record_post_action 21:53:47 INFO - Running post-action listener: set_extra_try_arguments 21:53:47 INFO - ##### 21:53:47 INFO - ##### Running populate-webroot step. 21:53:47 INFO - ##### 21:53:47 INFO - Running pre-action listener: _resource_record_pre_action 21:53:47 INFO - Running main action method: populate_webroot 21:53:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:53:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:53:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:53:47 INFO - '--tppagecycles', 21:53:47 INFO - '7'], 21:53:47 INFO - 'tests': ['tsvgm']}}, 21:53:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:53:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:53:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:53:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:53:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:53:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:53:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:53:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:47 INFO - 'talos_options': ['--e10s'], 21:53:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:53:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:47 INFO - 'tests': ['damp', 'tps']}, 21:53:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:47 INFO - 'talos_options': ['--e10s'], 21:53:47 INFO - 'tests': ['damp', 'tps']}, 21:53:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:53:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:53:47 INFO - 'other': {'tests': ['a11yr', 21:53:47 INFO - 'ts_paint', 21:53:47 INFO - 'tpaint', 21:53:47 INFO - 'sessionrestore', 21:53:47 INFO - 'sessionrestore_no_auto_restore']}, 21:53:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:53:47 INFO - 'tests': ['a11yr', 21:53:47 INFO - 'ts_paint', 21:53:47 INFO - 'tpaint', 21:53:47 INFO - 'sessionrestore', 21:53:47 INFO - 'sessionrestore_no_auto_restore']}, 21:53:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:53:47 INFO - 'tests': ['a11yr', 21:53:47 INFO - 'ts_paint', 21:53:47 INFO - 'tpaint', 21:53:47 INFO - 'sessionrestore', 21:53:47 INFO - 'sessionrestore_no_auto_restore']}, 21:53:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:53:47 INFO - 'tests': ['a11yr', 21:53:47 INFO - 'ts_paint', 21:53:47 INFO - 'tpaint', 21:53:47 INFO - 'sessionrestore', 21:53:47 INFO - 'sessionrestore_no_auto_restore']}, 21:53:47 INFO - 'other_l64': {'tests': ['a11yr', 21:53:47 INFO - 'ts_paint', 21:53:47 INFO - 'tpaint', 21:53:47 INFO - 'sessionrestore', 21:53:47 INFO - 'sessionrestore_no_auto_restore']}, 21:53:47 INFO - 'other_nol64': {'tests': ['a11yr', 21:53:47 INFO - 'ts_paint', 21:53:47 INFO - 'tpaint', 21:53:47 INFO - 'sessionrestore', 21:53:47 INFO - 'sessionrestore_no_auto_restore']}, 21:53:47 INFO - 'svgr': {'tests': ['tsvgx', 21:53:47 INFO - 'tsvgr_opacity', 21:53:47 INFO - 'tart', 21:53:47 INFO - 'tscrollx', 21:53:47 INFO - 'cart']}, 21:53:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:53:47 INFO - 'tests': ['tsvgx', 21:53:47 INFO - 'tsvgr_opacity', 21:53:47 INFO - 'tart', 21:53:47 INFO - 'tscrollx', 21:53:47 INFO - 'cart']}, 21:53:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:47 INFO - 'tests': ['tp5o']}, 21:53:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:47 INFO - 'talos_options': ['--e10s'], 21:53:47 INFO - 'tests': ['tp5o']}, 21:53:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:47 INFO - 'talos_options': ['--xperf_path', 21:53:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:53:47 INFO - 'tests': ['tp5n']}, 21:53:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:47 INFO - 'talos_options': ['--e10s', 21:53:47 INFO - '--xperf_path', 21:53:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:53:47 INFO - 'tests': ['tp5n']}}, 21:53:47 INFO - 'talos.zip': {'path': '', 21:53:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:53:47 INFO - Running post-action listener: _resource_record_post_action 21:53:47 INFO - ##### 21:53:47 INFO - ##### Running create-virtualenv step. 21:53:47 INFO - ##### 21:53:47 INFO - Running pre-action listener: _resource_record_pre_action 21:53:47 INFO - Running main action method: create_virtualenv 21:53:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:53:47 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:53:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:53:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:53:47 INFO - Using real prefix '/usr' 21:53:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:53:48 INFO - Installing distribute.............................................................................................................................................................................................done. 21:53:50 INFO - Installing pip.................done. 21:53:50 INFO - Return code: 0 21:53:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:50 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 0x7f73e53e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0660>, '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 0x14f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1a10>, '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': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', '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:53:50 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:53:50 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:53:50 INFO - Using env: {'DISPLAY': ':0', 21:53:50 INFO - 'HOME': '/home/cltbld', 21:53:50 INFO - 'LANG': 'en_US.UTF-8', 21:53:50 INFO - 'LANGUAGE': 'en_US:en', 21:53:50 INFO - 'LOGNAME': 'cltbld', 21:53:50 INFO - 'MAIL': '/var/mail/cltbld', 21:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:50 INFO - 'MOZ_NO_REMOTE': '1', 21:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:50 INFO - 'NO_EM_RESTART': '1', 21:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:53:50 INFO - 'PWD': '/builds/slave/test-pgo', 21:53:50 INFO - 'SHELL': '/bin/bash', 21:53:50 INFO - 'SHLVL': '1', 21:53:50 INFO - 'TERM': 'linux', 21:53:50 INFO - 'TMOUT': '86400', 21:53:50 INFO - 'USER': 'cltbld', 21:53:50 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', 21:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:50 INFO - '_': '/tools/buildbot/bin/python'} 21:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:50 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:53:50 INFO - Cleaning up... 21:53:50 INFO - Return code: 0 21:53:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:50 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 0x7f73e53e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0660>, '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 0x14f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1a10>, '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': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', '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:53:50 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:53:50 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:53:50 INFO - Using env: {'DISPLAY': ':0', 21:53:50 INFO - 'HOME': '/home/cltbld', 21:53:50 INFO - 'LANG': 'en_US.UTF-8', 21:53:50 INFO - 'LANGUAGE': 'en_US:en', 21:53:50 INFO - 'LOGNAME': 'cltbld', 21:53:50 INFO - 'MAIL': '/var/mail/cltbld', 21:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:50 INFO - 'MOZ_NO_REMOTE': '1', 21:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:50 INFO - 'NO_EM_RESTART': '1', 21:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:53:50 INFO - 'PWD': '/builds/slave/test-pgo', 21:53:50 INFO - 'SHELL': '/bin/bash', 21:53:50 INFO - 'SHLVL': '1', 21:53:50 INFO - 'TERM': 'linux', 21:53:50 INFO - 'TMOUT': '86400', 21:53:50 INFO - 'USER': 'cltbld', 21:53:50 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', 21:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:50 INFO - '_': '/tools/buildbot/bin/python'} 21:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:50 INFO - Downloading/unpacking psutil>=0.7.1 21:53:50 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:53:50 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:53:50 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:53:50 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:53:50 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:53:50 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:53:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:53:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:53:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:53:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:53:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:53:52 INFO - Installing collected packages: psutil 21:53:52 INFO - Running setup.py install for psutil 21:53:52 INFO - building 'psutil._psutil_linux' extension 21:53:52 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:53:52 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:53:52 INFO - building 'psutil._psutil_posix' extension 21:53:52 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:53:52 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:53:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:53:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:53:53 INFO - Successfully installed psutil 21:53:53 INFO - Cleaning up... 21:53:53 INFO - Return code: 0 21:53:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:53 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 0x7f73e53e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0660>, '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 0x14f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1a10>, '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': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', '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:53:53 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:53:53 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:53:53 INFO - Using env: {'DISPLAY': ':0', 21:53:53 INFO - 'HOME': '/home/cltbld', 21:53:53 INFO - 'LANG': 'en_US.UTF-8', 21:53:53 INFO - 'LANGUAGE': 'en_US:en', 21:53:53 INFO - 'LOGNAME': 'cltbld', 21:53:53 INFO - 'MAIL': '/var/mail/cltbld', 21:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:53 INFO - 'MOZ_NO_REMOTE': '1', 21:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:53 INFO - 'NO_EM_RESTART': '1', 21:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:53:53 INFO - 'PWD': '/builds/slave/test-pgo', 21:53:53 INFO - 'SHELL': '/bin/bash', 21:53:53 INFO - 'SHLVL': '1', 21:53:53 INFO - 'TERM': 'linux', 21:53:53 INFO - 'TMOUT': '86400', 21:53:53 INFO - 'USER': 'cltbld', 21:53:53 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', 21:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:53 INFO - '_': '/tools/buildbot/bin/python'} 21:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:53:53 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:53:53 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:53:53 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:53:53 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:53:53 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:53:53 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:53:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:53:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:53:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:53:55 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:53:55 INFO - Installing collected packages: mozsystemmonitor 21:53:55 INFO - Running setup.py install for mozsystemmonitor 21:53:55 INFO - Successfully installed mozsystemmonitor 21:53:55 INFO - Cleaning up... 21:53:55 INFO - Return code: 0 21:53:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:53: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:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53: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:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f73e53e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0660>, '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 0x14f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1a10>, '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': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', '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:53:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 21:53:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:53:55 INFO - Using env: {'DISPLAY': ':0', 21:53:55 INFO - 'HOME': '/home/cltbld', 21:53:55 INFO - 'LANG': 'en_US.UTF-8', 21:53:55 INFO - 'LANGUAGE': 'en_US:en', 21:53:55 INFO - 'LOGNAME': 'cltbld', 21:53:55 INFO - 'MAIL': '/var/mail/cltbld', 21:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:55 INFO - 'MOZ_NO_REMOTE': '1', 21:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:55 INFO - 'NO_EM_RESTART': '1', 21:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:53:55 INFO - 'PWD': '/builds/slave/test-pgo', 21:53:55 INFO - 'SHELL': '/bin/bash', 21:53:55 INFO - 'SHLVL': '1', 21:53:55 INFO - 'TERM': 'linux', 21:53:55 INFO - 'TMOUT': '86400', 21:53:55 INFO - 'USER': 'cltbld', 21:53:55 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', 21:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:55 INFO - '_': '/tools/buildbot/bin/python'} 21:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:55 INFO - Downloading/unpacking blobuploader==1.2.4 21:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:57 INFO - Downloading blobuploader-1.2.4.tar.gz 21:53:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:53:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:53:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:53:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:53:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:57 INFO - Downloading docopt-0.6.1.tar.gz 21:53:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:53:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:53:57 INFO - Installing collected packages: blobuploader, requests, docopt 21:53:57 INFO - Running setup.py install for blobuploader 21:53:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:53:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:53:57 INFO - Running setup.py install for requests 21:53:58 INFO - Running setup.py install for docopt 21:53:58 INFO - Successfully installed blobuploader requests docopt 21:53:58 INFO - Cleaning up... 21:53:58 INFO - Return code: 0 21:53:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:58 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 0x7f73e53e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0660>, '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 0x14f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1a10>, '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': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', '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:53:58 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:53:58 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:53:58 INFO - Using env: {'DISPLAY': ':0', 21:53:58 INFO - 'HOME': '/home/cltbld', 21:53:58 INFO - 'LANG': 'en_US.UTF-8', 21:53:58 INFO - 'LANGUAGE': 'en_US:en', 21:53:58 INFO - 'LOGNAME': 'cltbld', 21:53:58 INFO - 'MAIL': '/var/mail/cltbld', 21:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:58 INFO - 'MOZ_NO_REMOTE': '1', 21:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:58 INFO - 'NO_EM_RESTART': '1', 21:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:53:58 INFO - 'PWD': '/builds/slave/test-pgo', 21:53:58 INFO - 'SHELL': '/bin/bash', 21:53:58 INFO - 'SHLVL': '1', 21:53:58 INFO - 'TERM': 'linux', 21:53:58 INFO - 'TMOUT': '86400', 21:53:58 INFO - 'USER': 'cltbld', 21:53:58 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', 21:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:58 INFO - '_': '/tools/buildbot/bin/python'} 21:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:53:58 INFO - Running setup.py (path:/tmp/pip-akmhA3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:53:58 INFO - Running setup.py (path:/tmp/pip-NbrfKQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:53:58 INFO - Running setup.py (path:/tmp/pip-Ds7e49-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:53:58 INFO - Running setup.py (path:/tmp/pip-y49SB6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:53:58 INFO - Running setup.py (path:/tmp/pip-xnHbR7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:53:58 INFO - Running setup.py (path:/tmp/pip-OEy5wl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:53:59 INFO - Running setup.py (path:/tmp/pip-5SHryN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:53:59 INFO - Running setup.py (path:/tmp/pip-CnOZiM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:53:59 INFO - Running setup.py (path:/tmp/pip-n42Mcw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:53:59 INFO - Running setup.py (path:/tmp/pip-93QikP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:53:59 INFO - Running setup.py (path:/tmp/pip-aQiKTX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:53:59 INFO - Running setup.py (path:/tmp/pip-__opon-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:53:59 INFO - Running setup.py (path:/tmp/pip-dAhaNs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:53:59 INFO - Running setup.py (path:/tmp/pip-JqHgRC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:53:59 INFO - Running setup.py (path:/tmp/pip-HVFHO2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:53:59 INFO - Running setup.py (path:/tmp/pip-iUCmkc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:53:59 INFO - Running setup.py (path:/tmp/pip-U1IhNY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:53:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:53:59 INFO - Running setup.py install for manifestparser 21:53:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:53:59 INFO - Running setup.py install for mozcrash 21:54:00 INFO - Running setup.py install for mozdebug 21:54:00 INFO - Running setup.py install for mozdevice 21:54:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:54:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:54:00 INFO - Running setup.py install for mozfile 21:54:00 INFO - Running setup.py install for mozhttpd 21:54:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:54:00 INFO - Running setup.py install for mozinfo 21:54:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:54:00 INFO - Running setup.py install for mozInstall 21:54:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:54:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:54:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:54:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:54:00 INFO - Running setup.py install for mozleak 21:54:00 INFO - Running setup.py install for mozlog 21:54:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:54:00 INFO - Running setup.py install for moznetwork 21:54:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:54:00 INFO - Running setup.py install for mozprocess 21:54:01 INFO - Running setup.py install for mozprofile 21:54:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:54:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:54:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:54:01 INFO - Running setup.py install for mozrunner 21:54:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:54:01 INFO - Running setup.py install for mozscreenshot 21:54:01 INFO - Running setup.py install for moztest 21:54:01 INFO - Running setup.py install for mozversion 21:54:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:54:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:54:01 INFO - Cleaning up... 21:54:01 INFO - Return code: 0 21:54:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f73e53e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0660>, '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 0x14f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1a10>, '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': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', '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:54:01 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:54:01 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:54:01 INFO - Using env: {'DISPLAY': ':0', 21:54:01 INFO - 'HOME': '/home/cltbld', 21:54:01 INFO - 'LANG': 'en_US.UTF-8', 21:54:01 INFO - 'LANGUAGE': 'en_US:en', 21:54:01 INFO - 'LOGNAME': 'cltbld', 21:54:01 INFO - 'MAIL': '/var/mail/cltbld', 21:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:01 INFO - 'MOZ_NO_REMOTE': '1', 21:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:01 INFO - 'NO_EM_RESTART': '1', 21:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:01 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:01 INFO - 'SHELL': '/bin/bash', 21:54:01 INFO - 'SHLVL': '1', 21:54:01 INFO - 'TERM': 'linux', 21:54:01 INFO - 'TMOUT': '86400', 21:54:01 INFO - 'USER': 'cltbld', 21:54:01 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', 21:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:01 INFO - '_': '/tools/buildbot/bin/python'} 21:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:54:01 INFO - Running setup.py (path:/tmp/pip-sxsZM6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:54:01 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:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:54:01 INFO - Running setup.py (path:/tmp/pip-PEjLkQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:54:01 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:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:54:01 INFO - Running setup.py (path:/tmp/pip-wRgnX5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:54:02 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:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:54:02 INFO - Running setup.py (path:/tmp/pip-7dHe4b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:54:02 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:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:54:02 INFO - Running setup.py (path:/tmp/pip-IZ7K6h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:54:02 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:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:54:02 INFO - Running setup.py (path:/tmp/pip-fhvihx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:54:02 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:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:54:02 INFO - Running setup.py (path:/tmp/pip-83hzqm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:54:02 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:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:54:02 INFO - Running setup.py (path:/tmp/pip-Cu9PTr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:54:02 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:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:54:02 INFO - Running setup.py (path:/tmp/pip-PyrGSR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:54:02 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:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:54:02 INFO - Running setup.py (path:/tmp/pip-P0Ms2K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:54:02 INFO - Running setup.py (path:/tmp/pip-AVzl2U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:54:02 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:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:54:02 INFO - Running setup.py (path:/tmp/pip-ZbsSfy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:54:02 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:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:54:02 INFO - Running setup.py (path:/tmp/pip-6YV7_B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:54:02 INFO - Running setup.py (path:/tmp/pip-8SaLTJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:54:02 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:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:54:02 INFO - Running setup.py (path:/tmp/pip-vHNorG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:54:02 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:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:54:02 INFO - Running setup.py (path:/tmp/pip-wwDvVQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:54:02 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:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:54:02 INFO - Running setup.py (path:/tmp/pip-W9AXba-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:54:03 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:54:03 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:54:03 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:54:03 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:54:03 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:54:03 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:54:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:04 INFO - Downloading blessings-1.5.1.tar.gz 21:54:04 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:54:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:54:04 INFO - Installing collected packages: blessings 21:54:04 INFO - Running setup.py install for blessings 21:54:04 INFO - Successfully installed blessings 21:54:04 INFO - Cleaning up... 21:54:04 INFO - Return code: 0 21:54:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:54:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:54:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:54:05 INFO - Reading from file tmpfile_stdout 21:54:05 INFO - Current package versions: 21:54:05 INFO - argparse == 1.2.1 21:54:05 INFO - blessings == 1.5.1 21:54:05 INFO - blobuploader == 1.2.4 21:54:05 INFO - docopt == 0.6.1 21:54:05 INFO - manifestparser == 1.1 21:54:05 INFO - mozInstall == 1.12 21:54:05 INFO - mozcrash == 0.16 21:54:05 INFO - mozdebug == 0.1 21:54:05 INFO - mozdevice == 0.47 21:54:05 INFO - mozfile == 1.2 21:54:05 INFO - mozhttpd == 0.7 21:54:05 INFO - mozinfo == 0.9 21:54:05 INFO - mozleak == 0.1 21:54:05 INFO - mozlog == 3.1 21:54:05 INFO - moznetwork == 0.27 21:54:05 INFO - mozprocess == 0.22 21:54:05 INFO - mozprofile == 0.28 21:54:05 INFO - mozrunner == 6.11 21:54:05 INFO - mozscreenshot == 0.1 21:54:05 INFO - mozsystemmonitor == 0.0 21:54:05 INFO - moztest == 0.7 21:54:05 INFO - mozversion == 1.4 21:54:05 INFO - psutil == 3.1.1 21:54:05 INFO - requests == 1.2.3 21:54:05 INFO - wsgiref == 0.1.2 21:54:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:54: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:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54: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:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:05 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 0x7f73e53e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0660>, '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 0x14f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1a10>, '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': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', '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:54:05 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:54:05 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:54:05 INFO - Using env: {'DISPLAY': ':0', 21:54:05 INFO - 'HOME': '/home/cltbld', 21:54:05 INFO - 'LANG': 'en_US.UTF-8', 21:54:05 INFO - 'LANGUAGE': 'en_US:en', 21:54:05 INFO - 'LOGNAME': 'cltbld', 21:54:05 INFO - 'MAIL': '/var/mail/cltbld', 21:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:05 INFO - 'MOZ_NO_REMOTE': '1', 21:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:05 INFO - 'NO_EM_RESTART': '1', 21:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:05 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:05 INFO - 'SHELL': '/bin/bash', 21:54:05 INFO - 'SHLVL': '1', 21:54:05 INFO - 'TERM': 'linux', 21:54:05 INFO - 'TMOUT': '86400', 21:54:05 INFO - 'USER': 'cltbld', 21:54:05 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', 21:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:05 INFO - '_': '/tools/buildbot/bin/python'} 21:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 21:54:05 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 2)) 21:54:05 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 3)) 21:54:05 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 4)) 21:54:05 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 5)) 21:54:05 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 6)) 21:54:05 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 7)) 21:54:05 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 8)) 21:54:05 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 9)) 21:54:05 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 21:54:05 INFO - Cleaning up... 21:54:05 INFO - Return code: 0 21:54:05 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:54: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:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54: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:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:05 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73e53e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0660>, '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 0x14f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1a10>, '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': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', '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:54:05 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', 'jsonschema'] in /builds/slave/test-pgo/build 21:54:05 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 jsonschema 21:54:05 INFO - Using env: {'DISPLAY': ':0', 21:54:05 INFO - 'HOME': '/home/cltbld', 21:54:05 INFO - 'LANG': 'en_US.UTF-8', 21:54:05 INFO - 'LANGUAGE': 'en_US:en', 21:54:05 INFO - 'LOGNAME': 'cltbld', 21:54:05 INFO - 'MAIL': '/var/mail/cltbld', 21:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:05 INFO - 'MOZ_NO_REMOTE': '1', 21:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:05 INFO - 'NO_EM_RESTART': '1', 21:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:05 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:05 INFO - 'SHELL': '/bin/bash', 21:54:05 INFO - 'SHLVL': '1', 21:54:05 INFO - 'TERM': 'linux', 21:54:05 INFO - 'TMOUT': '86400', 21:54:05 INFO - 'USER': 'cltbld', 21:54:05 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', 21:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:05 INFO - '_': '/tools/buildbot/bin/python'} 21:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:05 INFO - Downloading/unpacking jsonschema 21:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:54:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 21:54:07 INFO - Downloading/unpacking functools32 (from jsonschema) 21:54:07 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:54:07 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:54:07 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:54:07 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:54:07 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:54:07 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:54:07 INFO - Downloading functools32-3.2.3-2.tar.gz 21:54:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:54:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:54:07 INFO - warning: no files found matching '*.txt' 21:54:07 INFO - no previously-included directories found matching 'build' 21:54:07 INFO - no previously-included directories found matching 'dist' 21:54:07 INFO - no previously-included directories found matching '.git*' 21:54:07 INFO - Installing collected packages: jsonschema, functools32 21:54:07 INFO - Running setup.py install for functools32 21:54:07 INFO - warning: no files found matching '*.txt' 21:54:07 INFO - no previously-included directories found matching 'build' 21:54:07 INFO - no previously-included directories found matching 'dist' 21:54:07 INFO - no previously-included directories found matching '.git*' 21:54:07 INFO - Successfully installed jsonschema functools32 21:54:07 INFO - Cleaning up... 21:54:07 INFO - Return code: 0 21:54:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73e53e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0660>, '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 0x14f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1a10>, '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': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', '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:54:07 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', 'flake8'] in /builds/slave/test-pgo/build 21:54:07 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 flake8 21:54:07 INFO - Using env: {'DISPLAY': ':0', 21:54:07 INFO - 'HOME': '/home/cltbld', 21:54:07 INFO - 'LANG': 'en_US.UTF-8', 21:54:07 INFO - 'LANGUAGE': 'en_US:en', 21:54:07 INFO - 'LOGNAME': 'cltbld', 21:54:07 INFO - 'MAIL': '/var/mail/cltbld', 21:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:07 INFO - 'MOZ_NO_REMOTE': '1', 21:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:07 INFO - 'NO_EM_RESTART': '1', 21:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:07 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:07 INFO - 'SHELL': '/bin/bash', 21:54:07 INFO - 'SHLVL': '1', 21:54:07 INFO - 'TERM': 'linux', 21:54:07 INFO - 'TMOUT': '86400', 21:54:07 INFO - 'USER': 'cltbld', 21:54:07 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', 21:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:07 INFO - '_': '/tools/buildbot/bin/python'} 21:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:07 INFO - Downloading/unpacking flake8 21:54:07 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:54:07 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:54:07 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:54:07 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:54:07 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:54:07 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:54:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:54:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 21:54:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:54:09 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:54:09 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:54:09 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:54:09 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:54:09 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:54:09 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:54:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:54:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 21:54:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:54:09 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:54:09 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:54:09 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:54:09 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:54:09 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:54:09 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:54:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 21:54:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:54:10 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:54:10 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:54:10 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:54:10 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:54:10 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:54:10 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:54:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:54:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:54:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:54:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:54:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:54:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:54:10 INFO - no previously-included directories found matching 'docs/_build' 21:54:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:54:10 INFO - Running setup.py install for pep8 21:54:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:54:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:54:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:54:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:54:10 INFO - no previously-included directories found matching 'docs/_build' 21:54:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:54:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:54:10 INFO - Cleaning up... 21:54:10 INFO - Return code: 0 21:54:10 INFO - Running post-action listener: _resource_record_post_action 21:54:10 INFO - Running post-action listener: _start_resource_monitoring 21:54:10 INFO - Starting resource monitoring. 21:54:10 INFO - ##### 21:54:10 INFO - ##### Running install step. 21:54:10 INFO - ##### 21:54:10 INFO - Running pre-action listener: _resource_record_pre_action 21:54:10 INFO - Running main action method: install 21:54:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:54:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:54:10 INFO - Reading from file tmpfile_stdout 21:54:10 INFO - Detecting whether we're running mozinstall >=1.0... 21:54:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:54:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:54:10 INFO - Reading from file tmpfile_stdout 21:54:10 INFO - Output received: 21:54:10 INFO - Usage: mozinstall [options] installer 21:54:10 INFO - Options: 21:54:10 INFO - -h, --help show this help message and exit 21:54:10 INFO - -d DEST, --destination=DEST 21:54:10 INFO - Directory to install application into. [default: 21:54:10 INFO - "/builds/slave/test-pgo"] 21:54:10 INFO - --app=APP Application being installed. [default: firefox] 21:54:10 INFO - mkdir: /builds/slave/test-pgo/build/application 21:54:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 21:54:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 21:54:26 INFO - Reading from file tmpfile_stdout 21:54:26 INFO - Output received: 21:54:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:54:26 INFO - Running post-action listener: _resource_record_post_action 21:54:26 INFO - ##### 21:54:26 INFO - ##### Running run-tests step. 21:54:26 INFO - ##### 21:54:26 INFO - Running pre-action listener: _resource_record_pre_action 21:54:26 INFO - Running main action method: run_tests 21:54:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:54:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:54:26 INFO - Python 2.7.3 21:54:26 INFO - Return code: 0 21:54:26 INFO - grabbing minidump binary from tooltool 21:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:26 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 0x14f0660>, '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 0x14f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:54:26 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:54:26 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:54:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:54:26 INFO - Return code: 0 21:54:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:54:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:54:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:54:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:54:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:54:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:54:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:54:27 INFO - Return code: 0 21:54:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 21:54:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:54:27 INFO - Using env: {'DISPLAY': ':0', 21:54:27 INFO - 'HOME': '/home/cltbld', 21:54:27 INFO - 'LANG': 'en_US.UTF-8', 21:54:27 INFO - 'LANGUAGE': 'en_US:en', 21:54:27 INFO - 'LOGNAME': 'cltbld', 21:54:27 INFO - 'MAIL': '/var/mail/cltbld', 21:54:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:54:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:27 INFO - 'MOZ_NO_REMOTE': '1', 21:54:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:27 INFO - 'NO_EM_RESTART': '1', 21:54:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:27 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:54:27 INFO - 'SHELL': '/bin/bash', 21:54:27 INFO - 'SHLVL': '1', 21:54:27 INFO - 'TERM': 'linux', 21:54:27 INFO - 'TMOUT': '86400', 21:54:27 INFO - 'USER': 'cltbld', 21:54:27 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166', 21:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:27 INFO - '_': '/tools/buildbot/bin/python'} 21:54:27 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:54:27 INFO - mozversion application_buildid: 20151221193326 21:54:27 INFO - mozversion application_changeset: 6432606228940213ff615cb381597e96ff227483 21:54:27 INFO - mozversion application_display_name: Nightly 21:54:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:54:27 INFO - mozversion application_name: Firefox 21:54:27 INFO - mozversion application_remotingname: firefox 21:54:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:54:27 INFO - mozversion application_vendor: Mozilla 21:54:27 INFO - mozversion application_version: 46.0a1 21:54:27 INFO - mozversion platform_buildid: 20151221193326 21:54:27 INFO - mozversion platform_changeset: 6432606228940213ff615cb381597e96ff227483 21:54:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:54:27 INFO - mozversion platform_version: 46.0a1 21:54:27 INFO - using testdate: 1450763667 21:54:27 INFO - actual date: 1450763667 21:54:28 INFO - starting webserver on 'localhost:51707' 21:54:28 INFO - SUITE-START | Running 3 tests 21:54:28 INFO - TEST-START | dromaeo_css 21:54:28 INFO - operating with platform_type : linux_ 21:54:28 INFO - Initialising browser for dromaeo_css test... 21:54:28 INFO - TEST-INFO | started process 6390 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpthSOhm/profile http://localhost:51707/getInfo.html) 21:54:32 INFO - PROCESS | 6390 | __metrics Screen width/height:1600/1200 21:54:32 INFO - PROCESS | 6390 | colorDepth:24 21:54:32 INFO - PROCESS | 6390 | Browser inner width/height: 1024/697 21:54:32 INFO - PROCESS | 6390 | __metrics 21:54:32 INFO - PROCESS | 6390 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:54:33 INFO - TEST-INFO | 6390: exit 0 21:54:33 INFO - Browser initialized. 21:54:33 INFO - Running cycle 1/1 for dromaeo_css test... 21:54:33 INFO - TEST-INFO | started process 6523 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpthSOhm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:54:45 INFO - PROCESS | 6523 | RSS: Main: 151031808 21:54:45 INFO - PROCESS | 6523 | 21:55:35 INFO - PROCESS | 6523 | 1450763735084 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:57:44 INFO - PROCESS | 6523 | Cycle 1(1): loaded http://localhost:51707/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51707/tests/dromaeo/cssquery-ext.html) 21:57:45 INFO - PROCESS | 6523 | RSS: Main: 158433280 21:57:45 INFO - PROCESS | 6523 | 22:00:47 INFO - PROCESS | 6523 | Cycle 1(1): loaded http://localhost:51707/tests/dromaeo/cssquery-ext.html (next: http://localhost:51707/tests/dromaeo/cssquery-jquery.html) 22:00:47 INFO - PROCESS | 6523 | RSS: Main: 153100288 22:00:47 INFO - PROCESS | 6523 | 22:03:49 INFO - PROCESS | 6523 | Cycle 1(1): loaded http://localhost:51707/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51707/tests/dromaeo/cssquery-mootools.html) 22:03:50 INFO - PROCESS | 6523 | RSS: Main: 153886720 22:03:50 INFO - PROCESS | 6523 | 22:06:51 INFO - PROCESS | 6523 | Cycle 1(1): loaded http://localhost:51707/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51707/tests/dromaeo/cssquery-prototype.html) 22:06:52 INFO - PROCESS | 6523 | RSS: Main: 153022464 22:06:52 INFO - PROCESS | 6523 | 22:09:54 INFO - PROCESS | 6523 | Cycle 1(1): loaded http://localhost:51707/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51707/tests/dromaeo/cssquery-yui.html) 22:09:55 INFO - PROCESS | 6523 | RSS: Main: 153784320 22:09:55 INFO - PROCESS | 6523 | 22:12:58 INFO - PROCESS | 6523 | Cycle 1(1): loaded http://localhost:51707/tests/dromaeo/cssquery-yui.html (next: http://localhost:51707/tests/dromaeo/cssquery-dojo.html) 22:12:58 INFO - PROCESS | 6523 | RSS: Main: 156045312 22:12:58 INFO - PROCESS | 6523 | 22:12:58 INFO - PROCESS | 6523 | __start_tp_report 22:12:58 INFO - PROCESS | 6523 | _x_x_mozilla_page_load 22:12:58 INFO - PROCESS | 6523 | _x_x_mozilla_page_load_details 22:12:58 INFO - PROCESS | 6523 | |i|pagename|runs| 22:12:58 INFO - PROCESS | 6523 | |0;dojo.html;3212.9678703212967;3253.6746325367453;3257.2508323085704;3286.671332866714;3295.4562497187967;5231.895362092756;5378.058839703051;5382.4886635769535;5434.0218760623075;5446.210299506569;5338.652987555806;5353.625246232766;5355.196720491928;5427.104527752926;5472.972635136829;4726.196546587072;4955.950440495594;5161.690298582078;5176.042432150046;5191.143461328877;4861.562459378655;5107.259447380127;5116.513931176532;5144.717040562768;5182.196759502283;4908.067467181224;4918.336024636682;4985.825496107655;5021.84934451967;5061.8734531637;4973.254011898208;4989.90020199594;4998.475160108209;5002.1496345621335;5029.19532874742;4844;4901;4973.1297023020825;4997.600191984632;5053.343065401511;5196.1166601677805;5234.8691282717855;5238.5023422774775;5261.5264626183825;5326.7869285228935;6011.068284415879;6022.156898034279;6024.457798798086;6027.9095813562835;6040.365761595057;5709.371969083398;5846.21076154718;5862.736176872008;6044.214252147237;6075.33171351151;5648.293963254593;5649.265595472603;5650.802221922254;5652.463016013472;5655.688937108416;6028.156058151862;6087.269527656621;6103.725332360054;6112.786052488231;6143.754249830046;5694.487496125369;5701.429857014348;5760.049591817387;5762.394948530427;5912.970435147883;5832.50423713989;5900.1739756434135;5981.730822113015;5996.280446346466;6015.879682406327;5950.613210141327;5972.701364931736;5984.371640977722;5992.64044157352;6012.6392416455155;5751.626144300607;5864.882702346014;5990.221271234712;5991.2510936132985;6001.819945401645;4515.435570553681;4564.566366195206;4572.725636461823;4602.608778253819;4622.86131416058;4042.6159514846045;4076.6534844538546;4088.325426304686;4088.448059511987;4110.691698122653;5398.24424580559;5446.319210098738;5503.422140675171;5548.528375088163;5611.7474713637985;5998.520118390518;6006.339302676702;6009.729562169713;6021.126936594169;6071.089336599545;5554.666719996813;5599.440055994368;5607.299087614048;5620.1569764534825;5657.745401456944;4987.202047672427;5070.543651071347;5081.0854046272025;5107.540321371094;5213.426523082534;6027.246594175728;6043.214382130383;6051.515878729603;6051.667158306247;6130.7241174146375;5921.319048309328;6006.909896351645;6011.338752737282;6015.368386319374;6023.156758053964;5915.112733090071;5990.101484777319;6017.127516509994;6056.57603967718;6060.181875446759;5841.649501029951;5883.441073098049;5886.205362276038;5912.5861189718025;5920.970395147997;5895.29256489224;5930.377310382521;5964.880702385841;5967.075103358986;5976.163337132718;5598.10430331145;5716.857078573069;5811.94188058114;5818.592698511233;5952.642841429528;5830.5627077968475;5845.707714614167;5850.853728656647;5877.324107727495;5880.529557635294;5683.630564013326;5686.09022556389;5687.459691329317;5688.061469857593;5708.914366284426;5667.4332566743;5742.827715168552;5781.190633311424;5800.1299805029585;5830.82507524775;5710.885782284414;5730.541556675373;5732.512736417451;5745.166950792195;5757.251557297524 22:12:58 INFO - PROCESS | 6523 | |1;ext.html;568.3208565763911;598.7006496751624;615.5198944823037;615.7075389190132;620.7299824576312;37758.433623495635;38159;38309.42535861964;38391.61608383915;38444.23111537771;41476.37785433221;41730.37404438928;41825.58174418255;41893.162136757244;41917.371239431435;8653.783655408617;8790.64837406503;8820.338474614398;8829.558522073903;8869.600867960957;8615.913840861574;8622.611982460805;8675.045744968049;8710.259627931633;8731.476111433303;8717.956410217972;8725.171108744658;8786.384953053288;8810.647574097029;8811.427257228292;8641.697540586081;8728.60721267538;8739.95630021849;8742.825143497126;8744.256738177262;8422.620982055822;8586.184312490303;8591.5704214789;8599.269062129726;8635.481871087755;39254.21491570152;39752.801235993924;39796.80101599502;39849.20301593952;39867;3148.071318960889;3190.9361812763614;3226.128945184787;3246.9086557638752;3249.6912793284837;29602.70397296021;30048.24879378033;30072.8496357519;30117.397652047057;30437.69562304393;3633.3096711624707;3957.28768821612;3993.301172294866;3997.780122093284;4001.199760047973;258861;260824;262494;262763;263662;57722.13416798751;58414.41585584175;60898;61273.08090378648;61396.386036139964;71922;72989;73102.63448682723;73285.63357183286;73390.26609733941;14980.700385992219;15301.234938253265;15345.079295242322;15379.692406151815;15411.845881541041;11527.423628818526;11583.76832463346;11587.130965177645;11613.883861161281;11645.243059201124;20267.66921803982;20811.79188208129;20855.58288834245;20965.056572454276;20971.37085887426;8082.191780821989;8116.2695357418115;8251.2986396157;8293;8397.790055248668;916.5371487398821;926.249737712455;1051.0172988256006;1063.914886809069;1150.1718762490993;27859;28510.857445713053;28642.713572864006;28733.13800585986;29083.709162908523;1005.4671024357102;1024.6208902705898;1040.079529616295;1046.602291129366;1158.5365853658604;16670.16649167537;17345.913270433568;17369.913150434168;17382.130893455276;17428.738568921475;362212;368093;368441;368997;370998;53653.7317313411;53887.73056134773;54246.186307205426;54373.72813135909;54598.18102728462;1325.5294370498334;1331.6138319887318;1341.7383610196114;1342.4630147940902;1350.230368689857;28941.42117157603;30326.393472130876;32682.34635307328;33676.831615841766;33812.15469613279;50098.749506252236;50764;50855.74572127116;50877.49122508727;50884.999999998516;283900;288604;289113;289118;289210;41635.7918210407;45536.77231613821;46058.7697061526;46587.301190482845;47053.294200587705;42482.36276455794;42933.14133717371;42942;42974.570254297054;43378.349324760784;35823;36148.81925590355;36149.81756807048;36431.817840910626;36865.63134368622;35997.82001089978;36563;36620.63379366279;36726.816365918;36749;35664;41132.38301425541;41671.58328416677;41954.1609167821;42026.159476810906;29756.256093597833;32536.83731581327;33007.66992330142;33072;33135;24783;24934.87532562398;25471.235862924143;25499.617505737056;26842.731572684803 22:12:58 INFO - PROCESS | 6523 | |2;jquery.html;359.6978538028054;360.63936063936063;360.66818526955205;365.7165696585147;367.1189146049481;16992.150392480373;18038.18828152733;18478;18918.810811891875;19327.130279137436;9989.300748947577;10304.742381440468;10376.118029967462;10427.32222405545;17169.57076073099;4946.802127914879;5103.311053007852;5194.532492075712;5518.779248830042;5535.750891209885;5397.541208997221;5450.645708028986;5454.209139674745;5454.400015998237;5459.754311055992;5125.589952803767;5134.383873935114;5271.024860400819;5385.78456861727;5410.513053825155;5236.7905283788605;5237.7904883804795;5240.4759524047295;5241.109011468022;5280.102382594968;5013.924791128136;5137.51193636604;5141.640085194038;5148.536631703165;5183.326167598226;12502.49990000399;15104.320305586274;18880.90559547207;19423.611527769506;19450.319238826574;2162.275637661385;2172.435166856613;2177.640689286266;2204.7574766775642;2234.1398561553756;9457.054294570557;9489.288303377274;9520.381175223589;9527.428354298765;13436.93281533586;1866.9066546672611;1877.802830702784;1897.2885168061978;1911.5603411215498;1930.1121484117323;57619.71190144023;60011.09983350253;62963.6851815738;63069.68465157645;64337.03494447587;9671.177949874198;9755.414675119515;9769.609215631437;9810.80378392428;9878.259130565237;12912.870871291354;12973.156744811557;12989.28558929268;13090.803637945248;13106.082574219714;7448.925510744932;7517.962410187914;7521.360684341783;7578.507397019176;7688.961555192188;7155.499115061895;7167.713291468387;7179.712811487587;7181.6409179540815;7193.244709305448;4258.361245813091;4334.913301734011;4391.14372697321;4449.532799056053;4458.130664520388;1763.8799362404966;1775.4318618042103;1779.1993602878756;1814.4738025972583;1820.654075725608;804.3002587748579;943.5046600534637;973.1922504321396;1008.3244226368204;1072.088724584113;14894.255287235595;15679.529614111594;15694.607634808992;16515.91742041282;17552.736708949375;872.4939535069644;893.9910600894038;926.990730092704;943.306669597845;984.4437892590806;8869.201771840566;9137.588808503633;9154.084591540792;9162.175404213653;9264.861027084598;521536;525061;528035;546890;547321;78996.21003790003;80187.59906200548;80632;80687;80687.19312806914;1147.5926046253626;1154.2728081308721;1218.104693050607;1221.132995573153;1236.5424792826711;14553.636159096108;14730.631734206301;14782.186979716218;14796.926015369854;14828.40686372533;33036.1740956478;33198;33410.832945835115;33452.996410107735;34708.132296692784;45560;46602.766986164854;47340;48059.27911081267;51260.74369628128;9312.767180820534;9399.765005874908;9473.100055494717;9598.856017159887;9628.566714498005;11445.427728613702;11451.59919402817;11539.423028848692;13761.38073786702;17747.11264436799;13810.792838107236;14386.856131438552;14597.12417254968;14659.780103298672;14776.63058423548;14471.131732096108;14503.274836257933;14570.4900328488;14772.852271477148;14938.253087345807;15315.770263445835;15380.077195368314;15383.69232615319;15428.614284642525;15522.301496432914;9459.101385368655;9521.857172142285;9559.283053770856;9563;9722.173615242784;11532.654020379403;14792.704145916807;14831.555053348417;15061.021033633217;15211.315490803161 22:12:58 INFO - PROCESS | 6523 | |3;mootools.html;1535.3781718404036;1668.5828542864283;1725.8619310455165;1726.6719323328566;1732.85270751986;7323.414126869851;7506.437017223703;7629.504082234651;7841.333486653642;7879.606019699021;7823.6870525179065;7860.174681658429;7884.132745398002;7907.090684571276;7923.9207607924045;2276.3512398966254;2307.4116100394376;2313.7223533175957;2324.8256380771427;2331.4521087544413;2286.314105768271;2323.175272778165;2333.2067097186955;2334.7665233476687;2337.532493501298;2214.413180507167;2221.8111460525874;2246.4159318577126;2294.6328587426015;2301.539692061586;2266.92065777697;2273.4202778291515;2300.551392478476;2302.401375642345;2317.5364927014666;2239.8208143348493;2287.977120228793;2311.7457079721216;2320.1531441023903;2328.1385887221836;7523.774286771406;7637.847243055164;7643.617819109078;7656.196099409537;7668.846623067563;4697.03710739301;4753.3107699383745;4773.498782627808;4776.832810851603;4784.66507344486;2970.985145074261;2972.8067675601233;3030.1061186949682;3052.6794686558037;3066.3254084101463;934.7429456899339;941.1153515695224;941.3692825806726;949.4113649537331;993.2699465892563;10473.738156546071;10507.947460262727;10553.84169237462;10576.68269951895;10577;4066.1664358806374;4108.260513107669;4136.73111247768;4140.0270936329935;4177.206330797138;8606.655733770704;8666.86999695005;8669.479831210148;8688.695895643623;8696.478211307342;4670.416197975253;4681.274402467623;4695.319178719066;4705.95294047062;4717.174494463524;4267.530571637118;4305.461817272841;4311.245532031882;4315.287977483743;4319.092990472036;3497.89506314811;3515.3672338978718;3541.94687079694;3542.0436482149676;3548.716102711777;1071.8124328242527;1096.040964156363;1100.8403781451646;1102.2064113838023;1103.3986477369854;956.4596003258137;964.9807003859884;1033.328336581213;1058.5818601652459;1296.623979046066;7148.499605027702;7159.642017899084;7207.099112610924;7222.530535515175;7255.709771609182;957.7557722780786;958.2190514730472;960.1790469148917;960.313375936195;965.2760429677742;5718.370979192286;5721.284839395075;5737.741801618937;5757.539396848242;5769.134629805562;7938.801529961682;8018.118007019223;8129.715459958873;9073.637054517878;9197.724068277963;8972.641094356153;8997;9040.502772347583;9086.409383390059;9102.31732620043;7217;7283.635818209068;7289.3439590436055;7292.598907060056;7298.306660867315;7140.571565706075;7216.9278307216255;7223.458240632079;7227.349538541556;7228.855422891618;8119.30985866208;8353.24820766134;8359.623816928131;8379.95810020946;8440.83118337642;8017.799555011172;8079.111297757125;8085.9595702021115;8134.349252059703;8218.137095604876;6617.702203400955;6906.654667266717;6928.445724342141;6932.722691092502;6959.304069593;7318.048653675201;7396.112466504054;7409.962950185214;7417.147028091623;7429.7399591014055;6286.214223222098;6925.238223795479;6928.930710692828;7024.121984751906;7149.320814522612;6839;6904.275051119761;6941.132358455193;6975.895361569479;6977.581345119309;6751.3586209312;6952.826179345557;6982.581045137308;6990.370866622028;6996.405305549085;6291.433770960452;6300.401461861115;6305.369463053658;6316.842078948063;6319.842003949938;6369.45859601939;6466.418022378009;6498.837529061811;6505.772297969548;6513.8697226056165 22:12:58 INFO - PROCESS | 6523 | |4;prototype.html;341.9692227699507;343.6580602300711;343.80918590182455;345.06659486090126;351.9384107781138;6236.469900058501;6352.110704501373;6413.8075857724225;6431.581947173437;6466.7736629217925;6119.969400153004;6285.088662143987;6303.9369606304035;6306.1171435998995;6321.841953951153;4839.15314819906;4867.415910090794;4885.902281954359;4892.8042878285005;4897.632677549181;4881.4874438184015;4890.902181956359;4897.338859254009;4898.338724272213;4905.852824415273;4645.488996210431;4699.976500117495;4755.9286610700865;4760.143174228638;4763.047390521892;4721.881952951187;4748.050389922012;4775.450823155347;4787.736674482902;4795.184818580849;4134.937975930364;4143.08852052548;4147;4148.087420767426;4151.647109995654;5981.730822113015;6054.4550990410635;6058;6061.696915154269;6062.757489700407;5567.832965011056;5594.4964953154;5624.15637654351;5624.746886390122;5625.493705566478;6754.189497260311;6755.493337999621;6760.864782704319;6762.425193858528;6763.932360676379;4636.53634636537;4642.257238841803;4647.070585882837;4648.767561621939;4664.253719404879;6911.827204319882;6924.7576334828545;6972.2330543640155;7012.632536655355;7036.612986285752;4648.767561621906;4654.86035418938;4661.394018777537;4676.275177347448;4698.3187437821325;4745.549172828576;4765.11845308619;4773.427188737373;4778.211595086772;4791.6406269529925;5595.496405323459;5599.916001259984;5605.299337582802;5608.85977850557;5612.158176273591;6608.669566521655;6786.778379891667;6849.417799487;6851.48613853953;6855.862882742317;1572.3710515793773;1580.0440733356384;1660.3109709470434;1686.6879627268995;1693.8560222381236;1097.4512743628186;1113.4154568851256;1122;1122.7361570031037;1128.6896103571582;6405.455536279468;6408.231012278557;6413.454856337264;6431.389018043278;6433.967830160819;6880.483963702743;6956.200036995709;6957.095577574984;6974.476914231352;6981.89527157093;6370.235571731422;6406.263279722892;6416.230052393743;6422.582532135396;6434.871302573923;3821.312163810541;3856.807159642007;3872.206197729459;3878.204967981557;3881.3013657541915;7181.533200341961;7202.099737532809;7226.060612120391;7234.457415693844;7237.312455316736;7168.713251469987;7295.452841036943;7304.926950730424;7318.853622927511;7325;7139.714411423485;7142.535735177197;7170.8207294817;7199.424046076301;7215.098112735908;7054.788356349318;7075.080239568823;7093.6453177341955;7108.751193708195;7115.359617634231;6812.080369150101;7020.227774944854;7025.789226323219;7030.613316267654;7052.576845389293;7248.202697703354;7249.818754531179;7251.854962900818;7253.746118885813;7261.927380726336;4840.1529732296;4866.148424025852;4878.0000099980125;4884.462709102067;4893.779779909842;6936.132983377078;6943.375096241362;7037.507374483737;7050.8237294066;7060.54106483077;6902.792916212522;6919.584824910521;6927.618980955895;6945.756898508528;6954.8956765647545;6828.214755303005;6902.378785909092;6904.067950826775;6906.551074180162;6912.792616221522;6509.934900650933;6626.536142470173;6636.7013484392355;6712.798616041527;6716.462682985251;6922.06552115458;6928.7228510859;6930.826729331606;6937.236903940663;6939.653017349214;6694.497912656473;6733.124693789776;6740.764073257413;6752.054712340375;6752.561083529555 22:12:58 INFO - PROCESS | 6523 | |5;yui.html;724.7644515532453;737.9262073792621;830.5598033042489;855.1662129423817;876.8202518483712;12826.935865320673;13028;13038.413271402786;13064.608061758163;13155.934220328885;12150.210236334655;12258.938705306484;12325.322107284095;12355;13603.38784754686;817.914119017505;819.5983967855767;823.5799742131496;825.224289168183;829.1956801902145;825.5995842016617;829.8298848736025;832.8584140696066;834.3742193354984;834.4117397234966;870.6952566601702;870.7170169694874;874.0734821089666;876.027609353617;878.0078511282275;858.3991206155654;860.4665107633244;861.1001503428901;864.7924498120437;866.0516734176099;631.5137344244906;635.3551145587232;636.656205648949;638.0333794301637;638.2245571630491;12870;12970.156939798882;12999.480020799158;13006.86993130066;13028;10275.075243228146;10368.13373592753;10892;10976.890231097746;11009.669709908716;9907.801843963152;10077.596896124147;10156.4921753912;10257.330045088836;10342.689719308433;3626.528551288342;3637.1270894985014;3685.4471829225563;3692.372296709539;3791.905202369963;41251.793741031404;42260.15479690389;46534.53465465336;47624.28563571549;48073.03853922902;10505.31715438494;10578.57685692579;10587.311824731369;10730.678079657622;11000.119990400748;18813.059347032868;18822.247110115717;18866.151023203987;18892.244310227437;18911;7794.493357931717;7895.921040789519;7897.921020789833;7993.120756716757;8165.387595930329;4385.210662080793;4463.352813841975;4494.235979883428;4515.074409745994;4548.13585418776;3209.3902158589794;3220.838958052088;3226.6934641209045;3228.6287076985977;3241.5137729340786;588.4027711872453;604.1391017799618;613.9048447490557;615.4460985113434;627.2003195925232;668.1814776898261;682.6279677575634;697.1982220446425;698.5284932670427;711.0756017177648;8169.836603267901;8588.957055214683;8646.3947523674;8797.252233560092;8826.293896488265;536.4608568388744;570.9771609135671;604.9987271066392;699.0946723992442;701.1340993872564;3866.613338666111;4069.5726948670554;4298.26929421999;4471.61991230749;4504.144212599595;54881.45118548763;55018;55228.723856381264;55448;55861.44138558643;48989.755051224514;49302.50697492979;49447.75276123596;49665.751671242135;49737.75131124321;39723.20553588912;40465.1906961865;51028.48971510312;51688.96622067538;52018;8333.208345207195;9128.224100951493;9265.397749146285;9279.164875161268;9315.39449935752;34379.65620343765;35187.472187917716;35398.46902296519;36180;36812.815935920145;43393.56606433895;44068.55931440645;44358.33462498001;44405.555944440144;44859.327110094026;11130.165237607374;11290.379029153475;11294.60468883585;11345.659630211107;11640;12342.691432713895;12457.439415226156;12458;12514.74970500603;12617.49530018789;11351.205415621158;11641.708957276136;11653.242539234923;11919.404029798648;12467.75064498723;11735.823962640738;12037.939810300892;12122.515099395925;12215;12375.616026363241;11550.422478875855;11769.411529423323;11963.222390544586;12091.758164836478;12507.687307817378;10058.492374031817;10200.58841915683;10439.112675422673;10454.42500662471;10799.028087472165;9281.814363712823;9445;9894.752631184278;10317.74205644865;10502.474876256309 22:12:58 INFO - PROCESS | 6523 | __end_tp_report 22:12:58 INFO - PROCESS | 6523 | __start_cc_report 22:12:58 INFO - PROCESS | 6523 | _x_x_mozilla_cycle_collect,309 22:12:58 INFO - PROCESS | 6523 | __end_cc_report 22:12:58 INFO - PROCESS | 6523 | __startTimestamp1450764778440__endTimestamp 22:12:58 INFO - PROCESS | 6523 | 22:12:58 INFO - PROCESS | 6523 | ------- Summary: start ------- 22:12:58 INFO - PROCESS | 6523 | Number of tests: 6 22:12:58 INFO - PROCESS | 6523 | 22:12:58 INFO - PROCESS | 6523 | [#0] dojo.html Cycles:165 Average:5491.92 Median:5701.43 stddev:624.73 (11.0%) stddev-sans-first:600.52 22:12:58 INFO - PROCESS | 6523 | Values: 3213.0 3253.7 3257.3 3286.7 3295.5 5231.9 5378.1 5382.5 5434.0 5446.2 5338.7 5353.6 5355.2 5427.1 5473.0 4726.2 4956.0 5161.7 5176.0 5191.1 4861.6 5107.3 5116.5 5144.7 5182.2 4908.1 4918.3 4985.8 5021.8 5061.9 4973.3 4989.9 4998.5 5002.1 5029.2 4844.0 4901.0 4973.1 4997.6 5053.3 5196.1 5234.9 5238.5 5261.5 5326.8 6011.1 6022.2 6024.5 6027.9 6040.4 5709.4 5846.2 5862.7 6044.2 6075.3 5648.3 5649.3 5650.8 5652.5 5655.7 6028.2 6087.3 6103.7 6112.8 6143.8 5694.5 5701.4 5760.0 5762.4 5913.0 5832.5 5900.2 5981.7 5996.3 6015.9 5950.6 5972.7 5984.4 5992.6 6012.6 5751.6 5864.9 5990.2 5991.3 6001.8 4515.4 4564.6 4572.7 4602.6 4622.9 4042.6 4076.7 4088.3 4088.4 4110.7 5398.2 5446.3 5503.4 5548.5 5611.7 5998.5 6006.3 6009.7 6021.1 6071.1 5554.7 5599.4 5607.3 5620.2 5657.7 4987.2 5070.5 5081.1 5107.5 5213.4 6027.2 6043.2 6051.5 6051.7 6130.7 5921.3 6006.9 6011.3 6015.4 6023.2 5915.1 5990.1 6017.1 6056.6 6060.2 5841.6 5883.4 5886.2 5912.6 5921.0 5895.3 5930.4 5964.9 5967.1 5976.2 5598.1 5716.9 5811.9 5818.6 5952.6 5830.6 5845.7 5850.9 5877.3 5880.5 5683.6 5686.1 5687.5 5688.1 5708.9 5667.4 5742.8 5781.2 5800.1 5830.8 5710.9 5730.5 5732.5 5745.2 5757.3 22:12:58 INFO - PROCESS | 6523 | 22:12:58 INFO - PROCESS | 6523 | [#1] ext.html Cycles:180 Average:48683.17 Median:37958.72 stddev:80982.24 (213.3%) stddev-sans-first:81128.84 22:12:58 INFO - PROCESS | 6523 | Values: 568.3 598.7 615.5 615.7 620.7 37758.4 38159.0 38309.4 38391.6 38444.2 41476.4 41730.4 41825.6 41893.2 41917.4 8653.8 8790.6 8820.3 8829.6 8869.6 8615.9 8622.6 8675.0 8710.3 8731.5 8718.0 8725.2 8786.4 8810.6 8811.4 8641.7 8728.6 8740.0 8742.8 8744.3 8422.6 8586.2 8591.6 8599.3 8635.5 39254.2 39752.8 39796.8 39849.2 39867.0 3148.1 3190.9 3226.1 3246.9 3249.7 29602.7 30048.2 30072.8 30117.4 30437.7 3633.3 3957.3 3993.3 3997.8 4001.2 258861.0 260824.0 262494.0 262763.0 263662.0 57722.1 58414.4 60898.0 61273.1 61396.4 71922.0 72989.0 73102.6 73285.6 73390.3 14980.7 15301.2 15345.1 15379.7 15411.8 11527.4 11583.8 11587.1 11613.9 11645.2 20267.7 20811.8 20855.6 20965.1 20971.4 8082.2 8116.3 8251.3 8293.0 8397.8 916.5 926.2 1051.0 1063.9 1150.2 27859.0 28510.9 28642.7 28733.1 29083.7 1005.5 1024.6 1040.1 1046.6 1158.5 16670.2 17345.9 17369.9 17382.1 17428.7 362212.0 368093.0 368441.0 368997.0 370998.0 53653.7 53887.7 54246.2 54373.7 54598.2 1325.5 1331.6 1341.7 1342.5 1350.2 28941.4 30326.4 32682.3 33676.8 33812.2 50098.7 50764.0 50855.7 50877.5 50885.0 283900.0 288604.0 289113.0 289118.0 289210.0 41635.8 45536.8 46058.8 46587.3 47053.3 42482.4 42933.1 42942.0 42974.6 43378.3 35823.0 36148.8 36149.8 36431.8 36865.6 35997.8 36563.0 36620.6 36726.8 36749.0 35664.0 41132.4 41671.6 41954.2 42026.2 29756.3 32536.8 33007.7 33072.0 33135.0 24783.0 24934.9 25471.2 25499.6 26842.7 22:12:58 INFO - PROCESS | 6523 | 22:12:58 INFO - PROCESS | 6523 | [#2] jquery.html Cycles:180 Average:28411.19 Median:4453.83 stddev:87300.65 (1960.1%) stddev-sans-first:87520.14 22:12:58 INFO - PROCESS | 6523 | Values: 359.7 360.6 360.7 365.7 367.1 16992.2 18038.2 18478.0 18918.8 19327.1 9989.3 10304.7 10376.1 10427.3 17169.6 4946.8 5103.3 5194.5 5518.8 5535.8 5397.5 5450.6 5454.2 5454.4 5459.8 5125.6 5134.4 5271.0 5385.8 5410.5 5236.8 5237.8 5240.5 5241.1 5280.1 5013.9 5137.5 5141.6 5148.5 5183.3 12502.5 15104.3 18880.9 19423.6 19450.3 2162.3 2172.4 2177.6 2204.8 2234.1 9457.1 9489.3 9520.4 9527.4 13436.9 1866.9 1877.8 1897.3 1911.6 1930.1 57619.7 60011.1 62963.7 63069.7 64337.0 9671.2 9755.4 9769.6 9810.8 9878.3 12912.9 12973.2 12989.3 13090.8 13106.1 7448.9 7518.0 7521.4 7578.5 7689.0 7155.5 7167.7 7179.7 7181.6 7193.2 4258.4 4334.9 4391.1 4449.5 4458.1 1763.9 1775.4 1779.2 1814.5 1820.7 804.3 943.5 973.2 1008.3 1072.1 14894.3 15679.5 15694.6 16515.9 17552.7 872.5 894.0 927.0 943.3 984.4 8869.2 9137.6 9154.1 9162.2 9264.9 521536.0 525061.0 528035.0 546890.0 547321.0 78996.2 80187.6 80632.0 80687.0 80687.2 1147.6 1154.3 1218.1 1221.1 1236.5 14553.6 14730.6 14782.2 14796.9 14828.4 33036.2 33198.0 33410.8 33453.0 34708.1 45560.0 46602.8 47340.0 48059.3 51260.7 9312.8 9399.8 9473.1 9598.9 9628.6 11445.4 11451.6 11539.4 13761.4 17747.1 13810.8 14386.9 14597.1 14659.8 14776.6 14471.1 14503.3 14570.5 14772.9 14938.3 15315.8 15380.1 15383.7 15428.6 15522.3 9459.1 9521.9 9559.3 9563.0 9722.2 11532.7 14792.7 14831.6 15061.0 15211.3 22:12:58 INFO - PROCESS | 6523 | 22:12:58 INFO - PROCESS | 6523 | [#3] mootools.html Cycles:180 Average:5364.94 Median:6795.18 stddev:2741.71 (40.3%) stddev-sans-first:2734.29 22:12:58 INFO - PROCESS | 6523 | Values: 1535.4 1668.6 1725.9 1726.7 1732.9 7323.4 7506.4 7629.5 7841.3 7879.6 7823.7 7860.2 7884.1 7907.1 7923.9 2276.4 2307.4 2313.7 2324.8 2331.5 2286.3 2323.2 2333.2 2334.8 2337.5 2214.4 2221.8 2246.4 2294.6 2301.5 2266.9 2273.4 2300.6 2302.4 2317.5 2239.8 2288.0 2311.7 2320.2 2328.1 7523.8 7637.8 7643.6 7656.2 7668.8 4697.0 4753.3 4773.5 4776.8 4784.7 2971.0 2972.8 3030.1 3052.7 3066.3 934.7 941.1 941.4 949.4 993.3 10473.7 10507.9 10553.8 10576.7 10577.0 4066.2 4108.3 4136.7 4140.0 4177.2 8606.7 8666.9 8669.5 8688.7 8696.5 4670.4 4681.3 4695.3 4706.0 4717.2 4267.5 4305.5 4311.2 4315.3 4319.1 3497.9 3515.4 3541.9 3542.0 3548.7 1071.8 1096.0 1100.8 1102.2 1103.4 956.5 965.0 1033.3 1058.6 1296.6 7148.5 7159.6 7207.1 7222.5 7255.7 957.8 958.2 960.2 960.3 965.3 5718.4 5721.3 5737.7 5757.5 5769.1 7938.8 8018.1 8129.7 9073.6 9197.7 8972.6 8997.0 9040.5 9086.4 9102.3 7217.0 7283.6 7289.3 7292.6 7298.3 7140.6 7216.9 7223.5 7227.3 7228.9 8119.3 8353.2 8359.6 8380.0 8440.8 8017.8 8079.1 8086.0 8134.3 8218.1 6617.7 6906.7 6928.4 6932.7 6959.3 7318.0 7396.1 7410.0 7417.1 7429.7 6286.2 6925.2 6928.9 7024.1 7149.3 6839.0 6904.3 6941.1 6975.9 6977.6 6751.4 6952.8 6982.6 6990.4 6996.4 6291.4 6300.4 6305.4 6316.8 6319.8 6369.5 6466.4 6498.8 6505.8 6513.9 22:12:58 INFO - PROCESS | 6523 | 22:12:58 INFO - PROCESS | 6523 | [#4] prototype.html Cycles:180 Average:5657.45 Median:6410.84 stddev:1731.65 (27.0%) stddev-sans-first:1689.92 22:12:58 INFO - PROCESS | 6523 | Values: 342.0 343.7 343.8 345.1 351.9 6236.5 6352.1 6413.8 6431.6 6466.8 6120.0 6285.1 6303.9 6306.1 6321.8 4839.2 4867.4 4885.9 4892.8 4897.6 4881.5 4890.9 4897.3 4898.3 4905.9 4645.5 4700.0 4755.9 4760.1 4763.0 4721.9 4748.1 4775.5 4787.7 4795.2 4134.9 4143.1 4147.0 4148.1 4151.6 5981.7 6054.5 6058.0 6061.7 6062.8 5567.8 5594.5 5624.2 5624.7 5625.5 6754.2 6755.5 6760.9 6762.4 6763.9 4636.5 4642.3 4647.1 4648.8 4664.3 6911.8 6924.8 6972.2 7012.6 7036.6 4648.8 4654.9 4661.4 4676.3 4698.3 4745.5 4765.1 4773.4 4778.2 4791.6 5595.5 5599.9 5605.3 5608.9 5612.2 6608.7 6786.8 6849.4 6851.5 6855.9 1572.4 1580.0 1660.3 1686.7 1693.9 1097.5 1113.4 1122.0 1122.7 1128.7 6405.5 6408.2 6413.5 6431.4 6434.0 6880.5 6956.2 6957.1 6974.5 6981.9 6370.2 6406.3 6416.2 6422.6 6434.9 3821.3 3856.8 3872.2 3878.2 3881.3 7181.5 7202.1 7226.1 7234.5 7237.3 7168.7 7295.5 7304.9 7318.9 7325.0 7139.7 7142.5 7170.8 7199.4 7215.1 7054.8 7075.1 7093.6 7108.8 7115.4 6812.1 7020.2 7025.8 7030.6 7052.6 7248.2 7249.8 7251.9 7253.7 7261.9 4840.2 4866.1 4878.0 4884.5 4893.8 6936.1 6943.4 7037.5 7050.8 7060.5 6902.8 6919.6 6927.6 6945.8 6954.9 6828.2 6902.4 6904.1 6906.6 6912.8 6509.9 6626.5 6636.7 6712.8 6716.5 6922.1 6928.7 6930.8 6937.2 6939.7 6694.5 6733.1 6740.8 6752.1 6752.6 22:12:58 INFO - PROCESS | 6523 | 22:12:58 INFO - PROCESS | 6523 | [#5] yui.html Cycles:180 Average:13710.46 Median:44213.45 stddev:15527.38 (35.1%) stddev-sans-first:15540.32 22:12:58 INFO - PROCESS | 6523 | Values: 724.8 737.9 830.6 855.2 876.8 12826.9 13028.0 13038.4 13064.6 13155.9 12150.2 12258.9 12325.3 12355.0 13603.4 817.9 819.6 823.6 825.2 829.2 825.6 829.8 832.9 834.4 834.4 870.7 870.7 874.1 876.0 878.0 858.4 860.5 861.1 864.8 866.1 631.5 635.4 636.7 638.0 638.2 12870.0 12970.2 12999.5 13006.9 13028.0 10275.1 10368.1 10892.0 10976.9 11009.7 9907.8 10077.6 10156.5 10257.3 10342.7 3626.5 3637.1 3685.4 3692.4 3791.9 41251.8 42260.2 46534.5 47624.3 48073.0 10505.3 10578.6 10587.3 10730.7 11000.1 18813.1 18822.2 18866.2 18892.2 18911.0 7794.5 7895.9 7897.9 7993.1 8165.4 4385.2 4463.4 4494.2 4515.1 4548.1 3209.4 3220.8 3226.7 3228.6 3241.5 588.4 604.1 613.9 615.4 627.2 668.2 682.6 697.2 698.5 711.1 8169.8 8589.0 8646.4 8797.3 8826.3 536.5 571.0 605.0 699.1 701.1 3866.6 4069.6 4298.3 4471.6 4504.1 54881.5 55018.0 55228.7 55448.0 55861.4 48989.8 49302.5 49447.8 49665.8 49737.8 39723.2 40465.2 51028.5 51689.0 52018.0 8333.2 9128.2 9265.4 9279.2 9315.4 34379.7 35187.5 35398.5 36180.0 36812.8 43393.6 44068.6 44358.3 44405.6 44859.3 11130.2 11290.4 11294.6 11345.7 11640.0 12342.7 12457.4 12458.0 12514.7 12617.5 11351.2 11641.7 11653.2 11919.4 12467.8 11735.8 12037.9 12122.5 12215.0 12375.6 11550.4 11769.4 11963.2 12091.8 12507.7 10058.5 10200.6 10439.1 10454.4 10799.0 9281.8 9445.0 9894.8 10317.7 10502.5 22:12:58 INFO - PROCESS | 6523 | -------- Summary: end -------- 22:12:58 INFO - PROCESS | 6523 | 22:12:59 INFO - TEST-INFO | 6523: exit 0 22:12:59 INFO - TEST-OK | dromaeo_css | took 1111087ms 22:12:59 INFO - TEST-START | kraken 22:12:59 INFO - operating with platform_type : linux_ 22:12:59 INFO - Initialising browser for kraken test... 22:12:59 INFO - TEST-INFO | started process 6769 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSR8dss/profile http://localhost:51707/getInfo.html) 22:13:03 INFO - PROCESS | 6769 | __metrics Screen width/height:1600/1200 22:13:03 INFO - PROCESS | 6769 | colorDepth:24 22:13:03 INFO - PROCESS | 6769 | Browser inner width/height: 1024/697 22:13:03 INFO - PROCESS | 6769 | __metrics 22:13:03 INFO - PROCESS | 6769 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:13:04 INFO - TEST-INFO | 6769: exit 0 22:13:04 INFO - Browser initialized. 22:13:04 INFO - Running cycle 1/1 for kraken test... 22:13:04 INFO - TEST-INFO | started process 6892 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSR8dss/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:13:16 INFO - PROCESS | 6892 | RSS: Main: 151097344 22:13:16 INFO - PROCESS | 6892 | 22:13:18 INFO - PROCESS | 6892 | Cycle 1(1): loaded http://localhost:51707/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51707/tests/kraken/driver.html?testName=audio-beat-detection) 22:13:19 INFO - PROCESS | 6892 | RSS: Main: 153010176 22:13:19 INFO - PROCESS | 6892 | 22:13:22 INFO - PROCESS | 6892 | Cycle 1(1): loaded http://localhost:51707/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51707/tests/kraken/driver.html?testName=audio-dft) 22:13:22 INFO - PROCESS | 6892 | RSS: Main: 152203264 22:13:22 INFO - PROCESS | 6892 | 22:13:25 INFO - PROCESS | 6892 | Cycle 1(1): loaded http://localhost:51707/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51707/tests/kraken/driver.html?testName=audio-fft) 22:13:26 INFO - PROCESS | 6892 | RSS: Main: 146268160 22:13:26 INFO - PROCESS | 6892 | 22:13:28 INFO - PROCESS | 6892 | Cycle 1(1): loaded http://localhost:51707/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51707/tests/kraken/driver.html?testName=audio-oscillator) 22:13:28 INFO - PROCESS | 6892 | RSS: Main: 146001920 22:13:28 INFO - PROCESS | 6892 | 22:13:30 INFO - PROCESS | 6892 | Cycle 1(1): loaded http://localhost:51707/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51707/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:13:31 INFO - PROCESS | 6892 | RSS: Main: 147181568 22:13:31 INFO - PROCESS | 6892 | 22:13:34 INFO - PROCESS | 6892 | Cycle 1(1): loaded http://localhost:51707/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51707/tests/kraken/driver.html?testName=imaging-darkroom) 22:13:35 INFO - PROCESS | 6892 | RSS: Main: 148123648 22:13:35 INFO - PROCESS | 6892 | 22:13:38 INFO - PROCESS | 6892 | Cycle 1(1): loaded http://localhost:51707/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51707/tests/kraken/driver.html?testName=imaging-desaturate) 22:13:39 INFO - PROCESS | 6892 | RSS: Main: 149192704 22:13:39 INFO - PROCESS | 6892 | 22:13:41 INFO - PROCESS | 6892 | Cycle 1(1): loaded http://localhost:51707/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51707/tests/kraken/driver.html?testName=json-parse-financial) 22:13:42 INFO - PROCESS | 6892 | RSS: Main: 149442560 22:13:42 INFO - PROCESS | 6892 | 22:13:44 INFO - PROCESS | 6892 | Cycle 1(1): loaded http://localhost:51707/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51707/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:13:44 INFO - PROCESS | 6892 | RSS: Main: 148365312 22:13:44 INFO - PROCESS | 6892 | 22:13:46 INFO - PROCESS | 6892 | Cycle 1(1): loaded http://localhost:51707/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51707/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:13:46 INFO - PROCESS | 6892 | RSS: Main: 149188608 22:13:46 INFO - PROCESS | 6892 | 22:13:49 INFO - PROCESS | 6892 | Cycle 1(1): loaded http://localhost:51707/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51707/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:13:49 INFO - PROCESS | 6892 | RSS: Main: 150073344 22:13:49 INFO - PROCESS | 6892 | 22:13:52 INFO - PROCESS | 6892 | Cycle 1(1): loaded http://localhost:51707/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51707/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:13:52 INFO - PROCESS | 6892 | RSS: Main: 150163456 22:13:52 INFO - PROCESS | 6892 | 22:13:55 INFO - PROCESS | 6892 | Cycle 1(1): loaded http://localhost:51707/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51707/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:13:55 INFO - PROCESS | 6892 | RSS: Main: 150233088 22:13:55 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | Cycle 1(1): loaded http://localhost:51707/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51707/tests/kraken/driver.html?testName=ai-astar) 22:13:57 INFO - PROCESS | 6892 | RSS: Main: 148578304 22:13:57 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | __start_tp_report 22:13:57 INFO - PROCESS | 6892 | _x_x_mozilla_page_load 22:13:57 INFO - PROCESS | 6892 | _x_x_mozilla_page_load_details 22:13:57 INFO - PROCESS | 6892 | |i|pagename|runs| 22:13:57 INFO - PROCESS | 6892 | |0;ai-astar;110;106;112;110;110;122;111;110;110;112 22:13:57 INFO - PROCESS | 6892 | |1;audio-beat-detection;147;123;148;161;127;164;175;137;166;124 22:13:57 INFO - PROCESS | 6892 | |2;audio-dft;160;163;161;162;161;161;161;163;172;162 22:13:57 INFO - PROCESS | 6892 | |3;audio-fft;71;71;72;72;73;134;71;73;73;72 22:13:57 INFO - PROCESS | 6892 | |4;audio-oscillator;93;92;140;93;93;93;131;93;95;132 22:13:57 INFO - PROCESS | 6892 | |5;imaging-gaussian-blur;110;109;110;109;110;109;110;111;110;111 22:13:57 INFO - PROCESS | 6892 | |6;imaging-darkroom;147;145;146;147;147;147;147;146;147;147 22:13:57 INFO - PROCESS | 6892 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;100;96 22:13:57 INFO - PROCESS | 6892 | |8;json-parse-financial;58;60;58;59;58;61;58;59;56;62 22:13:57 INFO - PROCESS | 6892 | |9;json-stringify-tinderbox;67;67;66;68;67;68;66;68;67;67 22:13:57 INFO - PROCESS | 6892 | |10;stanford-crypto-aes;82;85;86;93;84;83;85;83;85;90 22:13:57 INFO - PROCESS | 6892 | |11;stanford-crypto-ccm;125;118;121;120;121;117;128;134;121;135 22:13:57 INFO - PROCESS | 6892 | |12;stanford-crypto-pbkdf2;141;164;153;162;151;142;152;151;149;163 22:13:57 INFO - PROCESS | 6892 | |13;stanford-crypto-sha256-iterative;69;70;68;71;69;67;69;66;68;66 22:13:57 INFO - PROCESS | 6892 | __end_tp_report 22:13:57 INFO - PROCESS | 6892 | __start_cc_report 22:13:57 INFO - PROCESS | 6892 | _x_x_mozilla_cycle_collect,747 22:13:57 INFO - PROCESS | 6892 | __end_cc_report 22:13:57 INFO - PROCESS | 6892 | __startTimestamp1450764837906__endTimestamp 22:13:57 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | ------- Summary: start ------- 22:13:57 INFO - PROCESS | 6892 | Number of tests: 14 22:13:57 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | [#0] ai-astar Cycles:10 Average:111.30 Median:110.50 stddev:4.11 (3.7%) stddev-sans-first:4.33 22:13:57 INFO - PROCESS | 6892 | Values: 110.0 106.0 112.0 110.0 110.0 122.0 111.0 110.0 110.0 112.0 22:13:57 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:154.50 stddev:18.96 (12.3%) stddev-sans-first:20.11 22:13:57 INFO - PROCESS | 6892 | Values: 147.0 123.0 148.0 161.0 127.0 164.0 175.0 137.0 166.0 124.0 22:13:57 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:3.44 (2.1%) stddev-sans-first:3.52 22:13:57 INFO - PROCESS | 6892 | Values: 160.0 163.0 161.0 162.0 161.0 161.0 161.0 163.0 172.0 162.0 22:13:57 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | [#3] audio-fft Cycles:10 Average:78.20 Median:72.00 stddev:19.62 (27.3%) stddev-sans-first:20.64 22:13:57 INFO - PROCESS | 6892 | Values: 71.0 71.0 72.0 72.0 73.0 134.0 71.0 73.0 73.0 72.0 22:13:57 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | [#4] audio-oscillator Cycles:10 Average:105.50 Median:93.00 stddev:20.05 (21.6%) stddev-sans-first:20.75 22:13:57 INFO - PROCESS | 6892 | Values: 93.0 92.0 140.0 93.0 93.0 93.0 131.0 93.0 95.0 132.0 22:13:57 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 22:13:57 INFO - PROCESS | 6892 | Values: 110.0 109.0 110.0 109.0 110.0 109.0 110.0 111.0 110.0 111.0 22:13:57 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 22:13:57 INFO - PROCESS | 6892 | Values: 147.0 145.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 22:13:57 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.26 (1.3%) stddev-sans-first:1.33 22:13:57 INFO - PROCESS | 6892 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 100.0 96.0 22:13:57 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.00 stddev:1.73 (2.9%) stddev-sans-first:1.80 22:13:57 INFO - PROCESS | 6892 | Values: 58.0 60.0 58.0 59.0 58.0 61.0 58.0 59.0 56.0 62.0 22:13:57 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 22:13:57 INFO - PROCESS | 6892 | Values: 67.0 67.0 66.0 68.0 67.0 68.0 66.0 68.0 67.0 67.0 22:13:57 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:3.41 (4.0%) stddev-sans-first:3.35 22:13:57 INFO - PROCESS | 6892 | Values: 82.0 85.0 86.0 93.0 84.0 83.0 85.0 83.0 85.0 90.0 22:13:57 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:123.00 stddev:6.38 (5.2%) stddev-sans-first:6.75 22:13:57 INFO - PROCESS | 6892 | Values: 125.0 118.0 121.0 120.0 121.0 117.0 128.0 134.0 121.0 135.0 22:13:57 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.80 Median:152.50 stddev:8.11 (5.3%) stddev-sans-first:7.39 22:13:57 INFO - PROCESS | 6892 | Values: 141.0 164.0 153.0 162.0 151.0 142.0 152.0 151.0 149.0 163.0 22:13:57 INFO - PROCESS | 6892 | 22:13:57 INFO - PROCESS | 6892 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.64 (2.4%) stddev-sans-first:1.72 22:13:57 INFO - PROCESS | 6892 | Values: 69.0 70.0 68.0 71.0 69.0 67.0 69.0 66.0 68.0 66.0 22:13:57 INFO - PROCESS | 6892 | -------- Summary: end -------- 22:13:57 INFO - PROCESS | 6892 | 22:13:58 INFO - TEST-INFO | 6892: exit 0 22:13:58 INFO - TEST-OK | kraken | took 59814ms 22:13:58 INFO - TEST-START | v8_7 22:13:58 INFO - operating with platform_type : linux_ 22:13:58 INFO - Initialising browser for v8_7 test... 22:13:58 INFO - TEST-INFO | started process 7177 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAY6EjM/profile http://localhost:51707/getInfo.html) 22:14:03 INFO - PROCESS | 7177 | __metrics Screen width/height:1600/1200 22:14:03 INFO - PROCESS | 7177 | colorDepth:24 22:14:03 INFO - PROCESS | 7177 | Browser inner width/height: 1024/697 22:14:03 INFO - PROCESS | 7177 | __metrics 22:14:03 INFO - PROCESS | 7177 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:14:04 INFO - TEST-INFO | 7177: exit 0 22:14:04 INFO - Browser initialized. 22:14:04 INFO - Running cycle 1/1 for v8_7 test... 22:14:04 INFO - TEST-INFO | started process 7301 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAY6EjM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:16 INFO - PROCESS | 7301 | RSS: Main: 151220224 22:14:16 INFO - PROCESS | 7301 | 22:14:37 INFO - PROCESS | 7301 | Cycle 1(1): loaded http://localhost:51707/tests/v8_7/run.html (next: http://localhost:51707/tests/v8_7/run.html) 22:14:37 INFO - PROCESS | 7301 | RSS: Main: 146989056 22:14:37 INFO - PROCESS | 7301 | 22:14:37 INFO - PROCESS | 7301 | __start_tp_report 22:14:37 INFO - PROCESS | 7301 | _x_x_mozilla_page_load 22:14:37 INFO - PROCESS | 7301 | _x_x_mozilla_page_load_details 22:14:37 INFO - PROCESS | 7301 | |i|pagename|runs| 22:14:37 INFO - PROCESS | 7301 | |0;Richards;165.15276630883568 22:14:37 INFO - PROCESS | 7301 | |1;DeltaBlue;188.46588767433096 22:14:37 INFO - PROCESS | 7301 | |2;Encrypt;280.662363177098 22:14:37 INFO - PROCESS | 7301 | |3;Decrypt;5186.5284974093265 22:14:37 INFO - PROCESS | 7301 | |4;RayTrace;1062.6992561105208 22:14:37 INFO - PROCESS | 7301 | |5;Earley;710.2272727272727 22:14:37 INFO - PROCESS | 7301 | |6;Boyer;12216.867469879518 22:14:37 INFO - PROCESS | 7301 | |7;RegExp;24951.219512195123 22:14:37 INFO - PROCESS | 7301 | |8;Splay;594.5303210463734 22:14:37 INFO - PROCESS | 7301 | |9;NavierStokes;4840.579710144928 22:14:37 INFO - PROCESS | 7301 | __end_tp_report 22:14:37 INFO - PROCESS | 7301 | __startTimestamp1450764877965__endTimestamp 22:14:37 INFO - PROCESS | 7301 | 22:14:37 INFO - PROCESS | 7301 | ------- Summary: start ------- 22:14:37 INFO - PROCESS | 7301 | Number of tests: 10 22:14:37 INFO - PROCESS | 7301 | 22:14:37 INFO - PROCESS | 7301 | [#0] Richards Cycles:1 Average:165.15 Median:165.15 stddev:0.00 (0.0%) 22:14:37 INFO - PROCESS | 7301 | Values: 165.2 22:14:37 INFO - PROCESS | 7301 | 22:14:37 INFO - PROCESS | 7301 | [#1] DeltaBlue Cycles:1 Average:188.47 Median:188.47 stddev:0.00 (0.0%) 22:14:37 INFO - PROCESS | 7301 | Values: 188.5 22:14:37 INFO - PROCESS | 7301 | 22:14:37 INFO - PROCESS | 7301 | [#2] Encrypt Cycles:1 Average:280.66 Median:280.66 stddev:0.00 (0.0%) 22:14:37 INFO - PROCESS | 7301 | Values: 280.7 22:14:37 INFO - PROCESS | 7301 | 22:14:37 INFO - PROCESS | 7301 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 22:14:37 INFO - PROCESS | 7301 | Values: 5186.5 22:14:37 INFO - PROCESS | 7301 | 22:14:37 INFO - PROCESS | 7301 | [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 22:14:37 INFO - PROCESS | 7301 | Values: 1062.7 22:14:37 INFO - PROCESS | 7301 | 22:14:37 INFO - PROCESS | 7301 | [#5] Earley Cycles:1 Average:710.23 Median:710.23 stddev:0.00 (0.0%) 22:14:37 INFO - PROCESS | 7301 | Values: 710.2 22:14:37 INFO - PROCESS | 7301 | 22:14:37 INFO - PROCESS | 7301 | [#6] Boyer Cycles:1 Average:12216.87 Median:12216.87 stddev:0.00 (0.0%) 22:14:37 INFO - PROCESS | 7301 | Values: 12216.9 22:14:37 INFO - PROCESS | 7301 | 22:14:37 INFO - PROCESS | 7301 | [#7] RegExp Cycles:1 Average:24951.22 Median:24951.22 stddev:0.00 (0.0%) 22:14:37 INFO - PROCESS | 7301 | Values: 24951.2 22:14:37 INFO - PROCESS | 7301 | 22:14:37 INFO - PROCESS | 7301 | [#8] Splay Cycles:1 Average:594.53 Median:594.53 stddev:0.00 (0.0%) 22:14:37 INFO - PROCESS | 7301 | Values: 594.5 22:14:37 INFO - PROCESS | 7301 | 22:14:37 INFO - PROCESS | 7301 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 22:14:37 INFO - PROCESS | 7301 | Values: 4840.6 22:14:37 INFO - PROCESS | 7301 | -------- Summary: end -------- 22:14:37 INFO - PROCESS | 7301 | 22:14:39 INFO - TEST-INFO | 7301: exit 0 22:14:39 INFO - TEST-OK | v8_7 | took 40061ms 22:14:39 INFO - SUITE-END | took 1210s 22:14:39 INFO - Completed test suite (00:20:11) 22:14:39 INFO - Working with test: dromaeo_css 22:14:39 INFO - Generating results file: dromaeo_css 22:14:39 INFO - Working with test: kraken 22:14:39 INFO - Generating results file: kraken 22:14:39 INFO - javascript benchmark 22:14:39 INFO - Working with test: v8_7 22:14:39 INFO - Generating results file: v8_7 22:14:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:14:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 22:14:39 INFO - process_Request line: dromaeo_css 7119.41 graph.html#tests=[[72,63,43]] 22:14:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:14:39 INFO - process_Request line: kraken 1514.40 graph.html#tests=[[232,63,43]] 22:14:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:14:39 INFO - process_Request line: v8_7 21465.41 graph.html#tests=[[230,63,43]] 22:14:39 INFO - RETURN: dromaeo_css: 7119.41 22:14:39 INFO - RETURN: kraken: 1514.40 22:14:39 INFO - RETURN: v8_7: 21465.41 22:14:39 INFO - javascript benchmark 22:14:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3212.9678703212967, 3253.6746325367453, 3257.2508323085704, 3286.671332866714, 3295.4562497187967, 5231.895362092756, 5378.058839703051, 5382.4886635769535, 5434.0218760623075, 5446.210299506569, 5338.652987555806, 5353.625246232766, 5355.196720491928, 5427.104527752926, 5472.972635136829, 4726.196546587072, 4955.950440495594, 5161.690298582078, 5176.042432150046, 5191.143461328877, 4861.562459378655, 5107.259447380127, 5116.513931176532, 5144.717040562768, 5182.196759502283, 4908.067467181224, 4918.336024636682, 4985.825496107655, 5021.84934451967, 5061.8734531637, 4973.254011898208, 4989.90020199594, 4998.475160108209, 5002.1496345621335, 5029.19532874742, 4844.0, 4901.0, 4973.1297023020825, 4997.600191984632, 5053.343065401511, 5196.1166601677805, 5234.8691282717855, 5238.5023422774775, 5261.5264626183825, 5326.7869285228935, 6011.068284415879, 6022.156898034279, 6024.457798798086, 6027.9095813562835, 6040.365761595057, 5709.371969083398, 5846.21076154718, 5862.736176872008, 6044.214252147237, 6075.33171351151, 5648.293963254593, 5649.265595472603, 5650.802221922254, 5652.463016013472, 5655.688937108416, 6028.156058151862, 6087.269527656621, 6103.725332360054, 6112.786052488231, 6143.754249830046, 5694.487496125369, 5701.429857014348, 5760.049591817387, 5762.394948530427, 5912.970435147883, 5832.50423713989, 5900.1739756434135, 5981.730822113015, 5996.280446346466, 6015.879682406327, 5950.613210141327, 5972.701364931736, 5984.371640977722, 5992.64044157352, 6012.6392416455155, 5751.626144300607, 5864.882702346014, 5990.221271234712, 5991.2510936132985, 6001.819945401645, 4515.435570553681, 4564.566366195206, 4572.725636461823, 4602.608778253819, 4622.86131416058, 4042.6159514846045, 4076.6534844538546, 4088.325426304686, 4088.448059511987, 4110.691698122653, 5398.24424580559, 5446.319210098738, 5503.422140675171, 5548.528375088163, 5611.7474713637985, 5998.520118390518, 6006.339302676702, 6009.729562169713, 6021.126936594169, 6071.089336599545, 5554.666719996813, 5599.440055994368, 5607.299087614048, 5620.1569764534825, 5657.745401456944, 4987.202047672427, 5070.543651071347, 5081.0854046272025, 5107.540321371094, 5213.426523082534, 6027.246594175728, 6043.214382130383, 6051.515878729603, 6051.667158306247, 6130.7241174146375, 5921.319048309328, 6006.909896351645, 6011.338752737282, 6015.368386319374, 6023.156758053964, 5915.112733090071, 5990.101484777319, 6017.127516509994, 6056.57603967718, 6060.181875446759, 5841.649501029951, 5883.441073098049, 5886.205362276038, 5912.5861189718025, 5920.970395147997, 5895.29256489224, 5930.377310382521, 5964.880702385841, 5967.075103358986, 5976.163337132718, 5598.10430331145, 5716.857078573069, 5811.94188058114, 5818.592698511233, 5952.642841429528, 5830.5627077968475, 5845.707714614167, 5850.853728656647, 5877.324107727495, 5880.529557635294, 5683.630564013326, 5686.09022556389, 5687.459691329317, 5688.061469857593, 5708.914366284426, 5667.4332566743, 5742.827715168552, 5781.190633311424, 5800.1299805029585, 5830.82507524775, 5710.885782284414, 5730.541556675373, 5732.512736417451, 5745.166950792195, 5757.251557297524], "unit": "score", "name": "dojo.html", "value": 5450.578744809297}, {"lowerIsBetter": false, "replicates": [568.3208565763911, 598.7006496751624, 615.5198944823037, 615.7075389190132, 620.7299824576312, 37758.433623495635, 38159.0, 38309.42535861964, 38391.61608383915, 38444.23111537771, 41476.37785433221, 41730.37404438928, 41825.58174418255, 41893.162136757244, 41917.371239431435, 8653.783655408617, 8790.64837406503, 8820.338474614398, 8829.558522073903, 8869.600867960957, 8615.913840861574, 8622.611982460805, 8675.045744968049, 8710.259627931633, 8731.476111433303, 8717.956410217972, 8725.171108744658, 8786.384953053288, 8810.647574097029, 8811.427257228292, 8641.697540586081, 8728.60721267538, 8739.95630021849, 8742.825143497126, 8744.256738177262, 8422.620982055822, 8586.184312490303, 8591.5704214789, 8599.269062129726, 8635.481871087755, 39254.21491570152, 39752.801235993924, 39796.80101599502, 39849.20301593952, 39867.0, 3148.071318960889, 3190.9361812763614, 3226.128945184787, 3246.9086557638752, 3249.6912793284837, 29602.70397296021, 30048.24879378033, 30072.8496357519, 30117.397652047057, 30437.69562304393, 3633.3096711624707, 3957.28768821612, 3993.301172294866, 3997.780122093284, 4001.199760047973, 258861.0, 260824.0, 262494.0, 262763.0, 263662.0, 57722.13416798751, 58414.41585584175, 60898.0, 61273.08090378648, 61396.386036139964, 71922.0, 72989.0, 73102.63448682723, 73285.63357183286, 73390.26609733941, 14980.700385992219, 15301.234938253265, 15345.079295242322, 15379.692406151815, 15411.845881541041, 11527.423628818526, 11583.76832463346, 11587.130965177645, 11613.883861161281, 11645.243059201124, 20267.66921803982, 20811.79188208129, 20855.58288834245, 20965.056572454276, 20971.37085887426, 8082.191780821989, 8116.2695357418115, 8251.2986396157, 8293.0, 8397.790055248668, 916.5371487398821, 926.249737712455, 1051.0172988256006, 1063.914886809069, 1150.1718762490993, 27859.0, 28510.857445713053, 28642.713572864006, 28733.13800585986, 29083.709162908523, 1005.4671024357102, 1024.6208902705898, 1040.079529616295, 1046.602291129366, 1158.5365853658604, 16670.16649167537, 17345.913270433568, 17369.913150434168, 17382.130893455276, 17428.738568921475, 362212.0, 368093.0, 368441.0, 368997.0, 370998.0, 53653.7317313411, 53887.73056134773, 54246.186307205426, 54373.72813135909, 54598.18102728462, 1325.5294370498334, 1331.6138319887318, 1341.7383610196114, 1342.4630147940902, 1350.230368689857, 28941.42117157603, 30326.393472130876, 32682.34635307328, 33676.831615841766, 33812.15469613279, 50098.749506252236, 50764.0, 50855.74572127116, 50877.49122508727, 50884.999999998516, 283900.0, 288604.0, 289113.0, 289118.0, 289210.0, 41635.7918210407, 45536.77231613821, 46058.7697061526, 46587.301190482845, 47053.294200587705, 42482.36276455794, 42933.14133717371, 42942.0, 42974.570254297054, 43378.349324760784, 35823.0, 36148.81925590355, 36149.81756807048, 36431.817840910626, 36865.63134368622, 35997.82001089978, 36563.0, 36620.63379366279, 36726.816365918, 36749.0, 35664.0, 41132.38301425541, 41671.58328416677, 41954.1609167821, 42026.159476810906, 29756.256093597833, 32536.83731581327, 33007.66992330142, 33072.0, 33135.0, 24783.0, 24934.87532562398, 25471.235862924143, 25499.617505737056, 26842.731572684803], "unit": "score", "name": "ext.html", "value": 19145.624796468797}, {"lowerIsBetter": false, "replicates": [359.6978538028054, 360.63936063936063, 360.66818526955205, 365.7165696585147, 367.1189146049481, 16992.150392480373, 18038.18828152733, 18478.0, 18918.810811891875, 19327.130279137436, 9989.300748947577, 10304.742381440468, 10376.118029967462, 10427.32222405545, 17169.57076073099, 4946.802127914879, 5103.311053007852, 5194.532492075712, 5518.779248830042, 5535.750891209885, 5397.541208997221, 5450.645708028986, 5454.209139674745, 5454.400015998237, 5459.754311055992, 5125.589952803767, 5134.383873935114, 5271.024860400819, 5385.78456861727, 5410.513053825155, 5236.7905283788605, 5237.7904883804795, 5240.4759524047295, 5241.109011468022, 5280.102382594968, 5013.924791128136, 5137.51193636604, 5141.640085194038, 5148.536631703165, 5183.326167598226, 12502.49990000399, 15104.320305586274, 18880.90559547207, 19423.611527769506, 19450.319238826574, 2162.275637661385, 2172.435166856613, 2177.640689286266, 2204.7574766775642, 2234.1398561553756, 9457.054294570557, 9489.288303377274, 9520.381175223589, 9527.428354298765, 13436.93281533586, 1866.9066546672611, 1877.802830702784, 1897.2885168061978, 1911.5603411215498, 1930.1121484117323, 57619.71190144023, 60011.09983350253, 62963.6851815738, 63069.68465157645, 64337.03494447587, 9671.177949874198, 9755.414675119515, 9769.609215631437, 9810.80378392428, 9878.259130565237, 12912.870871291354, 12973.156744811557, 12989.28558929268, 13090.803637945248, 13106.082574219714, 7448.925510744932, 7517.962410187914, 7521.360684341783, 7578.507397019176, 7688.961555192188, 7155.499115061895, 7167.713291468387, 7179.712811487587, 7181.6409179540815, 7193.244709305448, 4258.361245813091, 4334.913301734011, 4391.14372697321, 4449.532799056053, 4458.130664520388, 1763.8799362404966, 1775.4318618042103, 1779.1993602878756, 1814.4738025972583, 1820.654075725608, 804.3002587748579, 943.5046600534637, 973.1922504321396, 1008.3244226368204, 1072.088724584113, 14894.255287235595, 15679.529614111594, 15694.607634808992, 16515.91742041282, 17552.736708949375, 872.4939535069644, 893.9910600894038, 926.990730092704, 943.306669597845, 984.4437892590806, 8869.201771840566, 9137.588808503633, 9154.084591540792, 9162.175404213653, 9264.861027084598, 521536.0, 525061.0, 528035.0, 546890.0, 547321.0, 78996.21003790003, 80187.59906200548, 80632.0, 80687.0, 80687.19312806914, 1147.5926046253626, 1154.2728081308721, 1218.104693050607, 1221.132995573153, 1236.5424792826711, 14553.636159096108, 14730.631734206301, 14782.186979716218, 14796.926015369854, 14828.40686372533, 33036.1740956478, 33198.0, 33410.832945835115, 33452.996410107735, 34708.132296692784, 45560.0, 46602.766986164854, 47340.0, 48059.27911081267, 51260.74369628128, 9312.767180820534, 9399.765005874908, 9473.100055494717, 9598.856017159887, 9628.566714498005, 11445.427728613702, 11451.59919402817, 11539.423028848692, 13761.38073786702, 17747.11264436799, 13810.792838107236, 14386.856131438552, 14597.12417254968, 14659.780103298672, 14776.63058423548, 14471.131732096108, 14503.274836257933, 14570.4900328488, 14772.852271477148, 14938.253087345807, 15315.770263445835, 15380.077195368314, 15383.69232615319, 15428.614284642525, 15522.301496432914, 9459.101385368655, 9521.857172142285, 9559.283053770856, 9563.0, 9722.173615242784, 11532.654020379403, 14792.704145916807, 14831.555053348417, 15061.021033633217, 15211.315490803161], "unit": "score", "name": "jquery.html", "value": 8703.197517463052}, {"lowerIsBetter": false, "replicates": [1535.3781718404036, 1668.5828542864283, 1725.8619310455165, 1726.6719323328566, 1732.85270751986, 7323.414126869851, 7506.437017223703, 7629.504082234651, 7841.333486653642, 7879.606019699021, 7823.6870525179065, 7860.174681658429, 7884.132745398002, 7907.090684571276, 7923.9207607924045, 2276.3512398966254, 2307.4116100394376, 2313.7223533175957, 2324.8256380771427, 2331.4521087544413, 2286.314105768271, 2323.175272778165, 2333.2067097186955, 2334.7665233476687, 2337.532493501298, 2214.413180507167, 2221.8111460525874, 2246.4159318577126, 2294.6328587426015, 2301.539692061586, 2266.92065777697, 2273.4202778291515, 2300.551392478476, 2302.401375642345, 2317.5364927014666, 2239.8208143348493, 2287.977120228793, 2311.7457079721216, 2320.1531441023903, 2328.1385887221836, 7523.774286771406, 7637.847243055164, 7643.617819109078, 7656.196099409537, 7668.846623067563, 4697.03710739301, 4753.3107699383745, 4773.498782627808, 4776.832810851603, 4784.66507344486, 2970.985145074261, 2972.8067675601233, 3030.1061186949682, 3052.6794686558037, 3066.3254084101463, 934.7429456899339, 941.1153515695224, 941.3692825806726, 949.4113649537331, 993.2699465892563, 10473.738156546071, 10507.947460262727, 10553.84169237462, 10576.68269951895, 10577.0, 4066.1664358806374, 4108.260513107669, 4136.73111247768, 4140.0270936329935, 4177.206330797138, 8606.655733770704, 8666.86999695005, 8669.479831210148, 8688.695895643623, 8696.478211307342, 4670.416197975253, 4681.274402467623, 4695.319178719066, 4705.95294047062, 4717.174494463524, 4267.530571637118, 4305.461817272841, 4311.245532031882, 4315.287977483743, 4319.092990472036, 3497.89506314811, 3515.3672338978718, 3541.94687079694, 3542.0436482149676, 3548.716102711777, 1071.8124328242527, 1096.040964156363, 1100.8403781451646, 1102.2064113838023, 1103.3986477369854, 956.4596003258137, 964.9807003859884, 1033.328336581213, 1058.5818601652459, 1296.623979046066, 7148.499605027702, 7159.642017899084, 7207.099112610924, 7222.530535515175, 7255.709771609182, 957.7557722780786, 958.2190514730472, 960.1790469148917, 960.313375936195, 965.2760429677742, 5718.370979192286, 5721.284839395075, 5737.741801618937, 5757.539396848242, 5769.134629805562, 7938.801529961682, 8018.118007019223, 8129.715459958873, 9073.637054517878, 9197.724068277963, 8972.641094356153, 8997.0, 9040.502772347583, 9086.409383390059, 9102.31732620043, 7217.0, 7283.635818209068, 7289.3439590436055, 7292.598907060056, 7298.306660867315, 7140.571565706075, 7216.9278307216255, 7223.458240632079, 7227.349538541556, 7228.855422891618, 8119.30985866208, 8353.24820766134, 8359.623816928131, 8379.95810020946, 8440.83118337642, 8017.799555011172, 8079.111297757125, 8085.9595702021115, 8134.349252059703, 8218.137095604876, 6617.702203400955, 6906.654667266717, 6928.445724342141, 6932.722691092502, 6959.304069593, 7318.048653675201, 7396.112466504054, 7409.962950185214, 7417.147028091623, 7429.7399591014055, 6286.214223222098, 6925.238223795479, 6928.930710692828, 7024.121984751906, 7149.320814522612, 6839.0, 6904.275051119761, 6941.132358455193, 6975.895361569479, 6977.581345119309, 6751.3586209312, 6952.826179345557, 6982.581045137308, 6990.370866622028, 6996.405305549085, 6291.433770960452, 6300.401461861115, 6305.369463053658, 6316.842078948063, 6319.842003949938, 6369.45859601939, 6466.418022378009, 6498.837529061811, 6505.772297969548, 6513.8697226056165], "unit": "score", "name": "mootools.html", "value": 4407.035933998252}, {"lowerIsBetter": false, "replicates": [341.9692227699507, 343.6580602300711, 343.80918590182455, 345.06659486090126, 351.9384107781138, 6236.469900058501, 6352.110704501373, 6413.8075857724225, 6431.581947173437, 6466.7736629217925, 6119.969400153004, 6285.088662143987, 6303.9369606304035, 6306.1171435998995, 6321.841953951153, 4839.15314819906, 4867.415910090794, 4885.902281954359, 4892.8042878285005, 4897.632677549181, 4881.4874438184015, 4890.902181956359, 4897.338859254009, 4898.338724272213, 4905.852824415273, 4645.488996210431, 4699.976500117495, 4755.9286610700865, 4760.143174228638, 4763.047390521892, 4721.881952951187, 4748.050389922012, 4775.450823155347, 4787.736674482902, 4795.184818580849, 4134.937975930364, 4143.08852052548, 4147.0, 4148.087420767426, 4151.647109995654, 5981.730822113015, 6054.4550990410635, 6058.0, 6061.696915154269, 6062.757489700407, 5567.832965011056, 5594.4964953154, 5624.15637654351, 5624.746886390122, 5625.493705566478, 6754.189497260311, 6755.493337999621, 6760.864782704319, 6762.425193858528, 6763.932360676379, 4636.53634636537, 4642.257238841803, 4647.070585882837, 4648.767561621939, 4664.253719404879, 6911.827204319882, 6924.7576334828545, 6972.2330543640155, 7012.632536655355, 7036.612986285752, 4648.767561621906, 4654.86035418938, 4661.394018777537, 4676.275177347448, 4698.3187437821325, 4745.549172828576, 4765.11845308619, 4773.427188737373, 4778.211595086772, 4791.6406269529925, 5595.496405323459, 5599.916001259984, 5605.299337582802, 5608.85977850557, 5612.158176273591, 6608.669566521655, 6786.778379891667, 6849.417799487, 6851.48613853953, 6855.862882742317, 1572.3710515793773, 1580.0440733356384, 1660.3109709470434, 1686.6879627268995, 1693.8560222381236, 1097.4512743628186, 1113.4154568851256, 1122.0, 1122.7361570031037, 1128.6896103571582, 6405.455536279468, 6408.231012278557, 6413.454856337264, 6431.389018043278, 6433.967830160819, 6880.483963702743, 6956.200036995709, 6957.095577574984, 6974.476914231352, 6981.89527157093, 6370.235571731422, 6406.263279722892, 6416.230052393743, 6422.582532135396, 6434.871302573923, 3821.312163810541, 3856.807159642007, 3872.206197729459, 3878.204967981557, 3881.3013657541915, 7181.533200341961, 7202.099737532809, 7226.060612120391, 7234.457415693844, 7237.312455316736, 7168.713251469987, 7295.452841036943, 7304.926950730424, 7318.853622927511, 7325.0, 7139.714411423485, 7142.535735177197, 7170.8207294817, 7199.424046076301, 7215.098112735908, 7054.788356349318, 7075.080239568823, 7093.6453177341955, 7108.751193708195, 7115.359617634231, 6812.080369150101, 7020.227774944854, 7025.789226323219, 7030.613316267654, 7052.576845389293, 7248.202697703354, 7249.818754531179, 7251.854962900818, 7253.746118885813, 7261.927380726336, 4840.1529732296, 4866.148424025852, 4878.0000099980125, 4884.462709102067, 4893.779779909842, 6936.132983377078, 6943.375096241362, 7037.507374483737, 7050.8237294066, 7060.54106483077, 6902.792916212522, 6919.584824910521, 6927.618980955895, 6945.756898508528, 6954.8956765647545, 6828.214755303005, 6902.378785909092, 6904.067950826775, 6906.551074180162, 6912.792616221522, 6509.934900650933, 6626.536142470173, 6636.7013484392355, 6712.798616041527, 6716.462682985251, 6922.06552115458, 6928.7228510859, 6930.826729331606, 6937.236903940663, 6939.653017349214, 6694.497912656473, 6733.124693789776, 6740.764073257413, 6752.054712340375, 6752.561083529555], "unit": "score", "name": "prototype.html", "value": 5085.798408136762}, {"lowerIsBetter": false, "replicates": [724.7644515532453, 737.9262073792621, 830.5598033042489, 855.1662129423817, 876.8202518483712, 12826.935865320673, 13028.0, 13038.413271402786, 13064.608061758163, 13155.934220328885, 12150.210236334655, 12258.938705306484, 12325.322107284095, 12355.0, 13603.38784754686, 817.914119017505, 819.5983967855767, 823.5799742131496, 825.224289168183, 829.1956801902145, 825.5995842016617, 829.8298848736025, 832.8584140696066, 834.3742193354984, 834.4117397234966, 870.6952566601702, 870.7170169694874, 874.0734821089666, 876.027609353617, 878.0078511282275, 858.3991206155654, 860.4665107633244, 861.1001503428901, 864.7924498120437, 866.0516734176099, 631.5137344244906, 635.3551145587232, 636.656205648949, 638.0333794301637, 638.2245571630491, 12870.0, 12970.156939798882, 12999.480020799158, 13006.86993130066, 13028.0, 10275.075243228146, 10368.13373592753, 10892.0, 10976.890231097746, 11009.669709908716, 9907.801843963152, 10077.596896124147, 10156.4921753912, 10257.330045088836, 10342.689719308433, 3626.528551288342, 3637.1270894985014, 3685.4471829225563, 3692.372296709539, 3791.905202369963, 41251.793741031404, 42260.15479690389, 46534.53465465336, 47624.28563571549, 48073.03853922902, 10505.31715438494, 10578.57685692579, 10587.311824731369, 10730.678079657622, 11000.119990400748, 18813.059347032868, 18822.247110115717, 18866.151023203987, 18892.244310227437, 18911.0, 7794.493357931717, 7895.921040789519, 7897.921020789833, 7993.120756716757, 8165.387595930329, 4385.210662080793, 4463.352813841975, 4494.235979883428, 4515.074409745994, 4548.13585418776, 3209.3902158589794, 3220.838958052088, 3226.6934641209045, 3228.6287076985977, 3241.5137729340786, 588.4027711872453, 604.1391017799618, 613.9048447490557, 615.4460985113434, 627.2003195925232, 668.1814776898261, 682.6279677575634, 697.1982220446425, 698.5284932670427, 711.0756017177648, 8169.836603267901, 8588.957055214683, 8646.3947523674, 8797.252233560092, 8826.293896488265, 536.4608568388744, 570.9771609135671, 604.9987271066392, 699.0946723992442, 701.1340993872564, 3866.613338666111, 4069.5726948670554, 4298.26929421999, 4471.61991230749, 4504.144212599595, 54881.45118548763, 55018.0, 55228.723856381264, 55448.0, 55861.44138558643, 48989.755051224514, 49302.50697492979, 49447.75276123596, 49665.751671242135, 49737.75131124321, 39723.20553588912, 40465.1906961865, 51028.48971510312, 51688.96622067538, 52018.0, 8333.208345207195, 9128.224100951493, 9265.397749146285, 9279.164875161268, 9315.39449935752, 34379.65620343765, 35187.472187917716, 35398.46902296519, 36180.0, 36812.815935920145, 43393.56606433895, 44068.55931440645, 44358.33462498001, 44405.555944440144, 44859.327110094026, 11130.165237607374, 11290.379029153475, 11294.60468883585, 11345.659630211107, 11640.0, 12342.691432713895, 12457.439415226156, 12458.0, 12514.74970500603, 12617.49530018789, 11351.205415621158, 11641.708957276136, 11653.242539234923, 11919.404029798648, 12467.75064498723, 11735.823962640738, 12037.939810300892, 12122.515099395925, 12215.0, 12375.616026363241, 11550.422478875855, 11769.411529423323, 11963.222390544586, 12091.758164836478, 12507.687307817378, 10058.492374031817, 10200.58841915683, 10439.112675422673, 10454.42500662471, 10799.028087472165, 9281.814363712823, 9445.0, 9894.752631184278, 10317.74205644865, 10502.474876256309], "unit": "score", "name": "yui.html", "value": 6396.2882341322875}], "name": "dromaeo_css", "value": 7119.406766728111}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 112.0, 110.0, 110.0, 122.0, 111.0, 110.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [147.0, 123.0, 148.0, 161.0, 127.0, 164.0, 175.0, 137.0, 166.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [160.0, 163.0, 161.0, 162.0, 161.0, 161.0, 161.0, 163.0, 172.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 72.0, 73.0, 134.0, 71.0, 73.0, 73.0, 72.0], "unit": "score", "name": "audio-fft", "value": 78.2}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 140.0, 93.0, 93.0, 93.0, 131.0, 93.0, 95.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 111.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 100.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [58.0, 60.0, 58.0, 59.0, 58.0, 61.0, 58.0, 59.0, 56.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 58.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 68.0, 67.0, 68.0, 66.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 86.0, 93.0, 84.0, 83.0, 85.0, 83.0, 85.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [125.0, 118.0, 121.0, 120.0, 121.0, 117.0, 128.0, 134.0, 121.0, 135.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.0}, {"lowerIsBetter": true, "replicates": [141.0, 164.0, 153.0, 162.0, 151.0, 142.0, 152.0, 151.0, 149.0, 163.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.8}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 68.0, 71.0, 69.0, 67.0, 69.0, 66.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1514.3999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.15276630883568], "unit": "score", "name": "Richards", "value": 213.75361000000004}, {"lowerIsBetter": false, "replicates": [188.46588767433096], "unit": "score", "name": "DeltaBlue", "value": 350.8221079999999}, {"lowerIsBetter": false, "replicates": [280.662363177098], "unit": "score", "name": "Encrypt", "value": 948.4029029999999}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1062.6992561105208], "unit": "score", "name": "RayTrace", "value": 696.3296489999998}, {"lowerIsBetter": false, "replicates": [710.2272727272727], "unit": "score", "name": "Earley", "value": 938.3799039999997}, {"lowerIsBetter": false, "replicates": [12216.867469879518], "unit": "score", "name": "Boyer", "value": 54.55269132149902}, {"lowerIsBetter": false, "replicates": [24951.219512195123], "unit": "score", "name": "RegExp", "value": 36.51064027370476}, {"lowerIsBetter": false, "replicates": [594.5303210463734], "unit": "score", "name": "Splay", "value": 137.06786199999996}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21465.412335752608}]} 22:14:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21465.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1514.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "7119.41"}}} 22:14:39 INFO - Return code: 0 22:14:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:14:39 INFO - # TBPL SUCCESS # 22:14:39 INFO - Running post-action listener: _resource_record_post_action 22:14:39 INFO - Running post-run listener: _resource_record_post_run 22:14:40 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 20480; Write bytes: 558972928; Read time: 56; Write time: 375848 22:14:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 235102208; Read time: 0; Write time: 212392 22:14:40 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 20480; Write bytes: 323870720; Read time: 56; Write time: 163456 22:14:40 INFO - Running post-run listener: _upload_blobber_files 22:14:40 INFO - Blob upload gear active. 22:14:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:14:40 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:14:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:14:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:14:41 INFO - (blobuploader) - INFO - Open directory for files ... 22:14:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:14:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:14:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:14:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:14:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:14:42 INFO - (blobuploader) - INFO - Done attempting. 22:14:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:14:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:14:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:14:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:14:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:14:42 INFO - (blobuploader) - INFO - Done attempting. 22:14:42 INFO - (blobuploader) - INFO - Iteration through files over. 22:14:42 INFO - Return code: 0 22:14:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:14:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:14:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f7bddc1b425259298dfd28de7a52149097cfec7d6caf06f68f843d63647635962a8346200c915660f39977871d67a958928c255218bdf15f67088ea83e0a5daf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f5a5e6c716497250fa35a221be5aec326ebcf3dd05f4c7eb6300a596f289709d9893d2b633d21f1bbad0d9dd88993b6cc339b04ee8cb40d9a11f6673c23423d3"} 22:14:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:14:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:14:42 INFO - Contents: 22:14:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f7bddc1b425259298dfd28de7a52149097cfec7d6caf06f68f843d63647635962a8346200c915660f39977871d67a958928c255218bdf15f67088ea83e0a5daf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f5a5e6c716497250fa35a221be5aec326ebcf3dd05f4c7eb6300a596f289709d9893d2b633d21f1bbad0d9dd88993b6cc339b04ee8cb40d9a11f6673c23423d3"} 22:14:42 INFO - Copying logs to upload dir... 22:14:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.218250 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-21 22:14:42.408524) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 22:14:42.411865) ========= 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=7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f7bddc1b425259298dfd28de7a52149097cfec7d6caf06f68f843d63647635962a8346200c915660f39977871d67a958928c255218bdf15f67088ea83e0a5daf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f5a5e6c716497250fa35a221be5aec326ebcf3dd05f4c7eb6300a596f289709d9893d2b633d21f1bbad0d9dd88993b6cc339b04ee8cb40d9a11f6673c23423d3"} build_url:https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011123 build_url: 'https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f7bddc1b425259298dfd28de7a52149097cfec7d6caf06f68f843d63647635962a8346200c915660f39977871d67a958928c255218bdf15f67088ea83e0a5daf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f5a5e6c716497250fa35a221be5aec326ebcf3dd05f4c7eb6300a596f289709d9893d2b633d21f1bbad0d9dd88993b6cc339b04ee8cb40d9a11f6673c23423d3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 22:14:42.436599) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:14:42.436924) ========= 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=7d909545e45784438f4e8e36000001b3-1450757739.481039-1107249166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004385 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:14:42.522499) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 22:14:42.522832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 22:14:42.523147) ========= ========= Total master_lag: 0.25 =========