builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-030 starttime: 1451184444.8 results: success (0) buildid: 20151226163004 builduid: 2abff7d4f28f4d679380d1eedad73d62 revision: 4c4e8470286f0dc817e988189f6584ba5d4ff5a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.803151) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.803622) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.803961) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006373 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.866234) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.866567) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.974201) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.974509) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004628 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.028108) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.028411) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.028800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.029132) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-26 18:47:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2015-12-26 18:47:25 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171217 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.214700) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.215431) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018422 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.268185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.268569) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4c4e8470286f0dc817e988189f6584ba5d4ff5a6 --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 4c4e8470286f0dc817e988189f6584ba5d4ff5a6 --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=23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-26 18:47:25,850 truncating revision to first 12 chars 2015-12-26 18:47:25,850 Setting DEBUG logging. 2015-12-26 18:47:25,850 attempt 1/10 2015-12-26 18:47:25,851 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4c4e8470286f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-26 18:47:26,092 unpacking tar archive at: mozilla-inbound-4c4e8470286f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528037 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.810437) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.810744) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.828666) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.828956) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.829388) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-26 18:47:25.829700) ========= /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=23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:47:26 INFO - MultiFileLogger online at 20151226 18:47:26 in /builds/slave/test-pgo 18:47:26 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 18:47:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:47:26 INFO - {'append_to_log': False, 18:47:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:47:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:47:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:47:26 INFO - 'branch': 'Mozilla-Inbound', 18:47:26 INFO - 'buildbot_json_path': 'buildprops.json', 18:47:26 INFO - 'config_files': ('talos/linux_config.py',), 18:47:26 INFO - 'default_actions': ('clobber', 18:47:26 INFO - 'read-buildbot-config', 18:47:26 INFO - 'download-and-extract', 18:47:26 INFO - 'populate-webroot', 18:47:26 INFO - 'create-virtualenv', 18:47:26 INFO - 'install', 18:47:26 INFO - 'run-tests'), 18:47:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:47:26 INFO - 'download_minidump_stackwalk': True, 18:47:26 INFO - 'download_symbols': 'ondemand', 18:47:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:47:26 INFO - 'tooltool.py': '/tools/tooltool.py', 18:47:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:47:26 INFO - '/tools/misc-python/virtualenv.py')}, 18:47:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:47:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:47:26 INFO - 'installer_path': 'installer.exe', 18:47:26 INFO - 'log_level': 'info', 18:47:26 INFO - 'log_name': 'talos', 18:47:26 INFO - 'log_to_console': True, 18:47:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:47:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:47:26 INFO - 'opt_config_files': (), 18:47:26 INFO - 'pip_index': False, 18:47:26 INFO - 'sps_profile': False, 18:47:26 INFO - 'sps_profile_interval': 0, 18:47:26 INFO - 'suite': 'dromaeojs-e10s', 18:47:26 INFO - 'system_bits': '64', 18:47:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:47:26 INFO - 'title': 'talos-linux64-ix-030', 18:47:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:47:26 INFO - 'use_talos_json': True, 18:47:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:47:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:47:26 INFO - 'work_dir': 'build'} 18:47:26 INFO - ##### 18:47:26 INFO - ##### Running clobber step. 18:47:26 INFO - ##### 18:47:26 INFO - Running pre-action listener: _resource_record_pre_action 18:47:26 INFO - Running main action method: clobber 18:47:26 INFO - rmtree: /builds/slave/test-pgo/build 18:47:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:47:26 INFO - Running post-action listener: _resource_record_post_action 18:47:26 INFO - ##### 18:47:26 INFO - ##### Running read-buildbot-config step. 18:47:26 INFO - ##### 18:47:26 INFO - Running pre-action listener: _resource_record_pre_action 18:47:26 INFO - Running main action method: read_buildbot_config 18:47:26 INFO - Using buildbot properties: 18:47:26 INFO - { 18:47:26 INFO - "project": "", 18:47:26 INFO - "product": "firefox", 18:47:26 INFO - "script_repo_revision": "production", 18:47:26 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 18:47:26 INFO - "repository": "", 18:47:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 18:47:26 INFO - "buildid": "20151226163004", 18:47:26 INFO - "pgo_build": "True", 18:47:26 INFO - "basedir": "/builds/slave/test-pgo", 18:47:26 INFO - "buildnumber": 554, 18:47:26 INFO - "slavename": "talos-linux64-ix-030", 18:47:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:47:26 INFO - "platform": "ubuntu64_hw", 18:47:26 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:47:26 INFO - "branch": "mozilla-inbound", 18:47:26 INFO - "repo_path": "integration/mozilla-inbound", 18:47:26 INFO - "revision": "4c4e8470286f0dc817e988189f6584ba5d4ff5a6", 18:47:26 INFO - "stage_platform": "linux64-pgo", 18:47:26 INFO - "builduid": "2abff7d4f28f4d679380d1eedad73d62", 18:47:26 INFO - "slavebuilddir": "test" 18:47:26 INFO - } 18:47:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:47:26 INFO - Running post-action listener: _resource_record_post_action 18:47:26 INFO - ##### 18:47:26 INFO - ##### Running download-and-extract step. 18:47:26 INFO - ##### 18:47:26 INFO - Running pre-action listener: _resource_record_pre_action 18:47:26 INFO - Running main action method: download_and_extract 18:47:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:47: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')]} 18:47:26 INFO - https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:47:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/test_packages.json 18:47:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/test_packages.json 18:47:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:47:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:47:31 INFO - Downloaded 1302 bytes. 18:47:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:47:31 INFO - Using the following test package requirements: 18:47:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:47:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:31 INFO - u'jsshell-linux-x86_64.zip'], 18:47:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:47:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:47:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:47:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:47:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:47:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:47: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')]} 18:47:31 INFO - https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:47:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/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 18:47:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/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 18:47:40 INFO - Downloaded 23191568 bytes. 18:47: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 18:47:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47: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 18:47:41 INFO - Return code: 0 18:47:41 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 18:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:41 INFO - https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:47:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/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 18:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/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 18:47:44 INFO - Downloaded 23191568 bytes. 18:47:44 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 18:47:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:44 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 18:47:45 INFO - Return code: 0 18:47: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')]} 18:47:45 INFO - https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:47:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/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 18:47:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/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 18:47:47 INFO - Downloaded 11132270 bytes. 18:47:47 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 18:47:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:47 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 18:47:47 INFO - Return code: 0 18:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:47 INFO - https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:47:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:47:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:47:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/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 18:47:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/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 18:47:48 INFO - Downloaded 54927265 bytes. 18:47:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:47:48 INFO - mkdir: /builds/slave/test-pgo/properties 18:47:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:47:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:47:48 INFO - Contents: 18:47:48 INFO - build_url:https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:47:48 INFO - Running post-action listener: _resource_record_post_action 18:47:48 INFO - Running post-action listener: set_extra_try_arguments 18:47:48 INFO - ##### 18:47:48 INFO - ##### Running populate-webroot step. 18:47:48 INFO - ##### 18:47:48 INFO - Running pre-action listener: _resource_record_pre_action 18:47:48 INFO - Running main action method: populate_webroot 18:47:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:47:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:47:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:47:48 INFO - '--tppagecycles', 18:47:48 INFO - '7'], 18:47:48 INFO - 'tests': ['tsvgm']}}, 18:47:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:47:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:47:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:47:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:47:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:47:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:47:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:47:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:48 INFO - 'talos_options': ['--e10s'], 18:47:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:47:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:48 INFO - 'tests': ['damp', 'tps']}, 18:47:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:48 INFO - 'talos_options': ['--e10s'], 18:47:48 INFO - 'tests': ['damp', 'tps']}, 18:47:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:47:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:47:48 INFO - 'other': {'tests': ['a11yr', 18:47:48 INFO - 'ts_paint', 18:47:48 INFO - 'tpaint', 18:47:48 INFO - 'sessionrestore', 18:47:48 INFO - 'sessionrestore_no_auto_restore']}, 18:47:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:47:48 INFO - 'tests': ['a11yr', 18:47:48 INFO - 'ts_paint', 18:47:48 INFO - 'tpaint', 18:47:48 INFO - 'sessionrestore', 18:47:48 INFO - 'sessionrestore_no_auto_restore']}, 18:47:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:47:48 INFO - 'tests': ['a11yr', 18:47:48 INFO - 'ts_paint', 18:47:48 INFO - 'tpaint', 18:47:48 INFO - 'sessionrestore', 18:47:48 INFO - 'sessionrestore_no_auto_restore']}, 18:47:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:47:48 INFO - 'tests': ['a11yr', 18:47:48 INFO - 'ts_paint', 18:47:48 INFO - 'tpaint', 18:47:48 INFO - 'sessionrestore', 18:47:48 INFO - 'sessionrestore_no_auto_restore']}, 18:47:48 INFO - 'other_l64': {'tests': ['a11yr', 18:47:48 INFO - 'ts_paint', 18:47:48 INFO - 'tpaint', 18:47:48 INFO - 'sessionrestore', 18:47:48 INFO - 'sessionrestore_no_auto_restore']}, 18:47:48 INFO - 'other_nol64': {'tests': ['a11yr', 18:47:48 INFO - 'ts_paint', 18:47:48 INFO - 'tpaint', 18:47:48 INFO - 'sessionrestore', 18:47:48 INFO - 'sessionrestore_no_auto_restore']}, 18:47:48 INFO - 'svgr': {'tests': ['tsvgx', 18:47:48 INFO - 'tsvgr_opacity', 18:47:48 INFO - 'tart', 18:47:48 INFO - 'tscrollx', 18:47:48 INFO - 'cart']}, 18:47:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:47:48 INFO - 'tests': ['tsvgx', 18:47:48 INFO - 'tsvgr_opacity', 18:47:48 INFO - 'tart', 18:47:48 INFO - 'tscrollx', 18:47:48 INFO - 'cart']}, 18:47:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:48 INFO - 'tests': ['tp5o']}, 18:47:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:48 INFO - 'talos_options': ['--e10s'], 18:47:48 INFO - 'tests': ['tp5o']}, 18:47:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:48 INFO - 'talos_options': ['--xperf_path', 18:47:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:47:48 INFO - 'tests': ['tp5n']}, 18:47:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:48 INFO - 'talos_options': ['--e10s', 18:47:48 INFO - '--xperf_path', 18:47:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:47:48 INFO - 'tests': ['tp5n']}}, 18:47:48 INFO - 'talos.zip': {'path': '', 18:47:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:47:48 INFO - Running post-action listener: _resource_record_post_action 18:47:48 INFO - ##### 18:47:48 INFO - ##### Running create-virtualenv step. 18:47:48 INFO - ##### 18:47:48 INFO - Running pre-action listener: _resource_record_pre_action 18:47:48 INFO - Running main action method: create_virtualenv 18:47:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:47:48 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 18:47:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:47:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:47:48 INFO - Using real prefix '/usr' 18:47:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:47:49 INFO - Installing distribute.............................................................................................................................................................................................done. 18:47:51 INFO - Installing pip.................done. 18:47:51 INFO - Return code: 0 18:47:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:51 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 0x7f92a0135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167f0>, '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 0x15822d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582760>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', '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 18:47:51 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 18:47:51 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 18:47:51 INFO - Using env: {'DISPLAY': ':0', 18:47:51 INFO - 'HOME': '/home/cltbld', 18:47:51 INFO - 'LANG': 'en_US.UTF-8', 18:47:51 INFO - 'LANGUAGE': 'en_US:en', 18:47:51 INFO - 'LOGNAME': 'cltbld', 18:47:51 INFO - 'MAIL': '/var/mail/cltbld', 18:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:51 INFO - 'MOZ_NO_REMOTE': '1', 18:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:51 INFO - 'NO_EM_RESTART': '1', 18:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:51 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:51 INFO - 'SHELL': '/bin/bash', 18:47:51 INFO - 'SHLVL': '1', 18:47:51 INFO - 'TERM': 'linux', 18:47:51 INFO - 'TMOUT': '86400', 18:47:51 INFO - 'USER': 'cltbld', 18:47:51 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', 18:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:51 INFO - '_': '/tools/buildbot/bin/python'} 18:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:51 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 18:47:51 INFO - Cleaning up... 18:47:51 INFO - Return code: 0 18:47:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:51 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 0x7f92a0135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167f0>, '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 0x15822d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582760>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', '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 18:47:51 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 18:47:51 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 18:47:51 INFO - Using env: {'DISPLAY': ':0', 18:47:51 INFO - 'HOME': '/home/cltbld', 18:47:51 INFO - 'LANG': 'en_US.UTF-8', 18:47:51 INFO - 'LANGUAGE': 'en_US:en', 18:47:51 INFO - 'LOGNAME': 'cltbld', 18:47:51 INFO - 'MAIL': '/var/mail/cltbld', 18:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:51 INFO - 'MOZ_NO_REMOTE': '1', 18:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:51 INFO - 'NO_EM_RESTART': '1', 18:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:51 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:51 INFO - 'SHELL': '/bin/bash', 18:47:51 INFO - 'SHLVL': '1', 18:47:51 INFO - 'TERM': 'linux', 18:47:51 INFO - 'TMOUT': '86400', 18:47:51 INFO - 'USER': 'cltbld', 18:47:51 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', 18:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:51 INFO - '_': '/tools/buildbot/bin/python'} 18:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:51 INFO - Downloading/unpacking psutil>=0.7.1 18:47:51 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 18:47:51 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 18:47:51 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 18:47:51 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 18:47:51 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 18:47:51 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 18:47:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:47:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:47:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:47:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:47:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:47:53 INFO - Installing collected packages: psutil 18:47:53 INFO - Running setup.py install for psutil 18:47:53 INFO - building 'psutil._psutil_linux' extension 18:47:53 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 18:47:53 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 18:47:53 INFO - building 'psutil._psutil_posix' extension 18:47:53 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 18:47:53 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 18:47:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:47:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:47:53 INFO - Successfully installed psutil 18:47:53 INFO - Cleaning up... 18:47:54 INFO - Return code: 0 18:47:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:54 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 0x7f92a0135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167f0>, '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 0x15822d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582760>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', '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 18:47:54 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 18:47:54 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 18:47:54 INFO - Using env: {'DISPLAY': ':0', 18:47:54 INFO - 'HOME': '/home/cltbld', 18:47:54 INFO - 'LANG': 'en_US.UTF-8', 18:47:54 INFO - 'LANGUAGE': 'en_US:en', 18:47:54 INFO - 'LOGNAME': 'cltbld', 18:47:54 INFO - 'MAIL': '/var/mail/cltbld', 18:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:54 INFO - 'MOZ_NO_REMOTE': '1', 18:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:54 INFO - 'NO_EM_RESTART': '1', 18:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:54 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:54 INFO - 'SHELL': '/bin/bash', 18:47:54 INFO - 'SHLVL': '1', 18:47:54 INFO - 'TERM': 'linux', 18:47:54 INFO - 'TMOUT': '86400', 18:47:54 INFO - 'USER': 'cltbld', 18:47:54 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', 18:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:54 INFO - '_': '/tools/buildbot/bin/python'} 18:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:47:54 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 18:47:54 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 18:47:54 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 18:47:54 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 18:47:54 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 18:47:54 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 18:47:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:47:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:47:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:47: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) 18:47:55 INFO - Installing collected packages: mozsystemmonitor 18:47:55 INFO - Running setup.py install for mozsystemmonitor 18:47:56 INFO - Successfully installed mozsystemmonitor 18:47:56 INFO - Cleaning up... 18:47:56 INFO - Return code: 0 18:47:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:56 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 0x7f92a0135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167f0>, '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 0x15822d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582760>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', '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 18:47:56 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 18:47:56 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 18:47:56 INFO - Using env: {'DISPLAY': ':0', 18:47:56 INFO - 'HOME': '/home/cltbld', 18:47:56 INFO - 'LANG': 'en_US.UTF-8', 18:47:56 INFO - 'LANGUAGE': 'en_US:en', 18:47:56 INFO - 'LOGNAME': 'cltbld', 18:47:56 INFO - 'MAIL': '/var/mail/cltbld', 18:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:56 INFO - 'MOZ_NO_REMOTE': '1', 18:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:56 INFO - 'NO_EM_RESTART': '1', 18:47:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:56 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:56 INFO - 'SHELL': '/bin/bash', 18:47:56 INFO - 'SHLVL': '1', 18:47:56 INFO - 'TERM': 'linux', 18:47:56 INFO - 'TMOUT': '86400', 18:47:56 INFO - 'USER': 'cltbld', 18:47:56 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', 18:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:56 INFO - '_': '/tools/buildbot/bin/python'} 18:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:56 INFO - Downloading/unpacking blobuploader==1.2.4 18:47:56 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 18:47:56 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 18:47:56 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 18:47:56 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 18:47:56 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 18:47:56 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 18:47:57 INFO - Downloading blobuploader-1.2.4.tar.gz 18:47:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:47:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:47:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:47:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:47:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:58 INFO - Downloading docopt-0.6.1.tar.gz 18:47:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:47:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:47:58 INFO - Installing collected packages: blobuploader, requests, docopt 18:47:58 INFO - Running setup.py install for blobuploader 18:47:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:47:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:47:58 INFO - Running setup.py install for requests 18:47:59 INFO - Running setup.py install for docopt 18:47:59 INFO - Successfully installed blobuploader requests docopt 18:47:59 INFO - Cleaning up... 18:47:59 INFO - Return code: 0 18:47:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:59 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 0x7f92a0135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167f0>, '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 0x15822d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582760>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', '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 18:47:59 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 18:47:59 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 18:47:59 INFO - Using env: {'DISPLAY': ':0', 18:47:59 INFO - 'HOME': '/home/cltbld', 18:47:59 INFO - 'LANG': 'en_US.UTF-8', 18:47:59 INFO - 'LANGUAGE': 'en_US:en', 18:47:59 INFO - 'LOGNAME': 'cltbld', 18:47:59 INFO - 'MAIL': '/var/mail/cltbld', 18:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:59 INFO - 'MOZ_NO_REMOTE': '1', 18:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:59 INFO - 'NO_EM_RESTART': '1', 18:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:59 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:59 INFO - 'SHELL': '/bin/bash', 18:47:59 INFO - 'SHLVL': '1', 18:47:59 INFO - 'TERM': 'linux', 18:47:59 INFO - 'TMOUT': '86400', 18:47:59 INFO - 'USER': 'cltbld', 18:47:59 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', 18:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:59 INFO - '_': '/tools/buildbot/bin/python'} 18:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:59 INFO - Running setup.py (path:/tmp/pip-6cSgqb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:59 INFO - Running setup.py (path:/tmp/pip-McfOZ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:59 INFO - Running setup.py (path:/tmp/pip-70w_BP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:59 INFO - Running setup.py (path:/tmp/pip-J4zwPx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:59 INFO - Running setup.py (path:/tmp/pip-yyDkxW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:59 INFO - Running setup.py (path:/tmp/pip-sqB5sY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:59 INFO - Running setup.py (path:/tmp/pip-C6JGE2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:59 INFO - Running setup.py (path:/tmp/pip-rnFCil-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:48:00 INFO - Running setup.py (path:/tmp/pip-nhCOCW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:48:00 INFO - Running setup.py (path:/tmp/pip-6PfSoj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:48:00 INFO - Running setup.py (path:/tmp/pip-jp43po-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:48:00 INFO - Running setup.py (path:/tmp/pip-MNWIqX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:48:00 INFO - Running setup.py (path:/tmp/pip-eKe1uZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:48:00 INFO - Running setup.py (path:/tmp/pip-oecArk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:48:00 INFO - Running setup.py (path:/tmp/pip-7WAnMl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:48:00 INFO - Running setup.py (path:/tmp/pip-CdsbBB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:48:00 INFO - Running setup.py (path:/tmp/pip-HZV0Ft-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:48:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:48:00 INFO - Running setup.py install for manifestparser 18:48:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:48:00 INFO - Running setup.py install for mozcrash 18:48:00 INFO - Running setup.py install for mozdebug 18:48:01 INFO - Running setup.py install for mozdevice 18:48:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:48:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:48:01 INFO - Running setup.py install for mozfile 18:48:01 INFO - Running setup.py install for mozhttpd 18:48:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:48:01 INFO - Running setup.py install for mozinfo 18:48:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:48:01 INFO - Running setup.py install for mozInstall 18:48:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:48:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:48:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:48:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:48:01 INFO - Running setup.py install for mozleak 18:48:01 INFO - Running setup.py install for mozlog 18:48:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:48:01 INFO - Running setup.py install for moznetwork 18:48:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:48:01 INFO - Running setup.py install for mozprocess 18:48:01 INFO - Running setup.py install for mozprofile 18:48:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:48:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:48:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:48:02 INFO - Running setup.py install for mozrunner 18:48:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:48:02 INFO - Running setup.py install for mozscreenshot 18:48:02 INFO - Running setup.py install for moztest 18:48:02 INFO - Running setup.py install for mozversion 18:48:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:48:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:48:02 INFO - Cleaning up... 18:48:02 INFO - Return code: 0 18:48:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:48:02 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')]} 18:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:02 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')]} 18:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:02 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 0x7f92a0135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167f0>, '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 0x15822d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582760>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', '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 18:48:02 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 18:48:02 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 18:48:02 INFO - Using env: {'DISPLAY': ':0', 18:48:02 INFO - 'HOME': '/home/cltbld', 18:48:02 INFO - 'LANG': 'en_US.UTF-8', 18:48:02 INFO - 'LANGUAGE': 'en_US:en', 18:48:02 INFO - 'LOGNAME': 'cltbld', 18:48:02 INFO - 'MAIL': '/var/mail/cltbld', 18:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:02 INFO - 'MOZ_NO_REMOTE': '1', 18:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:02 INFO - 'NO_EM_RESTART': '1', 18:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:02 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:02 INFO - 'SHELL': '/bin/bash', 18:48:02 INFO - 'SHLVL': '1', 18:48:02 INFO - 'TERM': 'linux', 18:48:02 INFO - 'TMOUT': '86400', 18:48:02 INFO - 'USER': 'cltbld', 18:48:02 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', 18:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:02 INFO - '_': '/tools/buildbot/bin/python'} 18:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:48:02 INFO - Running setup.py (path:/tmp/pip-DgcjFN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:48:02 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)) 18:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:48:02 INFO - Running setup.py (path:/tmp/pip-wz2TgY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:48:02 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)) 18:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:48:02 INFO - Running setup.py (path:/tmp/pip-bFgMm8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:48: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)) 18:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:48:02 INFO - Running setup.py (path:/tmp/pip-MRISsn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:48:03 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)) 18:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:48:03 INFO - Running setup.py (path:/tmp/pip-CbvPve-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:48:03 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)) 18:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:48:03 INFO - Running setup.py (path:/tmp/pip-2nrhGO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:48:03 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)) 18:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:48:03 INFO - Running setup.py (path:/tmp/pip-Rb24hl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:48:03 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)) 18:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:48:03 INFO - Running setup.py (path:/tmp/pip-DKkVSE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:48:03 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)) 18:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:48:03 INFO - Running setup.py (path:/tmp/pip-v98rz3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:48:03 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)) 18:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:48:03 INFO - Running setup.py (path:/tmp/pip-E0CkYB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:48:03 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)) 18:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:48:03 INFO - Running setup.py (path:/tmp/pip-kvV42S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:48:03 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)) 18:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:48:03 INFO - Running setup.py (path:/tmp/pip-6IxFRU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:48:03 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)) 18:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:48:03 INFO - Running setup.py (path:/tmp/pip-Y3JOKe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:48:03 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)) 18:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:48:03 INFO - Running setup.py (path:/tmp/pip-DdQPgj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:48:03 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)) 18:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:48:03 INFO - Running setup.py (path:/tmp/pip-Qu0voi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:48:03 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)) 18:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:48:03 INFO - Running setup.py (path:/tmp/pip-qIkOkk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:48:03 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)) 18:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:48:03 INFO - Running setup.py (path:/tmp/pip-XNi50i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:48: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)) 18:48: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)) 18:48: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)) 18:48: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)) 18:48: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)) 18:48: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)) 18:48:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:48: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 18:48: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 18:48: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 18:48: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 18:48: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 18:48: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 18:48:05 INFO - Downloading blessings-1.5.1.tar.gz 18:48:05 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 18:48:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:48:05 INFO - Installing collected packages: blessings 18:48:05 INFO - Running setup.py install for blessings 18:48:05 INFO - Successfully installed blessings 18:48:05 INFO - Cleaning up... 18:48:05 INFO - Return code: 0 18:48:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:48:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:48:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:48:06 INFO - Reading from file tmpfile_stdout 18:48:06 INFO - Current package versions: 18:48:06 INFO - argparse == 1.2.1 18:48:06 INFO - blessings == 1.5.1 18:48:06 INFO - blobuploader == 1.2.4 18:48:06 INFO - docopt == 0.6.1 18:48:06 INFO - manifestparser == 1.1 18:48:06 INFO - mozInstall == 1.12 18:48:06 INFO - mozcrash == 0.16 18:48:06 INFO - mozdebug == 0.1 18:48:06 INFO - mozdevice == 0.47 18:48:06 INFO - mozfile == 1.2 18:48:06 INFO - mozhttpd == 0.7 18:48:06 INFO - mozinfo == 0.9 18:48:06 INFO - mozleak == 0.1 18:48:06 INFO - mozlog == 3.1 18:48:06 INFO - moznetwork == 0.27 18:48:06 INFO - mozprocess == 0.22 18:48:06 INFO - mozprofile == 0.28 18:48:06 INFO - mozrunner == 6.11 18:48:06 INFO - mozscreenshot == 0.1 18:48:06 INFO - mozsystemmonitor == 0.0 18:48:06 INFO - moztest == 0.7 18:48:06 INFO - mozversion == 1.4 18:48:06 INFO - psutil == 3.1.1 18:48:06 INFO - requests == 1.2.3 18:48:06 INFO - wsgiref == 0.1.2 18:48:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:06 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 0x7f92a0135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167f0>, '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 0x15822d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582760>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', '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 18:48:06 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 18:48:06 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 18:48:06 INFO - Using env: {'DISPLAY': ':0', 18:48:06 INFO - 'HOME': '/home/cltbld', 18:48:06 INFO - 'LANG': 'en_US.UTF-8', 18:48:06 INFO - 'LANGUAGE': 'en_US:en', 18:48:06 INFO - 'LOGNAME': 'cltbld', 18:48:06 INFO - 'MAIL': '/var/mail/cltbld', 18:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:06 INFO - 'MOZ_NO_REMOTE': '1', 18:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:06 INFO - 'NO_EM_RESTART': '1', 18:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:06 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:06 INFO - 'SHELL': '/bin/bash', 18:48:06 INFO - 'SHLVL': '1', 18:48:06 INFO - 'TERM': 'linux', 18:48:06 INFO - 'TMOUT': '86400', 18:48:06 INFO - 'USER': 'cltbld', 18:48:06 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', 18:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:06 INFO - '_': '/tools/buildbot/bin/python'} 18:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:06 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)) 18:48:06 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)) 18:48:06 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)) 18:48:06 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)) 18:48:06 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)) 18:48:06 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)) 18:48:06 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)) 18:48:06 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)) 18:48:06 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)) 18:48:06 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)) 18:48:06 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)) 18:48:06 INFO - Cleaning up... 18:48:06 INFO - Return code: 0 18:48:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:06 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 0x7f92a0135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167f0>, '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 0x15822d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582760>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', '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 18:48:06 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 18:48:06 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 18:48:06 INFO - Using env: {'DISPLAY': ':0', 18:48:06 INFO - 'HOME': '/home/cltbld', 18:48:06 INFO - 'LANG': 'en_US.UTF-8', 18:48:06 INFO - 'LANGUAGE': 'en_US:en', 18:48:06 INFO - 'LOGNAME': 'cltbld', 18:48:06 INFO - 'MAIL': '/var/mail/cltbld', 18:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:06 INFO - 'MOZ_NO_REMOTE': '1', 18:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:06 INFO - 'NO_EM_RESTART': '1', 18:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:06 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:06 INFO - 'SHELL': '/bin/bash', 18:48:06 INFO - 'SHLVL': '1', 18:48:06 INFO - 'TERM': 'linux', 18:48:06 INFO - 'TMOUT': '86400', 18:48:06 INFO - 'USER': 'cltbld', 18:48:06 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', 18:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:06 INFO - '_': '/tools/buildbot/bin/python'} 18:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:06 INFO - Downloading/unpacking jsonschema 18:48:06 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 18:48:06 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 18:48:06 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 18:48:06 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 18:48:06 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 18:48:06 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 18:48:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:48:08 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 18:48:08 INFO - Downloading/unpacking functools32 (from jsonschema) 18:48:08 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 18:48:08 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 18:48:08 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 18:48:08 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 18:48:08 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 18:48:08 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 18:48:08 INFO - Downloading functools32-3.2.3-2.tar.gz 18:48:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:48:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:48:08 INFO - warning: no files found matching '*.txt' 18:48:08 INFO - no previously-included directories found matching 'build' 18:48:08 INFO - no previously-included directories found matching 'dist' 18:48:08 INFO - no previously-included directories found matching '.git*' 18:48:08 INFO - Installing collected packages: jsonschema, functools32 18:48:08 INFO - Running setup.py install for functools32 18:48:08 INFO - warning: no files found matching '*.txt' 18:48:08 INFO - no previously-included directories found matching 'build' 18:48:08 INFO - no previously-included directories found matching 'dist' 18:48:08 INFO - no previously-included directories found matching '.git*' 18:48:08 INFO - Successfully installed jsonschema functools32 18:48:08 INFO - Cleaning up... 18:48:08 INFO - Return code: 0 18:48:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:48:08 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')]} 18:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:08 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')]} 18:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:08 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 0x7f92a0135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167f0>, '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 0x15822d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582760>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', '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 18:48:08 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 18:48:08 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 18:48:08 INFO - Using env: {'DISPLAY': ':0', 18:48:08 INFO - 'HOME': '/home/cltbld', 18:48:08 INFO - 'LANG': 'en_US.UTF-8', 18:48:08 INFO - 'LANGUAGE': 'en_US:en', 18:48:08 INFO - 'LOGNAME': 'cltbld', 18:48:08 INFO - 'MAIL': '/var/mail/cltbld', 18:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:08 INFO - 'MOZ_NO_REMOTE': '1', 18:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:08 INFO - 'NO_EM_RESTART': '1', 18:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:08 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:08 INFO - 'SHELL': '/bin/bash', 18:48:08 INFO - 'SHLVL': '1', 18:48:08 INFO - 'TERM': 'linux', 18:48:08 INFO - 'TMOUT': '86400', 18:48:08 INFO - 'USER': 'cltbld', 18:48:08 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', 18:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:08 INFO - '_': '/tools/buildbot/bin/python'} 18:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:09 INFO - Downloading/unpacking flake8 18:48: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 18:48: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 18:48: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 18:48: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 18:48: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 18:48: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 18:48:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:48:10 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 18:48:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:48: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 18:48: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 18:48: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 18:48: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 18:48: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 18:48: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 18:48:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:48:10 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 18:48:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:48: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 18:48: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 18:48: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 18:48: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 18:48: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 18:48: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 18:48:11 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 18:48:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:48:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:48:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:48:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:48:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:48:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:48:11 INFO - no previously-included directories found matching 'docs/_build' 18:48:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:48:11 INFO - Running setup.py install for pep8 18:48:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:48:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:48:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:48:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:48:11 INFO - no previously-included directories found matching 'docs/_build' 18:48:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:48:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:48:11 INFO - Cleaning up... 18:48:11 INFO - Return code: 0 18:48:11 INFO - Running post-action listener: _resource_record_post_action 18:48:11 INFO - Running post-action listener: _start_resource_monitoring 18:48:11 INFO - Starting resource monitoring. 18:48:11 INFO - ##### 18:48:11 INFO - ##### Running install step. 18:48:11 INFO - ##### 18:48:11 INFO - Running pre-action listener: _resource_record_pre_action 18:48:11 INFO - Running main action method: install 18:48:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:48:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:48:11 INFO - Reading from file tmpfile_stdout 18:48:11 INFO - Detecting whether we're running mozinstall >=1.0... 18:48:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:48:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:48:11 INFO - Reading from file tmpfile_stdout 18:48:11 INFO - Output received: 18:48:11 INFO - Usage: mozinstall [options] installer 18:48:11 INFO - Options: 18:48:11 INFO - -h, --help show this help message and exit 18:48:11 INFO - -d DEST, --destination=DEST 18:48:11 INFO - Directory to install application into. [default: 18:48:11 INFO - "/builds/slave/test-pgo"] 18:48:11 INFO - --app=APP Application being installed. [default: firefox] 18:48:11 INFO - mkdir: /builds/slave/test-pgo/build/application 18:48:11 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'] 18:48:11 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 18:48:27 INFO - Reading from file tmpfile_stdout 18:48:27 INFO - Output received: 18:48:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:48:27 INFO - Running post-action listener: _resource_record_post_action 18:48:27 INFO - ##### 18:48:27 INFO - ##### Running run-tests step. 18:48:27 INFO - ##### 18:48:27 INFO - Running pre-action listener: _resource_record_pre_action 18:48:27 INFO - Running main action method: run_tests 18:48:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:48:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:48:27 INFO - Python 2.7.3 18:48:27 INFO - Return code: 0 18:48:27 INFO - grabbing minidump binary from tooltool 18:48:27 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')]} 18:48:27 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 0x16167f0>, '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 0x15822d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:48:27 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 18:48:27 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 18:48:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:48:27 INFO - Return code: 0 18:48:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:48:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:48:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:48:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:48:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:48:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:48:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:48:28 INFO - Return code: 0 18:48:28 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/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 18:48:28 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/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 18:48:28 INFO - Using env: {'DISPLAY': ':0', 18:48:28 INFO - 'HOME': '/home/cltbld', 18:48:28 INFO - 'LANG': 'en_US.UTF-8', 18:48:28 INFO - 'LANGUAGE': 'en_US:en', 18:48:28 INFO - 'LOGNAME': 'cltbld', 18:48:28 INFO - 'MAIL': '/var/mail/cltbld', 18:48:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:48:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:28 INFO - 'MOZ_NO_REMOTE': '1', 18:48:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:28 INFO - 'NO_EM_RESTART': '1', 18:48:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:28 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:48:28 INFO - 'SHELL': '/bin/bash', 18:48:28 INFO - 'SHLVL': '1', 18:48:28 INFO - 'TERM': 'linux', 18:48:28 INFO - 'TMOUT': '86400', 18:48:28 INFO - 'USER': 'cltbld', 18:48:28 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429', 18:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:28 INFO - '_': '/tools/buildbot/bin/python'} 18:48:28 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/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 18:48:28 INFO - mozversion application_buildid: 20151226163004 18:48:28 INFO - mozversion application_changeset: 4c4e8470286f0dc817e988189f6584ba5d4ff5a6 18:48:28 INFO - mozversion application_display_name: Nightly 18:48:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:48:28 INFO - mozversion application_name: Firefox 18:48:28 INFO - mozversion application_remotingname: firefox 18:48:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:48:28 INFO - mozversion application_vendor: Mozilla 18:48:28 INFO - mozversion application_version: 46.0a1 18:48:28 INFO - mozversion platform_buildid: 20151226163004 18:48:28 INFO - mozversion platform_changeset: 4c4e8470286f0dc817e988189f6584ba5d4ff5a6 18:48:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:48:28 INFO - mozversion platform_version: 46.0a1 18:48:28 INFO - using testdate: 1451184508 18:48:28 INFO - actual date: 1451184508 18:48:28 INFO - starting webserver on 'localhost:57163' 18:48:28 INFO - SUITE-START | Running 3 tests 18:48:28 INFO - TEST-START | dromaeo_css 18:48:28 INFO - operating with platform_type : linux_ 18:48:28 INFO - Initialising browser for dromaeo_css test... 18:48:28 INFO - TEST-INFO | started process 18090 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1JJvsw/profile http://localhost:57163/getInfo.html) 18:48:33 INFO - PROCESS | 18090 | __metrics Screen width/height:1600/1200 18:48:33 INFO - PROCESS | 18090 | colorDepth:24 18:48:33 INFO - PROCESS | 18090 | Browser inner width/height: 1024/697 18:48:33 INFO - PROCESS | 18090 | __metrics 18:48:33 INFO - PROCESS | 18090 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:48:34 INFO - TEST-INFO | 18090: exit 0 18:48:34 INFO - Browser initialized. 18:48:34 INFO - Running cycle 1/1 for dromaeo_css test... 18:48:34 INFO - TEST-INFO | started process 18223 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1JJvsw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:48:46 INFO - PROCESS | 18223 | RSS: Main: 149778432 18:48:46 INFO - PROCESS | 18223 | 18:49:36 INFO - PROCESS | 18223 | 1451184576076 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] 18:51:44 INFO - PROCESS | 18223 | Cycle 1(1): loaded http://localhost:57163/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57163/tests/dromaeo/cssquery-ext.html) 18:51:45 INFO - PROCESS | 18223 | RSS: Main: 158498816 18:51:45 INFO - PROCESS | 18223 | 18:54:48 INFO - PROCESS | 18223 | Cycle 1(1): loaded http://localhost:57163/tests/dromaeo/cssquery-ext.html (next: http://localhost:57163/tests/dromaeo/cssquery-jquery.html) 18:54:48 INFO - PROCESS | 18223 | RSS: Main: 152539136 18:54:48 INFO - PROCESS | 18223 | 18:57:50 INFO - PROCESS | 18223 | Cycle 1(1): loaded http://localhost:57163/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57163/tests/dromaeo/cssquery-mootools.html) 18:57:51 INFO - PROCESS | 18223 | RSS: Main: 153899008 18:57:51 INFO - PROCESS | 18223 | 19:00:52 INFO - PROCESS | 18223 | Cycle 1(1): loaded http://localhost:57163/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57163/tests/dromaeo/cssquery-prototype.html) 19:00:53 INFO - PROCESS | 18223 | RSS: Main: 152457216 19:00:53 INFO - PROCESS | 18223 | 19:03:55 INFO - PROCESS | 18223 | Cycle 1(1): loaded http://localhost:57163/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57163/tests/dromaeo/cssquery-yui.html) 19:03:56 INFO - PROCESS | 18223 | RSS: Main: 152600576 19:03:56 INFO - PROCESS | 18223 | 19:06:58 INFO - PROCESS | 18223 | Cycle 1(1): loaded http://localhost:57163/tests/dromaeo/cssquery-yui.html (next: http://localhost:57163/tests/dromaeo/cssquery-dojo.html) 19:06:58 INFO - PROCESS | 18223 | RSS: Main: 155308032 19:06:58 INFO - PROCESS | 18223 | 19:06:58 INFO - PROCESS | 18223 | __start_tp_report 19:06:58 INFO - PROCESS | 18223 | _x_x_mozilla_page_load 19:06:58 INFO - PROCESS | 18223 | _x_x_mozilla_page_load_details 19:06:58 INFO - PROCESS | 18223 | |i|pagename|runs| 19:06:58 INFO - PROCESS | 18223 | |0;dojo.html;3160.841957902105;3210.8073515589067;3236.789608675437;3249.5938007749023;3265.0531345909685;5105.668131571445;5270.947290527089;5271.393789714184;5285.497877701617;5297.655652382592;5178.171492561191;5225.477452254782;5291.841244762653;5391.218273350371;5406.297181366427;4855.805767769285;4919.803207871681;4986.476419975905;5006.22403527452;5006.624503162259;4867.3915760529935;4927.827526036589;4937.210046392578;4980.452150263468;5075.365579302587;4773.3078703588135;4860.586850117745;4902.950970490303;4928.507149285043;5014.072396606622;4860.076585448754;4913.189323761575;4920.40955085392;4927.950720492785;4936.580390666798;4828.106800241966;4837.462067871252;4837.637177211688;4860.562549370538;4897.094037603019;4994.575461085812;5059.519345662156;5083.059633967728;5112.514311140436;5140.691558506464;5578.721063946787;5620.578456615729;5695.202671625976;5771.942280577225;5800.506956908668;5756.712164391805;5793.942060579382;5799.768009279624;5803.593748437611;5805.796797112081;5272.868178295574;5430.104032834617;5432.266644003088;5437.238786569884;5447.400785913586;5794.942050579524;5859.091840764689;5896.292444906639;5902.6458412495385;5952.375000624872;5669.206311116447;5680.375158732536;5687.971560142173;5691.573132015115;5692.288463942007;5598.496135347838;5692;5696.829095127153;5698.31620205578;5766.855828604318;5672.8865422691315;5706.3152421709665;5743;5751.1085781703905;5765.85585360361;5731.254936858182;5742.081266997344;5756.942430575725;5767.423257674283;5777.075667893117;4320;4381.5618438155925;4383.802728877208;4428.82284708608;4467.195904737114;3926;3927.9607203927594;3940.822662980173;3963.781991990468;3976.5228172619472;5354.732263386815;5365.704886231217;5367.1680889462195;5373.059714549938;5418.02475554404;5595.132754423071;5622.437756224426;5691.0609749391715;5727.198192253088;5738.713064346766;5331.200319952039;5350.625456218105;5357.866053348697;5358.8660283492445;5361.115415956401;4885.706857588556;4888.682235654671;4895.167821470359;4895.7062576245535;4952.380952380952;5717.142428635738;5814.505767009767;5828.388019257917;5833.50415214703;5919.852003699942;5658.85852853682;5683.403242659461;5685.0335442973965;5698.145278208136;5702.6863522506665;5846;5863.618864773776;5886.381929897299;5890.617109887844;5904.734286957011;5554;5631.577631677558;5633.3521645009705;5635.211070450058;5737.655740655574;5687.317521897398;5739.770409183586;5743.913841292468;5745.97127014379;5752.165935939349;5462.453754624665;5524.917126243029;5526.889462210653;5533.916991245054;5536.916946245729;5501.284832971688;5534.972325138348;5544.362398324244;5556.194351818883;5588.6646801192055;5500.1199808032125;5500.257465242141;5522.972385138049;5523.502884740393;5524.364698059614;5487.64330318528;5573.637713548606;5599.692016939108;5617.775288988558;5715.428457154418;5452.645578037414;5522.558195344443;5523.447655234605;5524.8342549723575;5553.916691249715 19:06:58 INFO - PROCESS | 18223 | |1;ext.html;557.5093917352729;572.1246492865914;575.2579172867001;576.2623841482904;576.4840467781336;33781;35115.473267901005;35241.82379088104;35278.47082293768;35300.64699353009;37740.43389349155;38223.61776382235;38397.808010959976;38401;38522;8608.526531040807;8909.509976951265;8913.331500137483;8916.331275154356;8923.330750193729;8668.133186681313;8732.781680457976;8782.209601135897;8822.73531794044;8834.514101724402;8707.782305442352;8770.991335996347;8797.120287971184;8839.116088391174;8858;8763.12368763125;8829.205371516562;8835.20483156519;8853.42452740573;8859.379843410963;8497.107803680587;8653.610587523577;8691.521966291852;8705.216530512283;8707.34694897879;37979.810100949595;38751.64369247091;38756.61243387558;38759.418608720895;38795.41806872899;3074.3390171113097;3079.322549039208;3132.1230055584474;3417.8974630761118;3627.2564124354444;28967.42065158706;29098.70901290981;29350.853245733633;29784.8510757447;30294.242643933856;3883.611638836122;4023.2154729827694;4062.695297852673;4065.7763822989723;4068.8169032393316;210883;213732;213830;215417;215460;53136.468635313926;54780.452195477534;55278.72360638171;55660;59766.91981181561;54183.18725219125;54446.72776636091;54572;54816;54854;14427.711445771025;14506.057106288057;14572.85427145715;14575.562733117811;14617.926910365593;11072.723181920355;11210.66368008961;11226.214165008534;11233.213675042669;11256.21206515536;19325.226990920204;19590.545523494224;20078.19296263343;20218.595628087354;20269.797302026793;7861.292483676497;7954.164812694699;8017.639206235734;8047.436679432383;8172.877406838902;892.5403417240127;944.2823454174877;944.2964991081689;1038.5274700011478;1063.7181146996052;27145.728542714714;27157.72842271552;27375.45249095047;27681.86159069232;27684.861575691993;1017.1913328903539;1025.4718819807806;1040.0847254416065;1057.836035414512;1127.939736647565;14338.334113149562;14513.419463221353;14517.854821451861;14564.198969056804;14615;303946;304568;306589;306790;309707;49569.25646115311;49758.253626195634;50059.74970125126;50156.498435015914;50391.24413133806;1302.1926405628572;1352.5942217334957;1354.214555557774;1358.429459626959;1363.3660347938057;26005.6099158509;27442.725572744817;27824.304392390353;28009.43981120407;28075.859620701765;45907.770461147484;46069;46270.305945410175;46307.76846115748;46398.76800615976;280614;284724;284972;285031;285150;31946.36107277888;40973.59026409817;42589.787051064544;42821.35767963421;42956.57043429526;39093.41359879661;39888.2022359557;40024.599754003255;40065;40668.79665601653;35378.292434151685;35503.69653493471;35516.11209719778;35884.820575896956;36348.63651363453;36325.818370907975;36641;37455.81272093622;38500.614993850824;38945.8052709746;33103.33793324072;33715;33962.81130160433;34137.31725365429;34175.48736769;28778;29441.85279073591;30570.235744105685;32790.180245494055;33782.8310858454;23617.40956476102;23852.642210367205;24507.387315316548;25269.24192274235;26176.73823261743 19:06:58 INFO - PROCESS | 18223 | |2;jquery.html;350.9420945543985;353.72939701128627;357.44595876391605;357.59770258459224;359.2169071424294;11401.657950261506;11862.051035917128;15992.12043337616;16287.185640717977;16855.747163792523;16826.24281907314;16889.23998420071;16902.57743556412;17009.829901700978;17023.148842557883;5742.655440673562;6021.2473440819895;6021.698915054251;6032.69836508175;6043.244594425697;4490.865274041784;5962.34414214436;6008.519318454513;6015.578909476339;6015.849603759897;6115.235595550556;6116.969415152918;6120.785772497963;6360;6595.53831231814;6441.4524765395;6551.493156573991;6564.04821300911;6589.703463344161;6901.654917254167;6646.900296495556;6659.533832631718;6679.866402671968;6680.83297917551;6695.46436285096;21374.679379809317;21919.452013699625;22252.10991560352;22833.543329133325;22842.657360139612;2258.1419060756807;2260.0394832196416;2307.5038866643754;2367.171489978511;2537.581299085649;13844;13877;13928.93035534826;14417.71164576713;14468.421263149461;2027.6451620966272;2043.5606344635974;2054.6404379233572;2054.6917962305624;2056.23919149914;63042;68917.65541172313;69103;69822.65088674524;71257.28742712559;14970.251487425803;15212;15268.465603703817;15309;15342.232888355538;23845.403864903168;23975.28074157778;24044;24149.637755433683;24219.515609687707;8527.658893644184;8540.871886921701;8545.487270763773;8558.95720521406;8598.140185981352;6983.9650801745665;7009.369156775914;7038.155421349368;7044.330788575077;7063.752768653072;7565.054368203974;7569.318761311509;7596.2023987481625;7607.315341619281;7618.352440042548;1771.6899542579997;3010.5785190073407;3034.7117023882697;3086.6758990305693;3158.1788734928623;454.09861425071205;459.12307492689473;469.0127282071191;795.3408674464866;994.5673631970116;16147.354105835635;16582.419615313407;16643.83356166447;16936.153192340334;17171.31314747421;877.5568337989274;904.2539904578617;949.2785483032944;959.4435227567993;1001.519270750044;8819.382643215042;9031.864522032174;9116.81766364669;9238.722838314861;9462.52687365629;562417;566334;581001;585691;589140;38393;38591.614083859364;38644;75278.62360688162;76140.23859761443;1103.6633826682778;1108.4070022537903;1136.2614300704442;1162.430409099552;1176.0709039858586;15402.691946161238;15612.4535641252;15683.294251758927;15695.843041569895;15729.134897580743;34389.65610343964;34510.65489345175;35051.47422788711;35321.11697207487;35541;44086.77956610196;45059.77470112628;45676;46006.309905352115;46162.307565387215;9715.271354648288;9723;9856.950715246665;12800.807987880375;13152.934235328763;18120.818791811915;18252;18587.90706046461;18593.53516162107;18797.248110075445;9875.913649498692;10080.395176289447;10243.07812296897;10277.9486102569;10433.634822781167;10043.196544276294;10057.597696092074;10165.695029149138;10198.541065651914;10474.319169253975;10056.446895420822;10312.432816195182;10514.842277365693;10535.15718742514;10576.576936922436;14538.491152809602;14625.122492650475;14781.260936952895;14865.554033379016;14878.10731356122;15452.459163929208;15731.921340393683;15759.369625215322;15769.68460630758;15872.841271587136 19:06:58 INFO - PROCESS | 18223 | |3;mootools.html;1415.929203539823;1420.865017823307;1542.8457154284572;1692.0778175894136;1714.4685147604243;7108.715651373946;7120.394766444859;7222.061132052832;7248.0577524921755;7253.1296244450605;7192.712291508346;7204.279572042793;7271.709131634741;7284.417246620271;7290.635468226581;2198.1756841184556;2229.4649284171846;2232.553489302138;2235.8099561537288;2237.161064600775;2173.6956826044366;2220.9222677206303;2232.977670223301;2236.1279101150562;2236.507968246983;2171.587398394308;2178.9891050544725;2198.835087368446;2199.186301068607;2228.4206106412366;2113.8414618903644;2117.76704562498;2135.2099723102397;2142.967855482161;2146.0771868096713;2172.0443005077714;2177.0529819528397;2182.6071307164702;2185.497335612802;2190.8575942563684;6833.521653484258;6869.7595584154315;6885.965570172117;6895;6936.79189624307;4372.650187984986;4403.251447253974;4403.581659742319;4452.977735111303;4459.777011149462;2897.043975488084;2947.852607369623;2964.985175074111;2972.4203780262856;2979.433907557557;993.8658281132027;995.6365926436871;1011.2163073617932;1043.405259002369;1050.070687441612;9390.95304523473;9457;9488.810223795486;9501.382410143387;9516.476593787338;3937.724359294822;4019.1157945252;4025.7383270087353;4030.6976976726864;4047.919041619151;8279.710210142737;8356.582170891432;8376.706815261437;8388.11924747905;8423.747287581382;4405.096955124256;4405.273129933525;4413.426254586883;4433.490148632948;4435.2903535434825;4024.7987600619854;4029.9395509067385;4034.959650403517;4042.3532234842282;4066.4510291110914;3448.3275761226823;3448.620651728308;3470.444728843373;3471.4272145096284;3490.650934906489;1124.173732306754;1125.8254970479588;1129.8813624569466;1131.8415421840948;1151.7120719820045;934.0612684252283;969.6121551379364;1058.4284486377423;1081.7728277061906;1269.022852403644;6453.709583068773;6454.515911306671;6492.805215843532;6492.837679058061;6498.252700939358;585.645684360964;592.1916583863082;596.5674885707914;633.2590868683559;733.9834329453745;5098.694078355311;5177.870553236199;5186.533212010937;5193.2989046479;5194.27280180775;8022.9197708022175;8111.351091912633;8200.630971606291;8215.383846211558;8303.377246706521;8061.153578874251;8158.184181581794;8193.918060819435;8207;8220.547869867096;6610.7025183866845;6620.503462240351;6782.186137663413;6813.931860681429;6853.246142924274;6533.379328963741;6651.201855777338;6700.899486507804;6706.93293067063;6712.060311556288;7586.165521792488;7723.073231212291;7735.806604834699;7820.687172513036;7830.608469576612;7598.430117741081;7883.211678832071;7899.0126234220725;7979.16218797018;7985.760427187193;6282.1519094921605;6324.905126423199;6358.682065896594;6385.904211436739;6404.551681382259;6739.528233023641;6920.8961865573065;6926.653667316715;6933.272006439453;6956.826079348057;5623.915641265467;6540.771073012422;6590.373914478117;6611.206655201407;6737.797866064026;5881.7647294109465;6363.87272254543;6436.13112229843;6517;6533.8693226136165;6362.0774987627465;6424.421802037652;6437.517186210959;6476.579022363531;6489.610623362613;5927.407259274038;5976.013957696931;5989.101634754822;5996.070609055603;6005.399460054135;5808.76764929415;5827.125931110368;5828.825135245949;5840.386759390372;5851.61964472308 19:06:58 INFO - PROCESS | 18223 | |4;prototype.html;329.5221928204104;337.4516410832398;338.2507745344062;339.64846383992574;345.4024537550038;6224.595401298912;6253.155823963763;6267.341929097447;6292.5909815862;6355.046742988554;6203.782867599635;6295.811125666226;6305.653189074611;6306.59007164534;6317.77887773928;4763.309320148576;4768.403949506312;4786.593139583122;4788.018456216468;4789.137955168068;4783.402074740658;4787.521247875202;4791.496892826255;4793.137235297645;4794.993051459198;4656.1153380857695;4711.199096153645;4718.764061796914;4720.575148236658;4722.8110875564935;4697;4701.482836887957;4706.3411122442885;4708.835190768341;4714;4060.106776509193;4079.3065178919655;4092.4679791627195;4097.44684467596;4099.262132816092;5988.610740301867;5994.400559944014;6018.6689732064715;6040.516758659341;6109.541784366146;5373.489518495737;5537.197106419587;5548.029094908416;5548.056830338852;5549.334079910396;6690.230623478314;6705.497087718391;6713.798586042427;6719;6721.66391680414;4534.977325113353;4541.137183935041;4561.771911404417;4585.197590421696;4592.311153326994;6830.897536536956;6920.100386949664;6978;6987.37113659768;6998.580085194853;4633.073385322881;4637.60580350674;4650.67445278834;4651.906961860744;4661.394018777537;4686.953130468652;4722.693024953367;4723.7874295656775;4724.503927087675;4726.3146843708155;5495.725213739297;5496.945030549723;5501.477359650827;5508.614396992172;5514.228008078872;6598.868022639616;6724.6301453419555;6725.327467253235;6728;6732.865342693119;1623.350659736115;1654.6359800843795;1671.4901954903871;1675.388483203622;1676.1451659653421;1082.7888561730388;1099.69758316462;1110.4336788238056;1112.4548971004149;1115.1301984451977;6236.75052997875;6269.341719119518;6282.151909492251;6284.905726414107;6292.528060395397;6805.421539169127;6853.211880633791;6870.965645171742;6874.518783685094;6876.965615171892;6062.302835173923;6260.186175797117;6267.122602835607;6277.403646653561;6279.560430769893;3711.4432835074954;3715.8142092895246;3728.5525736911745;3735.14091758897;3745.9438108428394;7119.074520312326;7130.500864939509;7136.357727804522;7198.5320954137815;7230.710771569078;6950.582965022115;6980.546264492792;6994.8950765738555;7017.122859642544;7020.9648951755935;7305.123385193704;7312.926870731331;7317.926820731831;7322.048133742579;7347.265273472717;7024.613646249505;7034.050403195503;7037.753678621224;7041.471889608402;7043.964780176067;6781.0845535854005;6907.171139463297;6912.308769123048;6945.687444064928;6951.582905025714;7275.054242948383;7295.197528271779;7296.160941491797;7298.23368546295;7319.121705395387;4556.270996640522;4563.885902852455;4585.243434833215;4606.3551102846295;4613.261878099488;6882.5870447773295;6965.825854353681;6992.1259842519685;7003.229644739176;7003.26465721092;6782.491313151632;6788.66056697173;6788.898166527605;6794.898076528955;6810.62541560219;6738.932610673831;6742.25835158142;6769.93230067693;6775.661216939035;6795.864082718417;6536;6661.1007513985;6668.499862510234;6672.666366681549;6675.833104172434;6779.491538134561;6830.829229269109;6844.931550684629;6853.451723861979;6858.5199036067;6601.207855057424;6662.800115996528;6664.133662623828;6673.833154171185;6687.431568316748 19:06:58 INFO - PROCESS | 18223 | |5;yui.html;738.427718518148;747.8317378589818;763.427429427929;775.6160700453277;786.1038416205523;13210.801837972438;13582.864171358284;13584.592462226125;13590.592282231537;13603.319834008285;12395.628131156058;12757.489700411972;12864.871351286485;12873.098883078188;12874.613761587145;797.1271457753751;806.1575653442167;807.5598798654718;808.0586117173486;808.2523665609287;644.3942693867749;659.4065341192941;802.1256830055239;832.2385017708789;832.429785596865;855.243109847783;859.7119964811795;868.0451503346331;868.2316150207049;871.485823364215;853.5007020892754;855.8245559660255;860.8364410761998;863.1325517854548;863.404251066762;625.0468036244717;626.8558231606711;630.0328994992665;631.4254028833785;632.0203684289379;13076.280804555745;13129.671758206026;13188.274644894527;13221.206727596278;13248.40382182804;11881.643550693492;12143.089268304824;12294.815577766341;12592.181508201938;13126.540571080062;9981.800363992752;10237.846432303522;10317.9484102579;10733.355998640107;10872.402017889013;3546.929061418783;3553.964460355415;3565.8395372208315;3574.4817001534634;3589.946150807714;43102.78448607768;43548.56451435509;43571.78214108941;43930.56069439297;44012.3398149028;9837.80324393508;9886.752831179278;10033.548490317953;10047.648332308334;10090.09189172978;18339.724904126448;18568;18571;18574.071296435126;18581;7701.691932322644;7734.961325193338;7836.098848632366;7912.762617121495;8091.150429204967;4416.668749843775;4531.773411329486;4551.8179272829375;4555.681102322806;4657.6273898088075;2867.311845157147;2881.063654312357;2909.0109362816743;2931.5016447204025;2949.1447480230495;522.636767446621;527.0565687419553;530.7425898439254;532.9786808527615;543.3045701502084;587.6973358720262;605.4308949587373;651.4104735214638;694.3820000199726;701.3547536266647;8006.23862750194;8414.410991230678;8638.13618638131;8777.605007774666;8784.560771961376;532.8774381892109;551.3824516541499;702.9771682202384;709.6664567653195;711.9430445564342;3734.514513113278;3999;4080.836766529365;4083.1629515949157;4102.856400025985;53480.465195348326;53495.46504534905;53712.73143634335;53919.19121213185;53941;43493.78253108714;46303.5369646306;48710;49253.75373123112;49361;43387.132257355304;44483;44921;45540.772296138304;45582.54417455849;8826.735197944072;8951.776205594912;8967.775805604912;8979.865302020344;9040.88833954665;34342.82828585841;34601.65398346085;35173.12067198341;35240;35263.294734105686;39800.60199397969;41286.38070428886;43881.78059109684;44101.33847992218;44193.11613767642;11064.502097405475;11270.887291126985;11301.71745706331;11431.885681143081;11630.88369116298;12063.034957203578;12277.386130693609;12639.684007899876;12685.873141268468;13083.542076027674;11243.943780281046;11444.713882153013;11504.884951150716;11715.062794976551;11806.763864722829;11130.220884538328;11350.716232094264;11354.489047992694;11595.362255076052;11646.534138634359;11051.668449946514;11327.773444531229;11330.830037549278;11421;11571.479283432434;9935.552900119657;9979.351342162736;10262.948685256824;10294.279400441897;10303.3817970922;8717.869231961398;8834.160754728291;8839.734807955772;9133.40632858862;9986.950065249628 19:06:58 INFO - PROCESS | 18223 | __end_tp_report 19:06:58 INFO - PROCESS | 18223 | __start_cc_report 19:06:58 INFO - PROCESS | 18223 | _x_x_mozilla_cycle_collect,303 19:06:58 INFO - PROCESS | 18223 | __end_cc_report 19:06:58 INFO - PROCESS | 18223 | __startTimestamp1451185618938__endTimestamp 19:06:58 INFO - PROCESS | 18223 | 19:06:58 INFO - PROCESS | 18223 | ------- Summary: start ------- 19:06:58 INFO - PROCESS | 18223 | Number of tests: 6 19:06:58 INFO - PROCESS | 18223 | 19:06:58 INFO - PROCESS | 18223 | [#0] dojo.html Cycles:165 Average:5307.47 Median:5522.97 stddev:577.03 (10.4%) stddev-sans-first:553.68 19:06:58 INFO - PROCESS | 18223 | Values: 3160.8 3210.8 3236.8 3249.6 3265.1 5105.7 5270.9 5271.4 5285.5 5297.7 5178.2 5225.5 5291.8 5391.2 5406.3 4855.8 4919.8 4986.5 5006.2 5006.6 4867.4 4927.8 4937.2 4980.5 5075.4 4773.3 4860.6 4903.0 4928.5 5014.1 4860.1 4913.2 4920.4 4928.0 4936.6 4828.1 4837.5 4837.6 4860.6 4897.1 4994.6 5059.5 5083.1 5112.5 5140.7 5578.7 5620.6 5695.2 5771.9 5800.5 5756.7 5793.9 5799.8 5803.6 5805.8 5272.9 5430.1 5432.3 5437.2 5447.4 5794.9 5859.1 5896.3 5902.6 5952.4 5669.2 5680.4 5688.0 5691.6 5692.3 5598.5 5692.0 5696.8 5698.3 5766.9 5672.9 5706.3 5743.0 5751.1 5765.9 5731.3 5742.1 5756.9 5767.4 5777.1 4320.0 4381.6 4383.8 4428.8 4467.2 3926.0 3928.0 3940.8 3963.8 3976.5 5354.7 5365.7 5367.2 5373.1 5418.0 5595.1 5622.4 5691.1 5727.2 5738.7 5331.2 5350.6 5357.9 5358.9 5361.1 4885.7 4888.7 4895.2 4895.7 4952.4 5717.1 5814.5 5828.4 5833.5 5919.9 5658.9 5683.4 5685.0 5698.1 5702.7 5846.0 5863.6 5886.4 5890.6 5904.7 5554.0 5631.6 5633.4 5635.2 5737.7 5687.3 5739.8 5743.9 5746.0 5752.2 5462.5 5524.9 5526.9 5533.9 5536.9 5501.3 5535.0 5544.4 5556.2 5588.7 5500.1 5500.3 5523.0 5523.5 5524.4 5487.6 5573.6 5599.7 5617.8 5715.4 5452.6 5522.6 5523.4 5524.8 5553.9 19:06:58 INFO - PROCESS | 18223 | 19:06:58 INFO - PROCESS | 18223 | [#1] ext.html Cycles:180 Average:43703.27 Median:19756.04 stddev:70686.47 (357.8%) stddev-sans-first:70810.53 19:06:58 INFO - PROCESS | 18223 | Values: 557.5 572.1 575.3 576.3 576.5 33781.0 35115.5 35241.8 35278.5 35300.6 37740.4 38223.6 38397.8 38401.0 38522.0 8608.5 8909.5 8913.3 8916.3 8923.3 8668.1 8732.8 8782.2 8822.7 8834.5 8707.8 8771.0 8797.1 8839.1 8858.0 8763.1 8829.2 8835.2 8853.4 8859.4 8497.1 8653.6 8691.5 8705.2 8707.3 37979.8 38751.6 38756.6 38759.4 38795.4 3074.3 3079.3 3132.1 3417.9 3627.3 28967.4 29098.7 29350.9 29784.9 30294.2 3883.6 4023.2 4062.7 4065.8 4068.8 210883.0 213732.0 213830.0 215417.0 215460.0 53136.5 54780.5 55278.7 55660.0 59766.9 54183.2 54446.7 54572.0 54816.0 54854.0 14427.7 14506.1 14572.9 14575.6 14617.9 11072.7 11210.7 11226.2 11233.2 11256.2 19325.2 19590.5 20078.2 20218.6 20269.8 7861.3 7954.2 8017.6 8047.4 8172.9 892.5 944.3 944.3 1038.5 1063.7 27145.7 27157.7 27375.5 27681.9 27684.9 1017.2 1025.5 1040.1 1057.8 1127.9 14338.3 14513.4 14517.9 14564.2 14615.0 303946.0 304568.0 306589.0 306790.0 309707.0 49569.3 49758.3 50059.7 50156.5 50391.2 1302.2 1352.6 1354.2 1358.4 1363.4 26005.6 27442.7 27824.3 28009.4 28075.9 45907.8 46069.0 46270.3 46307.8 46398.8 280614.0 284724.0 284972.0 285031.0 285150.0 31946.4 40973.6 42589.8 42821.4 42956.6 39093.4 39888.2 40024.6 40065.0 40668.8 35378.3 35503.7 35516.1 35884.8 36348.6 36325.8 36641.0 37455.8 38500.6 38945.8 33103.3 33715.0 33962.8 34137.3 34175.5 28778.0 29441.9 30570.2 32790.2 33782.8 23617.4 23852.6 24507.4 25269.2 26176.7 19:06:58 INFO - PROCESS | 18223 | 19:06:58 INFO - PROCESS | 18223 | [#2] jquery.html Cycles:180 Average:30083.43 Median:3122.43 stddev:93918.31 (3007.9%) stddev-sans-first:94155.23 19:06:58 INFO - PROCESS | 18223 | Values: 350.9 353.7 357.4 357.6 359.2 11401.7 11862.1 15992.1 16287.2 16855.7 16826.2 16889.2 16902.6 17009.8 17023.1 5742.7 6021.2 6021.7 6032.7 6043.2 4490.9 5962.3 6008.5 6015.6 6015.8 6115.2 6117.0 6120.8 6360.0 6595.5 6441.5 6551.5 6564.0 6589.7 6901.7 6646.9 6659.5 6679.9 6680.8 6695.5 21374.7 21919.5 22252.1 22833.5 22842.7 2258.1 2260.0 2307.5 2367.2 2537.6 13844.0 13877.0 13928.9 14417.7 14468.4 2027.6 2043.6 2054.6 2054.7 2056.2 63042.0 68917.7 69103.0 69822.7 71257.3 14970.3 15212.0 15268.5 15309.0 15342.2 23845.4 23975.3 24044.0 24149.6 24219.5 8527.7 8540.9 8545.5 8559.0 8598.1 6984.0 7009.4 7038.2 7044.3 7063.8 7565.1 7569.3 7596.2 7607.3 7618.4 1771.7 3010.6 3034.7 3086.7 3158.2 454.1 459.1 469.0 795.3 994.6 16147.4 16582.4 16643.8 16936.2 17171.3 877.6 904.3 949.3 959.4 1001.5 8819.4 9031.9 9116.8 9238.7 9462.5 562417.0 566334.0 581001.0 585691.0 589140.0 38393.0 38591.6 38644.0 75278.6 76140.2 1103.7 1108.4 1136.3 1162.4 1176.1 15402.7 15612.5 15683.3 15695.8 15729.1 34389.7 34510.7 35051.5 35321.1 35541.0 44086.8 45059.8 45676.0 46006.3 46162.3 9715.3 9723.0 9857.0 12800.8 13152.9 18120.8 18252.0 18587.9 18593.5 18797.2 9875.9 10080.4 10243.1 10277.9 10433.6 10043.2 10057.6 10165.7 10198.5 10474.3 10056.4 10312.4 10514.8 10535.2 10576.6 14538.5 14625.1 14781.3 14865.6 14878.1 15452.5 15731.9 15759.4 15769.7 15872.8 19:06:58 INFO - PROCESS | 18223 | 19:06:58 INFO - PROCESS | 18223 | [#3] mootools.html Cycles:180 Average:5002.11 Median:6143.78 stddev:2521.91 (41.0%) stddev-sans-first:2514.58 19:06:58 INFO - PROCESS | 18223 | Values: 1415.9 1420.9 1542.8 1692.1 1714.5 7108.7 7120.4 7222.1 7248.1 7253.1 7192.7 7204.3 7271.7 7284.4 7290.6 2198.2 2229.5 2232.6 2235.8 2237.2 2173.7 2220.9 2233.0 2236.1 2236.5 2171.6 2179.0 2198.8 2199.2 2228.4 2113.8 2117.8 2135.2 2143.0 2146.1 2172.0 2177.1 2182.6 2185.5 2190.9 6833.5 6869.8 6886.0 6895.0 6936.8 4372.7 4403.3 4403.6 4453.0 4459.8 2897.0 2947.9 2965.0 2972.4 2979.4 993.9 995.6 1011.2 1043.4 1050.1 9391.0 9457.0 9488.8 9501.4 9516.5 3937.7 4019.1 4025.7 4030.7 4047.9 8279.7 8356.6 8376.7 8388.1 8423.7 4405.1 4405.3 4413.4 4433.5 4435.3 4024.8 4029.9 4035.0 4042.4 4066.5 3448.3 3448.6 3470.4 3471.4 3490.7 1124.2 1125.8 1129.9 1131.8 1151.7 934.1 969.6 1058.4 1081.8 1269.0 6453.7 6454.5 6492.8 6492.8 6498.3 585.6 592.2 596.6 633.3 734.0 5098.7 5177.9 5186.5 5193.3 5194.3 8022.9 8111.4 8200.6 8215.4 8303.4 8061.2 8158.2 8193.9 8207.0 8220.5 6610.7 6620.5 6782.2 6813.9 6853.2 6533.4 6651.2 6700.9 6706.9 6712.1 7586.2 7723.1 7735.8 7820.7 7830.6 7598.4 7883.2 7899.0 7979.2 7985.8 6282.2 6324.9 6358.7 6385.9 6404.6 6739.5 6920.9 6926.7 6933.3 6956.8 5623.9 6540.8 6590.4 6611.2 6737.8 5881.8 6363.9 6436.1 6517.0 6533.9 6362.1 6424.4 6437.5 6476.6 6489.6 5927.4 5976.0 5989.1 5996.1 6005.4 5808.8 5827.1 5828.8 5840.4 5851.6 19:06:58 INFO - PROCESS | 18223 | 19:06:58 INFO - PROCESS | 18223 | [#4] prototype.html Cycles:180 Average:5586.16 Median:6280.86 stddev:1721.95 (27.4%) stddev-sans-first:1680.97 19:06:58 INFO - PROCESS | 18223 | Values: 329.5 337.5 338.3 339.6 345.4 6224.6 6253.2 6267.3 6292.6 6355.0 6203.8 6295.8 6305.7 6306.6 6317.8 4763.3 4768.4 4786.6 4788.0 4789.1 4783.4 4787.5 4791.5 4793.1 4795.0 4656.1 4711.2 4718.8 4720.6 4722.8 4697.0 4701.5 4706.3 4708.8 4714.0 4060.1 4079.3 4092.5 4097.4 4099.3 5988.6 5994.4 6018.7 6040.5 6109.5 5373.5 5537.2 5548.0 5548.1 5549.3 6690.2 6705.5 6713.8 6719.0 6721.7 4535.0 4541.1 4561.8 4585.2 4592.3 6830.9 6920.1 6978.0 6987.4 6998.6 4633.1 4637.6 4650.7 4651.9 4661.4 4687.0 4722.7 4723.8 4724.5 4726.3 5495.7 5496.9 5501.5 5508.6 5514.2 6598.9 6724.6 6725.3 6728.0 6732.9 1623.4 1654.6 1671.5 1675.4 1676.1 1082.8 1099.7 1110.4 1112.5 1115.1 6236.8 6269.3 6282.2 6284.9 6292.5 6805.4 6853.2 6871.0 6874.5 6877.0 6062.3 6260.2 6267.1 6277.4 6279.6 3711.4 3715.8 3728.6 3735.1 3745.9 7119.1 7130.5 7136.4 7198.5 7230.7 6950.6 6980.5 6994.9 7017.1 7021.0 7305.1 7312.9 7317.9 7322.0 7347.3 7024.6 7034.1 7037.8 7041.5 7044.0 6781.1 6907.2 6912.3 6945.7 6951.6 7275.1 7295.2 7296.2 7298.2 7319.1 4556.3 4563.9 4585.2 4606.4 4613.3 6882.6 6965.8 6992.1 7003.2 7003.3 6782.5 6788.7 6788.9 6794.9 6810.6 6738.9 6742.3 6769.9 6775.7 6795.9 6536.0 6661.1 6668.5 6672.7 6675.8 6779.5 6830.8 6844.9 6853.5 6858.5 6601.2 6662.8 6664.1 6673.8 6687.4 19:06:58 INFO - PROCESS | 18223 | 19:06:58 INFO - PROCESS | 18223 | [#5] yui.html Cycles:180 Average:13394.49 Median:24259.00 stddev:14947.99 (61.6%) stddev-sans-first:14959.71 19:06:58 INFO - PROCESS | 18223 | Values: 738.4 747.8 763.4 775.6 786.1 13210.8 13582.9 13584.6 13590.6 13603.3 12395.6 12757.5 12864.9 12873.1 12874.6 797.1 806.2 807.6 808.1 808.3 644.4 659.4 802.1 832.2 832.4 855.2 859.7 868.0 868.2 871.5 853.5 855.8 860.8 863.1 863.4 625.0 626.9 630.0 631.4 632.0 13076.3 13129.7 13188.3 13221.2 13248.4 11881.6 12143.1 12294.8 12592.2 13126.5 9981.8 10237.8 10317.9 10733.4 10872.4 3546.9 3554.0 3565.8 3574.5 3589.9 43102.8 43548.6 43571.8 43930.6 44012.3 9837.8 9886.8 10033.5 10047.6 10090.1 18339.7 18568.0 18571.0 18574.1 18581.0 7701.7 7735.0 7836.1 7912.8 8091.2 4416.7 4531.8 4551.8 4555.7 4657.6 2867.3 2881.1 2909.0 2931.5 2949.1 522.6 527.1 530.7 533.0 543.3 587.7 605.4 651.4 694.4 701.4 8006.2 8414.4 8638.1 8777.6 8784.6 532.9 551.4 703.0 709.7 711.9 3734.5 3999.0 4080.8 4083.2 4102.9 53480.5 53495.5 53712.7 53919.2 53941.0 43493.8 46303.5 48710.0 49253.8 49361.0 43387.1 44483.0 44921.0 45540.8 45582.5 8826.7 8951.8 8967.8 8979.9 9040.9 34342.8 34601.7 35173.1 35240.0 35263.3 39800.6 41286.4 43881.8 44101.3 44193.1 11064.5 11270.9 11301.7 11431.9 11630.9 12063.0 12277.4 12639.7 12685.9 13083.5 11243.9 11444.7 11504.9 11715.1 11806.8 11130.2 11350.7 11354.5 11595.4 11646.5 11051.7 11327.8 11330.8 11421.0 11571.5 9935.6 9979.4 10262.9 10294.3 10303.4 8717.9 8834.2 8839.7 9133.4 9987.0 19:06:58 INFO - PROCESS | 18223 | -------- Summary: end -------- 19:06:58 INFO - PROCESS | 18223 | 19:06:59 INFO - TEST-INFO | 18223: exit 0 19:06:59 INFO - TEST-OK | dromaeo_css | took 1110703ms 19:06:59 INFO - TEST-START | kraken 19:06:59 INFO - operating with platform_type : linux_ 19:06:59 INFO - Initialising browser for kraken test... 19:06:59 INFO - TEST-INFO | started process 18462 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNwIpUQ/profile http://localhost:57163/getInfo.html) 19:07:04 INFO - PROCESS | 18462 | __metrics Screen width/height:1600/1200 19:07:04 INFO - PROCESS | 18462 | colorDepth:24 19:07:04 INFO - PROCESS | 18462 | Browser inner width/height: 1024/697 19:07:04 INFO - PROCESS | 18462 | __metrics 19:07:04 INFO - PROCESS | 18462 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:07:05 INFO - TEST-INFO | 18462: exit 0 19:07:05 INFO - Browser initialized. 19:07:05 INFO - Running cycle 1/1 for kraken test... 19:07:05 INFO - TEST-INFO | started process 18581 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNwIpUQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:07:16 INFO - PROCESS | 18581 | RSS: Main: 149581824 19:07:16 INFO - PROCESS | 18581 | 19:07:19 INFO - PROCESS | 18581 | Cycle 1(1): loaded http://localhost:57163/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57163/tests/kraken/driver.html?testName=audio-beat-detection) 19:07:20 INFO - PROCESS | 18581 | RSS: Main: 150900736 19:07:20 INFO - PROCESS | 18581 | 19:07:22 INFO - PROCESS | 18581 | Cycle 1(1): loaded http://localhost:57163/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57163/tests/kraken/driver.html?testName=audio-dft) 19:07:23 INFO - PROCESS | 18581 | RSS: Main: 149692416 19:07:23 INFO - PROCESS | 18581 | 19:07:26 INFO - PROCESS | 18581 | Cycle 1(1): loaded http://localhost:57163/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57163/tests/kraken/driver.html?testName=audio-fft) 19:07:26 INFO - PROCESS | 18581 | RSS: Main: 145584128 19:07:26 INFO - PROCESS | 18581 | 19:07:29 INFO - PROCESS | 18581 | Cycle 1(1): loaded http://localhost:57163/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57163/tests/kraken/driver.html?testName=audio-oscillator) 19:07:29 INFO - PROCESS | 18581 | RSS: Main: 146702336 19:07:29 INFO - PROCESS | 18581 | 19:07:31 INFO - PROCESS | 18581 | Cycle 1(1): loaded http://localhost:57163/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57163/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:07:32 INFO - PROCESS | 18581 | RSS: Main: 146882560 19:07:32 INFO - PROCESS | 18581 | 19:07:35 INFO - PROCESS | 18581 | Cycle 1(1): loaded http://localhost:57163/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57163/tests/kraken/driver.html?testName=imaging-darkroom) 19:07:36 INFO - PROCESS | 18581 | RSS: Main: 145780736 19:07:36 INFO - PROCESS | 18581 | 19:07:39 INFO - PROCESS | 18581 | Cycle 1(1): loaded http://localhost:57163/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57163/tests/kraken/driver.html?testName=imaging-desaturate) 19:07:39 INFO - PROCESS | 18581 | RSS: Main: 147992576 19:07:39 INFO - PROCESS | 18581 | 19:07:42 INFO - PROCESS | 18581 | Cycle 1(1): loaded http://localhost:57163/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57163/tests/kraken/driver.html?testName=json-parse-financial) 19:07:43 INFO - PROCESS | 18581 | RSS: Main: 147365888 19:07:43 INFO - PROCESS | 18581 | 19:07:45 INFO - PROCESS | 18581 | Cycle 1(1): loaded http://localhost:57163/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57163/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:07:45 INFO - PROCESS | 18581 | RSS: Main: 148361216 19:07:45 INFO - PROCESS | 18581 | 19:07:47 INFO - PROCESS | 18581 | Cycle 1(1): loaded http://localhost:57163/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57163/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:07:48 INFO - PROCESS | 18581 | RSS: Main: 148766720 19:07:48 INFO - PROCESS | 18581 | 19:07:50 INFO - PROCESS | 18581 | Cycle 1(1): loaded http://localhost:57163/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57163/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:07:50 INFO - PROCESS | 18581 | RSS: Main: 148365312 19:07:50 INFO - PROCESS | 18581 | 19:07:53 INFO - PROCESS | 18581 | Cycle 1(1): loaded http://localhost:57163/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:07:53 INFO - PROCESS | 18581 | RSS: Main: 147132416 19:07:53 INFO - PROCESS | 18581 | 19:07:56 INFO - PROCESS | 18581 | Cycle 1(1): loaded http://localhost:57163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:07:56 INFO - PROCESS | 18581 | RSS: Main: 148828160 19:07:56 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | Cycle 1(1): loaded http://localhost:57163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57163/tests/kraken/driver.html?testName=ai-astar) 19:07:58 INFO - PROCESS | 18581 | RSS: Main: 148013056 19:07:58 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | __start_tp_report 19:07:58 INFO - PROCESS | 18581 | _x_x_mozilla_page_load 19:07:58 INFO - PROCESS | 18581 | _x_x_mozilla_page_load_details 19:07:58 INFO - PROCESS | 18581 | |i|pagename|runs| 19:07:58 INFO - PROCESS | 18581 | |0;ai-astar;111;107;114;111;114;121;112;113;112;115 19:07:58 INFO - PROCESS | 18581 | |1;audio-beat-detection;157;139;157;168;125;164;152;130;166;130 19:07:58 INFO - PROCESS | 18581 | |2;audio-dft;162;163;163;164;163;162;162;171;163;164 19:07:58 INFO - PROCESS | 18581 | |3;audio-fft;74;73;73;73;71;73;72;138;71;72 19:07:58 INFO - PROCESS | 18581 | |4;audio-oscillator;98;97;140;97;95;97;142;98;97;145 19:07:58 INFO - PROCESS | 18581 | |5;imaging-gaussian-blur;110;110;110;110;109;111;110;114;109;110 19:07:58 INFO - PROCESS | 18581 | |6;imaging-darkroom;147;145;147;146;148;146;147;146;146;146 19:07:58 INFO - PROCESS | 18581 | |7;imaging-desaturate;101;96;96;98;96;96;97;96;96;97 19:07:58 INFO - PROCESS | 18581 | |8;json-parse-financial;63;59;60;59;59;61;59;63;63;58 19:07:58 INFO - PROCESS | 18581 | |9;json-stringify-tinderbox;67;70;68;67;69;68;68;68;68;68 19:07:58 INFO - PROCESS | 18581 | |10;stanford-crypto-aes;92;86;96;89;86;86;86;85;86;88 19:07:58 INFO - PROCESS | 18581 | |11;stanford-crypto-ccm;122;122;119;124;122;126;119;121;121;117 19:07:58 INFO - PROCESS | 18581 | |12;stanford-crypto-pbkdf2;141;150;157;152;150;142;151;142;153;151 19:07:58 INFO - PROCESS | 18581 | |13;stanford-crypto-sha256-iterative;66;67;68;75;68;67;69;67;66;66 19:07:58 INFO - PROCESS | 18581 | __end_tp_report 19:07:58 INFO - PROCESS | 18581 | __start_cc_report 19:07:58 INFO - PROCESS | 18581 | _x_x_mozilla_cycle_collect,745 19:07:58 INFO - PROCESS | 18581 | __end_cc_report 19:07:58 INFO - PROCESS | 18581 | __startTimestamp1451185678941__endTimestamp 19:07:58 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | ------- Summary: start ------- 19:07:58 INFO - PROCESS | 18581 | Number of tests: 14 19:07:58 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.50 stddev:3.59 (3.2%) stddev-sans-first:3.73 19:07:58 INFO - PROCESS | 18581 | Values: 111.0 107.0 114.0 111.0 114.0 121.0 112.0 113.0 112.0 115.0 19:07:58 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:157.00 stddev:16.36 (10.4%) stddev-sans-first:17.08 19:07:58 INFO - PROCESS | 18581 | Values: 157.0 139.0 157.0 168.0 125.0 164.0 152.0 130.0 166.0 130.0 19:07:58 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:2.67 (1.6%) stddev-sans-first:2.76 19:07:58 INFO - PROCESS | 18581 | Values: 162.0 163.0 163.0 164.0 163.0 162.0 162.0 171.0 163.0 164.0 19:07:58 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | [#3] audio-fft Cycles:10 Average:79.00 Median:73.00 stddev:20.75 (28.4%) stddev-sans-first:21.93 19:07:58 INFO - PROCESS | 18581 | Values: 74.0 73.0 73.0 73.0 71.0 73.0 72.0 138.0 71.0 72.0 19:07:58 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:97.00 stddev:21.95 (22.6%) stddev-sans-first:22.80 19:07:58 INFO - PROCESS | 18581 | Values: 98.0 97.0 140.0 97.0 95.0 97.0 142.0 98.0 97.0 145.0 19:07:58 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:1.42 (1.3%) stddev-sans-first:1.50 19:07:58 INFO - PROCESS | 18581 | Values: 110.0 110.0 110.0 110.0 109.0 111.0 110.0 114.0 109.0 110.0 19:07:58 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 19:07:58 INFO - PROCESS | 18581 | Values: 147.0 145.0 147.0 146.0 148.0 146.0 147.0 146.0 146.0 146.0 19:07:58 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:96.00 stddev:1.60 (1.7%) stddev-sans-first:0.73 19:07:58 INFO - PROCESS | 18581 | Values: 101.0 96.0 96.0 98.0 96.0 96.0 97.0 96.0 96.0 97.0 19:07:58 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | [#8] json-parse-financial Cycles:10 Average:60.40 Median:60.50 stddev:1.96 (3.2%) stddev-sans-first:1.83 19:07:58 INFO - PROCESS | 18581 | Values: 63.0 59.0 60.0 59.0 59.0 61.0 59.0 63.0 63.0 58.0 19:07:58 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 19:07:58 INFO - PROCESS | 18581 | Values: 67.0 70.0 68.0 67.0 69.0 68.0 68.0 68.0 68.0 68.0 19:07:58 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:87.00 stddev:3.50 (4.0%) stddev-sans-first:3.40 19:07:58 INFO - PROCESS | 18581 | Values: 92.0 86.0 96.0 89.0 86.0 86.0 86.0 85.0 86.0 88.0 19:07:58 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:122.00 stddev:2.58 (2.1%) stddev-sans-first:2.73 19:07:58 INFO - PROCESS | 18581 | Values: 122.0 122.0 119.0 124.0 122.0 126.0 119.0 121.0 121.0 117.0 19:07:58 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:151.00 stddev:5.38 (3.6%) stddev-sans-first:4.89 19:07:58 INFO - PROCESS | 18581 | Values: 141.0 150.0 157.0 152.0 150.0 142.0 151.0 142.0 153.0 151.0 19:07:58 INFO - PROCESS | 18581 | 19:07:58 INFO - PROCESS | 18581 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:2.69 (4.0%) stddev-sans-first:2.76 19:07:58 INFO - PROCESS | 18581 | Values: 66.0 67.0 68.0 75.0 68.0 67.0 69.0 67.0 66.0 66.0 19:07:58 INFO - PROCESS | 18581 | -------- Summary: end -------- 19:07:58 INFO - PROCESS | 18581 | 19:07:59 INFO - TEST-INFO | 18581: exit 0 19:07:59 INFO - TEST-OK | kraken | took 60159ms 19:07:59 INFO - TEST-START | v8_7 19:07:59 INFO - operating with platform_type : linux_ 19:07:59 INFO - Initialising browser for v8_7 test... 19:07:59 INFO - TEST-INFO | started process 18868 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJtJoCI/profile http://localhost:57163/getInfo.html) 19:08:04 INFO - PROCESS | 18868 | __metrics Screen width/height:1600/1200 19:08:04 INFO - PROCESS | 18868 | colorDepth:24 19:08:04 INFO - PROCESS | 18868 | Browser inner width/height: 1024/697 19:08:04 INFO - PROCESS | 18868 | __metrics 19:08:04 INFO - PROCESS | 18868 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:08:05 INFO - TEST-INFO | 18868: exit 0 19:08:05 INFO - Browser initialized. 19:08:05 INFO - Running cycle 1/1 for v8_7 test... 19:08:05 INFO - TEST-INFO | started process 18993 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJtJoCI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:17 INFO - PROCESS | 18993 | RSS: Main: 149602304 19:08:17 INFO - PROCESS | 18993 | 19:08:38 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:57163/tests/v8_7/run.html (next: http://localhost:57163/tests/v8_7/run.html) 19:08:38 INFO - PROCESS | 18993 | RSS: Main: 146558976 19:08:38 INFO - PROCESS | 18993 | 19:08:38 INFO - PROCESS | 18993 | __start_tp_report 19:08:38 INFO - PROCESS | 18993 | _x_x_mozilla_page_load 19:08:38 INFO - PROCESS | 18993 | _x_x_mozilla_page_load_details 19:08:38 INFO - PROCESS | 18993 | |i|pagename|runs| 19:08:38 INFO - PROCESS | 18993 | |0;Richards;171.32088401576152 19:08:38 INFO - PROCESS | 18993 | |1;DeltaBlue;191.2411550965768 19:08:38 INFO - PROCESS | 18993 | |2;Encrypt;279.79854504756577 19:08:38 INFO - PROCESS | 18993 | |3;Decrypt;5223.958333333333 19:08:38 INFO - PROCESS | 18993 | |4;RayTrace;1064.9627263045793 19:08:38 INFO - PROCESS | 18993 | |5;Earley;706.4220183486239 19:08:38 INFO - PROCESS | 18993 | |6;Boyer;12207.317073170732 19:08:38 INFO - PROCESS | 18993 | |7;RegExp;25450 19:08:38 INFO - PROCESS | 18993 | |8;Splay;684.641638225256 19:08:38 INFO - PROCESS | 18993 | |9;NavierStokes;4830.917874396136 19:08:38 INFO - PROCESS | 18993 | __end_tp_report 19:08:38 INFO - PROCESS | 18993 | __startTimestamp1451185718716__endTimestamp 19:08:38 INFO - PROCESS | 18993 | 19:08:38 INFO - PROCESS | 18993 | ------- Summary: start ------- 19:08:38 INFO - PROCESS | 18993 | Number of tests: 10 19:08:38 INFO - PROCESS | 18993 | 19:08:38 INFO - PROCESS | 18993 | [#0] Richards Cycles:1 Average:171.32 Median:171.32 stddev:0.00 (0.0%) 19:08:38 INFO - PROCESS | 18993 | Values: 171.3 19:08:38 INFO - PROCESS | 18993 | 19:08:38 INFO - PROCESS | 18993 | [#1] DeltaBlue Cycles:1 Average:191.24 Median:191.24 stddev:0.00 (0.0%) 19:08:38 INFO - PROCESS | 18993 | Values: 191.2 19:08:38 INFO - PROCESS | 18993 | 19:08:38 INFO - PROCESS | 18993 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 19:08:38 INFO - PROCESS | 18993 | Values: 279.8 19:08:38 INFO - PROCESS | 18993 | 19:08:38 INFO - PROCESS | 18993 | [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 19:08:38 INFO - PROCESS | 18993 | Values: 5224.0 19:08:38 INFO - PROCESS | 18993 | 19:08:38 INFO - PROCESS | 18993 | [#4] RayTrace Cycles:1 Average:1064.96 Median:1064.96 stddev:0.00 (0.0%) 19:08:38 INFO - PROCESS | 18993 | Values: 1065.0 19:08:38 INFO - PROCESS | 18993 | 19:08:38 INFO - PROCESS | 18993 | [#5] Earley Cycles:1 Average:706.42 Median:706.42 stddev:0.00 (0.0%) 19:08:38 INFO - PROCESS | 18993 | Values: 706.4 19:08:38 INFO - PROCESS | 18993 | 19:08:38 INFO - PROCESS | 18993 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 19:08:38 INFO - PROCESS | 18993 | Values: 12207.3 19:08:38 INFO - PROCESS | 18993 | 19:08:38 INFO - PROCESS | 18993 | [#7] RegExp Cycles:1 Average:25450.00 Median:25450.00 stddev:0.00 (0.0%) 19:08:38 INFO - PROCESS | 18993 | Values: 25450.0 19:08:38 INFO - PROCESS | 18993 | 19:08:38 INFO - PROCESS | 18993 | [#8] Splay Cycles:1 Average:684.64 Median:684.64 stddev:0.00 (0.0%) 19:08:38 INFO - PROCESS | 18993 | Values: 684.6 19:08:38 INFO - PROCESS | 18993 | 19:08:38 INFO - PROCESS | 18993 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 19:08:38 INFO - PROCESS | 18993 | Values: 4830.9 19:08:38 INFO - PROCESS | 18993 | -------- Summary: end -------- 19:08:38 INFO - PROCESS | 18993 | 19:08:39 INFO - TEST-INFO | 18993: exit 0 19:08:39 INFO - TEST-OK | v8_7 | took 39745ms 19:08:39 INFO - SUITE-END | took 1210s 19:08:39 INFO - Completed test suite (00:20:10) 19:08:39 INFO - Working with test: dromaeo_css 19:08:39 INFO - Generating results file: dromaeo_css 19:08:39 INFO - Working with test: kraken 19:08:39 INFO - Generating results file: kraken 19:08:39 INFO - javascript benchmark 19:08:39 INFO - Working with test: v8_7 19:08:39 INFO - Generating results file: v8_7 19:08:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:08:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 19:08:39 INFO - process_Request line: dromaeo_css 6991.37 graph.html#tests=[[72,63,43]] 19:08:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:08:39 INFO - process_Request line: kraken 1523.30 graph.html#tests=[[232,63,43]] 19:08:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:08:39 INFO - process_Request line: v8_7 21020.79 graph.html#tests=[[230,63,43]] 19:08:39 INFO - RETURN: dromaeo_css: 6991.37 19:08:39 INFO - RETURN: kraken: 1523.30 19:08:39 INFO - RETURN: v8_7: 21020.79 19:08:39 INFO - javascript benchmark 19:08:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3160.841957902105, 3210.8073515589067, 3236.789608675437, 3249.5938007749023, 3265.0531345909685, 5105.668131571445, 5270.947290527089, 5271.393789714184, 5285.497877701617, 5297.655652382592, 5178.171492561191, 5225.477452254782, 5291.841244762653, 5391.218273350371, 5406.297181366427, 4855.805767769285, 4919.803207871681, 4986.476419975905, 5006.22403527452, 5006.624503162259, 4867.3915760529935, 4927.827526036589, 4937.210046392578, 4980.452150263468, 5075.365579302587, 4773.3078703588135, 4860.586850117745, 4902.950970490303, 4928.507149285043, 5014.072396606622, 4860.076585448754, 4913.189323761575, 4920.40955085392, 4927.950720492785, 4936.580390666798, 4828.106800241966, 4837.462067871252, 4837.637177211688, 4860.562549370538, 4897.094037603019, 4994.575461085812, 5059.519345662156, 5083.059633967728, 5112.514311140436, 5140.691558506464, 5578.721063946787, 5620.578456615729, 5695.202671625976, 5771.942280577225, 5800.506956908668, 5756.712164391805, 5793.942060579382, 5799.768009279624, 5803.593748437611, 5805.796797112081, 5272.868178295574, 5430.104032834617, 5432.266644003088, 5437.238786569884, 5447.400785913586, 5794.942050579524, 5859.091840764689, 5896.292444906639, 5902.6458412495385, 5952.375000624872, 5669.206311116447, 5680.375158732536, 5687.971560142173, 5691.573132015115, 5692.288463942007, 5598.496135347838, 5692.0, 5696.829095127153, 5698.31620205578, 5766.855828604318, 5672.8865422691315, 5706.3152421709665, 5743.0, 5751.1085781703905, 5765.85585360361, 5731.254936858182, 5742.081266997344, 5756.942430575725, 5767.423257674283, 5777.075667893117, 4320.0, 4381.5618438155925, 4383.802728877208, 4428.82284708608, 4467.195904737114, 3926.0, 3927.9607203927594, 3940.822662980173, 3963.781991990468, 3976.5228172619472, 5354.732263386815, 5365.704886231217, 5367.1680889462195, 5373.059714549938, 5418.02475554404, 5595.132754423071, 5622.437756224426, 5691.0609749391715, 5727.198192253088, 5738.713064346766, 5331.200319952039, 5350.625456218105, 5357.866053348697, 5358.8660283492445, 5361.115415956401, 4885.706857588556, 4888.682235654671, 4895.167821470359, 4895.7062576245535, 4952.380952380952, 5717.142428635738, 5814.505767009767, 5828.388019257917, 5833.50415214703, 5919.852003699942, 5658.85852853682, 5683.403242659461, 5685.0335442973965, 5698.145278208136, 5702.6863522506665, 5846.0, 5863.618864773776, 5886.381929897299, 5890.617109887844, 5904.734286957011, 5554.0, 5631.577631677558, 5633.3521645009705, 5635.211070450058, 5737.655740655574, 5687.317521897398, 5739.770409183586, 5743.913841292468, 5745.97127014379, 5752.165935939349, 5462.453754624665, 5524.917126243029, 5526.889462210653, 5533.916991245054, 5536.916946245729, 5501.284832971688, 5534.972325138348, 5544.362398324244, 5556.194351818883, 5588.6646801192055, 5500.1199808032125, 5500.257465242141, 5522.972385138049, 5523.502884740393, 5524.364698059614, 5487.64330318528, 5573.637713548606, 5599.692016939108, 5617.775288988558, 5715.428457154418, 5452.645578037414, 5522.558195344443, 5523.447655234605, 5524.8342549723575, 5553.916691249715], "unit": "score", "name": "dojo.html", "value": 5270.843828209338}, {"lowerIsBetter": false, "replicates": [557.5093917352729, 572.1246492865914, 575.2579172867001, 576.2623841482904, 576.4840467781336, 33781.0, 35115.473267901005, 35241.82379088104, 35278.47082293768, 35300.64699353009, 37740.43389349155, 38223.61776382235, 38397.808010959976, 38401.0, 38522.0, 8608.526531040807, 8909.509976951265, 8913.331500137483, 8916.331275154356, 8923.330750193729, 8668.133186681313, 8732.781680457976, 8782.209601135897, 8822.73531794044, 8834.514101724402, 8707.782305442352, 8770.991335996347, 8797.120287971184, 8839.116088391174, 8858.0, 8763.12368763125, 8829.205371516562, 8835.20483156519, 8853.42452740573, 8859.379843410963, 8497.107803680587, 8653.610587523577, 8691.521966291852, 8705.216530512283, 8707.34694897879, 37979.810100949595, 38751.64369247091, 38756.61243387558, 38759.418608720895, 38795.41806872899, 3074.3390171113097, 3079.322549039208, 3132.1230055584474, 3417.8974630761118, 3627.2564124354444, 28967.42065158706, 29098.70901290981, 29350.853245733633, 29784.8510757447, 30294.242643933856, 3883.611638836122, 4023.2154729827694, 4062.695297852673, 4065.7763822989723, 4068.8169032393316, 210883.0, 213732.0, 213830.0, 215417.0, 215460.0, 53136.468635313926, 54780.452195477534, 55278.72360638171, 55660.0, 59766.91981181561, 54183.18725219125, 54446.72776636091, 54572.0, 54816.0, 54854.0, 14427.711445771025, 14506.057106288057, 14572.85427145715, 14575.562733117811, 14617.926910365593, 11072.723181920355, 11210.66368008961, 11226.214165008534, 11233.213675042669, 11256.21206515536, 19325.226990920204, 19590.545523494224, 20078.19296263343, 20218.595628087354, 20269.797302026793, 7861.292483676497, 7954.164812694699, 8017.639206235734, 8047.436679432383, 8172.877406838902, 892.5403417240127, 944.2823454174877, 944.2964991081689, 1038.5274700011478, 1063.7181146996052, 27145.728542714714, 27157.72842271552, 27375.45249095047, 27681.86159069232, 27684.861575691993, 1017.1913328903539, 1025.4718819807806, 1040.0847254416065, 1057.836035414512, 1127.939736647565, 14338.334113149562, 14513.419463221353, 14517.854821451861, 14564.198969056804, 14615.0, 303946.0, 304568.0, 306589.0, 306790.0, 309707.0, 49569.25646115311, 49758.253626195634, 50059.74970125126, 50156.498435015914, 50391.24413133806, 1302.1926405628572, 1352.5942217334957, 1354.214555557774, 1358.429459626959, 1363.3660347938057, 26005.6099158509, 27442.725572744817, 27824.304392390353, 28009.43981120407, 28075.859620701765, 45907.770461147484, 46069.0, 46270.305945410175, 46307.76846115748, 46398.76800615976, 280614.0, 284724.0, 284972.0, 285031.0, 285150.0, 31946.36107277888, 40973.59026409817, 42589.787051064544, 42821.35767963421, 42956.57043429526, 39093.41359879661, 39888.2022359557, 40024.599754003255, 40065.0, 40668.79665601653, 35378.292434151685, 35503.69653493471, 35516.11209719778, 35884.820575896956, 36348.63651363453, 36325.818370907975, 36641.0, 37455.81272093622, 38500.614993850824, 38945.8052709746, 33103.33793324072, 33715.0, 33962.81130160433, 34137.31725365429, 34175.48736769, 28778.0, 29441.85279073591, 30570.235744105685, 32790.180245494055, 33782.8310858454, 23617.40956476102, 23852.642210367205, 24507.387315316548, 25269.24192274235, 26176.73823261743], "unit": "score", "name": "ext.html", "value": 18052.95975172041}, {"lowerIsBetter": false, "replicates": [350.9420945543985, 353.72939701128627, 357.44595876391605, 357.59770258459224, 359.2169071424294, 11401.657950261506, 11862.051035917128, 15992.12043337616, 16287.185640717977, 16855.747163792523, 16826.24281907314, 16889.23998420071, 16902.57743556412, 17009.829901700978, 17023.148842557883, 5742.655440673562, 6021.2473440819895, 6021.698915054251, 6032.69836508175, 6043.244594425697, 4490.865274041784, 5962.34414214436, 6008.519318454513, 6015.578909476339, 6015.849603759897, 6115.235595550556, 6116.969415152918, 6120.785772497963, 6360.0, 6595.53831231814, 6441.4524765395, 6551.493156573991, 6564.04821300911, 6589.703463344161, 6901.654917254167, 6646.900296495556, 6659.533832631718, 6679.866402671968, 6680.83297917551, 6695.46436285096, 21374.679379809317, 21919.452013699625, 22252.10991560352, 22833.543329133325, 22842.657360139612, 2258.1419060756807, 2260.0394832196416, 2307.5038866643754, 2367.171489978511, 2537.581299085649, 13844.0, 13877.0, 13928.93035534826, 14417.71164576713, 14468.421263149461, 2027.6451620966272, 2043.5606344635974, 2054.6404379233572, 2054.6917962305624, 2056.23919149914, 63042.0, 68917.65541172313, 69103.0, 69822.65088674524, 71257.28742712559, 14970.251487425803, 15212.0, 15268.465603703817, 15309.0, 15342.232888355538, 23845.403864903168, 23975.28074157778, 24044.0, 24149.637755433683, 24219.515609687707, 8527.658893644184, 8540.871886921701, 8545.487270763773, 8558.95720521406, 8598.140185981352, 6983.9650801745665, 7009.369156775914, 7038.155421349368, 7044.330788575077, 7063.752768653072, 7565.054368203974, 7569.318761311509, 7596.2023987481625, 7607.315341619281, 7618.352440042548, 1771.6899542579997, 3010.5785190073407, 3034.7117023882697, 3086.6758990305693, 3158.1788734928623, 454.09861425071205, 459.12307492689473, 469.0127282071191, 795.3408674464866, 994.5673631970116, 16147.354105835635, 16582.419615313407, 16643.83356166447, 16936.153192340334, 17171.31314747421, 877.5568337989274, 904.2539904578617, 949.2785483032944, 959.4435227567993, 1001.519270750044, 8819.382643215042, 9031.864522032174, 9116.81766364669, 9238.722838314861, 9462.52687365629, 562417.0, 566334.0, 581001.0, 585691.0, 589140.0, 38393.0, 38591.614083859364, 38644.0, 75278.62360688162, 76140.23859761443, 1103.6633826682778, 1108.4070022537903, 1136.2614300704442, 1162.430409099552, 1176.0709039858586, 15402.691946161238, 15612.4535641252, 15683.294251758927, 15695.843041569895, 15729.134897580743, 34389.65610343964, 34510.65489345175, 35051.47422788711, 35321.11697207487, 35541.0, 44086.77956610196, 45059.77470112628, 45676.0, 46006.309905352115, 46162.307565387215, 9715.271354648288, 9723.0, 9856.950715246665, 12800.807987880375, 13152.934235328763, 18120.818791811915, 18252.0, 18587.90706046461, 18593.53516162107, 18797.248110075445, 9875.913649498692, 10080.395176289447, 10243.07812296897, 10277.9486102569, 10433.634822781167, 10043.196544276294, 10057.597696092074, 10165.695029149138, 10198.541065651914, 10474.319169253975, 10056.446895420822, 10312.432816195182, 10514.842277365693, 10535.15718742514, 10576.576936922436, 14538.491152809602, 14625.122492650475, 14781.260936952895, 14865.554033379016, 14878.10731356122, 15452.459163929208, 15731.921340393683, 15759.369625215322, 15769.68460630758, 15872.841271587136], "unit": "score", "name": "jquery.html", "value": 9505.076895836184}, {"lowerIsBetter": false, "replicates": [1415.929203539823, 1420.865017823307, 1542.8457154284572, 1692.0778175894136, 1714.4685147604243, 7108.715651373946, 7120.394766444859, 7222.061132052832, 7248.0577524921755, 7253.1296244450605, 7192.712291508346, 7204.279572042793, 7271.709131634741, 7284.417246620271, 7290.635468226581, 2198.1756841184556, 2229.4649284171846, 2232.553489302138, 2235.8099561537288, 2237.161064600775, 2173.6956826044366, 2220.9222677206303, 2232.977670223301, 2236.1279101150562, 2236.507968246983, 2171.587398394308, 2178.9891050544725, 2198.835087368446, 2199.186301068607, 2228.4206106412366, 2113.8414618903644, 2117.76704562498, 2135.2099723102397, 2142.967855482161, 2146.0771868096713, 2172.0443005077714, 2177.0529819528397, 2182.6071307164702, 2185.497335612802, 2190.8575942563684, 6833.521653484258, 6869.7595584154315, 6885.965570172117, 6895.0, 6936.79189624307, 4372.650187984986, 4403.251447253974, 4403.581659742319, 4452.977735111303, 4459.777011149462, 2897.043975488084, 2947.852607369623, 2964.985175074111, 2972.4203780262856, 2979.433907557557, 993.8658281132027, 995.6365926436871, 1011.2163073617932, 1043.405259002369, 1050.070687441612, 9390.95304523473, 9457.0, 9488.810223795486, 9501.382410143387, 9516.476593787338, 3937.724359294822, 4019.1157945252, 4025.7383270087353, 4030.6976976726864, 4047.919041619151, 8279.710210142737, 8356.582170891432, 8376.706815261437, 8388.11924747905, 8423.747287581382, 4405.096955124256, 4405.273129933525, 4413.426254586883, 4433.490148632948, 4435.2903535434825, 4024.7987600619854, 4029.9395509067385, 4034.959650403517, 4042.3532234842282, 4066.4510291110914, 3448.3275761226823, 3448.620651728308, 3470.444728843373, 3471.4272145096284, 3490.650934906489, 1124.173732306754, 1125.8254970479588, 1129.8813624569466, 1131.8415421840948, 1151.7120719820045, 934.0612684252283, 969.6121551379364, 1058.4284486377423, 1081.7728277061906, 1269.022852403644, 6453.709583068773, 6454.515911306671, 6492.805215843532, 6492.837679058061, 6498.252700939358, 585.645684360964, 592.1916583863082, 596.5674885707914, 633.2590868683559, 733.9834329453745, 5098.694078355311, 5177.870553236199, 5186.533212010937, 5193.2989046479, 5194.27280180775, 8022.9197708022175, 8111.351091912633, 8200.630971606291, 8215.383846211558, 8303.377246706521, 8061.153578874251, 8158.184181581794, 8193.918060819435, 8207.0, 8220.547869867096, 6610.7025183866845, 6620.503462240351, 6782.186137663413, 6813.931860681429, 6853.246142924274, 6533.379328963741, 6651.201855777338, 6700.899486507804, 6706.93293067063, 6712.060311556288, 7586.165521792488, 7723.073231212291, 7735.806604834699, 7820.687172513036, 7830.608469576612, 7598.430117741081, 7883.211678832071, 7899.0126234220725, 7979.16218797018, 7985.760427187193, 6282.1519094921605, 6324.905126423199, 6358.682065896594, 6385.904211436739, 6404.551681382259, 6739.528233023641, 6920.8961865573065, 6926.653667316715, 6933.272006439453, 6956.826079348057, 5623.915641265467, 6540.771073012422, 6590.373914478117, 6611.206655201407, 6737.797866064026, 5881.7647294109465, 6363.87272254543, 6436.13112229843, 6517.0, 6533.8693226136165, 6362.0774987627465, 6424.421802037652, 6437.517186210959, 6476.579022363531, 6489.610623362613, 5927.407259274038, 5976.013957696931, 5989.101634754822, 5996.070609055603, 6005.399460054135, 5808.76764929415, 5827.125931110368, 5828.825135245949, 5840.386759390372, 5851.61964472308], "unit": "score", "name": "mootools.html", "value": 4119.914020172102}, {"lowerIsBetter": false, "replicates": [329.5221928204104, 337.4516410832398, 338.2507745344062, 339.64846383992574, 345.4024537550038, 6224.595401298912, 6253.155823963763, 6267.341929097447, 6292.5909815862, 6355.046742988554, 6203.782867599635, 6295.811125666226, 6305.653189074611, 6306.59007164534, 6317.77887773928, 4763.309320148576, 4768.403949506312, 4786.593139583122, 4788.018456216468, 4789.137955168068, 4783.402074740658, 4787.521247875202, 4791.496892826255, 4793.137235297645, 4794.993051459198, 4656.1153380857695, 4711.199096153645, 4718.764061796914, 4720.575148236658, 4722.8110875564935, 4697.0, 4701.482836887957, 4706.3411122442885, 4708.835190768341, 4714.0, 4060.106776509193, 4079.3065178919655, 4092.4679791627195, 4097.44684467596, 4099.262132816092, 5988.610740301867, 5994.400559944014, 6018.6689732064715, 6040.516758659341, 6109.541784366146, 5373.489518495737, 5537.197106419587, 5548.029094908416, 5548.056830338852, 5549.334079910396, 6690.230623478314, 6705.497087718391, 6713.798586042427, 6719.0, 6721.66391680414, 4534.977325113353, 4541.137183935041, 4561.771911404417, 4585.197590421696, 4592.311153326994, 6830.897536536956, 6920.100386949664, 6978.0, 6987.37113659768, 6998.580085194853, 4633.073385322881, 4637.60580350674, 4650.67445278834, 4651.906961860744, 4661.394018777537, 4686.953130468652, 4722.693024953367, 4723.7874295656775, 4724.503927087675, 4726.3146843708155, 5495.725213739297, 5496.945030549723, 5501.477359650827, 5508.614396992172, 5514.228008078872, 6598.868022639616, 6724.6301453419555, 6725.327467253235, 6728.0, 6732.865342693119, 1623.350659736115, 1654.6359800843795, 1671.4901954903871, 1675.388483203622, 1676.1451659653421, 1082.7888561730388, 1099.69758316462, 1110.4336788238056, 1112.4548971004149, 1115.1301984451977, 6236.75052997875, 6269.341719119518, 6282.151909492251, 6284.905726414107, 6292.528060395397, 6805.421539169127, 6853.211880633791, 6870.965645171742, 6874.518783685094, 6876.965615171892, 6062.302835173923, 6260.186175797117, 6267.122602835607, 6277.403646653561, 6279.560430769893, 3711.4432835074954, 3715.8142092895246, 3728.5525736911745, 3735.14091758897, 3745.9438108428394, 7119.074520312326, 7130.500864939509, 7136.357727804522, 7198.5320954137815, 7230.710771569078, 6950.582965022115, 6980.546264492792, 6994.8950765738555, 7017.122859642544, 7020.9648951755935, 7305.123385193704, 7312.926870731331, 7317.926820731831, 7322.048133742579, 7347.265273472717, 7024.613646249505, 7034.050403195503, 7037.753678621224, 7041.471889608402, 7043.964780176067, 6781.0845535854005, 6907.171139463297, 6912.308769123048, 6945.687444064928, 6951.582905025714, 7275.054242948383, 7295.197528271779, 7296.160941491797, 7298.23368546295, 7319.121705395387, 4556.270996640522, 4563.885902852455, 4585.243434833215, 4606.3551102846295, 4613.261878099488, 6882.5870447773295, 6965.825854353681, 6992.1259842519685, 7003.229644739176, 7003.26465721092, 6782.491313151632, 6788.66056697173, 6788.898166527605, 6794.898076528955, 6810.62541560219, 6738.932610673831, 6742.25835158142, 6769.93230067693, 6775.661216939035, 6795.864082718417, 6536.0, 6661.1007513985, 6668.499862510234, 6672.666366681549, 6675.833104172434, 6779.491538134561, 6830.829229269109, 6844.931550684629, 6853.451723861979, 6858.5199036067, 6601.207855057424, 6662.800115996528, 6664.133662623828, 6673.833154171185, 6687.431568316748], "unit": "score", "name": "prototype.html", "value": 5019.20963950292}, {"lowerIsBetter": false, "replicates": [738.427718518148, 747.8317378589818, 763.427429427929, 775.6160700453277, 786.1038416205523, 13210.801837972438, 13582.864171358284, 13584.592462226125, 13590.592282231537, 13603.319834008285, 12395.628131156058, 12757.489700411972, 12864.871351286485, 12873.098883078188, 12874.613761587145, 797.1271457753751, 806.1575653442167, 807.5598798654718, 808.0586117173486, 808.2523665609287, 644.3942693867749, 659.4065341192941, 802.1256830055239, 832.2385017708789, 832.429785596865, 855.243109847783, 859.7119964811795, 868.0451503346331, 868.2316150207049, 871.485823364215, 853.5007020892754, 855.8245559660255, 860.8364410761998, 863.1325517854548, 863.404251066762, 625.0468036244717, 626.8558231606711, 630.0328994992665, 631.4254028833785, 632.0203684289379, 13076.280804555745, 13129.671758206026, 13188.274644894527, 13221.206727596278, 13248.40382182804, 11881.643550693492, 12143.089268304824, 12294.815577766341, 12592.181508201938, 13126.540571080062, 9981.800363992752, 10237.846432303522, 10317.9484102579, 10733.355998640107, 10872.402017889013, 3546.929061418783, 3553.964460355415, 3565.8395372208315, 3574.4817001534634, 3589.946150807714, 43102.78448607768, 43548.56451435509, 43571.78214108941, 43930.56069439297, 44012.3398149028, 9837.80324393508, 9886.752831179278, 10033.548490317953, 10047.648332308334, 10090.09189172978, 18339.724904126448, 18568.0, 18571.0, 18574.071296435126, 18581.0, 7701.691932322644, 7734.961325193338, 7836.098848632366, 7912.762617121495, 8091.150429204967, 4416.668749843775, 4531.773411329486, 4551.8179272829375, 4555.681102322806, 4657.6273898088075, 2867.311845157147, 2881.063654312357, 2909.0109362816743, 2931.5016447204025, 2949.1447480230495, 522.636767446621, 527.0565687419553, 530.7425898439254, 532.9786808527615, 543.3045701502084, 587.6973358720262, 605.4308949587373, 651.4104735214638, 694.3820000199726, 701.3547536266647, 8006.23862750194, 8414.410991230678, 8638.13618638131, 8777.605007774666, 8784.560771961376, 532.8774381892109, 551.3824516541499, 702.9771682202384, 709.6664567653195, 711.9430445564342, 3734.514513113278, 3999.0, 4080.836766529365, 4083.1629515949157, 4102.856400025985, 53480.465195348326, 53495.46504534905, 53712.73143634335, 53919.19121213185, 53941.0, 43493.78253108714, 46303.5369646306, 48710.0, 49253.75373123112, 49361.0, 43387.132257355304, 44483.0, 44921.0, 45540.772296138304, 45582.54417455849, 8826.735197944072, 8951.776205594912, 8967.775805604912, 8979.865302020344, 9040.88833954665, 34342.82828585841, 34601.65398346085, 35173.12067198341, 35240.0, 35263.294734105686, 39800.60199397969, 41286.38070428886, 43881.78059109684, 44101.33847992218, 44193.11613767642, 11064.502097405475, 11270.887291126985, 11301.71745706331, 11431.885681143081, 11630.88369116298, 12063.034957203578, 12277.386130693609, 12639.684007899876, 12685.873141268468, 13083.542076027674, 11243.943780281046, 11444.713882153013, 11504.884951150716, 11715.062794976551, 11806.763864722829, 11130.220884538328, 11350.716232094264, 11354.489047992694, 11595.362255076052, 11646.534138634359, 11051.668449946514, 11327.773444531229, 11330.830037549278, 11421.0, 11571.479283432434, 9935.552900119657, 9979.351342162736, 10262.948685256824, 10294.279400441897, 10303.3817970922, 8717.869231961398, 8834.160754728291, 8839.734807955772, 9133.40632858862, 9986.950065249628], "unit": "score", "name": "yui.html", "value": 6243.452375444283}], "name": "dromaeo_css", "value": 6991.369164406885}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 114.0, 111.0, 114.0, 121.0, 112.0, 113.0, 112.0, 115.0], "unit": "score", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [157.0, 139.0, 157.0, 168.0, 125.0, 164.0, 152.0, 130.0, 166.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 164.0, 163.0, 162.0, 162.0, 171.0, 163.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 73.0, 73.0, 71.0, 73.0, 72.0, 138.0, 71.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 140.0, 97.0, 95.0, 97.0, 142.0, 98.0, 97.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 111.0, 110.0, 114.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 147.0, 146.0, 148.0, 146.0, 147.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [101.0, 96.0, 96.0, 98.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [63.0, 59.0, 60.0, 59.0, 59.0, 61.0, 59.0, 63.0, 63.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 60.4}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 68.0, 67.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [92.0, 86.0, 96.0, 89.0, 86.0, 86.0, 86.0, 85.0, 86.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.0}, {"lowerIsBetter": true, "replicates": [122.0, 122.0, 119.0, 124.0, 122.0, 126.0, 119.0, 121.0, 121.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [141.0, 150.0, 157.0, 152.0, 150.0, 142.0, 151.0, 142.0, 153.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.9}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 68.0, 75.0, 68.0, 67.0, 69.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1523.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.32088401576152], "unit": "score", "name": "Richards", "value": 206.05777399999997}, {"lowerIsBetter": false, "replicates": [191.2411550965768], "unit": "score", "name": "DeltaBlue", "value": 345.7310220000001}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [1064.9627263045793], "unit": "score", "name": "RayTrace", "value": 694.8496709999997}, {"lowerIsBetter": false, "replicates": [706.4220183486239], "unit": "score", "name": "Earley", "value": 943.4346363636364}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [25450.0], "unit": "score", "name": "RegExp", "value": 35.79508840864438}, {"lowerIsBetter": false, "replicates": [684.641638225256], "unit": "score", "name": "Splay", "value": 119.02723330009968}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21020.78968419217}]} 19:08:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21020.79"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1523.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6991.37"}}} 19:08:40 INFO - Return code: 0 19:08:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:08:40 INFO - # TBPL SUCCESS # 19:08:40 INFO - Running post-action listener: _resource_record_post_action 19:08:40 INFO - Running post-run listener: _resource_record_post_run 19:08:41 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 16384; Write bytes: 554921984; Read time: 100; Write time: 394984 19:08:41 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 235372544; Read time: 60; Write time: 243032 19:08:41 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 12288; Write bytes: 319549440; Read time: 40; Write time: 151952 19:08:41 INFO - Running post-run listener: _upload_blobber_files 19:08:41 INFO - Blob upload gear active. 19:08:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:08:41 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 19:08:41 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'] 19:08:41 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 19:08:41 INFO - (blobuploader) - INFO - Open directory for files ... 19:08:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:08:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:08:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:08:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:08:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:08:42 INFO - (blobuploader) - INFO - Done attempting. 19:08:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:08:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:08:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:08:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:08:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:08:43 INFO - (blobuploader) - INFO - Done attempting. 19:08:43 INFO - (blobuploader) - INFO - Iteration through files over. 19:08:43 INFO - Return code: 0 19:08:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:08:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:08:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/deb1a615eb2b4a8a270f0159bd841ccd5db6804fb7a463c211c8675d6d95858d64d7ded88ceda865ae5f9342ef1454180b4ef1bdccd9842b38413f69eac704de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea5a137f444367688d46dbae8eec87bf106bdb957bd7f1ea4da99cf546e664ac9591b5074f61e21eb2a9ea371eb45d1f46b65d00fef5d27a7355c116db82ca7e"} 19:08:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:08:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:08:43 INFO - Contents: 19:08:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/deb1a615eb2b4a8a270f0159bd841ccd5db6804fb7a463c211c8675d6d95858d64d7ded88ceda865ae5f9342ef1454180b4ef1bdccd9842b38413f69eac704de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea5a137f444367688d46dbae8eec87bf106bdb957bd7f1ea4da99cf546e664ac9591b5074f61e21eb2a9ea371eb45d1f46b65d00fef5d27a7355c116db82ca7e"} 19:08:43 INFO - Copying logs to upload dir... 19:08:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.052033 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-26 19:08:42.913099) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-26 19:08:42.916446) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429 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/deb1a615eb2b4a8a270f0159bd841ccd5db6804fb7a463c211c8675d6d95858d64d7ded88ceda865ae5f9342ef1454180b4ef1bdccd9842b38413f69eac704de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea5a137f444367688d46dbae8eec87bf106bdb957bd7f1ea4da99cf546e664ac9591b5074f61e21eb2a9ea371eb45d1f46b65d00fef5d27a7355c116db82ca7e"} build_url:https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011523 build_url: 'https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/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/deb1a615eb2b4a8a270f0159bd841ccd5db6804fb7a463c211c8675d6d95858d64d7ded88ceda865ae5f9342ef1454180b4ef1bdccd9842b38413f69eac704de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea5a137f444367688d46dbae8eec87bf106bdb957bd7f1ea4da99cf546e664ac9591b5074f61e21eb2a9ea371eb45d1f46b65d00fef5d27a7355c116db82ca7e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-26 19:08:42.944212) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 19:08:42.944857) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1451179051.868741-1118043429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 19:08:43.026680) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-26 19:08:43.027069) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-26 19:08:43.027390) ========= ========= Total master_lag: 0.29 =========