builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1450785324.72 results: success (0) buildid: 20151222013009 builduid: 912c5f9f634e4a77b8495a9689905c95 revision: 61e79fef8e0c44d06b0e9e377ec19602bd269f2c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:24.719642) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:24.720133) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:24.720429) ========= 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=a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006324 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:24.751263) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:24.751525) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:24.812766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:24.813029) ========= 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=a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:24.863525) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:24.863796) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:24.864160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:24.864464) ========= 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=a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 03:55:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2015-12-22 03:55:25 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171771 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:25.048835) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:25.049140) ========= 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=a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014837 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:25.132851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:25.133276) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 61e79fef8e0c44d06b0e9e377ec19602bd269f2c --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 61e79fef8e0c44d06b0e9e377ec19602bd269f2c --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=a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 03:55:26,055 truncating revision to first 12 chars 2015-12-22 03:55:26,055 Setting DEBUG logging. 2015-12-22 03:55:26,055 attempt 1/10 2015-12-22 03:55:26,055 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/61e79fef8e0c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 03:55:26,389 unpacking tar archive at: mozilla-inbound-61e79fef8e0c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630849 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:25.777190) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:25.777481) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:25.787674) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:25.787920) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:25.788303) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-22 03:55:25.788576) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:55:26 INFO - MultiFileLogger online at 20151222 03:55:26 in /builds/slave/test-pgo 03:55:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 03:55:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:55:26 INFO - {'append_to_log': False, 03:55:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:55:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:55:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:55:26 INFO - 'branch': 'Mozilla-Inbound', 03:55:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:55:26 INFO - 'config_files': ('talos/linux_config.py',), 03:55:26 INFO - 'default_actions': ('clobber', 03:55:26 INFO - 'read-buildbot-config', 03:55:26 INFO - 'download-and-extract', 03:55:26 INFO - 'populate-webroot', 03:55:26 INFO - 'create-virtualenv', 03:55:26 INFO - 'install', 03:55:26 INFO - 'run-tests'), 03:55:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:55:26 INFO - 'download_minidump_stackwalk': True, 03:55:26 INFO - 'download_symbols': 'ondemand', 03:55:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:55:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:55:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:55:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:55:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:55:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:55:26 INFO - 'installer_path': 'installer.exe', 03:55:26 INFO - 'log_level': 'info', 03:55:26 INFO - 'log_name': 'talos', 03:55:26 INFO - 'log_to_console': True, 03:55:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:55:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:55:26 INFO - 'opt_config_files': (), 03:55:26 INFO - 'pip_index': False, 03:55:26 INFO - 'sps_profile': False, 03:55:26 INFO - 'sps_profile_interval': 0, 03:55:26 INFO - 'suite': 'dromaeojs', 03:55:26 INFO - 'system_bits': '64', 03:55:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:55:26 INFO - 'title': 'talos-linux64-ix-026', 03:55:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:55:26 INFO - 'use_talos_json': True, 03:55:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:55:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:55:26 INFO - 'work_dir': 'build'} 03:55:26 INFO - ##### 03:55:26 INFO - ##### Running clobber step. 03:55:26 INFO - ##### 03:55:26 INFO - Running pre-action listener: _resource_record_pre_action 03:55:26 INFO - Running main action method: clobber 03:55:26 INFO - rmtree: /builds/slave/test-pgo/build 03:55:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:55:27 INFO - Running post-action listener: _resource_record_post_action 03:55:27 INFO - ##### 03:55:27 INFO - ##### Running read-buildbot-config step. 03:55:27 INFO - ##### 03:55:27 INFO - Running pre-action listener: _resource_record_pre_action 03:55:27 INFO - Running main action method: read_buildbot_config 03:55:27 INFO - Using buildbot properties: 03:55:27 INFO - { 03:55:27 INFO - "project": "", 03:55:27 INFO - "product": "firefox", 03:55:27 INFO - "script_repo_revision": "production", 03:55:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 03:55:27 INFO - "repository": "", 03:55:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 03:55:27 INFO - "buildid": "20151222013009", 03:55:27 INFO - "pgo_build": "True", 03:55:27 INFO - "basedir": "/builds/slave/test-pgo", 03:55:27 INFO - "buildnumber": 1364, 03:55:27 INFO - "slavename": "talos-linux64-ix-026", 03:55:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:55:27 INFO - "platform": "ubuntu64_hw", 03:55:27 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:55:27 INFO - "branch": "mozilla-inbound", 03:55:27 INFO - "repo_path": "integration/mozilla-inbound", 03:55:27 INFO - "revision": "61e79fef8e0c44d06b0e9e377ec19602bd269f2c", 03:55:27 INFO - "stage_platform": "linux64-pgo", 03:55:27 INFO - "builduid": "912c5f9f634e4a77b8495a9689905c95", 03:55:27 INFO - "slavebuilddir": "test" 03:55:27 INFO - } 03:55:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:55:27 INFO - Running post-action listener: _resource_record_post_action 03:55:27 INFO - ##### 03:55:27 INFO - ##### Running download-and-extract step. 03:55:27 INFO - ##### 03:55:27 INFO - Running pre-action listener: _resource_record_pre_action 03:55:27 INFO - Running main action method: download_and_extract 03:55:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:55: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')]} 03:55:27 INFO - https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:55:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/test_packages.json 03:55:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/test_packages.json 03:55:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:55:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:55:31 INFO - Downloaded 1302 bytes. 03:55:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:55:31 INFO - Using the following test package requirements: 03:55:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:55:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:55:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:31 INFO - u'jsshell-linux-x86_64.zip'], 03:55:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:55:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:55:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:55:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:55:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:55:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:55:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:55:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:55: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')]} 03:55:31 INFO - https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:55:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:55:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:55:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/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 03:55:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/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 03:55:35 INFO - Downloaded 23174991 bytes. 03:55:35 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 03:55:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:55:35 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 03:55:36 INFO - Return code: 0 03:55:36 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 03:55:36 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')]} 03:55:36 INFO - https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:55:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:55:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:55:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/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 03:55:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/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 03:55:47 INFO - Downloaded 23174991 bytes. 03:55:47 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 03:55:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:55:47 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 03:55:49 INFO - Return code: 0 03:55:49 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')]} 03:55:49 INFO - https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:55:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:55:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:55:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/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 03:55:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/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 03:55:50 INFO - Downloaded 11132277 bytes. 03:55:50 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 03:55:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:55:50 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 03:55:50 INFO - Return code: 0 03:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:55:50 INFO - https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:55:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:55:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:55:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/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 03:55:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/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 03:55:51 INFO - Downloaded 54913961 bytes. 03:55:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:55:51 INFO - mkdir: /builds/slave/test-pgo/properties 03:55:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:55:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:55:51 INFO - Contents: 03:55:51 INFO - build_url:https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:55:51 INFO - Running post-action listener: _resource_record_post_action 03:55:51 INFO - Running post-action listener: set_extra_try_arguments 03:55:51 INFO - ##### 03:55:51 INFO - ##### Running populate-webroot step. 03:55:51 INFO - ##### 03:55:51 INFO - Running pre-action listener: _resource_record_pre_action 03:55:51 INFO - Running main action method: populate_webroot 03:55:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:55:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:55:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:55:51 INFO - '--tppagecycles', 03:55:51 INFO - '7'], 03:55:51 INFO - 'tests': ['tsvgm']}}, 03:55:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:55:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:55:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:55:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:55:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:55:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:55:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:51 INFO - 'talos_options': ['--e10s'], 03:55:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:51 INFO - 'tests': ['damp', 'tps']}, 03:55:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:51 INFO - 'talos_options': ['--e10s'], 03:55:51 INFO - 'tests': ['damp', 'tps']}, 03:55:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:55:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:55:51 INFO - 'other': {'tests': ['a11yr', 03:55:51 INFO - 'ts_paint', 03:55:51 INFO - 'tpaint', 03:55:51 INFO - 'sessionrestore', 03:55:51 INFO - 'sessionrestore_no_auto_restore']}, 03:55:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:55:51 INFO - 'tests': ['a11yr', 03:55:51 INFO - 'ts_paint', 03:55:51 INFO - 'tpaint', 03:55:51 INFO - 'sessionrestore', 03:55:51 INFO - 'sessionrestore_no_auto_restore']}, 03:55:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:55:51 INFO - 'tests': ['a11yr', 03:55:51 INFO - 'ts_paint', 03:55:51 INFO - 'tpaint', 03:55:51 INFO - 'sessionrestore', 03:55:51 INFO - 'sessionrestore_no_auto_restore']}, 03:55:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:55:51 INFO - 'tests': ['a11yr', 03:55:51 INFO - 'ts_paint', 03:55:51 INFO - 'tpaint', 03:55:51 INFO - 'sessionrestore', 03:55:51 INFO - 'sessionrestore_no_auto_restore']}, 03:55:51 INFO - 'other_l64': {'tests': ['a11yr', 03:55:51 INFO - 'ts_paint', 03:55:51 INFO - 'tpaint', 03:55:51 INFO - 'sessionrestore', 03:55:51 INFO - 'sessionrestore_no_auto_restore']}, 03:55:51 INFO - 'other_nol64': {'tests': ['a11yr', 03:55:51 INFO - 'ts_paint', 03:55:51 INFO - 'tpaint', 03:55:51 INFO - 'sessionrestore', 03:55:51 INFO - 'sessionrestore_no_auto_restore']}, 03:55:51 INFO - 'svgr': {'tests': ['tsvgx', 03:55:51 INFO - 'tsvgr_opacity', 03:55:51 INFO - 'tart', 03:55:51 INFO - 'tscrollx', 03:55:51 INFO - 'cart']}, 03:55:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:55:51 INFO - 'tests': ['tsvgx', 03:55:51 INFO - 'tsvgr_opacity', 03:55:51 INFO - 'tart', 03:55:51 INFO - 'tscrollx', 03:55:51 INFO - 'cart']}, 03:55:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:51 INFO - 'tests': ['tp5o']}, 03:55:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:51 INFO - 'talos_options': ['--e10s'], 03:55:51 INFO - 'tests': ['tp5o']}, 03:55:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:51 INFO - 'talos_options': ['--xperf_path', 03:55:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:51 INFO - 'tests': ['tp5n']}, 03:55:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:51 INFO - 'talos_options': ['--e10s', 03:55:51 INFO - '--xperf_path', 03:55:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:51 INFO - 'tests': ['tp5n']}}, 03:55:51 INFO - 'talos.zip': {'path': '', 03:55:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:55:51 INFO - Running post-action listener: _resource_record_post_action 03:55:51 INFO - ##### 03:55:51 INFO - ##### Running create-virtualenv step. 03:55:51 INFO - ##### 03:55:51 INFO - Running pre-action listener: _resource_record_pre_action 03:55:51 INFO - Running main action method: create_virtualenv 03:55:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:55:51 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 03:55:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:55:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:55:52 INFO - Using real prefix '/usr' 03:55:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:55:52 INFO - Installing distribute.............................................................................................................................................................................................done. 03:55:54 INFO - Installing pip.................done. 03:55:54 INFO - Return code: 0 03:55:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:55: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')]} 03:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55: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')]} 03:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7673c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25147f0>, '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 0x24802d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2480760>, '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': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', '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 03:55: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:55: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 pip>=1.5 03:55:54 INFO - Using env: {'DISPLAY': ':0', 03:55:54 INFO - 'HOME': '/home/cltbld', 03:55:54 INFO - 'LANG': 'en_US.UTF-8', 03:55:54 INFO - 'LANGUAGE': 'en_US:en', 03:55:54 INFO - 'LOGNAME': 'cltbld', 03:55:54 INFO - 'MAIL': '/var/mail/cltbld', 03:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:54 INFO - 'MOZ_NO_REMOTE': '1', 03:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:54 INFO - 'NO_EM_RESTART': '1', 03:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:55:54 INFO - 'PWD': '/builds/slave/test-pgo', 03:55:54 INFO - 'SHELL': '/bin/bash', 03:55:54 INFO - 'SHLVL': '1', 03:55:54 INFO - 'TERM': 'linux', 03:55:54 INFO - 'TMOUT': '86400', 03:55:54 INFO - 'USER': 'cltbld', 03:55:54 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', 03:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:54 INFO - '_': '/tools/buildbot/bin/python'} 03:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:54 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 03:55:54 INFO - Cleaning up... 03:55:54 INFO - Return code: 0 03:55:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:55: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')]} 03:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55: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')]} 03:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55: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', '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 0x7f7673c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25147f0>, '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 0x24802d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2480760>, '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': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', '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 03:55: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:55: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 psutil>=0.7.1 03:55:54 INFO - Using env: {'DISPLAY': ':0', 03:55:54 INFO - 'HOME': '/home/cltbld', 03:55:54 INFO - 'LANG': 'en_US.UTF-8', 03:55:54 INFO - 'LANGUAGE': 'en_US:en', 03:55:54 INFO - 'LOGNAME': 'cltbld', 03:55:54 INFO - 'MAIL': '/var/mail/cltbld', 03:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:54 INFO - 'MOZ_NO_REMOTE': '1', 03:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:54 INFO - 'NO_EM_RESTART': '1', 03:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:55:54 INFO - 'PWD': '/builds/slave/test-pgo', 03:55:54 INFO - 'SHELL': '/bin/bash', 03:55:54 INFO - 'SHLVL': '1', 03:55:54 INFO - 'TERM': 'linux', 03:55:54 INFO - 'TMOUT': '86400', 03:55:54 INFO - 'USER': 'cltbld', 03:55:54 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', 03:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:54 INFO - '_': '/tools/buildbot/bin/python'} 03:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:55 INFO - Downloading/unpacking psutil>=0.7.1 03:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:55:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:55:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:55:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:55:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:55:56 INFO - Installing collected packages: psutil 03:55:56 INFO - Running setup.py install for psutil 03:55:56 INFO - building 'psutil._psutil_linux' extension 03:55:56 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 03:55:57 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 03:55:57 INFO - building 'psutil._psutil_posix' extension 03:55:57 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 03:55:57 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 03:55:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:55:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:55:57 INFO - Successfully installed psutil 03:55:57 INFO - Cleaning up... 03:55:57 INFO - Return code: 0 03:55:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:55:57 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')]} 03:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:57 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')]} 03:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:57 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 0x7f7673c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25147f0>, '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 0x24802d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2480760>, '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': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', '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 03:55:57 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 03:55:57 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 03:55:57 INFO - Using env: {'DISPLAY': ':0', 03:55:57 INFO - 'HOME': '/home/cltbld', 03:55:57 INFO - 'LANG': 'en_US.UTF-8', 03:55:57 INFO - 'LANGUAGE': 'en_US:en', 03:55:57 INFO - 'LOGNAME': 'cltbld', 03:55:57 INFO - 'MAIL': '/var/mail/cltbld', 03:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:57 INFO - 'MOZ_NO_REMOTE': '1', 03:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:57 INFO - 'NO_EM_RESTART': '1', 03:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:55:57 INFO - 'PWD': '/builds/slave/test-pgo', 03:55:57 INFO - 'SHELL': '/bin/bash', 03:55:57 INFO - 'SHLVL': '1', 03:55:57 INFO - 'TERM': 'linux', 03:55:57 INFO - 'TMOUT': '86400', 03:55:57 INFO - 'USER': 'cltbld', 03:55:57 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', 03:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:57 INFO - '_': '/tools/buildbot/bin/python'} 03:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:55:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:55:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:55:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:55:59 INFO - Installing collected packages: mozsystemmonitor 03:55:59 INFO - Running setup.py install for mozsystemmonitor 03:55:59 INFO - Successfully installed mozsystemmonitor 03:55:59 INFO - Cleaning up... 03:55:59 INFO - Return code: 0 03:55:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:55: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')]} 03:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55: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')]} 03:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:59 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 0x7f7673c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25147f0>, '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 0x24802d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2480760>, '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': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', '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 03:55:59 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 03:55:59 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 03:55:59 INFO - Using env: {'DISPLAY': ':0', 03:55:59 INFO - 'HOME': '/home/cltbld', 03:55:59 INFO - 'LANG': 'en_US.UTF-8', 03:55:59 INFO - 'LANGUAGE': 'en_US:en', 03:55:59 INFO - 'LOGNAME': 'cltbld', 03:55:59 INFO - 'MAIL': '/var/mail/cltbld', 03:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:59 INFO - 'MOZ_NO_REMOTE': '1', 03:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:59 INFO - 'NO_EM_RESTART': '1', 03:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:55:59 INFO - 'PWD': '/builds/slave/test-pgo', 03:55:59 INFO - 'SHELL': '/bin/bash', 03:55:59 INFO - 'SHLVL': '1', 03:55:59 INFO - 'TERM': 'linux', 03:55:59 INFO - 'TMOUT': '86400', 03:55:59 INFO - 'USER': 'cltbld', 03:55:59 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', 03:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:59 INFO - '_': '/tools/buildbot/bin/python'} 03:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:59 INFO - Downloading/unpacking blobuploader==1.2.4 03:55:59 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 03:55:59 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 03:55:59 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 03:55:59 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 03:55:59 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 03:55:59 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 03:56:01 INFO - Downloading blobuploader-1.2.4.tar.gz 03:56:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:56:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:56:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:56:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:56:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:01 INFO - Downloading docopt-0.6.1.tar.gz 03:56:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:56:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:56:02 INFO - Installing collected packages: blobuploader, requests, docopt 03:56:02 INFO - Running setup.py install for blobuploader 03:56:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:56:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:56:02 INFO - Running setup.py install for requests 03:56:02 INFO - Running setup.py install for docopt 03:56:02 INFO - Successfully installed blobuploader requests docopt 03:56:02 INFO - Cleaning up... 03:56:02 INFO - Return code: 0 03:56:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:56: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')]} 03:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56: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')]} 03:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:02 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 0x7f7673c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25147f0>, '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 0x24802d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2480760>, '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': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', '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 03:56:02 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 03:56:02 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 03:56:02 INFO - Using env: {'DISPLAY': ':0', 03:56:02 INFO - 'HOME': '/home/cltbld', 03:56:02 INFO - 'LANG': 'en_US.UTF-8', 03:56:02 INFO - 'LANGUAGE': 'en_US:en', 03:56:02 INFO - 'LOGNAME': 'cltbld', 03:56:02 INFO - 'MAIL': '/var/mail/cltbld', 03:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:02 INFO - 'MOZ_NO_REMOTE': '1', 03:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:02 INFO - 'NO_EM_RESTART': '1', 03:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:02 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:02 INFO - 'SHELL': '/bin/bash', 03:56:02 INFO - 'SHLVL': '1', 03:56:02 INFO - 'TERM': 'linux', 03:56:02 INFO - 'TMOUT': '86400', 03:56:02 INFO - 'USER': 'cltbld', 03:56:02 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', 03:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:02 INFO - '_': '/tools/buildbot/bin/python'} 03:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:56:02 INFO - Running setup.py (path:/tmp/pip-D7d3HH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:56:02 INFO - Running setup.py (path:/tmp/pip-wFRBmy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:56:03 INFO - Running setup.py (path:/tmp/pip-RZO9LK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:56:03 INFO - Running setup.py (path:/tmp/pip-qhTqNr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:56:03 INFO - Running setup.py (path:/tmp/pip-YFs25p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:56:03 INFO - Running setup.py (path:/tmp/pip-peO42T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:56:03 INFO - Running setup.py (path:/tmp/pip-g4sNF9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:56:03 INFO - Running setup.py (path:/tmp/pip-puEqif-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:56:03 INFO - Running setup.py (path:/tmp/pip-E6ioxi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:56:03 INFO - Running setup.py (path:/tmp/pip-MPI5Cb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:56:03 INFO - Running setup.py (path:/tmp/pip-9p8qp2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:56:03 INFO - Running setup.py (path:/tmp/pip-ZevptL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:56:03 INFO - Running setup.py (path:/tmp/pip-rxRxZt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:56:03 INFO - Running setup.py (path:/tmp/pip-8UPCbJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:56:03 INFO - Running setup.py (path:/tmp/pip-ZRkWuv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:56:03 INFO - Running setup.py (path:/tmp/pip-uic16E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:56:04 INFO - Running setup.py (path:/tmp/pip-u1Zgad-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:56:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:56:04 INFO - Running setup.py install for manifestparser 03:56:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:56:04 INFO - Running setup.py install for mozcrash 03:56:04 INFO - Running setup.py install for mozdebug 03:56:04 INFO - Running setup.py install for mozdevice 03:56:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:56:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:56:04 INFO - Running setup.py install for mozfile 03:56:04 INFO - Running setup.py install for mozhttpd 03:56:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:56:04 INFO - Running setup.py install for mozinfo 03:56:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:56:04 INFO - Running setup.py install for mozInstall 03:56:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:56:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:56:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:56:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:56:04 INFO - Running setup.py install for mozleak 03:56:04 INFO - Running setup.py install for mozlog 03:56:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:56:05 INFO - Running setup.py install for moznetwork 03:56:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:56:05 INFO - Running setup.py install for mozprocess 03:56:05 INFO - Running setup.py install for mozprofile 03:56:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:56:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:56:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:56:05 INFO - Running setup.py install for mozrunner 03:56:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:56:05 INFO - Running setup.py install for mozscreenshot 03:56:05 INFO - Running setup.py install for moztest 03:56:05 INFO - Running setup.py install for mozversion 03:56:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:56:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:56:05 INFO - Cleaning up... 03:56:05 INFO - Return code: 0 03:56:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f7673c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25147f0>, '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 0x24802d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2480760>, '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': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', '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 03:56:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 03:56:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 03:56:05 INFO - Using env: {'DISPLAY': ':0', 03:56:05 INFO - 'HOME': '/home/cltbld', 03:56:05 INFO - 'LANG': 'en_US.UTF-8', 03:56:05 INFO - 'LANGUAGE': 'en_US:en', 03:56:05 INFO - 'LOGNAME': 'cltbld', 03:56:05 INFO - 'MAIL': '/var/mail/cltbld', 03:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:05 INFO - 'MOZ_NO_REMOTE': '1', 03:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:05 INFO - 'NO_EM_RESTART': '1', 03:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:05 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:05 INFO - 'SHELL': '/bin/bash', 03:56:05 INFO - 'SHLVL': '1', 03:56:05 INFO - 'TERM': 'linux', 03:56:05 INFO - 'TMOUT': '86400', 03:56:05 INFO - 'USER': 'cltbld', 03:56:05 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', 03:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:05 INFO - '_': '/tools/buildbot/bin/python'} 03:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:56:06 INFO - Running setup.py (path:/tmp/pip-g4ayxz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:56:06 INFO - Running setup.py (path:/tmp/pip-s_4GrD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:56:06 INFO - Running setup.py (path:/tmp/pip-sO6rHK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:56:06 INFO - Running setup.py (path:/tmp/pip-XyT7l3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:56:06 INFO - Running setup.py (path:/tmp/pip-KuD5sr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:56:06 INFO - Running setup.py (path:/tmp/pip-YQWr_o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:56:06 INFO - Running setup.py (path:/tmp/pip-Jj1zIF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:56:06 INFO - Running setup.py (path:/tmp/pip-BmNSnx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:56:06 INFO - Running setup.py (path:/tmp/pip-2b_pcD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:56:06 INFO - Running setup.py (path:/tmp/pip-cJezIF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:56:06 INFO - Running setup.py (path:/tmp/pip-oeRHdV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:56:06 INFO - Running setup.py (path:/tmp/pip-UBYzbm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:56:06 INFO - Running setup.py (path:/tmp/pip-pz7Mr8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:56:07 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)) 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:56:07 INFO - Running setup.py (path:/tmp/pip-vDmMqt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:56:07 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)) 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:56:07 INFO - Running setup.py (path:/tmp/pip-a2gtyy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:56:07 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)) 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:56:07 INFO - Running setup.py (path:/tmp/pip-gT8tMK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:56:07 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)) 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:56:07 INFO - Running setup.py (path:/tmp/pip-OhVFqa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:56:07 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)) 03:56:07 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)) 03:56:07 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)) 03:56:07 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)) 03:56:07 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)) 03:56:07 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)) 03:56:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:09 INFO - Downloading blessings-1.5.1.tar.gz 03:56:09 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 03:56:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:56:09 INFO - Installing collected packages: blessings 03:56:09 INFO - Running setup.py install for blessings 03:56:09 INFO - Successfully installed blessings 03:56:09 INFO - Cleaning up... 03:56:09 INFO - Return code: 0 03:56:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:56:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:56:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:56:09 INFO - Reading from file tmpfile_stdout 03:56:09 INFO - Current package versions: 03:56:09 INFO - argparse == 1.2.1 03:56:09 INFO - blessings == 1.5.1 03:56:09 INFO - blobuploader == 1.2.4 03:56:09 INFO - docopt == 0.6.1 03:56:09 INFO - manifestparser == 1.1 03:56:09 INFO - mozInstall == 1.12 03:56:09 INFO - mozcrash == 0.16 03:56:09 INFO - mozdebug == 0.1 03:56:09 INFO - mozdevice == 0.47 03:56:09 INFO - mozfile == 1.2 03:56:09 INFO - mozhttpd == 0.7 03:56:09 INFO - mozinfo == 0.9 03:56:09 INFO - mozleak == 0.1 03:56:09 INFO - mozlog == 3.1 03:56:09 INFO - moznetwork == 0.27 03:56:09 INFO - mozprocess == 0.22 03:56:09 INFO - mozprofile == 0.28 03:56:09 INFO - mozrunner == 6.11 03:56:09 INFO - mozscreenshot == 0.1 03:56:09 INFO - mozsystemmonitor == 0.0 03:56:09 INFO - moztest == 0.7 03:56:09 INFO - mozversion == 1.4 03:56:09 INFO - psutil == 3.1.1 03:56:09 INFO - requests == 1.2.3 03:56:09 INFO - wsgiref == 0.1.2 03:56:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f7673c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25147f0>, '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 0x24802d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2480760>, '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': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', '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 03:56:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 03:56:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 03:56:09 INFO - Using env: {'DISPLAY': ':0', 03:56:09 INFO - 'HOME': '/home/cltbld', 03:56:09 INFO - 'LANG': 'en_US.UTF-8', 03:56:09 INFO - 'LANGUAGE': 'en_US:en', 03:56:09 INFO - 'LOGNAME': 'cltbld', 03:56:09 INFO - 'MAIL': '/var/mail/cltbld', 03:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:09 INFO - 'MOZ_NO_REMOTE': '1', 03:56:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:09 INFO - 'NO_EM_RESTART': '1', 03:56:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:09 INFO - 'SHELL': '/bin/bash', 03:56:09 INFO - 'SHLVL': '1', 03:56:09 INFO - 'TERM': 'linux', 03:56:09 INFO - 'TMOUT': '86400', 03:56:09 INFO - 'USER': 'cltbld', 03:56:09 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', 03:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:09 INFO - '_': '/tools/buildbot/bin/python'} 03:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:09 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)) 03:56:09 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)) 03:56:09 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)) 03:56:09 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)) 03:56:09 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)) 03:56:09 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)) 03:56:09 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)) 03:56:09 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)) 03:56:09 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)) 03:56:09 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)) 03:56:09 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)) 03:56:09 INFO - Cleaning up... 03:56:09 INFO - Return code: 0 03:56:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f7673c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25147f0>, '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 0x24802d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2480760>, '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': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', '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 03:56:09 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 03:56:09 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 03:56:09 INFO - Using env: {'DISPLAY': ':0', 03:56:09 INFO - 'HOME': '/home/cltbld', 03:56:09 INFO - 'LANG': 'en_US.UTF-8', 03:56:09 INFO - 'LANGUAGE': 'en_US:en', 03:56:09 INFO - 'LOGNAME': 'cltbld', 03:56:09 INFO - 'MAIL': '/var/mail/cltbld', 03:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:09 INFO - 'MOZ_NO_REMOTE': '1', 03:56:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:09 INFO - 'NO_EM_RESTART': '1', 03:56:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:09 INFO - 'SHELL': '/bin/bash', 03:56:09 INFO - 'SHLVL': '1', 03:56:09 INFO - 'TERM': 'linux', 03:56:09 INFO - 'TMOUT': '86400', 03:56:09 INFO - 'USER': 'cltbld', 03:56:09 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', 03:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:09 INFO - '_': '/tools/buildbot/bin/python'} 03:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:09 INFO - Downloading/unpacking jsonschema 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:56:11 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 03:56:11 INFO - Downloading/unpacking functools32 (from jsonschema) 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56:11 INFO - Downloading functools32-3.2.3-2.tar.gz 03:56:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:56:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:56:11 INFO - warning: no files found matching '*.txt' 03:56:11 INFO - no previously-included directories found matching 'build' 03:56:11 INFO - no previously-included directories found matching 'dist' 03:56:11 INFO - no previously-included directories found matching '.git*' 03:56:11 INFO - Installing collected packages: jsonschema, functools32 03:56:11 INFO - Running setup.py install for functools32 03:56:11 INFO - warning: no files found matching '*.txt' 03:56:11 INFO - no previously-included directories found matching 'build' 03:56:11 INFO - no previously-included directories found matching 'dist' 03:56:11 INFO - no previously-included directories found matching '.git*' 03:56:11 INFO - Successfully installed jsonschema functools32 03:56:11 INFO - Cleaning up... 03:56:12 INFO - Return code: 0 03:56:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7673c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25147f0>, '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 0x24802d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2480760>, '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': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', '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 03:56:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 03:56:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:56:12 INFO - Using env: {'DISPLAY': ':0', 03:56:12 INFO - 'HOME': '/home/cltbld', 03:56:12 INFO - 'LANG': 'en_US.UTF-8', 03:56:12 INFO - 'LANGUAGE': 'en_US:en', 03:56:12 INFO - 'LOGNAME': 'cltbld', 03:56:12 INFO - 'MAIL': '/var/mail/cltbld', 03:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:12 INFO - 'MOZ_NO_REMOTE': '1', 03:56:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:12 INFO - 'NO_EM_RESTART': '1', 03:56:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:12 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:12 INFO - 'SHELL': '/bin/bash', 03:56:12 INFO - 'SHLVL': '1', 03:56:12 INFO - 'TERM': 'linux', 03:56:12 INFO - 'TMOUT': '86400', 03:56:12 INFO - 'USER': 'cltbld', 03:56:12 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', 03:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:12 INFO - '_': '/tools/buildbot/bin/python'} 03:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:12 INFO - Downloading/unpacking flake8 03:56:12 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 03:56:12 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 03:56:12 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 03:56:12 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 03:56:12 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 03:56:12 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 03:56:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:56:13 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 03:56:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:56:14 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 03:56:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:56:14 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 03:56:14 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 03:56:14 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 03:56:14 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 03:56:14 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 03:56:14 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 03:56:14 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 03:56:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:56:14 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 03:56:14 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 03:56:14 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 03:56:14 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 03:56:14 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 03:56:14 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 03:56:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:56:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:56:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:56:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:56:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:56:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:56:14 INFO - no previously-included directories found matching 'docs/_build' 03:56:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:56:14 INFO - Running setup.py install for pep8 03:56:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:56:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:56:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:56:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:56:14 INFO - no previously-included directories found matching 'docs/_build' 03:56:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:56:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:56:14 INFO - Cleaning up... 03:56:14 INFO - Return code: 0 03:56:14 INFO - Running post-action listener: _resource_record_post_action 03:56:14 INFO - Running post-action listener: _start_resource_monitoring 03:56:14 INFO - Starting resource monitoring. 03:56:14 INFO - ##### 03:56:14 INFO - ##### Running install step. 03:56:14 INFO - ##### 03:56:14 INFO - Running pre-action listener: _resource_record_pre_action 03:56:14 INFO - Running main action method: install 03:56:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:56:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:56:15 INFO - Reading from file tmpfile_stdout 03:56:15 INFO - Detecting whether we're running mozinstall >=1.0... 03:56:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:56:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:56:15 INFO - Reading from file tmpfile_stdout 03:56:15 INFO - Output received: 03:56:15 INFO - Usage: mozinstall [options] installer 03:56:15 INFO - Options: 03:56:15 INFO - -h, --help show this help message and exit 03:56:15 INFO - -d DEST, --destination=DEST 03:56:15 INFO - Directory to install application into. [default: 03:56:15 INFO - "/builds/slave/test-pgo"] 03:56:15 INFO - --app=APP Application being installed. [default: firefox] 03:56:15 INFO - mkdir: /builds/slave/test-pgo/build/application 03:56:15 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'] 03:56:15 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 03:56:30 INFO - Reading from file tmpfile_stdout 03:56:30 INFO - Output received: 03:56:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:56:30 INFO - Running post-action listener: _resource_record_post_action 03:56:30 INFO - ##### 03:56:30 INFO - ##### Running run-tests step. 03:56:30 INFO - ##### 03:56:30 INFO - Running pre-action listener: _resource_record_pre_action 03:56:30 INFO - Running main action method: run_tests 03:56:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:56:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:56:30 INFO - Python 2.7.3 03:56:30 INFO - Return code: 0 03:56:30 INFO - grabbing minidump binary from tooltool 03:56:30 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')]} 03:56:30 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 0x25147f0>, '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 0x24802d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2480760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:56:30 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 03:56:30 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 03:56:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:56:30 INFO - Return code: 0 03:56:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:56:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:56:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:56:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:56:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:56:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:56:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:56:31 INFO - Return code: 0 03:56:31 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 03:56:31 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 03:56:31 INFO - Using env: {'DISPLAY': ':0', 03:56:31 INFO - 'HOME': '/home/cltbld', 03:56:31 INFO - 'LANG': 'en_US.UTF-8', 03:56:31 INFO - 'LANGUAGE': 'en_US:en', 03:56:31 INFO - 'LOGNAME': 'cltbld', 03:56:31 INFO - 'MAIL': '/var/mail/cltbld', 03:56:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:56:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:31 INFO - 'MOZ_NO_REMOTE': '1', 03:56:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:31 INFO - 'NO_EM_RESTART': '1', 03:56:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:31 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:56:31 INFO - 'SHELL': '/bin/bash', 03:56:31 INFO - 'SHLVL': '1', 03:56:31 INFO - 'TERM': 'linux', 03:56:31 INFO - 'TMOUT': '86400', 03:56:31 INFO - 'USER': 'cltbld', 03:56:31 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210', 03:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:31 INFO - '_': '/tools/buildbot/bin/python'} 03:56:31 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:56:32 INFO - mozversion application_buildid: 20151222013009 03:56:32 INFO - mozversion application_changeset: 61e79fef8e0c44d06b0e9e377ec19602bd269f2c 03:56:32 INFO - mozversion application_display_name: Nightly 03:56:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:56:32 INFO - mozversion application_name: Firefox 03:56:32 INFO - mozversion application_remotingname: firefox 03:56:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:56:32 INFO - mozversion application_vendor: Mozilla 03:56:32 INFO - mozversion application_version: 46.0a1 03:56:32 INFO - mozversion platform_buildid: 20151222013009 03:56:32 INFO - mozversion platform_changeset: 61e79fef8e0c44d06b0e9e377ec19602bd269f2c 03:56:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:56:32 INFO - mozversion platform_version: 46.0a1 03:56:32 INFO - using testdate: 1450785392 03:56:32 INFO - actual date: 1450785392 03:56:32 INFO - starting webserver on 'localhost:55330' 03:56:32 INFO - SUITE-START | Running 3 tests 03:56:32 INFO - TEST-START | dromaeo_css 03:56:32 INFO - operating with platform_type : linux_ 03:56:32 INFO - Initialising browser for dromaeo_css test... 03:56:32 INFO - TEST-INFO | started process 3482 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo8dLAw/profile http://localhost:55330/getInfo.html) 03:56:36 INFO - PROCESS | 3482 | __metrics Screen width/height:1600/1200 03:56:36 INFO - PROCESS | 3482 | colorDepth:24 03:56:36 INFO - PROCESS | 3482 | Browser inner width/height: 1024/697 03:56:36 INFO - PROCESS | 3482 | __metrics 03:56:36 INFO - PROCESS | 3482 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:56:36 INFO - PROCESS | 3482 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:56:37 INFO - TEST-INFO | 3482: exit 0 03:56:37 INFO - Browser initialized. 03:56:37 INFO - Running cycle 1/1 for dromaeo_css test... 03:56:37 INFO - TEST-INFO | started process 3575 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo8dLAw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:49 INFO - PROCESS | 3575 | RSS: Main: 150142976 03:56:49 INFO - PROCESS | 3575 | 03:57:40 INFO - PROCESS | 3575 | 1450785460894 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] 03:59:49 INFO - PROCESS | 3575 | Cycle 1(1): loaded http://localhost:55330/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55330/tests/dromaeo/cssquery-ext.html) 03:59:50 INFO - PROCESS | 3575 | RSS: Main: 263569408 03:59:50 INFO - PROCESS | 3575 | 04:02:52 INFO - PROCESS | 3575 | Cycle 1(1): loaded http://localhost:55330/tests/dromaeo/cssquery-ext.html (next: http://localhost:55330/tests/dromaeo/cssquery-jquery.html) 04:02:53 INFO - PROCESS | 3575 | RSS: Main: 229126144 04:02:53 INFO - PROCESS | 3575 | 04:05:55 INFO - PROCESS | 3575 | Cycle 1(1): loaded http://localhost:55330/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55330/tests/dromaeo/cssquery-mootools.html) 04:05:55 INFO - PROCESS | 3575 | RSS: Main: 222920704 04:05:55 INFO - PROCESS | 3575 | 04:08:57 INFO - PROCESS | 3575 | Cycle 1(1): loaded http://localhost:55330/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55330/tests/dromaeo/cssquery-prototype.html) 04:08:58 INFO - PROCESS | 3575 | RSS: Main: 208392192 04:08:58 INFO - PROCESS | 3575 | 04:12:00 INFO - PROCESS | 3575 | Cycle 1(1): loaded http://localhost:55330/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55330/tests/dromaeo/cssquery-yui.html) 04:12:01 INFO - PROCESS | 3575 | RSS: Main: 215924736 04:12:01 INFO - PROCESS | 3575 | 04:15:04 INFO - PROCESS | 3575 | Cycle 1(1): loaded http://localhost:55330/tests/dromaeo/cssquery-yui.html (next: http://localhost:55330/tests/dromaeo/cssquery-dojo.html) 04:15:04 INFO - PROCESS | 3575 | RSS: Main: 291205120 04:15:04 INFO - PROCESS | 3575 | 04:15:04 INFO - PROCESS | 3575 | __start_tp_report 04:15:04 INFO - PROCESS | 3575 | _x_x_mozilla_page_load 04:15:04 INFO - PROCESS | 3575 | _x_x_mozilla_page_load_details 04:15:04 INFO - PROCESS | 3575 | |i|pagename|runs| 04:15:04 INFO - PROCESS | 3575 | |0;dojo.html;3104.3015321552652;3138.9372212555736;3189.1389324882284;3191.21815155287;3212.887548935788;5092.719900405476;5220.060389129955;5320.175372817214;5321.015612111762;5354.785808567657;5217.452167522412;5261.947380526203;5353.866153346158;5385.380681221661;5389.5688344932405;4789.11401390743;4859.271109333593;4870.780814863339;4924.901501969976;4952.628552858532;4834.250691142878;4953;4977;5016.899662006757;5050.292958985745;4689.249720044776;4783.043391321749;4959.504049595048;4961.5038496150455;5030.974845125769;4848.321235027099;4933.161362568372;4946.2580612908;4947.183714687072;4948.703077815343;4919.26211068339;4939.777710003059;4940.987097644974;4957.7769000395065;4977.477364876672;5051.797928082872;5109.463506331856;5122.871928201787;5258.290130832327;5302.549283310923;5744.827655170351;5749.82750517481;5754;5837.532997360201;5884.941150588482;5765.567582431292;5771.480566749013;5773.3072031356505;5773.797917072924;5778.797742079007;5176.404713457963;5269.894602107936;5280.392754833167;5367.0339338918975;5377.0321342158395;5885;5963.314218864799;5971.0744834550715;6008.158857759917;6017.338092809788;5677.233573467612;5681.147827825776;5683.715814209356;5687.374388817227;5711.457411545896;5528.44715528452;5671.2060311556415;5684.9431505684415;5746.511546518509;5751;5736;5771.192033115367;5816.767329306865;5823;5866.882662346729;5679.602427830012;5683.232763576947;5686.317641883001;5687.260656114679;5696.686682232434;4270.380794784739;4301.483821941324;4375.365571992107;4406.9559304407185;4438.911221775611;3987.102901847119;3995.34076877312;3998.6001399859783;4007.979960100239;4019.2765302245293;5298.496642818926;5299.754557678943;5304.893902121936;5306.124489459196;5346.385165705994;5538.556915446835;5652.7738890443925;5664.85837854057;5769.68266745333;5797.188393624896;5236;5242.76407561653;5249.160134378481;5270.578353731692;5291.285676433632;4926.950730492721;4927.77824997876;4932.804287844383;4949.901001980013;4964.553190212898;5628.943710562842;5763.942360576424;5828.504577110993;5839.970800145972;5859.2090067841145;5663.32040155184;5703.914441283301;5752.022156233534;5772.163036359789;5810.186573879576;5867.031939729897;5878.823635290948;5879.911801322898;5880.382559831327;5941.851453713692;5568.470995255444;5708.343540492897;5765.250517432874;5769.3942136076785;5773.047447171338;5695.430456954437;5714.085746280575;5721.227634269487;5751.3673495916255;5799.188113664175;5689.487946084872;5700.173474846041;5732.656040637575;5740.598158129058;5740.6268592541355;5461.453854614507;5558.221848941233;5656.773729050792;5688.203651488712;5717.342505611741;5391.7304134793885;5418.756155972912;5472.370677372153;5475.397706252229;5514.641548299348;5664.603477756517;5721.256236689203;5721.685307308138;5730.169125476866;5791.218185545066;5385.434529374359;5457.7271136443815;5601.775928962796;5609;5614.157876318422 04:15:04 INFO - PROCESS | 3575 | |1;ext.html;549.5763682161668;579.7043507811018;584.1763114009243;588.9646621202728;596.2129988415293;38535.22929541411;39104.413433798516;39134.21731565367;39143.41284880725;39153.41269880954;42634.78682606583;42700.57299427005;43306.56693433065;43341.349879751826;43501.564984350145;7548.66031028605;7628.694852205905;7640.121386040621;8740.519271440084;8920.464772113693;7628.542287462742;7736.883946740803;10602.469876506182;10834.458277086154;10837.024667779899;10465.476726163699;10559.947200263989;10564.26050176488;10564.313319634237;10566.418846963414;7810.101838288612;7956.045274567089;10405.063544281013;10516.579336826519;10517.737056573647;7649.770506884803;10594.841077383768;10850.403227822466;10860.782784344348;10864.45677716119;39619.8019009906;39791.8010409949;39795.40306895399;40018.199636007404;40061.59938400608;3482.3905816482015;3996.680265578776;4056.229316429869;4071.7353372030725;4148.751074935483;32509.837450812596;33000.6699933;33089;33357.83321083403;33421.498677519856;3642.7267954903223;3797.411401232813;3803.904902377435;3817.8854634361014;3827.215420838749;279801;281864;282411;282950;285085;60333.39666603366;60351.698241508515;60553;60768.39231607627;60796.70439547283;62165;62494.68752656208;62495;62503;62556.37443625597;14967.027143235655;15206.391744330323;15209.315580798891;15216.543503694686;15256.618584535476;11279.548818047186;11372.374519401512;11375.886241137483;11376.146788990858;11389.886101138882;17887.234492978423;20019.29932452357;20183.596328073356;20211.59576808485;20251.29120480776;6819.488538359643;8089.474184178127;8222.944263934016;8311.584420778936;8416.158384161536;874.3529787956866;936.765808547863;955.9330846840654;977.9902200977899;1089.1290439371276;28248.435031299257;28343.433131337257;28537.71462285392;28646.427071458453;28698.713012870023;1094.518411898762;1123.5730422439422;1158.415000424797;1170.0931777872217;1192.3978390912707;13672.65818354549;14864.878345620247;15154.848451515343;16137;16911.323547058226;381517;383338;383763;384337;385182;53546.19680704793;53956;54147.72926135423;54394;54399.728001360534;1329.2356894785537;1362.455017992791;1393.4495874129864;1393.5192358636255;1394.1077710265438;28352.57471137976;29281.41437171202;29431.705682943753;29724;29822.701772981993;41976.370354444094;42017.57982420259;45409.77295113503;47695.28457073077;48438;240087;240173;242415;242508;242694;26868.73131268662;31143.221419464695;31291;31410.371792564478;31488.527672085394;29635;36077.27845443129;40729.592704073766;41316.79341603273;42225.155496890504;34608.65391346054;35325.646743532234;35453.82273088618;35915.46126808048;36041.09897252485;35089.824550878104;35930.8203458981;35987.64012359843;35992.100197495274;36017;34879.651203488655;35126;35239;35377.82311088428;35436.645633544365;31075;32266.35467290688;32687.67312326846;32734;32736.345273093928;24599.139030133858;25292.49415011726;26327.73672263253;26406.339841503348;26532.33669158209 04:15:04 INFO - PROCESS | 3575 | |2;jquery.html;357.27473229344423;358.43188546154346;361.9583747868995;363.1140018355215;367.3974681522304;13499.662508437294;13766.105203161787;15695;15987.680246395064;16451.17744112794;13379.331033448312;13811.65470863229;15739.291731872065;15917.124558149297;16605.252763625635;4788.52114788521;5463.890722185554;5465.098258787295;5468.015757163709;5471.616986810905;3953;4011.7793521356316;5265.552428043621;5420.051490989081;5439.428859969706;5804.303483581976;5972.0444728843395;5996.820095397145;6001;6007.8197654070445;5827.475527202572;5958.463738263534;5963.731632076567;5967.134765459005;5967.761289548413;5252.107141785906;5255.080360936859;5255.132903071027;5256.342957130359;5257.18513630384;20167.495812604655;20289;20354.18583256668;20382.592348153103;20486.692699609517;2110.6517424624917;2280.8745518996448;2299.72403311602;2325.162941341116;2330.254318618026;12543.310117943509;13061;13130.803037954438;13276.535321263806;13337.53318633843;1740.9042502662348;1767.4962635648908;1793.1213705284447;1825.4797382745853;1864.3754342295347;59062.11406828858;59082.70458647679;61951;63141.5272160031;69850.65074674595;10060.798784024424;10272.075513203697;10288.76534815827;10349.689509314732;10378.844317335246;13693.109947853358;13699.589012329647;13713.794293085612;13725.725485490433;13730.244836534086;6939.75710850128;7178.784636460915;7189.496735228484;7236.927630723625;7308.159561650372;6990.986306985458;7093.574385536885;7178.318059784312;7193.676284567207;7283.70865165398;4397.956020439755;4460.397846290709;4461.3047042124435;4481.439820022497;4491.775411229425;1768.9027103509432;1785.1342099081935;1795.2549691877985;1820.3537744100918;1826.5981484073482;427.65573713161206;432.3126229295435;784.4273680213362;929.1869614087673;946.5787724462685;9605.37565058269;10091.243156763125;10179.440130792878;10217.951722521726;10232.283740138268;413.6237316616;445.34978930760803;445.43652279865995;450.54494960090545;462;5858.589898707135;5871.119332100134;5936.970315148396;5983.910241346383;6200.689965501707;525703;532613;536897;544232;546993;83169.58415207885;84161.15838841656;86628.56685716531;87138;88191.11808881829;507.5737178528274;508.03473400538536;508.1412413021981;508.1970486631114;511.84644606617866;10329.9483502582;10492.632757853438;10622.73443163927;10974.396408197626;15077;35427.82286088553;36359;37389.81305093457;37614;38069;40811;42053;42360.576394235664;42756.786216069966;43334.56665433305;9895.109440150422;10058.949705251427;10109.34289271195;10227.07956283938;10227.130693890806;17424.12879356002;17756.28974840992;18127.274909003492;18295.908520457313;18311.175997079896;14767.187804670846;14819.481318153812;15140.545783626509;15264.618384540476;15362.30869610848;14542.4910128145;14665.26673666291;14883.181425021729;14892.255387230378;15053.6989260212;14763.335649895995;14989.100653960797;15171.393144274105;15457.768133478232;15801.525954221392;8576.957115214384;8655.826883462421;9661.275404344562;9701.70894873155;9772.85340719904;13884.652883677989;14050.859491404955;14239.715205696035;14266;14551.490697825526 04:15:04 INFO - PROCESS | 3575 | |3;mootools.html;1448.3916754962916;1485.4524490498795;1544.9613759656015;1625.8455446732564;1757.4464043826194;6683.29825368336;7343.155537113227;7443.888341674872;7480.887786683191;7484.812879678011;6963.199232088299;7172.96413517933;7187.173475050371;7188.029616001838;7191.748288809893;1977.2091163534558;2012.748406449194;2016.1028342387644;2273.59075366434;2308.6998690170253;2263.852849564773;2305.9308220753405;2311.3528212100637;2311.895964681585;2317.2932255662017;2123.8300935925167;2162.4593851537115;2164;2165.3828658832235;2166.068590506082;2266.331432227497;2266.5240299537036;2278.054607337961;2294.162630639821;2311.3759284992957;2264.4338915271182;2292.094622624071;2312.5143719818857;2313.340697901107;2319.4665226997718;7512.6619302130985;7582.886256706154;7592.658330375147;7596.164421913585;7604;4599.770011499445;4669.4396672399525;4701.388819453483;4703.388559487279;4708.835190768341;3037.9848100759355;3075.600171977651;3085.167004908662;3102.115896969353;3180.2844360019044;1013.9087482126644;1017.7201269650906;1047.2459828923163;1089.7330154112215;1102.1898904305328;10338.7415314617;10383.376997380181;10491.79016419675;10508.211884108647;10519.211059170593;3997.6601988830694;4126.216018956388;4126.896827579274;4137.358709399988;4243.511996120424;8819.470831750115;8821.2060914518;8828.337874659426;8839.60221790021;8841.204291613785;4582.908341833211;4623.976880115578;4627.838025669153;4628.884277893012;4629.884252893705;4177.185448837508;4220.704550681423;4222.619964203236;4224.028473451123;4226.049138943775;3373.628900820908;3445.0526105320737;3445.9834348867143;3542.5748910130433;3655.7258205634685;1136.4885801389407;1145.828125781123;1156.5200441816721;1164.8776878427811;1182.0720734223764;1003.3227571389283;1014.4572653630272;1036.0468369100445;1058.6612284069024;1062.0972173652333;7007.754728584475;7059.964700176569;7066.787996360117;7067.081279433641;7071.222165561784;640.7308930249307;645.0421124629921;653.947684185264;655.7967030220647;787.5471603827707;5635.605507614509;5768.538516918637;5774.133879918046;5776;5777.075667893117;8583.871241931376;8720.30237580992;8753.956230218935;8764.38649294556;8866.86699699505;8935.731928042169;8952.552372381355;8987.640494380283;9055.230305424113;9058.184763371328;6985.89521157183;7133.964330178316;7186.532875363085;7212.3869471094495;7238.52949558277;6705.698243578953;6720.0255962886085;6753.054572359775;6778.254392016973;6813.557118787263;7793.454458188099;7992.880106798287;8103.149169337371;8141.9185808141165;8197;8015.959920200362;8026.438149329724;8165.14266002085;8195.795105122419;8197.303229225583;6816.795496135124;6857.862842743217;6933.1333583302085;6941.0629565010095;6944;6399.104125422537;6500.70746816385;6868.862622747617;7509.962450187714;7552.584607846621;6685.8328541784895;6785.355391237825;6849.315068493111;6859.725610975505;7091.964540177266;6866.313368663094;6933.479989000744;6935.063766391472;6992.26581208986;7075.257098004636;6939.722411103701;6984.965075174591;6991.196012458429;7004.4046256068805;7031.296870312928;6243.96878015607;6449.161608990801;6475.967620161869;6507.186601674791;6520.608763474207;6497.772577959749;6538.738450462119;6560.737570497126;6566.9343306566325;6579.407853293226 04:15:04 INFO - PROCESS | 3575 | |4;prototype.html;344.92066824630336;350.4357983646329;351.4587535195799;351.4973587769489;354.31970616416476;5864.208331875196;5907.527397808176;5917.9408205917925;5923.496502797262;5928.110783382494;5622.606417550773;5683.886322273552;5759.222504961829;5816.214811000514;5840.707964601764;4551.249043907751;4563.520830312819;4565.429321334833;4579.244424669925;4585.679002469828;4386.846460373888;4575.839845605405;4576.748278844662;4578.748168850712;4579.038401935598;4399.758013309267;4454.242778727624;4541.613962813149;4548.090381923612;4552.226121559343;4488.955110448886;4508.909821803579;4521.547845215452;4525.660575456854;4539.75031373276;4009.4186342980106;4020.6984476164403;4022.034711669208;4027.7180597358197;4028.0332720146953;5457.399686034533;5555.916661250085;5556.888862222733;5561.304836895388;5568;5289.153735402318;5292.523672869422;5302.628815982883;5305.283786688825;5308.309919710451;6190.659513726743;6194.4115309045565;6204.410580994799;6205.782797602107;6210.254769427653;4448.377227188196;4449.844255451076;4451.332300154971;4458.1306645204195;4470.642348612103;6325.430711236011;6481.351864813528;6494.285628580852;6501.187351581005;6503.447206987365;4555.134524440346;4558.726476411426;4560.361549383089;4574.4510658721165;4577.977110114494;4631.768411579407;4636.907261854744;4637.6289896808175;4638.304254361873;4641.6054635355695;5277.20841873722;5280.815171469057;5281.867953301121;5284.762185701653;5285.207218917117;6057.727402266909;6207.906881396782;6264.404881536247;6267.341929097471;6288.213973253343;1572.1981789287545;1575.1572908493902;1575.527341797456;1576.7398379267293;1578.27399396279;1066.5360568152878;1079.6221322537049;1081.9729506762394;1097.9286346387619;1102.1183053557122;5830.533557315404;5834.591578589458;5837.036888913367;5842.2405087338375;5844.853878653068;6424.839379015469;6427.485801135898;6427.678616069178;6429.067785171217;6440.871182576322;5660.433956604306;5787.189793428924;5789.160571717078;5901.380355062743;5911.852203694942;3484.6689564491335;3499.5100685903994;3507.035565219534;3507.263474670297;3511.719062474996;6415.13395691585;6492.740290388331;6584.078229047937;6584.242812076673;6585.1439312889015;6580.309067547934;6659.800205993828;6663.233728121231;6668.333166683293;6694.631795251308;6581;6585.275619681831;6586.209654841449;6592.604443733488;6593.3736295051895;6338.524610654127;6424.518161138027;6471.7734879279;6474.352564743488;6487.610743355413;6389.105525226565;6396.264429590657;6398.072279519537;6402.90395644075;6410.871782564229;6583.177102862142;6589.209294884645;6592.17597800275;6592.76925307612;6594.274629790623;4509.706869053501;4510.143072816154;4513.277875539898;4516.525764794649;4517.299818528133;6456.418922297016;6463.224413070461;6464.5798023128345;6468.6442245676935;6470.967645161744;6286.339934306832;6287.2140982377205;6299.370062993848;6300.117983482408;6300.936990630035;6156.199694039746;6236.688165591793;6267.529935254783;6276.905846412399;6280.403361680633;6146.938530614637;6149.108379284889;6152.077188421773;6153.446189842935;6156.538259630456;6289.276733175743;6292.622442653455;6295.244570651368;6299.811005669837;6311.747530098928;6030.969845150747;6108.389161083856;6111.144439778345;6162.291336496181;6166.1983942087245 04:15:04 INFO - PROCESS | 3575 | |5;yui.html;745.262190431473;773.7059917231452;869.3436455476118;882.3602887906267;889.3729920406114;13636.318184090793;13744.93127534361;13870.722585548283;13872.930635346835;13879.097858639181;13165.341732913364;13272.668183295422;13275.734485310311;13276.137051091697;13277;678.5691086160274;696.4602433114326;819.3486178488116;834.7829564313262;847.2120927537388;840.5503055865113;844.472204871955;851.5444237333028;851.8594431918757;852.799592095857;885.5041176940902;893.9061398553156;894.150556970877;894.8478758611052;895.0914821456228;714.9106361704787;735.8675438421109;874.4228808986039;887.525174031893;887.8313120507083;654.3750718064238;655.0469067506766;655.3741177175785;655.4494224851148;655.9147310849606;12291.323977181251;12355.505779768799;12383.133180677356;12395.070369722216;12395.814062789066;11264.267822591506;12219.633410997685;12557.93721031389;12655.93672031634;13006.804897926539;9950.701478955643;10186.643467478676;10611.575536978511;10800.351978881292;10811.135109191246;3625.1843335249623;3688.5020522229424;3722.2927643747603;3820.1022759651737;3824.9808750956345;44676.106477870584;45113.54886451159;45504.77247613774;45663.54336456626;45851.54148458506;9604.183644390165;9636.084571965652;9667.806643867083;9677.935427103013;9882.357646752938;16638.3344666212;16817.243224054946;17148.142592870558;17151.74272385915;17263.913680431517;7852.646630901623;7954;8007.399445041645;8036.316913062338;8144.429889907649;4399.12017596482;4434.600885920283;4516.299973504112;4556.886077848014;4648.535146485325;3151.4800057990633;3183.920401989969;3189.9840500797814;3191.505316675919;3194.488881778904;551.1512271102538;551.4154995704566;559.9244102046254;562.9099344104924;587.4712758517284;601.0833478944644;628.9654069026247;641.7336805225872;670.3798985937988;708.8936659501013;8250.339972802161;8256.876146857801;8504.192101750325;8579.871301930476;8715.259202967693;645.5997281685385;646.9870602587922;660.1681880830189;662.622305285992;666.5700623098074;3608.7654302470783;3947.407888816643;3960.366341385422;3961.1087505311652;4193.391958166048;52160.21759673608;52718.209226861625;52902.470975290526;53065.469345306825;53153.73423132937;49425.75287123541;49462.50537494651;53710.46289537055;54297;55037;44811.55188448139;45105;45213.54786452094;45252.3212151818;46447;8473.872891906503;8705.303575714055;8777.868331975153;8925.241354484942;8954.776130596787;34217.486737698455;34374.312513749086;35118.473222901164;35921;35938.10154746152;42320.365194522725;42331.576684232765;43555.782221088695;43804.12391752083;44498.3325250115;11070.723231919266;11141.665750027512;11173.162012849232;11539.423028848356;11546.781098727519;12134.939325303318;12411.317377544321;12432.564860229848;12513.186642868184;12660.303683297507;11645.475953582278;11648.184627076023;11988.940055299669;12051;12337.814932775836;11163;11369.147313951322;11511.827322590336;11716.648500544998;11826.408679566159;10679.679609611723;10707.946460267649;10732.248742587944;10828.350298982086;11083.399840382823;9885.406875587487;9928.25538084661;10177.796444071226;10197.694069177936;10559.947200263949;8905.599248033725;8974.14745599167;9237.07629237071;9566.091221333962;9589.280803939871 04:15:04 INFO - PROCESS | 3575 | __end_tp_report 04:15:04 INFO - PROCESS | 3575 | __start_cc_report 04:15:04 INFO - PROCESS | 3575 | _x_x_mozilla_cycle_collect,879 04:15:04 INFO - PROCESS | 3575 | __end_cc_report 04:15:04 INFO - PROCESS | 3575 | __startTimestamp1450786504350__endTimestamp 04:15:04 INFO - PROCESS | 3575 | 04:15:04 INFO - PROCESS | 3575 | ------- Summary: start ------- 04:15:04 INFO - PROCESS | 3575 | Number of tests: 6 04:15:04 INFO - PROCESS | 3575 | 04:15:04 INFO - PROCESS | 3575 | [#0] dojo.html Cycles:165 Average:5323.59 Median:5514.64 stddev:593.08 (10.8%) stddev-sans-first:568.77 04:15:04 INFO - PROCESS | 3575 | Values: 3104.3 3138.9 3189.1 3191.2 3212.9 5092.7 5220.1 5320.2 5321.0 5354.8 5217.5 5261.9 5353.9 5385.4 5389.6 4789.1 4859.3 4870.8 4924.9 4952.6 4834.3 4953.0 4977.0 5016.9 5050.3 4689.2 4783.0 4959.5 4961.5 5031.0 4848.3 4933.2 4946.3 4947.2 4948.7 4919.3 4939.8 4941.0 4957.8 4977.5 5051.8 5109.5 5122.9 5258.3 5302.5 5744.8 5749.8 5754.0 5837.5 5884.9 5765.6 5771.5 5773.3 5773.8 5778.8 5176.4 5269.9 5280.4 5367.0 5377.0 5885.0 5963.3 5971.1 6008.2 6017.3 5677.2 5681.1 5683.7 5687.4 5711.5 5528.4 5671.2 5684.9 5746.5 5751.0 5736.0 5771.2 5816.8 5823.0 5866.9 5679.6 5683.2 5686.3 5687.3 5696.7 4270.4 4301.5 4375.4 4407.0 4438.9 3987.1 3995.3 3998.6 4008.0 4019.3 5298.5 5299.8 5304.9 5306.1 5346.4 5538.6 5652.8 5664.9 5769.7 5797.2 5236.0 5242.8 5249.2 5270.6 5291.3 4927.0 4927.8 4932.8 4949.9 4964.6 5628.9 5763.9 5828.5 5840.0 5859.2 5663.3 5703.9 5752.0 5772.2 5810.2 5867.0 5878.8 5879.9 5880.4 5941.9 5568.5 5708.3 5765.3 5769.4 5773.0 5695.4 5714.1 5721.2 5751.4 5799.2 5689.5 5700.2 5732.7 5740.6 5740.6 5461.5 5558.2 5656.8 5688.2 5717.3 5391.7 5418.8 5472.4 5475.4 5514.6 5664.6 5721.3 5721.7 5730.2 5791.2 5385.4 5457.7 5601.8 5609.0 5614.2 04:15:04 INFO - PROCESS | 3575 | 04:15:04 INFO - PROCESS | 3575 | [#1] ext.html Cycles:180 Average:47357.51 Median:35107.91 stddev:80893.09 (230.4%) stddev-sans-first:81043.67 04:15:04 INFO - PROCESS | 3575 | Values: 549.6 579.7 584.2 589.0 596.2 38535.2 39104.4 39134.2 39143.4 39153.4 42634.8 42700.6 43306.6 43341.3 43501.6 7548.7 7628.7 7640.1 8740.5 8920.5 7628.5 7736.9 10602.5 10834.5 10837.0 10465.5 10559.9 10564.3 10564.3 10566.4 7810.1 7956.0 10405.1 10516.6 10517.7 7649.8 10594.8 10850.4 10860.8 10864.5 39619.8 39791.8 39795.4 40018.2 40061.6 3482.4 3996.7 4056.2 4071.7 4148.8 32509.8 33000.7 33089.0 33357.8 33421.5 3642.7 3797.4 3803.9 3817.9 3827.2 279801.0 281864.0 282411.0 282950.0 285085.0 60333.4 60351.7 60553.0 60768.4 60796.7 62165.0 62494.7 62495.0 62503.0 62556.4 14967.0 15206.4 15209.3 15216.5 15256.6 11279.5 11372.4 11375.9 11376.1 11389.9 17887.2 20019.3 20183.6 20211.6 20251.3 6819.5 8089.5 8222.9 8311.6 8416.2 874.4 936.8 955.9 978.0 1089.1 28248.4 28343.4 28537.7 28646.4 28698.7 1094.5 1123.6 1158.4 1170.1 1192.4 13672.7 14864.9 15154.8 16137.0 16911.3 381517.0 383338.0 383763.0 384337.0 385182.0 53546.2 53956.0 54147.7 54394.0 54399.7 1329.2 1362.5 1393.4 1393.5 1394.1 28352.6 29281.4 29431.7 29724.0 29822.7 41976.4 42017.6 45409.8 47695.3 48438.0 240087.0 240173.0 242415.0 242508.0 242694.0 26868.7 31143.2 31291.0 31410.4 31488.5 29635.0 36077.3 40729.6 41316.8 42225.2 34608.7 35325.6 35453.8 35915.5 36041.1 35089.8 35930.8 35987.6 35992.1 36017.0 34879.7 35126.0 35239.0 35377.8 35436.6 31075.0 32266.4 32687.7 32734.0 32736.3 24599.1 25292.5 26327.7 26406.3 26532.3 04:15:04 INFO - PROCESS | 3575 | 04:15:04 INFO - PROCESS | 3575 | [#2] jquery.html Cycles:180 Average:28631.25 Median:37501.91 stddev:87959.46 (234.5%) stddev-sans-first:88180.59 04:15:04 INFO - PROCESS | 3575 | Values: 357.3 358.4 362.0 363.1 367.4 13499.7 13766.1 15695.0 15987.7 16451.2 13379.3 13811.7 15739.3 15917.1 16605.3 4788.5 5463.9 5465.1 5468.0 5471.6 3953.0 4011.8 5265.6 5420.1 5439.4 5804.3 5972.0 5996.8 6001.0 6007.8 5827.5 5958.5 5963.7 5967.1 5967.8 5252.1 5255.1 5255.1 5256.3 5257.2 20167.5 20289.0 20354.2 20382.6 20486.7 2110.7 2280.9 2299.7 2325.2 2330.3 12543.3 13061.0 13130.8 13276.5 13337.5 1740.9 1767.5 1793.1 1825.5 1864.4 59062.1 59082.7 61951.0 63141.5 69850.7 10060.8 10272.1 10288.8 10349.7 10378.8 13693.1 13699.6 13713.8 13725.7 13730.2 6939.8 7178.8 7189.5 7236.9 7308.2 6991.0 7093.6 7178.3 7193.7 7283.7 4398.0 4460.4 4461.3 4481.4 4491.8 1768.9 1785.1 1795.3 1820.4 1826.6 427.7 432.3 784.4 929.2 946.6 9605.4 10091.2 10179.4 10218.0 10232.3 413.6 445.3 445.4 450.5 462.0 5858.6 5871.1 5937.0 5983.9 6200.7 525703.0 532613.0 536897.0 544232.0 546993.0 83169.6 84161.2 86628.6 87138.0 88191.1 507.6 508.0 508.1 508.2 511.8 10329.9 10492.6 10622.7 10974.4 15077.0 35427.8 36359.0 37389.8 37614.0 38069.0 40811.0 42053.0 42360.6 42756.8 43334.6 9895.1 10058.9 10109.3 10227.1 10227.1 17424.1 17756.3 18127.3 18295.9 18311.2 14767.2 14819.5 15140.5 15264.6 15362.3 14542.5 14665.3 14883.2 14892.3 15053.7 14763.3 14989.1 15171.4 15457.8 15801.5 8577.0 8655.8 9661.3 9701.7 9772.9 13884.7 14050.9 14239.7 14266.0 14551.5 04:15:04 INFO - PROCESS | 3575 | 04:15:04 INFO - PROCESS | 3575 | [#3] mootools.html Cycles:180 Average:5289.71 Median:6486.87 stddev:2722.17 (42.0%) stddev-sans-first:2714.49 04:15:04 INFO - PROCESS | 3575 | Values: 1448.4 1485.5 1545.0 1625.8 1757.4 6683.3 7343.2 7443.9 7480.9 7484.8 6963.2 7173.0 7187.2 7188.0 7191.7 1977.2 2012.7 2016.1 2273.6 2308.7 2263.9 2305.9 2311.4 2311.9 2317.3 2123.8 2162.5 2164.0 2165.4 2166.1 2266.3 2266.5 2278.1 2294.2 2311.4 2264.4 2292.1 2312.5 2313.3 2319.5 7512.7 7582.9 7592.7 7596.2 7604.0 4599.8 4669.4 4701.4 4703.4 4708.8 3038.0 3075.6 3085.2 3102.1 3180.3 1013.9 1017.7 1047.2 1089.7 1102.2 10338.7 10383.4 10491.8 10508.2 10519.2 3997.7 4126.2 4126.9 4137.4 4243.5 8819.5 8821.2 8828.3 8839.6 8841.2 4582.9 4624.0 4627.8 4628.9 4629.9 4177.2 4220.7 4222.6 4224.0 4226.0 3373.6 3445.1 3446.0 3542.6 3655.7 1136.5 1145.8 1156.5 1164.9 1182.1 1003.3 1014.5 1036.0 1058.7 1062.1 7007.8 7060.0 7066.8 7067.1 7071.2 640.7 645.0 653.9 655.8 787.5 5635.6 5768.5 5774.1 5776.0 5777.1 8583.9 8720.3 8754.0 8764.4 8866.9 8935.7 8952.6 8987.6 9055.2 9058.2 6985.9 7134.0 7186.5 7212.4 7238.5 6705.7 6720.0 6753.1 6778.3 6813.6 7793.5 7992.9 8103.1 8141.9 8197.0 8016.0 8026.4 8165.1 8195.8 8197.3 6816.8 6857.9 6933.1 6941.1 6944.0 6399.1 6500.7 6868.9 7510.0 7552.6 6685.8 6785.4 6849.3 6859.7 7092.0 6866.3 6933.5 6935.1 6992.3 7075.3 6939.7 6985.0 6991.2 7004.4 7031.3 6244.0 6449.2 6476.0 6507.2 6520.6 6497.8 6538.7 6560.7 6566.9 6579.4 04:15:04 INFO - PROCESS | 3575 | 04:15:04 INFO - PROCESS | 3575 | [#4] prototype.html Cycles:180 Average:5231.49 Median:5841.47 stddev:1548.24 (26.5%) stddev-sans-first:1508.52 04:15:04 INFO - PROCESS | 3575 | Values: 344.9 350.4 351.5 351.5 354.3 5864.2 5907.5 5917.9 5923.5 5928.1 5622.6 5683.9 5759.2 5816.2 5840.7 4551.2 4563.5 4565.4 4579.2 4585.7 4386.8 4575.8 4576.7 4578.7 4579.0 4399.8 4454.2 4541.6 4548.1 4552.2 4489.0 4508.9 4521.5 4525.7 4539.8 4009.4 4020.7 4022.0 4027.7 4028.0 5457.4 5555.9 5556.9 5561.3 5568.0 5289.2 5292.5 5302.6 5305.3 5308.3 6190.7 6194.4 6204.4 6205.8 6210.3 4448.4 4449.8 4451.3 4458.1 4470.6 6325.4 6481.4 6494.3 6501.2 6503.4 4555.1 4558.7 4560.4 4574.5 4578.0 4631.8 4636.9 4637.6 4638.3 4641.6 5277.2 5280.8 5281.9 5284.8 5285.2 6057.7 6207.9 6264.4 6267.3 6288.2 1572.2 1575.2 1575.5 1576.7 1578.3 1066.5 1079.6 1082.0 1097.9 1102.1 5830.5 5834.6 5837.0 5842.2 5844.9 6424.8 6427.5 6427.7 6429.1 6440.9 5660.4 5787.2 5789.2 5901.4 5911.9 3484.7 3499.5 3507.0 3507.3 3511.7 6415.1 6492.7 6584.1 6584.2 6585.1 6580.3 6659.8 6663.2 6668.3 6694.6 6581.0 6585.3 6586.2 6592.6 6593.4 6338.5 6424.5 6471.8 6474.4 6487.6 6389.1 6396.3 6398.1 6402.9 6410.9 6583.2 6589.2 6592.2 6592.8 6594.3 4509.7 4510.1 4513.3 4516.5 4517.3 6456.4 6463.2 6464.6 6468.6 6471.0 6286.3 6287.2 6299.4 6300.1 6300.9 6156.2 6236.7 6267.5 6276.9 6280.4 6146.9 6149.1 6152.1 6153.4 6156.5 6289.3 6292.6 6295.2 6299.8 6311.7 6031.0 6108.4 6111.1 6162.3 6166.2 04:15:04 INFO - PROCESS | 3575 | 04:15:04 INFO - PROCESS | 3575 | [#5] yui.html Cycles:180 Average:13553.62 Median:45378.55 stddev:15368.61 (33.9%) stddev-sans-first:15381.62 04:15:04 INFO - PROCESS | 3575 | Values: 745.3 773.7 869.3 882.4 889.4 13636.3 13744.9 13870.7 13872.9 13879.1 13165.3 13272.7 13275.7 13276.1 13277.0 678.6 696.5 819.3 834.8 847.2 840.6 844.5 851.5 851.9 852.8 885.5 893.9 894.2 894.8 895.1 714.9 735.9 874.4 887.5 887.8 654.4 655.0 655.4 655.4 655.9 12291.3 12355.5 12383.1 12395.1 12395.8 11264.3 12219.6 12557.9 12655.9 13006.8 9950.7 10186.6 10611.6 10800.4 10811.1 3625.2 3688.5 3722.3 3820.1 3825.0 44676.1 45113.5 45504.8 45663.5 45851.5 9604.2 9636.1 9667.8 9677.9 9882.4 16638.3 16817.2 17148.1 17151.7 17263.9 7852.6 7954.0 8007.4 8036.3 8144.4 4399.1 4434.6 4516.3 4556.9 4648.5 3151.5 3183.9 3190.0 3191.5 3194.5 551.2 551.4 559.9 562.9 587.5 601.1 629.0 641.7 670.4 708.9 8250.3 8256.9 8504.2 8579.9 8715.3 645.6 647.0 660.2 662.6 666.6 3608.8 3947.4 3960.4 3961.1 4193.4 52160.2 52718.2 52902.5 53065.5 53153.7 49425.8 49462.5 53710.5 54297.0 55037.0 44811.6 45105.0 45213.5 45252.3 46447.0 8473.9 8705.3 8777.9 8925.2 8954.8 34217.5 34374.3 35118.5 35921.0 35938.1 42320.4 42331.6 43555.8 43804.1 44498.3 11070.7 11141.7 11173.2 11539.4 11546.8 12134.9 12411.3 12432.6 12513.2 12660.3 11645.5 11648.2 11988.9 12051.0 12337.8 11163.0 11369.1 11511.8 11716.6 11826.4 10679.7 10707.9 10732.2 10828.4 11083.4 9885.4 9928.3 10177.8 10197.7 10559.9 8905.6 8974.1 9237.1 9566.1 9589.3 04:15:04 INFO - PROCESS | 3575 | -------- Summary: end -------- 04:15:04 INFO - PROCESS | 3575 | 04:15:05 INFO - TEST-INFO | 3575: exit 0 04:15:05 INFO - TEST-OK | dromaeo_css | took 1112999ms 04:15:05 INFO - TEST-START | kraken 04:15:05 INFO - operating with platform_type : linux_ 04:15:05 INFO - Initialising browser for kraken test... 04:15:05 INFO - TEST-INFO | started process 3767 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzVqPox/profile http://localhost:55330/getInfo.html) 04:15:09 INFO - PROCESS | 3767 | __metrics Screen width/height:1600/1200 04:15:09 INFO - PROCESS | 3767 | colorDepth:24 04:15:09 INFO - PROCESS | 3767 | Browser inner width/height: 1024/697 04:15:09 INFO - PROCESS | 3767 | __metrics 04:15:09 INFO - PROCESS | 3767 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:15:09 INFO - PROCESS | 3767 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:15:10 INFO - TEST-INFO | 3767: exit 0 04:15:10 INFO - Browser initialized. 04:15:10 INFO - Running cycle 1/1 for kraken test... 04:15:10 INFO - TEST-INFO | started process 3850 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzVqPox/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:22 INFO - PROCESS | 3850 | RSS: Main: 149946368 04:15:22 INFO - PROCESS | 3850 | 04:15:24 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55330/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55330/tests/kraken/driver.html?testName=audio-beat-detection) 04:15:25 INFO - PROCESS | 3850 | RSS: Main: 186044416 04:15:25 INFO - PROCESS | 3850 | 04:15:27 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55330/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55330/tests/kraken/driver.html?testName=audio-dft) 04:15:28 INFO - PROCESS | 3850 | RSS: Main: 177414144 04:15:28 INFO - PROCESS | 3850 | 04:15:31 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55330/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55330/tests/kraken/driver.html?testName=audio-fft) 04:15:31 INFO - PROCESS | 3850 | RSS: Main: 161284096 04:15:31 INFO - PROCESS | 3850 | 04:15:33 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55330/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55330/tests/kraken/driver.html?testName=audio-oscillator) 04:15:34 INFO - PROCESS | 3850 | RSS: Main: 163373056 04:15:34 INFO - PROCESS | 3850 | 04:15:36 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55330/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55330/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:15:37 INFO - PROCESS | 3850 | RSS: Main: 165838848 04:15:37 INFO - PROCESS | 3850 | 04:15:40 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55330/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55330/tests/kraken/driver.html?testName=imaging-darkroom) 04:15:40 INFO - PROCESS | 3850 | RSS: Main: 163954688 04:15:40 INFO - PROCESS | 3850 | 04:15:43 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55330/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55330/tests/kraken/driver.html?testName=imaging-desaturate) 04:15:44 INFO - PROCESS | 3850 | RSS: Main: 166117376 04:15:44 INFO - PROCESS | 3850 | 04:15:47 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55330/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55330/tests/kraken/driver.html?testName=json-parse-financial) 04:15:47 INFO - PROCESS | 3850 | RSS: Main: 163848192 04:15:47 INFO - PROCESS | 3850 | 04:15:49 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55330/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55330/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:15:49 INFO - PROCESS | 3850 | RSS: Main: 176340992 04:15:49 INFO - PROCESS | 3850 | 04:15:51 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55330/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55330/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:15:52 INFO - PROCESS | 3850 | RSS: Main: 173449216 04:15:52 INFO - PROCESS | 3850 | 04:15:54 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55330/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55330/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:15:55 INFO - PROCESS | 3850 | RSS: Main: 183975936 04:15:55 INFO - PROCESS | 3850 | 04:15:57 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55330/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:15:58 INFO - PROCESS | 3850 | RSS: Main: 191905792 04:15:58 INFO - PROCESS | 3850 | 04:16:00 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:16:01 INFO - PROCESS | 3850 | RSS: Main: 189247488 04:16:01 INFO - PROCESS | 3850 | 04:16:02 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55330/tests/kraken/driver.html?testName=ai-astar) 04:16:03 INFO - PROCESS | 3850 | RSS: Main: 248209408 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - PROCESS | 3850 | __start_tp_report 04:16:03 INFO - PROCESS | 3850 | _x_x_mozilla_page_load 04:16:03 INFO - PROCESS | 3850 | _x_x_mozilla_page_load_details 04:16:03 INFO - PROCESS | 3850 | |i|pagename|runs| 04:16:03 INFO - PROCESS | 3850 | |0;ai-astar;108;110;104;111;110;110;99;112;109;116 04:16:03 INFO - PROCESS | 3850 | |1;audio-beat-detection;150;126;155;165;126;146;151;125;161;126 04:16:03 INFO - PROCESS | 3850 | |2;audio-dft;161;162;161;162;160;162;162;164;161;163 04:16:03 INFO - PROCESS | 3850 | |3;audio-fft;72;72;78;92;71;78;72;107;95;73 04:16:03 INFO - PROCESS | 3850 | |4;audio-oscillator;94;94;136;93;93;94;140;95;94;134 04:16:03 INFO - PROCESS | 3850 | |5;imaging-gaussian-blur;110;109;109;109;109;110;110;109;110;109 04:16:03 INFO - PROCESS | 3850 | |6;imaging-darkroom;147;146;145;145;145;146;145;145;146;145 04:16:03 INFO - PROCESS | 3850 | |7;imaging-desaturate;95;95;96;95;96;96;96;96;96;96 04:16:03 INFO - PROCESS | 3850 | |8;json-parse-financial;59;57;58;56;58;56;58;65;56;55 04:16:03 INFO - PROCESS | 3850 | |9;json-stringify-tinderbox;67;68;69;68;67;68;68;68;68;68 04:16:03 INFO - PROCESS | 3850 | |10;stanford-crypto-aes;84;85;85;85;85;85;93;87;94;85 04:16:03 INFO - PROCESS | 3850 | |11;stanford-crypto-ccm;125;116;119;115;120;118;132;123;124;123 04:16:03 INFO - PROCESS | 3850 | |12;stanford-crypto-pbkdf2;149;154;152;151;144;142;153;170;150;142 04:16:03 INFO - PROCESS | 3850 | |13;stanford-crypto-sha256-iterative;67;66;68;69;68;66;68;67;66;67 04:16:03 INFO - PROCESS | 3850 | __end_tp_report 04:16:03 INFO - PROCESS | 3850 | __start_cc_report 04:16:03 INFO - PROCESS | 3850 | _x_x_mozilla_cycle_collect,913 04:16:03 INFO - PROCESS | 3850 | __end_cc_report 04:16:03 INFO - PROCESS | 3850 | __startTimestamp1450786563119__endTimestamp 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - PROCESS | 3850 | ------- Summary: start ------- 04:16:03 INFO - PROCESS | 3850 | Number of tests: 14 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - PROCESS | 3850 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.50 stddev:4.61 (4.2%) stddev-sans-first:4.87 04:16:03 INFO - PROCESS | 3850 | Values: 108.0 110.0 104.0 111.0 110.0 110.0 99.0 112.0 109.0 116.0 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - PROCESS | 3850 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:150.50 stddev:15.86 (10.5%) stddev-sans-first:16.63 04:16:03 INFO - PROCESS | 3850 | Values: 150.0 126.0 155.0 165.0 126.0 146.0 151.0 125.0 161.0 126.0 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - PROCESS | 3850 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.17 04:16:03 INFO - PROCESS | 3850 | Values: 161.0 162.0 161.0 162.0 160.0 162.0 162.0 164.0 161.0 163.0 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - PROCESS | 3850 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.50 stddev:12.55 (16.6%) stddev-sans-first:12.88 04:16:03 INFO - PROCESS | 3850 | Values: 72.0 72.0 78.0 92.0 71.0 78.0 72.0 107.0 95.0 73.0 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - PROCESS | 3850 | [#4] audio-oscillator Cycles:10 Average:106.70 Median:94.00 stddev:20.74 (22.1%) stddev-sans-first:21.48 04:16:03 INFO - PROCESS | 3850 | Values: 94.0 94.0 136.0 93.0 93.0 94.0 140.0 95.0 94.0 134.0 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - PROCESS | 3850 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:16:03 INFO - PROCESS | 3850 | Values: 110.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 110.0 109.0 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - PROCESS | 3850 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 04:16:03 INFO - PROCESS | 3850 | Values: 147.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 145.0 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - PROCESS | 3850 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 04:16:03 INFO - PROCESS | 3850 | Values: 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - PROCESS | 3850 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:2.82 (4.9%) stddev-sans-first:2.96 04:16:03 INFO - PROCESS | 3850 | Values: 59.0 57.0 58.0 56.0 58.0 56.0 58.0 65.0 56.0 55.0 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - PROCESS | 3850 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 04:16:03 INFO - PROCESS | 3850 | Values: 67.0 68.0 69.0 68.0 67.0 68.0 68.0 68.0 68.0 68.0 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - PROCESS | 3850 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:85.00 stddev:3.61 (4.3%) stddev-sans-first:3.69 04:16:03 INFO - PROCESS | 3850 | Values: 84.0 85.0 85.0 85.0 85.0 85.0 93.0 87.0 94.0 85.0 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - PROCESS | 3850 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:123.00 stddev:5.02 (4.1%) stddev-sans-first:5.16 04:16:03 INFO - PROCESS | 3850 | Values: 125.0 116.0 119.0 115.0 120.0 118.0 132.0 123.0 124.0 123.0 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - PROCESS | 3850 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:151.50 stddev:8.10 (5.3%) stddev-sans-first:8.57 04:16:03 INFO - PROCESS | 3850 | Values: 149.0 154.0 152.0 151.0 144.0 142.0 153.0 170.0 150.0 142.0 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - PROCESS | 3850 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.03 (1.5%) stddev-sans-first:1.09 04:16:03 INFO - PROCESS | 3850 | Values: 67.0 66.0 68.0 69.0 68.0 66.0 68.0 67.0 66.0 67.0 04:16:03 INFO - PROCESS | 3850 | -------- Summary: end -------- 04:16:03 INFO - PROCESS | 3850 | 04:16:03 INFO - TEST-INFO | 3850: exit 0 04:16:04 INFO - TEST-OK | kraken | took 58884ms 04:16:04 INFO - TEST-START | v8_7 04:16:04 INFO - operating with platform_type : linux_ 04:16:04 INFO - Initialising browser for v8_7 test... 04:16:04 INFO - TEST-INFO | started process 4099 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXkSJOw/profile http://localhost:55330/getInfo.html) 04:16:07 INFO - PROCESS | 4099 | __metrics Screen width/height:1600/1200 04:16:07 INFO - PROCESS | 4099 | colorDepth:24 04:16:07 INFO - PROCESS | 4099 | Browser inner width/height: 1024/697 04:16:07 INFO - PROCESS | 4099 | __metrics 04:16:08 INFO - PROCESS | 4099 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:16:08 INFO - PROCESS | 4099 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:16:09 INFO - TEST-INFO | 4099: exit 0 04:16:09 INFO - Browser initialized. 04:16:09 INFO - Running cycle 1/1 for v8_7 test... 04:16:09 INFO - TEST-INFO | started process 4182 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXkSJOw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:21 INFO - PROCESS | 4182 | RSS: Main: 149528576 04:16:21 INFO - PROCESS | 4182 | 04:16:42 INFO - PROCESS | 4182 | Cycle 1(1): loaded http://localhost:55330/tests/v8_7/run.html (next: http://localhost:55330/tests/v8_7/run.html) 04:16:42 INFO - PROCESS | 4182 | RSS: Main: 612270080 04:16:42 INFO - PROCESS | 4182 | 04:16:42 INFO - PROCESS | 4182 | __start_tp_report 04:16:42 INFO - PROCESS | 4182 | _x_x_mozilla_page_load 04:16:42 INFO - PROCESS | 4182 | _x_x_mozilla_page_load_details 04:16:42 INFO - PROCESS | 4182 | |i|pagename|runs| 04:16:42 INFO - PROCESS | 4182 | |0;Richards;167.02856188408217 04:16:42 INFO - PROCESS | 4182 | |1;DeltaBlue;189.0359168241966 04:16:42 INFO - PROCESS | 4182 | |2;Encrypt;280.2690582959641 04:16:42 INFO - PROCESS | 4182 | |3;Decrypt;5138.461538461538 04:16:42 INFO - PROCESS | 4182 | |4;RayTrace;1088.139281828074 04:16:42 INFO - PROCESS | 4182 | |5;Earley;777.6049766718507 04:16:42 INFO - PROCESS | 4182 | |6;Boyer;11802.32558139535 04:16:42 INFO - PROCESS | 4182 | |7;RegExp;25974.358974358973 04:16:42 INFO - PROCESS | 4182 | |8;Splay;657.328990228013 04:16:42 INFO - PROCESS | 4182 | |9;NavierStokes;4864.077669902913 04:16:42 INFO - PROCESS | 4182 | __end_tp_report 04:16:42 INFO - PROCESS | 4182 | __startTimestamp1450786602639__endTimestamp 04:16:42 INFO - PROCESS | 4182 | 04:16:42 INFO - PROCESS | 4182 | ------- Summary: start ------- 04:16:42 INFO - PROCESS | 4182 | Number of tests: 10 04:16:42 INFO - PROCESS | 4182 | 04:16:42 INFO - PROCESS | 4182 | [#0] Richards Cycles:1 Average:167.03 Median:167.03 stddev:0.00 (0.0%) 04:16:42 INFO - PROCESS | 4182 | Values: 167.0 04:16:42 INFO - PROCESS | 4182 | 04:16:42 INFO - PROCESS | 4182 | [#1] DeltaBlue Cycles:1 Average:189.04 Median:189.04 stddev:0.00 (0.0%) 04:16:42 INFO - PROCESS | 4182 | Values: 189.0 04:16:42 INFO - PROCESS | 4182 | 04:16:42 INFO - PROCESS | 4182 | [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 04:16:42 INFO - PROCESS | 4182 | Values: 280.3 04:16:42 INFO - PROCESS | 4182 | 04:16:42 INFO - PROCESS | 4182 | [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 04:16:42 INFO - PROCESS | 4182 | Values: 5138.5 04:16:42 INFO - PROCESS | 4182 | 04:16:42 INFO - PROCESS | 4182 | [#4] RayTrace Cycles:1 Average:1088.14 Median:1088.14 stddev:0.00 (0.0%) 04:16:42 INFO - PROCESS | 4182 | Values: 1088.1 04:16:42 INFO - PROCESS | 4182 | 04:16:42 INFO - PROCESS | 4182 | [#5] Earley Cycles:1 Average:777.60 Median:777.60 stddev:0.00 (0.0%) 04:16:42 INFO - PROCESS | 4182 | Values: 777.6 04:16:42 INFO - PROCESS | 4182 | 04:16:42 INFO - PROCESS | 4182 | [#6] Boyer Cycles:1 Average:11802.33 Median:11802.33 stddev:0.00 (0.0%) 04:16:42 INFO - PROCESS | 4182 | Values: 11802.3 04:16:42 INFO - PROCESS | 4182 | 04:16:42 INFO - PROCESS | 4182 | [#7] RegExp Cycles:1 Average:25974.36 Median:25974.36 stddev:0.00 (0.0%) 04:16:42 INFO - PROCESS | 4182 | Values: 25974.4 04:16:42 INFO - PROCESS | 4182 | 04:16:42 INFO - PROCESS | 4182 | [#8] Splay Cycles:1 Average:657.33 Median:657.33 stddev:0.00 (0.0%) 04:16:42 INFO - PROCESS | 4182 | Values: 657.3 04:16:42 INFO - PROCESS | 4182 | 04:16:42 INFO - PROCESS | 4182 | [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 04:16:42 INFO - PROCESS | 4182 | Values: 4864.1 04:16:42 INFO - PROCESS | 4182 | -------- Summary: end -------- 04:16:42 INFO - PROCESS | 4182 | 04:16:43 INFO - TEST-INFO | 4182: exit 0 04:16:43 INFO - TEST-OK | v8_7 | took 39475ms 04:16:43 INFO - SUITE-END | took 1211s 04:16:43 INFO - Completed test suite (00:20:11) 04:16:43 INFO - Working with test: dromaeo_css 04:16:43 INFO - Generating results file: dromaeo_css 04:16:43 INFO - Working with test: kraken 04:16:43 INFO - Generating results file: kraken 04:16:43 INFO - javascript benchmark 04:16:43 INFO - Working with test: v8_7 04:16:43 INFO - Generating results file: v8_7 04:16:43 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:16:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 04:16:43 INFO - process_Request line: dromaeo_css 6881.99 graph.html#tests=[[72,63,35]] 04:16:43 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:16:43 INFO - process_Request line: kraken 1504.00 graph.html#tests=[[232,63,35]] 04:16:43 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:16:43 INFO - process_Request line: v8_7 20980.27 graph.html#tests=[[230,63,35]] 04:16:43 INFO - RETURN: dromaeo_css: 6881.99 04:16:43 INFO - RETURN: kraken: 1504.00 04:16:43 INFO - RETURN: v8_7: 20980.27 04:16:43 INFO - javascript benchmark 04:16:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3104.3015321552652, 3138.9372212555736, 3189.1389324882284, 3191.21815155287, 3212.887548935788, 5092.719900405476, 5220.060389129955, 5320.175372817214, 5321.015612111762, 5354.785808567657, 5217.452167522412, 5261.947380526203, 5353.866153346158, 5385.380681221661, 5389.5688344932405, 4789.11401390743, 4859.271109333593, 4870.780814863339, 4924.901501969976, 4952.628552858532, 4834.250691142878, 4953.0, 4977.0, 5016.899662006757, 5050.292958985745, 4689.249720044776, 4783.043391321749, 4959.504049595048, 4961.5038496150455, 5030.974845125769, 4848.321235027099, 4933.161362568372, 4946.2580612908, 4947.183714687072, 4948.703077815343, 4919.26211068339, 4939.777710003059, 4940.987097644974, 4957.7769000395065, 4977.477364876672, 5051.797928082872, 5109.463506331856, 5122.871928201787, 5258.290130832327, 5302.549283310923, 5744.827655170351, 5749.82750517481, 5754.0, 5837.532997360201, 5884.941150588482, 5765.567582431292, 5771.480566749013, 5773.3072031356505, 5773.797917072924, 5778.797742079007, 5176.404713457963, 5269.894602107936, 5280.392754833167, 5367.0339338918975, 5377.0321342158395, 5885.0, 5963.314218864799, 5971.0744834550715, 6008.158857759917, 6017.338092809788, 5677.233573467612, 5681.147827825776, 5683.715814209356, 5687.374388817227, 5711.457411545896, 5528.44715528452, 5671.2060311556415, 5684.9431505684415, 5746.511546518509, 5751.0, 5736.0, 5771.192033115367, 5816.767329306865, 5823.0, 5866.882662346729, 5679.602427830012, 5683.232763576947, 5686.317641883001, 5687.260656114679, 5696.686682232434, 4270.380794784739, 4301.483821941324, 4375.365571992107, 4406.9559304407185, 4438.911221775611, 3987.102901847119, 3995.34076877312, 3998.6001399859783, 4007.979960100239, 4019.2765302245293, 5298.496642818926, 5299.754557678943, 5304.893902121936, 5306.124489459196, 5346.385165705994, 5538.556915446835, 5652.7738890443925, 5664.85837854057, 5769.68266745333, 5797.188393624896, 5236.0, 5242.76407561653, 5249.160134378481, 5270.578353731692, 5291.285676433632, 4926.950730492721, 4927.77824997876, 4932.804287844383, 4949.901001980013, 4964.553190212898, 5628.943710562842, 5763.942360576424, 5828.504577110993, 5839.970800145972, 5859.2090067841145, 5663.32040155184, 5703.914441283301, 5752.022156233534, 5772.163036359789, 5810.186573879576, 5867.031939729897, 5878.823635290948, 5879.911801322898, 5880.382559831327, 5941.851453713692, 5568.470995255444, 5708.343540492897, 5765.250517432874, 5769.3942136076785, 5773.047447171338, 5695.430456954437, 5714.085746280575, 5721.227634269487, 5751.3673495916255, 5799.188113664175, 5689.487946084872, 5700.173474846041, 5732.656040637575, 5740.598158129058, 5740.6268592541355, 5461.453854614507, 5558.221848941233, 5656.773729050792, 5688.203651488712, 5717.342505611741, 5391.7304134793885, 5418.756155972912, 5472.370677372153, 5475.397706252229, 5514.641548299348, 5664.603477756517, 5721.256236689203, 5721.685307308138, 5730.169125476866, 5791.218185545066, 5385.434529374359, 5457.7271136443815, 5601.775928962796, 5609.0, 5614.157876318422], "unit": "score", "name": "dojo.html", "value": 5285.000696413086}, {"lowerIsBetter": false, "replicates": [549.5763682161668, 579.7043507811018, 584.1763114009243, 588.9646621202728, 596.2129988415293, 38535.22929541411, 39104.413433798516, 39134.21731565367, 39143.41284880725, 39153.41269880954, 42634.78682606583, 42700.57299427005, 43306.56693433065, 43341.349879751826, 43501.564984350145, 7548.66031028605, 7628.694852205905, 7640.121386040621, 8740.519271440084, 8920.464772113693, 7628.542287462742, 7736.883946740803, 10602.469876506182, 10834.458277086154, 10837.024667779899, 10465.476726163699, 10559.947200263989, 10564.26050176488, 10564.313319634237, 10566.418846963414, 7810.101838288612, 7956.045274567089, 10405.063544281013, 10516.579336826519, 10517.737056573647, 7649.770506884803, 10594.841077383768, 10850.403227822466, 10860.782784344348, 10864.45677716119, 39619.8019009906, 39791.8010409949, 39795.40306895399, 40018.199636007404, 40061.59938400608, 3482.3905816482015, 3996.680265578776, 4056.229316429869, 4071.7353372030725, 4148.751074935483, 32509.837450812596, 33000.6699933, 33089.0, 33357.83321083403, 33421.498677519856, 3642.7267954903223, 3797.411401232813, 3803.904902377435, 3817.8854634361014, 3827.215420838749, 279801.0, 281864.0, 282411.0, 282950.0, 285085.0, 60333.39666603366, 60351.698241508515, 60553.0, 60768.39231607627, 60796.70439547283, 62165.0, 62494.68752656208, 62495.0, 62503.0, 62556.37443625597, 14967.027143235655, 15206.391744330323, 15209.315580798891, 15216.543503694686, 15256.618584535476, 11279.548818047186, 11372.374519401512, 11375.886241137483, 11376.146788990858, 11389.886101138882, 17887.234492978423, 20019.29932452357, 20183.596328073356, 20211.59576808485, 20251.29120480776, 6819.488538359643, 8089.474184178127, 8222.944263934016, 8311.584420778936, 8416.158384161536, 874.3529787956866, 936.765808547863, 955.9330846840654, 977.9902200977899, 1089.1290439371276, 28248.435031299257, 28343.433131337257, 28537.71462285392, 28646.427071458453, 28698.713012870023, 1094.518411898762, 1123.5730422439422, 1158.415000424797, 1170.0931777872217, 1192.3978390912707, 13672.65818354549, 14864.878345620247, 15154.848451515343, 16137.0, 16911.323547058226, 381517.0, 383338.0, 383763.0, 384337.0, 385182.0, 53546.19680704793, 53956.0, 54147.72926135423, 54394.0, 54399.728001360534, 1329.2356894785537, 1362.455017992791, 1393.4495874129864, 1393.5192358636255, 1394.1077710265438, 28352.57471137976, 29281.41437171202, 29431.705682943753, 29724.0, 29822.701772981993, 41976.370354444094, 42017.57982420259, 45409.77295113503, 47695.28457073077, 48438.0, 240087.0, 240173.0, 242415.0, 242508.0, 242694.0, 26868.73131268662, 31143.221419464695, 31291.0, 31410.371792564478, 31488.527672085394, 29635.0, 36077.27845443129, 40729.592704073766, 41316.79341603273, 42225.155496890504, 34608.65391346054, 35325.646743532234, 35453.82273088618, 35915.46126808048, 36041.09897252485, 35089.824550878104, 35930.8203458981, 35987.64012359843, 35992.100197495274, 36017.0, 34879.651203488655, 35126.0, 35239.0, 35377.82311088428, 35436.645633544365, 31075.0, 32266.35467290688, 32687.67312326846, 32734.0, 32736.345273093928, 24599.139030133858, 25292.49415011726, 26327.73672263253, 26406.339841503348, 26532.33669158209], "unit": "score", "name": "ext.html", "value": 18859.438825558795}, {"lowerIsBetter": false, "replicates": [357.27473229344423, 358.43188546154346, 361.9583747868995, 363.1140018355215, 367.3974681522304, 13499.662508437294, 13766.105203161787, 15695.0, 15987.680246395064, 16451.17744112794, 13379.331033448312, 13811.65470863229, 15739.291731872065, 15917.124558149297, 16605.252763625635, 4788.52114788521, 5463.890722185554, 5465.098258787295, 5468.015757163709, 5471.616986810905, 3953.0, 4011.7793521356316, 5265.552428043621, 5420.051490989081, 5439.428859969706, 5804.303483581976, 5972.0444728843395, 5996.820095397145, 6001.0, 6007.8197654070445, 5827.475527202572, 5958.463738263534, 5963.731632076567, 5967.134765459005, 5967.761289548413, 5252.107141785906, 5255.080360936859, 5255.132903071027, 5256.342957130359, 5257.18513630384, 20167.495812604655, 20289.0, 20354.18583256668, 20382.592348153103, 20486.692699609517, 2110.6517424624917, 2280.8745518996448, 2299.72403311602, 2325.162941341116, 2330.254318618026, 12543.310117943509, 13061.0, 13130.803037954438, 13276.535321263806, 13337.53318633843, 1740.9042502662348, 1767.4962635648908, 1793.1213705284447, 1825.4797382745853, 1864.3754342295347, 59062.11406828858, 59082.70458647679, 61951.0, 63141.5272160031, 69850.65074674595, 10060.798784024424, 10272.075513203697, 10288.76534815827, 10349.689509314732, 10378.844317335246, 13693.109947853358, 13699.589012329647, 13713.794293085612, 13725.725485490433, 13730.244836534086, 6939.75710850128, 7178.784636460915, 7189.496735228484, 7236.927630723625, 7308.159561650372, 6990.986306985458, 7093.574385536885, 7178.318059784312, 7193.676284567207, 7283.70865165398, 4397.956020439755, 4460.397846290709, 4461.3047042124435, 4481.439820022497, 4491.775411229425, 1768.9027103509432, 1785.1342099081935, 1795.2549691877985, 1820.3537744100918, 1826.5981484073482, 427.65573713161206, 432.3126229295435, 784.4273680213362, 929.1869614087673, 946.5787724462685, 9605.37565058269, 10091.243156763125, 10179.440130792878, 10217.951722521726, 10232.283740138268, 413.6237316616, 445.34978930760803, 445.43652279865995, 450.54494960090545, 462.0, 5858.589898707135, 5871.119332100134, 5936.970315148396, 5983.910241346383, 6200.689965501707, 525703.0, 532613.0, 536897.0, 544232.0, 546993.0, 83169.58415207885, 84161.15838841656, 86628.56685716531, 87138.0, 88191.11808881829, 507.5737178528274, 508.03473400538536, 508.1412413021981, 508.1970486631114, 511.84644606617866, 10329.9483502582, 10492.632757853438, 10622.73443163927, 10974.396408197626, 15077.0, 35427.82286088553, 36359.0, 37389.81305093457, 37614.0, 38069.0, 40811.0, 42053.0, 42360.576394235664, 42756.786216069966, 43334.56665433305, 9895.109440150422, 10058.949705251427, 10109.34289271195, 10227.07956283938, 10227.130693890806, 17424.12879356002, 17756.28974840992, 18127.274909003492, 18295.908520457313, 18311.175997079896, 14767.187804670846, 14819.481318153812, 15140.545783626509, 15264.618384540476, 15362.30869610848, 14542.4910128145, 14665.26673666291, 14883.181425021729, 14892.255387230378, 15053.6989260212, 14763.335649895995, 14989.100653960797, 15171.393144274105, 15457.768133478232, 15801.525954221392, 8576.957115214384, 8655.826883462421, 9661.275404344562, 9701.70894873155, 9772.85340719904, 13884.652883677989, 14050.859491404955, 14239.715205696035, 14266.0, 14551.490697825526], "unit": "score", "name": "jquery.html", "value": 8254.627716346882}, {"lowerIsBetter": false, "replicates": [1448.3916754962916, 1485.4524490498795, 1544.9613759656015, 1625.8455446732564, 1757.4464043826194, 6683.29825368336, 7343.155537113227, 7443.888341674872, 7480.887786683191, 7484.812879678011, 6963.199232088299, 7172.96413517933, 7187.173475050371, 7188.029616001838, 7191.748288809893, 1977.2091163534558, 2012.748406449194, 2016.1028342387644, 2273.59075366434, 2308.6998690170253, 2263.852849564773, 2305.9308220753405, 2311.3528212100637, 2311.895964681585, 2317.2932255662017, 2123.8300935925167, 2162.4593851537115, 2164.0, 2165.3828658832235, 2166.068590506082, 2266.331432227497, 2266.5240299537036, 2278.054607337961, 2294.162630639821, 2311.3759284992957, 2264.4338915271182, 2292.094622624071, 2312.5143719818857, 2313.340697901107, 2319.4665226997718, 7512.6619302130985, 7582.886256706154, 7592.658330375147, 7596.164421913585, 7604.0, 4599.770011499445, 4669.4396672399525, 4701.388819453483, 4703.388559487279, 4708.835190768341, 3037.9848100759355, 3075.600171977651, 3085.167004908662, 3102.115896969353, 3180.2844360019044, 1013.9087482126644, 1017.7201269650906, 1047.2459828923163, 1089.7330154112215, 1102.1898904305328, 10338.7415314617, 10383.376997380181, 10491.79016419675, 10508.211884108647, 10519.211059170593, 3997.6601988830694, 4126.216018956388, 4126.896827579274, 4137.358709399988, 4243.511996120424, 8819.470831750115, 8821.2060914518, 8828.337874659426, 8839.60221790021, 8841.204291613785, 4582.908341833211, 4623.976880115578, 4627.838025669153, 4628.884277893012, 4629.884252893705, 4177.185448837508, 4220.704550681423, 4222.619964203236, 4224.028473451123, 4226.049138943775, 3373.628900820908, 3445.0526105320737, 3445.9834348867143, 3542.5748910130433, 3655.7258205634685, 1136.4885801389407, 1145.828125781123, 1156.5200441816721, 1164.8776878427811, 1182.0720734223764, 1003.3227571389283, 1014.4572653630272, 1036.0468369100445, 1058.6612284069024, 1062.0972173652333, 7007.754728584475, 7059.964700176569, 7066.787996360117, 7067.081279433641, 7071.222165561784, 640.7308930249307, 645.0421124629921, 653.947684185264, 655.7967030220647, 787.5471603827707, 5635.605507614509, 5768.538516918637, 5774.133879918046, 5776.0, 5777.075667893117, 8583.871241931376, 8720.30237580992, 8753.956230218935, 8764.38649294556, 8866.86699699505, 8935.731928042169, 8952.552372381355, 8987.640494380283, 9055.230305424113, 9058.184763371328, 6985.89521157183, 7133.964330178316, 7186.532875363085, 7212.3869471094495, 7238.52949558277, 6705.698243578953, 6720.0255962886085, 6753.054572359775, 6778.254392016973, 6813.557118787263, 7793.454458188099, 7992.880106798287, 8103.149169337371, 8141.9185808141165, 8197.0, 8015.959920200362, 8026.438149329724, 8165.14266002085, 8195.795105122419, 8197.303229225583, 6816.795496135124, 6857.862842743217, 6933.1333583302085, 6941.0629565010095, 6944.0, 6399.104125422537, 6500.70746816385, 6868.862622747617, 7509.962450187714, 7552.584607846621, 6685.8328541784895, 6785.355391237825, 6849.315068493111, 6859.725610975505, 7091.964540177266, 6866.313368663094, 6933.479989000744, 6935.063766391472, 6992.26581208986, 7075.257098004636, 6939.722411103701, 6984.965075174591, 6991.196012458429, 7004.4046256068805, 7031.296870312928, 6243.96878015607, 6449.161608990801, 6475.967620161869, 6507.186601674791, 6520.608763474207, 6497.772577959749, 6538.738450462119, 6560.737570497126, 6566.9343306566325, 6579.407853293226], "unit": "score", "name": "mootools.html", "value": 4318.884884074115}, {"lowerIsBetter": false, "replicates": [344.92066824630336, 350.4357983646329, 351.4587535195799, 351.4973587769489, 354.31970616416476, 5864.208331875196, 5907.527397808176, 5917.9408205917925, 5923.496502797262, 5928.110783382494, 5622.606417550773, 5683.886322273552, 5759.222504961829, 5816.214811000514, 5840.707964601764, 4551.249043907751, 4563.520830312819, 4565.429321334833, 4579.244424669925, 4585.679002469828, 4386.846460373888, 4575.839845605405, 4576.748278844662, 4578.748168850712, 4579.038401935598, 4399.758013309267, 4454.242778727624, 4541.613962813149, 4548.090381923612, 4552.226121559343, 4488.955110448886, 4508.909821803579, 4521.547845215452, 4525.660575456854, 4539.75031373276, 4009.4186342980106, 4020.6984476164403, 4022.034711669208, 4027.7180597358197, 4028.0332720146953, 5457.399686034533, 5555.916661250085, 5556.888862222733, 5561.304836895388, 5568.0, 5289.153735402318, 5292.523672869422, 5302.628815982883, 5305.283786688825, 5308.309919710451, 6190.659513726743, 6194.4115309045565, 6204.410580994799, 6205.782797602107, 6210.254769427653, 4448.377227188196, 4449.844255451076, 4451.332300154971, 4458.1306645204195, 4470.642348612103, 6325.430711236011, 6481.351864813528, 6494.285628580852, 6501.187351581005, 6503.447206987365, 4555.134524440346, 4558.726476411426, 4560.361549383089, 4574.4510658721165, 4577.977110114494, 4631.768411579407, 4636.907261854744, 4637.6289896808175, 4638.304254361873, 4641.6054635355695, 5277.20841873722, 5280.815171469057, 5281.867953301121, 5284.762185701653, 5285.207218917117, 6057.727402266909, 6207.906881396782, 6264.404881536247, 6267.341929097471, 6288.213973253343, 1572.1981789287545, 1575.1572908493902, 1575.527341797456, 1576.7398379267293, 1578.27399396279, 1066.5360568152878, 1079.6221322537049, 1081.9729506762394, 1097.9286346387619, 1102.1183053557122, 5830.533557315404, 5834.591578589458, 5837.036888913367, 5842.2405087338375, 5844.853878653068, 6424.839379015469, 6427.485801135898, 6427.678616069178, 6429.067785171217, 6440.871182576322, 5660.433956604306, 5787.189793428924, 5789.160571717078, 5901.380355062743, 5911.852203694942, 3484.6689564491335, 3499.5100685903994, 3507.035565219534, 3507.263474670297, 3511.719062474996, 6415.13395691585, 6492.740290388331, 6584.078229047937, 6584.242812076673, 6585.1439312889015, 6580.309067547934, 6659.800205993828, 6663.233728121231, 6668.333166683293, 6694.631795251308, 6581.0, 6585.275619681831, 6586.209654841449, 6592.604443733488, 6593.3736295051895, 6338.524610654127, 6424.518161138027, 6471.7734879279, 6474.352564743488, 6487.610743355413, 6389.105525226565, 6396.264429590657, 6398.072279519537, 6402.90395644075, 6410.871782564229, 6583.177102862142, 6589.209294884645, 6592.17597800275, 6592.76925307612, 6594.274629790623, 4509.706869053501, 4510.143072816154, 4513.277875539898, 4516.525764794649, 4517.299818528133, 6456.418922297016, 6463.224413070461, 6464.5798023128345, 6468.6442245676935, 6470.967645161744, 6286.339934306832, 6287.2140982377205, 6299.370062993848, 6300.117983482408, 6300.936990630035, 6156.199694039746, 6236.688165591793, 6267.529935254783, 6276.905846412399, 6280.403361680633, 6146.938530614637, 6149.108379284889, 6152.077188421773, 6153.446189842935, 6156.538259630456, 6289.276733175743, 6292.622442653455, 6295.244570651368, 6299.811005669837, 6311.747530098928, 6030.969845150747, 6108.389161083856, 6111.144439778345, 6162.291336496181, 6166.1983942087245], "unit": "score", "name": "prototype.html", "value": 4734.035027411761}, {"lowerIsBetter": false, "replicates": [745.262190431473, 773.7059917231452, 869.3436455476118, 882.3602887906267, 889.3729920406114, 13636.318184090793, 13744.93127534361, 13870.722585548283, 13872.930635346835, 13879.097858639181, 13165.341732913364, 13272.668183295422, 13275.734485310311, 13276.137051091697, 13277.0, 678.5691086160274, 696.4602433114326, 819.3486178488116, 834.7829564313262, 847.2120927537388, 840.5503055865113, 844.472204871955, 851.5444237333028, 851.8594431918757, 852.799592095857, 885.5041176940902, 893.9061398553156, 894.150556970877, 894.8478758611052, 895.0914821456228, 714.9106361704787, 735.8675438421109, 874.4228808986039, 887.525174031893, 887.8313120507083, 654.3750718064238, 655.0469067506766, 655.3741177175785, 655.4494224851148, 655.9147310849606, 12291.323977181251, 12355.505779768799, 12383.133180677356, 12395.070369722216, 12395.814062789066, 11264.267822591506, 12219.633410997685, 12557.93721031389, 12655.93672031634, 13006.804897926539, 9950.701478955643, 10186.643467478676, 10611.575536978511, 10800.351978881292, 10811.135109191246, 3625.1843335249623, 3688.5020522229424, 3722.2927643747603, 3820.1022759651737, 3824.9808750956345, 44676.106477870584, 45113.54886451159, 45504.77247613774, 45663.54336456626, 45851.54148458506, 9604.183644390165, 9636.084571965652, 9667.806643867083, 9677.935427103013, 9882.357646752938, 16638.3344666212, 16817.243224054946, 17148.142592870558, 17151.74272385915, 17263.913680431517, 7852.646630901623, 7954.0, 8007.399445041645, 8036.316913062338, 8144.429889907649, 4399.12017596482, 4434.600885920283, 4516.299973504112, 4556.886077848014, 4648.535146485325, 3151.4800057990633, 3183.920401989969, 3189.9840500797814, 3191.505316675919, 3194.488881778904, 551.1512271102538, 551.4154995704566, 559.9244102046254, 562.9099344104924, 587.4712758517284, 601.0833478944644, 628.9654069026247, 641.7336805225872, 670.3798985937988, 708.8936659501013, 8250.339972802161, 8256.876146857801, 8504.192101750325, 8579.871301930476, 8715.259202967693, 645.5997281685385, 646.9870602587922, 660.1681880830189, 662.622305285992, 666.5700623098074, 3608.7654302470783, 3947.407888816643, 3960.366341385422, 3961.1087505311652, 4193.391958166048, 52160.21759673608, 52718.209226861625, 52902.470975290526, 53065.469345306825, 53153.73423132937, 49425.75287123541, 49462.50537494651, 53710.46289537055, 54297.0, 55037.0, 44811.55188448139, 45105.0, 45213.54786452094, 45252.3212151818, 46447.0, 8473.872891906503, 8705.303575714055, 8777.868331975153, 8925.241354484942, 8954.776130596787, 34217.486737698455, 34374.312513749086, 35118.473222901164, 35921.0, 35938.10154746152, 42320.365194522725, 42331.576684232765, 43555.782221088695, 43804.12391752083, 44498.3325250115, 11070.723231919266, 11141.665750027512, 11173.162012849232, 11539.423028848356, 11546.781098727519, 12134.939325303318, 12411.317377544321, 12432.564860229848, 12513.186642868184, 12660.303683297507, 11645.475953582278, 11648.184627076023, 11988.940055299669, 12051.0, 12337.814932775836, 11163.0, 11369.147313951322, 11511.827322590336, 11716.648500544998, 11826.408679566159, 10679.679609611723, 10707.946460267649, 10732.248742587944, 10828.350298982086, 11083.399840382823, 9885.406875587487, 9928.25538084661, 10177.796444071226, 10197.694069177936, 10559.947200263949, 8905.599248033725, 8974.14745599167, 9237.07629237071, 9566.091221333962, 9589.280803939871], "unit": "score", "name": "yui.html", "value": 6314.933675408897}], "name": "dromaeo_css", "value": 6881.987910333992}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 104.0, 111.0, 110.0, 110.0, 99.0, 112.0, 109.0, 116.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [150.0, 126.0, 155.0, 165.0, 126.0, 146.0, 151.0, 125.0, 161.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 162.0, 160.0, 162.0, 162.0, 164.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 78.0, 92.0, 71.0, 78.0, 72.0, 107.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 136.0, 93.0, 93.0, 94.0, 140.0, 95.0, 94.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 58.0, 56.0, 58.0, 56.0, 58.0, 65.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 93.0, 87.0, 94.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [125.0, 116.0, 119.0, 115.0, 120.0, 118.0, 132.0, 123.0, 124.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [149.0, 154.0, 152.0, 151.0, 144.0, 142.0, 153.0, 170.0, 150.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.7}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 68.0, 69.0, 68.0, 66.0, 68.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1504.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.02856188408217], "unit": "score", "name": "Richards", "value": 211.35307400000002}, {"lowerIsBetter": false, "replicates": [189.0359168241966], "unit": "score", "name": "DeltaBlue", "value": 349.7642200000001}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [1088.139281828074], "unit": "score", "name": "RayTrace", "value": 680.0498910000001}, {"lowerIsBetter": false, "replicates": [777.6049766718507], "unit": "score", "name": "Earley", "value": 857.0714179999998}, {"lowerIsBetter": false, "replicates": [11802.32558139535], "unit": "score", "name": "Boyer", "value": 56.46878620689652}, {"lowerIsBetter": false, "replicates": [25974.358974358973], "unit": "score", "name": "RegExp", "value": 35.072472852912156}, {"lowerIsBetter": false, "replicates": [657.328990228013], "unit": "score", "name": "Splay", "value": 123.97292864222}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 20980.268655054064}]} 04:16:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20980.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1504.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6881.99"}}} 04:16:43 INFO - Return code: 0 04:16:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:16:43 INFO - # TBPL SUCCESS # 04:16:43 INFO - Running post-action listener: _resource_record_post_action 04:16:43 INFO - Running post-run listener: _resource_record_post_run 04:16:44 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 546791424; Read time: 188; Write time: 513916 04:16:44 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235077632; Read time: 0; Write time: 303192 04:16:44 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311713792; Read time: 188; Write time: 210724 04:16:44 INFO - Running post-run listener: _upload_blobber_files 04:16:44 INFO - Blob upload gear active. 04:16:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:16:44 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 04:16:44 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'] 04:16:44 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 04:16:45 INFO - (blobuploader) - INFO - Open directory for files ... 04:16:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 04:16:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:16:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:46 INFO - (blobuploader) - INFO - Done attempting. 04:16:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:16:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:16:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:47 INFO - (blobuploader) - INFO - Done attempting. 04:16:47 INFO - (blobuploader) - INFO - Iteration through files over. 04:16:47 INFO - Return code: 0 04:16:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:16:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:16:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e061ffdeb596270473934b42de3c36bee3aad6141c214c92d24e6d51110eb43ee2ffb6d98cbff9c374d27b39e6e491632366e5a4f41e4c1f5444e6ddce9ab1e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9523f3b031c34c37c29900537e333c06040e2fe2ac2b8d40f1191ad2e9273b39d48b3235987c78cf19862b1a6f4822a542fd8746f1cb452761b1824655ab58e8"} 04:16:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:16:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:16:47 INFO - Contents: 04:16:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e061ffdeb596270473934b42de3c36bee3aad6141c214c92d24e6d51110eb43ee2ffb6d98cbff9c374d27b39e6e491632366e5a4f41e4c1f5444e6ddce9ab1e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9523f3b031c34c37c29900537e333c06040e2fe2ac2b8d40f1191ad2e9273b39d48b3235987c78cf19862b1a6f4822a542fd8746f1cb452761b1824655ab58e8"} 04:16:47 INFO - Copying logs to upload dir... 04:16:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1280.675883 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-22 04:16:46.481172) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 04:16:46.484418) ========= 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=a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e061ffdeb596270473934b42de3c36bee3aad6141c214c92d24e6d51110eb43ee2ffb6d98cbff9c374d27b39e6e491632366e5a4f41e4c1f5444e6ddce9ab1e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9523f3b031c34c37c29900537e333c06040e2fe2ac2b8d40f1191ad2e9273b39d48b3235987c78cf19862b1a6f4822a542fd8746f1cb452761b1824655ab58e8"} build_url:https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e061ffdeb596270473934b42de3c36bee3aad6141c214c92d24e6d51110eb43ee2ffb6d98cbff9c374d27b39e6e491632366e5a4f41e4c1f5444e6ddce9ab1e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9523f3b031c34c37c29900537e333c06040e2fe2ac2b8d40f1191ad2e9273b39d48b3235987c78cf19862b1a6f4822a542fd8746f1cb452761b1824655ab58e8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 04:16:46.508961) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:16:46.509291) ========= 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=a65b340e283ce644d68cb24e000001c9-1450782124.649506-2063850210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:16:46.591344) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 04:16:46.591653) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 04:16:46.591996) ========= ========= Total master_lag: 0.27 =========