builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1450785328.99 results: success (0) buildid: 20151222013009 builduid: 912c5f9f634e4a77b8495a9689905c95 revision: 61e79fef8e0c44d06b0e9e377ec19602bd269f2c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:28.990972) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:28.991666) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:28.992195) ========= 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=70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006359 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:29.020259) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:29.020630) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:29.034512) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:29.034828) ========= 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=70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:29.084363) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:29.084691) ========= 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:29.085110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:29.085466) ========= 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=70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 03:55:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2015-12-22 03:55:29 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159427 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:29.258271) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:29.258663) ========= 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=70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017866 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:29.308644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:29.309096) ========= 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=70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 03:55:29,730 truncating revision to first 12 chars 2015-12-22 03:55:29,730 Setting DEBUG logging. 2015-12-22 03:55:29,730 attempt 1/10 2015-12-22 03:55:29,730 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:30,011 unpacking tar archive at: mozilla-inbound-61e79fef8e0c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565136 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:29.888922) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:29.889405) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:29.898156) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 03:55:29.898469) ========= 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:29.898958) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-22 03:55:29.899384) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:55:30 INFO - MultiFileLogger online at 20151222 03:55:30 in /builds/slave/test-pgo 03:55:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:55:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:55:30 INFO - {'append_to_log': False, 03:55:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:55:30 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:55:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:55:30 INFO - 'branch': 'Mozilla-Inbound', 03:55:30 INFO - 'buildbot_json_path': 'buildprops.json', 03:55:30 INFO - 'config_files': ('talos/linux_config.py',), 03:55:30 INFO - 'default_actions': ('clobber', 03:55:30 INFO - 'read-buildbot-config', 03:55:30 INFO - 'download-and-extract', 03:55:30 INFO - 'populate-webroot', 03:55:30 INFO - 'create-virtualenv', 03:55:30 INFO - 'install', 03:55:30 INFO - 'run-tests'), 03:55:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:55:30 INFO - 'download_minidump_stackwalk': True, 03:55:30 INFO - 'download_symbols': 'ondemand', 03:55:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:55:30 INFO - 'tooltool.py': '/tools/tooltool.py', 03:55:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:55:30 INFO - '/tools/misc-python/virtualenv.py')}, 03:55:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:55:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:55:30 INFO - 'installer_path': 'installer.exe', 03:55:30 INFO - 'log_level': 'info', 03:55:30 INFO - 'log_name': 'talos', 03:55:30 INFO - 'log_to_console': True, 03:55:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:55:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:55:30 INFO - 'opt_config_files': (), 03:55:30 INFO - 'pip_index': False, 03:55:30 INFO - 'sps_profile': False, 03:55:30 INFO - 'sps_profile_interval': 0, 03:55:30 INFO - 'suite': 'dromaeojs-e10s', 03:55:30 INFO - 'system_bits': '64', 03:55:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:55:30 INFO - 'title': 'talos-linux64-ix-015', 03:55:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:55:30 INFO - 'use_talos_json': True, 03:55:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:55:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:55:30 INFO - 'work_dir': 'build'} 03:55:30 INFO - ##### 03:55:30 INFO - ##### Running clobber step. 03:55:30 INFO - ##### 03:55:30 INFO - Running pre-action listener: _resource_record_pre_action 03:55:30 INFO - Running main action method: clobber 03:55:30 INFO - rmtree: /builds/slave/test-pgo/build 03:55:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:55:30 INFO - Running post-action listener: _resource_record_post_action 03:55:30 INFO - ##### 03:55:30 INFO - ##### Running read-buildbot-config step. 03:55:30 INFO - ##### 03:55:30 INFO - Running pre-action listener: _resource_record_pre_action 03:55:30 INFO - Running main action method: read_buildbot_config 03:55:30 INFO - Using buildbot properties: 03:55:30 INFO - { 03:55:30 INFO - "project": "", 03:55:30 INFO - "product": "firefox", 03:55:30 INFO - "script_repo_revision": "production", 03:55:30 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 03:55:30 INFO - "repository": "", 03:55:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 03:55:30 INFO - "buildid": "20151222013009", 03:55:30 INFO - "pgo_build": "True", 03:55:30 INFO - "basedir": "/builds/slave/test-pgo", 03:55:30 INFO - "buildnumber": 262, 03:55:30 INFO - "slavename": "talos-linux64-ix-015", 03:55:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:55:30 INFO - "platform": "ubuntu64_hw", 03:55:30 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:55:30 INFO - "branch": "mozilla-inbound", 03:55:30 INFO - "repo_path": "integration/mozilla-inbound", 03:55:30 INFO - "revision": "61e79fef8e0c44d06b0e9e377ec19602bd269f2c", 03:55:30 INFO - "stage_platform": "linux64-pgo", 03:55:30 INFO - "builduid": "912c5f9f634e4a77b8495a9689905c95", 03:55:30 INFO - "slavebuilddir": "test" 03:55:30 INFO - } 03:55:30 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:30 INFO - Running post-action listener: _resource_record_post_action 03:55:30 INFO - ##### 03:55:30 INFO - ##### Running download-and-extract step. 03:55:30 INFO - ##### 03:55:30 INFO - Running pre-action listener: _resource_record_pre_action 03:55:30 INFO - Running main action method: download_and_extract 03:55:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:55: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:55:30 INFO - https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:55:30 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:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/test_packages.json 03:55:30 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:30 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:37 INFO - Downloaded 1302 bytes. 03:55:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:55:37 INFO - Using the following test package requirements: 03:55:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:55:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:55:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:37 INFO - u'jsshell-linux-x86_64.zip'], 03:55:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:55:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:55:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:55:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:55:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:55:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:55:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:55:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:55:37 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:37 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:37 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:37 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:37 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:50 INFO - Downloaded 23174991 bytes. 03:55:50 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:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:55:50 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:51 INFO - Return code: 0 03:55:51 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:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:55:51 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:51 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:51 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:51 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:51 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:52 INFO - Downloaded 23174991 bytes. 03:55:52 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:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:55:52 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:53 INFO - Return code: 0 03:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:55:53 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:53 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:53 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:53 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:53 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:54 INFO - Downloaded 11132277 bytes. 03:55:54 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:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:55:54 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:54 INFO - Return code: 0 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 - 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:54 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:54 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:54 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:54 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:55 INFO - Downloaded 54913961 bytes. 03:55:55 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:55 INFO - mkdir: /builds/slave/test-pgo/properties 03:55:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:55:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:55:55 INFO - Contents: 03:55:55 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:55 INFO - Running post-action listener: _resource_record_post_action 03:55:55 INFO - Running post-action listener: set_extra_try_arguments 03:55:55 INFO - ##### 03:55:55 INFO - ##### Running populate-webroot step. 03:55:55 INFO - ##### 03:55:55 INFO - Running pre-action listener: _resource_record_pre_action 03:55:55 INFO - Running main action method: populate_webroot 03:55:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:55:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:55:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:55:55 INFO - '--tppagecycles', 03:55:55 INFO - '7'], 03:55:55 INFO - 'tests': ['tsvgm']}}, 03:55:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:55:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:55:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:55:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:55:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:55:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:55:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:55 INFO - 'talos_options': ['--e10s'], 03:55:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:55 INFO - 'tests': ['damp', 'tps']}, 03:55:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:55 INFO - 'talos_options': ['--e10s'], 03:55:55 INFO - 'tests': ['damp', 'tps']}, 03:55:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:55:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:55:55 INFO - 'other': {'tests': ['a11yr', 03:55:55 INFO - 'ts_paint', 03:55:55 INFO - 'tpaint', 03:55:55 INFO - 'sessionrestore', 03:55:55 INFO - 'sessionrestore_no_auto_restore']}, 03:55:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:55:55 INFO - 'tests': ['a11yr', 03:55:55 INFO - 'ts_paint', 03:55:55 INFO - 'tpaint', 03:55:55 INFO - 'sessionrestore', 03:55:55 INFO - 'sessionrestore_no_auto_restore']}, 03:55:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:55:55 INFO - 'tests': ['a11yr', 03:55:55 INFO - 'ts_paint', 03:55:55 INFO - 'tpaint', 03:55:55 INFO - 'sessionrestore', 03:55:55 INFO - 'sessionrestore_no_auto_restore']}, 03:55:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:55:55 INFO - 'tests': ['a11yr', 03:55:55 INFO - 'ts_paint', 03:55:55 INFO - 'tpaint', 03:55:55 INFO - 'sessionrestore', 03:55:55 INFO - 'sessionrestore_no_auto_restore']}, 03:55:55 INFO - 'other_l64': {'tests': ['a11yr', 03:55:55 INFO - 'ts_paint', 03:55:55 INFO - 'tpaint', 03:55:55 INFO - 'sessionrestore', 03:55:55 INFO - 'sessionrestore_no_auto_restore']}, 03:55:55 INFO - 'other_nol64': {'tests': ['a11yr', 03:55:55 INFO - 'ts_paint', 03:55:55 INFO - 'tpaint', 03:55:55 INFO - 'sessionrestore', 03:55:55 INFO - 'sessionrestore_no_auto_restore']}, 03:55:55 INFO - 'svgr': {'tests': ['tsvgx', 03:55:55 INFO - 'tsvgr_opacity', 03:55:55 INFO - 'tart', 03:55:55 INFO - 'tscrollx', 03:55:55 INFO - 'cart']}, 03:55:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:55:55 INFO - 'tests': ['tsvgx', 03:55:55 INFO - 'tsvgr_opacity', 03:55:55 INFO - 'tart', 03:55:55 INFO - 'tscrollx', 03:55:55 INFO - 'cart']}, 03:55:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:55 INFO - 'tests': ['tp5o']}, 03:55:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:55 INFO - 'talos_options': ['--e10s'], 03:55:55 INFO - 'tests': ['tp5o']}, 03:55:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:55 INFO - 'talos_options': ['--xperf_path', 03:55:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:55 INFO - 'tests': ['tp5n']}, 03:55:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:55 INFO - 'talos_options': ['--e10s', 03:55:55 INFO - '--xperf_path', 03:55:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:55 INFO - 'tests': ['tp5n']}}, 03:55:55 INFO - 'talos.zip': {'path': '', 03:55:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:55:55 INFO - Running post-action listener: _resource_record_post_action 03:55:55 INFO - ##### 03:55:55 INFO - ##### Running create-virtualenv step. 03:55:55 INFO - ##### 03:55:55 INFO - Running pre-action listener: _resource_record_pre_action 03:55:55 INFO - Running main action method: create_virtualenv 03:55:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:55:55 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:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:55:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:55:56 INFO - Using real prefix '/usr' 03:55:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:55:56 INFO - Installing distribute.............................................................................................................................................................................................done. 03:55:58 INFO - Installing pip.................done. 03:55:58 INFO - Return code: 0 03:55:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f66e23bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb9540>, '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 0xeba440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeba8f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', '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:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:55:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:55:58 INFO - Using env: {'DISPLAY': ':0', 03:55:58 INFO - 'HOME': '/home/cltbld', 03:55:58 INFO - 'LANG': 'en_US.UTF-8', 03:55:58 INFO - 'LANGUAGE': 'en_US:en', 03:55:58 INFO - 'LOGNAME': 'cltbld', 03:55:58 INFO - 'MAIL': '/var/mail/cltbld', 03:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:58 INFO - 'MOZ_NO_REMOTE': '1', 03:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:58 INFO - 'NO_EM_RESTART': '1', 03:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:55:58 INFO - 'PWD': '/builds/slave/test-pgo', 03:55:58 INFO - 'SHELL': '/bin/bash', 03:55:58 INFO - 'SHLVL': '1', 03:55:58 INFO - 'TERM': 'linux', 03:55:58 INFO - 'TMOUT': '86400', 03:55:58 INFO - 'USER': 'cltbld', 03:55:58 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', 03:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:58 INFO - '_': '/tools/buildbot/bin/python'} 03:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:55:58 INFO - Cleaning up... 03:55:58 INFO - Return code: 0 03:55:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f66e23bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb9540>, '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 0xeba440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeba8f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', '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:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:55:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:55:58 INFO - Using env: {'DISPLAY': ':0', 03:55:58 INFO - 'HOME': '/home/cltbld', 03:55:58 INFO - 'LANG': 'en_US.UTF-8', 03:55:58 INFO - 'LANGUAGE': 'en_US:en', 03:55:58 INFO - 'LOGNAME': 'cltbld', 03:55:58 INFO - 'MAIL': '/var/mail/cltbld', 03:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:58 INFO - 'MOZ_NO_REMOTE': '1', 03:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:58 INFO - 'NO_EM_RESTART': '1', 03:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:55:58 INFO - 'PWD': '/builds/slave/test-pgo', 03:55:58 INFO - 'SHELL': '/bin/bash', 03:55:58 INFO - 'SHLVL': '1', 03:55:58 INFO - 'TERM': 'linux', 03:55:58 INFO - 'TMOUT': '86400', 03:55:58 INFO - 'USER': 'cltbld', 03:55:58 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', 03:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:58 INFO - '_': '/tools/buildbot/bin/python'} 03:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:58 INFO - Downloading/unpacking psutil>=0.7.1 03:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:56:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:56:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:56:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:00 INFO - Installing collected packages: psutil 03:56:00 INFO - Running setup.py install for psutil 03:56:00 INFO - building 'psutil._psutil_linux' extension 03:56:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:56:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:56:01 INFO - building 'psutil._psutil_posix' extension 03:56:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:56:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:56:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:01 INFO - Successfully installed psutil 03:56:01 INFO - Cleaning up... 03:56:01 INFO - Return code: 0 03:56:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f66e23bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb9540>, '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 0xeba440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeba8f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', '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:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:56:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:56:01 INFO - Using env: {'DISPLAY': ':0', 03:56:01 INFO - 'HOME': '/home/cltbld', 03:56:01 INFO - 'LANG': 'en_US.UTF-8', 03:56:01 INFO - 'LANGUAGE': 'en_US:en', 03:56:01 INFO - 'LOGNAME': 'cltbld', 03:56:01 INFO - 'MAIL': '/var/mail/cltbld', 03:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:01 INFO - 'MOZ_NO_REMOTE': '1', 03:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:01 INFO - 'NO_EM_RESTART': '1', 03:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:01 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:01 INFO - 'SHELL': '/bin/bash', 03:56:01 INFO - 'SHLVL': '1', 03:56:01 INFO - 'TERM': 'linux', 03:56:01 INFO - 'TMOUT': '86400', 03:56:01 INFO - 'USER': 'cltbld', 03:56:01 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', 03:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:01 INFO - '_': '/tools/buildbot/bin/python'} 03:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 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:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:56:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:56:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:56:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:56:03 INFO - Installing collected packages: mozsystemmonitor 03:56:03 INFO - Running setup.py install for mozsystemmonitor 03:56:03 INFO - Successfully installed mozsystemmonitor 03:56:03 INFO - Cleaning up... 03:56:03 INFO - Return code: 0 03:56:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f66e23bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb9540>, '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 0xeba440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeba8f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', '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:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:56:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:56:03 INFO - Using env: {'DISPLAY': ':0', 03:56:03 INFO - 'HOME': '/home/cltbld', 03:56:03 INFO - 'LANG': 'en_US.UTF-8', 03:56:03 INFO - 'LANGUAGE': 'en_US:en', 03:56:03 INFO - 'LOGNAME': 'cltbld', 03:56:03 INFO - 'MAIL': '/var/mail/cltbld', 03:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:03 INFO - 'MOZ_NO_REMOTE': '1', 03:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:03 INFO - 'NO_EM_RESTART': '1', 03:56:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:03 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:03 INFO - 'SHELL': '/bin/bash', 03:56:03 INFO - 'SHLVL': '1', 03:56:03 INFO - 'TERM': 'linux', 03:56:03 INFO - 'TMOUT': '86400', 03:56:03 INFO - 'USER': 'cltbld', 03:56:03 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', 03:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:03 INFO - '_': '/tools/buildbot/bin/python'} 03:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:56:05 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:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:56:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:05 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:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:56:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:06 INFO - Downloading docopt-0.6.1.tar.gz 03:56:06 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:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:56:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:56:06 INFO - Running setup.py install for blobuploader 03:56:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:56:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:56:06 INFO - Running setup.py install for requests 03:56:06 INFO - Running setup.py install for docopt 03:56:06 INFO - Successfully installed blobuploader requests docopt 03:56:06 INFO - Cleaning up... 03:56:06 INFO - Return code: 0 03:56:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f66e23bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb9540>, '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 0xeba440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeba8f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', '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:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:56:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:56:06 INFO - Using env: {'DISPLAY': ':0', 03:56:06 INFO - 'HOME': '/home/cltbld', 03:56:06 INFO - 'LANG': 'en_US.UTF-8', 03:56:06 INFO - 'LANGUAGE': 'en_US:en', 03:56:06 INFO - 'LOGNAME': 'cltbld', 03:56:06 INFO - 'MAIL': '/var/mail/cltbld', 03:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:06 INFO - 'MOZ_NO_REMOTE': '1', 03:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:06 INFO - 'NO_EM_RESTART': '1', 03:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:06 INFO - 'SHELL': '/bin/bash', 03:56:06 INFO - 'SHLVL': '1', 03:56:06 INFO - 'TERM': 'linux', 03:56:06 INFO - 'TMOUT': '86400', 03:56:06 INFO - 'USER': 'cltbld', 03:56:06 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', 03:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:06 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-2qnj4v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:56:07 INFO - Running setup.py (path:/tmp/pip-YtcHhh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:56:07 INFO - Running setup.py (path:/tmp/pip-tBvYkS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:56:07 INFO - Running setup.py (path:/tmp/pip-SgT9SX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:56:07 INFO - Running setup.py (path:/tmp/pip-eUFNAl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:56:07 INFO - Running setup.py (path:/tmp/pip-y2jRhi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:56:07 INFO - Running setup.py (path:/tmp/pip-JKO1I9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:56:07 INFO - Running setup.py (path:/tmp/pip-dcXy5M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:56:07 INFO - Running setup.py (path:/tmp/pip-QoKd_C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:56:07 INFO - Running setup.py (path:/tmp/pip-6Cf6bK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:56:07 INFO - Running setup.py (path:/tmp/pip-18sLyj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:56:07 INFO - Running setup.py (path:/tmp/pip-xBTICb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:56:07 INFO - Running setup.py (path:/tmp/pip-9gzM5Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:56:07 INFO - Running setup.py (path:/tmp/pip-vLqQDr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:56:07 INFO - Running setup.py (path:/tmp/pip-FEW9y9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:56:08 INFO - Running setup.py (path:/tmp/pip-q2Dw45-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:56:08 INFO - Running setup.py (path:/tmp/pip-MnDwhN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:56:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:56:08 INFO - Running setup.py install for manifestparser 03:56:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:56:08 INFO - Running setup.py install for mozcrash 03:56:08 INFO - Running setup.py install for mozdebug 03:56:08 INFO - Running setup.py install for mozdevice 03:56:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:56:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:56:08 INFO - Running setup.py install for mozfile 03:56:08 INFO - Running setup.py install for mozhttpd 03:56:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:56:08 INFO - Running setup.py install for mozinfo 03:56:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:56:08 INFO - Running setup.py install for mozInstall 03:56:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:56:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:56:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:56:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:56:08 INFO - Running setup.py install for mozleak 03:56:09 INFO - Running setup.py install for mozlog 03:56:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:56:09 INFO - Running setup.py install for moznetwork 03:56:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:56:09 INFO - Running setup.py install for mozprocess 03:56:09 INFO - Running setup.py install for mozprofile 03:56:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:56:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:56:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:56:09 INFO - Running setup.py install for mozrunner 03:56:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:56:09 INFO - Running setup.py install for mozscreenshot 03:56:09 INFO - Running setup.py install for moztest 03:56:09 INFO - Running setup.py install for mozversion 03:56:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:56:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:56:09 INFO - Cleaning up... 03:56:09 INFO - Return code: 0 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/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 0x7f66e23bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb9540>, '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 0xeba440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeba8f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', '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/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:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 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': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', 03:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:09 INFO - '_': '/tools/buildbot/bin/python'} 03:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:56:10 INFO - Running setup.py (path:/tmp/pip-3ViXTu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:56:10 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:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:56:10 INFO - Running setup.py (path:/tmp/pip-VgQZfB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:56:10 INFO - Running setup.py (path:/tmp/pip-TRwcXH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:56:10 INFO - Running setup.py (path:/tmp/pip-y4c4Rz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:56:10 INFO - Running setup.py (path:/tmp/pip-VoknAC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 03:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:56:10 INFO - Running setup.py (path:/tmp/pip-N91TqI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 03:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:56:10 INFO - Running setup.py (path:/tmp/pip-Z3HhcI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 03:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:56:10 INFO - Running setup.py (path:/tmp/pip-R01Q2J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:56:10 INFO - Running setup.py (path:/tmp/pip-oJVCSq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:56:10 INFO - Running setup.py (path:/tmp/pip-3M_k_2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:56:10 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:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:56:10 INFO - Running setup.py (path:/tmp/pip-nxuZKI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:56:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:56:10 INFO - Running setup.py (path:/tmp/pip-PksmC_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:56:11 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:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:56:11 INFO - Running setup.py (path:/tmp/pip-cios1_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:56:11 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:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:56:11 INFO - Running setup.py (path:/tmp/pip-KSVoWn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:56:11 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:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:56:11 INFO - Running setup.py (path:/tmp/pip-exo7pa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 03:56:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:56:11 INFO - Running setup.py (path:/tmp/pip-H6CtiB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 03:56:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:56:11 INFO - Running setup.py (path:/tmp/pip-TVZbGf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 03:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:56:11 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: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:13 INFO - Downloading blessings-1.5.1.tar.gz 03:56:13 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:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:56:13 INFO - Installing collected packages: blessings 03:56:13 INFO - Running setup.py install for blessings 03:56:13 INFO - Successfully installed blessings 03:56:13 INFO - Cleaning up... 03:56:13 INFO - Return code: 0 03:56:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:56:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:56:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:56:13 INFO - Reading from file tmpfile_stdout 03:56:13 INFO - Current package versions: 03:56:13 INFO - argparse == 1.2.1 03:56:13 INFO - blessings == 1.5.1 03:56:13 INFO - blobuploader == 1.2.4 03:56:13 INFO - docopt == 0.6.1 03:56:13 INFO - manifestparser == 1.1 03:56:13 INFO - mozInstall == 1.12 03:56:13 INFO - mozcrash == 0.16 03:56:13 INFO - mozdebug == 0.1 03:56:13 INFO - mozdevice == 0.47 03:56:13 INFO - mozfile == 1.2 03:56:13 INFO - mozhttpd == 0.7 03:56:13 INFO - mozinfo == 0.9 03:56:13 INFO - mozleak == 0.1 03:56:13 INFO - mozlog == 3.1 03:56:13 INFO - moznetwork == 0.27 03:56:13 INFO - mozprocess == 0.22 03:56:13 INFO - mozprofile == 0.28 03:56:13 INFO - mozrunner == 6.11 03:56:13 INFO - mozscreenshot == 0.1 03:56:13 INFO - mozsystemmonitor == 0.0 03:56:13 INFO - moztest == 0.7 03:56:13 INFO - mozversion == 1.4 03:56:13 INFO - psutil == 3.1.1 03:56:13 INFO - requests == 1.2.3 03:56:13 INFO - wsgiref == 0.1.2 03:56:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f66e23bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb9540>, '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 0xeba440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeba8f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', '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:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 03:56:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:56:13 INFO - Using env: {'DISPLAY': ':0', 03:56:13 INFO - 'HOME': '/home/cltbld', 03:56:13 INFO - 'LANG': 'en_US.UTF-8', 03:56:13 INFO - 'LANGUAGE': 'en_US:en', 03:56:13 INFO - 'LOGNAME': 'cltbld', 03:56:13 INFO - 'MAIL': '/var/mail/cltbld', 03:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:13 INFO - 'MOZ_NO_REMOTE': '1', 03:56:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:13 INFO - 'NO_EM_RESTART': '1', 03:56:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:13 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:13 INFO - 'SHELL': '/bin/bash', 03:56:13 INFO - 'SHLVL': '1', 03:56:13 INFO - 'TERM': 'linux', 03:56:13 INFO - 'TMOUT': '86400', 03:56:13 INFO - 'USER': 'cltbld', 03:56:13 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', 03:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:13 INFO - '_': '/tools/buildbot/bin/python'} 03:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:13 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:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 03:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:56:13 INFO - Cleaning up... 03:56:13 INFO - Return code: 0 03:56:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f66e23bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb9540>, '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 0xeba440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeba8f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', '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:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 03:56:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:56:13 INFO - Using env: {'DISPLAY': ':0', 03:56:13 INFO - 'HOME': '/home/cltbld', 03:56:13 INFO - 'LANG': 'en_US.UTF-8', 03:56:13 INFO - 'LANGUAGE': 'en_US:en', 03:56:13 INFO - 'LOGNAME': 'cltbld', 03:56:13 INFO - 'MAIL': '/var/mail/cltbld', 03:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:13 INFO - 'MOZ_NO_REMOTE': '1', 03:56:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:13 INFO - 'NO_EM_RESTART': '1', 03:56:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:13 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:13 INFO - 'SHELL': '/bin/bash', 03:56:13 INFO - 'SHLVL': '1', 03:56:13 INFO - 'TERM': 'linux', 03:56:13 INFO - 'TMOUT': '86400', 03:56:13 INFO - 'USER': 'cltbld', 03:56:13 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', 03:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:13 INFO - '_': '/tools/buildbot/bin/python'} 03:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:13 INFO - Downloading/unpacking jsonschema 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:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:56:15 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:15 INFO - Downloading/unpacking functools32 (from jsonschema) 03:56:15 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:15 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:15 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:15 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:15 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:15 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:15 INFO - Downloading functools32-3.2.3-2.tar.gz 03:56:15 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:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:56:15 INFO - warning: no files found matching '*.txt' 03:56:15 INFO - no previously-included directories found matching 'build' 03:56:15 INFO - no previously-included directories found matching 'dist' 03:56:15 INFO - no previously-included directories found matching '.git*' 03:56:15 INFO - Installing collected packages: jsonschema, functools32 03:56:15 INFO - Running setup.py install for functools32 03:56:15 INFO - warning: no files found matching '*.txt' 03:56:16 INFO - no previously-included directories found matching 'build' 03:56:16 INFO - no previously-included directories found matching 'dist' 03:56:16 INFO - no previously-included directories found matching '.git*' 03:56:16 INFO - Successfully installed jsonschema functools32 03:56:16 INFO - Cleaning up... 03:56:16 INFO - Return code: 0 03:56:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:56:16 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:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:16 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:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:16 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 0x7f66e23bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb9540>, '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 0xeba440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeba8f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', '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:16 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:16 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:16 INFO - Using env: {'DISPLAY': ':0', 03:56:16 INFO - 'HOME': '/home/cltbld', 03:56:16 INFO - 'LANG': 'en_US.UTF-8', 03:56:16 INFO - 'LANGUAGE': 'en_US:en', 03:56:16 INFO - 'LOGNAME': 'cltbld', 03:56:16 INFO - 'MAIL': '/var/mail/cltbld', 03:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:16 INFO - 'MOZ_NO_REMOTE': '1', 03:56:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:16 INFO - 'NO_EM_RESTART': '1', 03:56:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:16 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:16 INFO - 'SHELL': '/bin/bash', 03:56:16 INFO - 'SHLVL': '1', 03:56:16 INFO - 'TERM': 'linux', 03:56:16 INFO - 'TMOUT': '86400', 03:56:16 INFO - 'USER': 'cltbld', 03:56:16 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', 03:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:16 INFO - '_': '/tools/buildbot/bin/python'} 03:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:16 INFO - Downloading/unpacking flake8 03:56:16 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:16 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:16 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:16 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:16 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:16 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:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:56:17 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:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:56:18 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:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:56:18 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:18 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:18 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:18 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:18 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:18 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:18 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:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:56:18 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:18 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:18 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:18 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:18 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:18 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:18 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:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:56:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:56:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:56:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:56:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:56:18 INFO - no previously-included directories found matching 'docs/_build' 03:56:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:56:18 INFO - Running setup.py install for pep8 03:56:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:56:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:56:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:56:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:56:18 INFO - no previously-included directories found matching 'docs/_build' 03:56:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:56:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:56:18 INFO - Cleaning up... 03:56:18 INFO - Return code: 0 03:56:18 INFO - Running post-action listener: _resource_record_post_action 03:56:18 INFO - Running post-action listener: _start_resource_monitoring 03:56:18 INFO - Starting resource monitoring. 03:56:18 INFO - ##### 03:56:18 INFO - ##### Running install step. 03:56:18 INFO - ##### 03:56:18 INFO - Running pre-action listener: _resource_record_pre_action 03:56:18 INFO - Running main action method: install 03:56:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:56:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:56:19 INFO - Reading from file tmpfile_stdout 03:56:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:56:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:56:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:56:19 INFO - Reading from file tmpfile_stdout 03:56:19 INFO - Output received: 03:56:19 INFO - Usage: mozinstall [options] installer 03:56:19 INFO - Options: 03:56:19 INFO - -h, --help show this help message and exit 03:56:19 INFO - -d DEST, --destination=DEST 03:56:19 INFO - Directory to install application into. [default: 03:56:19 INFO - "/builds/slave/test-pgo"] 03:56:19 INFO - --app=APP Application being installed. [default: firefox] 03:56:19 INFO - mkdir: /builds/slave/test-pgo/build/application 03:56:19 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:19 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:34 INFO - Reading from file tmpfile_stdout 03:56:34 INFO - Output received: 03:56:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:56:34 INFO - Running post-action listener: _resource_record_post_action 03:56:34 INFO - ##### 03:56:34 INFO - ##### Running run-tests step. 03:56:34 INFO - ##### 03:56:34 INFO - Running pre-action listener: _resource_record_pre_action 03:56:34 INFO - Running main action method: run_tests 03:56:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:56:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:56:34 INFO - Python 2.7.3 03:56:34 INFO - Return code: 0 03:56:34 INFO - grabbing minidump binary from tooltool 03:56:34 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:34 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 0xeb9540>, '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 0xeba440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeba8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:56:34 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:34 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:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:56:35 INFO - Return code: 0 03:56:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:56:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:56:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:56:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:56:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:56:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:56:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:56:35 INFO - Return code: 0 03:56:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 03:56:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:56:35 INFO - Using env: {'DISPLAY': ':0', 03:56:35 INFO - 'HOME': '/home/cltbld', 03:56:35 INFO - 'LANG': 'en_US.UTF-8', 03:56:35 INFO - 'LANGUAGE': 'en_US:en', 03:56:35 INFO - 'LOGNAME': 'cltbld', 03:56:35 INFO - 'MAIL': '/var/mail/cltbld', 03:56:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:56:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:35 INFO - 'MOZ_NO_REMOTE': '1', 03:56:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:35 INFO - 'NO_EM_RESTART': '1', 03:56:35 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:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:35 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:56:35 INFO - 'SHELL': '/bin/bash', 03:56:35 INFO - 'SHLVL': '1', 03:56:35 INFO - 'TERM': 'linux', 03:56:35 INFO - 'TMOUT': '86400', 03:56:35 INFO - 'USER': 'cltbld', 03:56:35 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002', 03:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:35 INFO - '_': '/tools/buildbot/bin/python'} 03:56:35 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EUjaBJu3Q9-nlXGLBFWaeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:56:36 INFO - mozversion application_buildid: 20151222013009 03:56:36 INFO - mozversion application_changeset: 61e79fef8e0c44d06b0e9e377ec19602bd269f2c 03:56:36 INFO - mozversion application_display_name: Nightly 03:56:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:56:36 INFO - mozversion application_name: Firefox 03:56:36 INFO - mozversion application_remotingname: firefox 03:56:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:56:36 INFO - mozversion application_vendor: Mozilla 03:56:36 INFO - mozversion application_version: 46.0a1 03:56:36 INFO - mozversion platform_buildid: 20151222013009 03:56:36 INFO - mozversion platform_changeset: 61e79fef8e0c44d06b0e9e377ec19602bd269f2c 03:56:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:56:36 INFO - mozversion platform_version: 46.0a1 03:56:36 INFO - using testdate: 1450785396 03:56:36 INFO - actual date: 1450785396 03:56:36 INFO - starting webserver on 'localhost:56912' 03:56:36 INFO - SUITE-START | Running 3 tests 03:56:36 INFO - TEST-START | dromaeo_css 03:56:36 INFO - operating with platform_type : linux_ 03:56:36 INFO - Initialising browser for dromaeo_css test... 03:56:36 INFO - TEST-INFO | started process 18543 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiIPupo/profile http://localhost:56912/getInfo.html) 03:56:41 INFO - PROCESS | 18543 | __metrics Screen width/height:1600/1200 03:56:41 INFO - PROCESS | 18543 | colorDepth:24 03:56:41 INFO - PROCESS | 18543 | Browser inner width/height: 1024/697 03:56:41 INFO - PROCESS | 18543 | __metrics 03:56:41 INFO - PROCESS | 18543 | 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:42 INFO - TEST-INFO | 18543: exit 0 03:56:42 INFO - Browser initialized. 03:56:42 INFO - Running cycle 1/1 for dromaeo_css test... 03:56:42 INFO - TEST-INFO | started process 18676 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiIPupo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:53 INFO - PROCESS | 18676 | RSS: Main: 151203840 03:56:53 INFO - PROCESS | 18676 | 03:57:43 INFO - PROCESS | 18676 | 1450785463455 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:52 INFO - PROCESS | 18676 | Cycle 1(1): loaded http://localhost:56912/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56912/tests/dromaeo/cssquery-ext.html) 03:59:53 INFO - PROCESS | 18676 | RSS: Main: 158068736 03:59:53 INFO - PROCESS | 18676 | 04:02:55 INFO - PROCESS | 18676 | Cycle 1(1): loaded http://localhost:56912/tests/dromaeo/cssquery-ext.html (next: http://localhost:56912/tests/dromaeo/cssquery-jquery.html) 04:02:56 INFO - PROCESS | 18676 | RSS: Main: 153518080 04:02:56 INFO - PROCESS | 18676 | 04:05:57 INFO - PROCESS | 18676 | Cycle 1(1): loaded http://localhost:56912/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56912/tests/dromaeo/cssquery-mootools.html) 04:05:58 INFO - PROCESS | 18676 | RSS: Main: 153153536 04:05:58 INFO - PROCESS | 18676 | 04:08:59 INFO - PROCESS | 18676 | Cycle 1(1): loaded http://localhost:56912/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56912/tests/dromaeo/cssquery-prototype.html) 04:09:00 INFO - PROCESS | 18676 | RSS: Main: 152805376 04:09:00 INFO - PROCESS | 18676 | 04:12:02 INFO - PROCESS | 18676 | Cycle 1(1): loaded http://localhost:56912/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56912/tests/dromaeo/cssquery-yui.html) 04:12:03 INFO - PROCESS | 18676 | RSS: Main: 153460736 04:12:03 INFO - PROCESS | 18676 | 04:15:05 INFO - PROCESS | 18676 | Cycle 1(1): loaded http://localhost:56912/tests/dromaeo/cssquery-yui.html (next: http://localhost:56912/tests/dromaeo/cssquery-dojo.html) 04:15:06 INFO - PROCESS | 18676 | RSS: Main: 156135424 04:15:06 INFO - PROCESS | 18676 | 04:15:06 INFO - PROCESS | 18676 | __start_tp_report 04:15:06 INFO - PROCESS | 18676 | _x_x_mozilla_page_load 04:15:06 INFO - PROCESS | 18676 | _x_x_mozilla_page_load_details 04:15:06 INFO - PROCESS | 18676 | |i|pagename|runs| 04:15:06 INFO - PROCESS | 18676 | |0;dojo.html;3187.8246696431693;3238.1418923985134;3254.9349013019755;3271.345730853829;3279.622843373011;5292.338457692788;5441.537469315108;5484.561235101192;5512.696801675911;5524.5856560758;5371.140617501201;5424.620276580641;5461.563074954004;5493.945060549393;5516.613837031409;4630.722156670594;4936.432310284309;4994.101061808873;5020.548150666439;5031.396232452093;4819.277108433728;5002.649814512967;5024.974875125619;5063.544281014708;5079.746012699368;4836.806527738886;4886.193778026622;4974.328465657126;4982.451930287665;4987.975060124712;4956.083124621957;5064.012517559077;5071.087204303224;5103.18349064148;5106.489351064901;4866.270059491069;4949;5015.1975683890405;5024.296598476216;5060.443351231362;5138.229265610151;5194.506521880416;5209.088409528317;5225.555827754645;5285.207218917155;5880.794172203995;5935.91096133554;5950.9107363389585;5960.105984102376;5966.940330596682;5809.7676092956235;5835.387284335126;5904.61619994699;6004.6997650117755;6017.428344307284;5418.187271909245;5437.891242175135;5438.211459338413;5444.3194600674915;5454.481824226732;5953.880922381615;5954.583179177503;5958.255218097738;5961.5230781537375;5970.164177015221;5550.611457197957;5649.830505084854;5699.971500142473;5758.193852860602;5807.88384232313;5779.797707080232;5869.20765696634;5875.265591801025;5883.911741323884;5888.9705551472825;5772.509336706343;5801.419858014249;5840.912386314209;5849.795257165979;5858.560607954335;5718.970585294687;5775.960327141155;5822.621529600647;5837.182794408786;5882.49998750111;4475.5748203920575;4487.528809475023;4500.054988452462;4522.3668686383935;4538.546145385501;3931.233409485123;4001.479807625048;4004.039030632627;4027.073773032219;4045.696572757055;5372.086745253317;5384.6769193848495;5385.192221166778;5393.9730301348245;5397.460253974571;5834.941650583524;5851.736671849777;5873.119032145127;5875.236219291465;5985.760569577168;5421.566274698014;5430.049741295257;5441.863953401117;5449.264349312872;5454.072807622713;5081.187010078444;5090.541851233407;5093.9490605094215;5098.1842905135;5122.154844450624;5734.197212390269;5830.912536311958;5944.673042982591;6079.878402431927;6103.542234332443;5661.801836935688;5733.426657334233;5740;5747.080467125407;5766.826995190151;5874.559408044328;5883.352831188651;5904.055351143968;5916.615419997686;5917.674527900835;5666.405027472056;5778.191053252464;5781.392953739797;5782.710864456844;5786.479216870333;5772.797952071657;5837.737301821513;5872.941270587239;5873.4126587340925;5884.6469211847425;5751.9424805751405;5757.596968212185;5760.6255593386295;5770.13447982806;5770.307563092288;5745.683987380567;5765.019946609171;5769.913451298318;5812.360640329645;5825.737841797214;5424.891502170013;5519.061759500814;5566.944330556643;5678.68767217807;5682.488576028178;5764.279465066867;5769.653820770767;5784.045632470596;5803;5831.94168058331;5367.704776237344;5686.687232202103;5689.971550142222;5696.401877802937;5704.914426283692 04:15:06 INFO - PROCESS | 18676 | |1;ext.html;551.0411883323017;566.7223060700259;594.6016169166661;603.2097951683295;607.3380015782795;36762.44856327154;36790.44814327787;36852.815735921286;36890.44664330037;37018.62981370189;42317;42812.571874281246;43092.138157236834;43117;43235;8740.781480462976;8880.689175878846;8884.73345799627;8910.42082264654;8936.374453788238;8648.437851539662;8760.299176065932;8776.2101410873;8802.339824513156;8808.207261346477;8648.870266946002;8774.210321071103;8791.736247912573;8829.249513791336;8840.160184782468;8716.477011379338;8739.781505462319;8755.518446485472;8813.074627164184;8823.029466758651;8565.914340856574;8669.393142480028;8669.479831210085;8682.262007729287;8700.869486957701;39734;39763;39794.60205397967;40193.97575303087;40292;3312.337532493487;3315.088350703576;3363.1423986883433;3366.1416338833687;3508.1580420698847;29036;29054.854725726236;29181.27046823825;30000.249993750112;30330.090097297118;3737.439384092381;3748.287825313209;3763.6424539668687;3784.1674831537016;3807.8667246646232;253335;255186;255188;255509;256747;56998;57019.42980570141;57599.424005760244;57758.42241577614;57818.7109064452;69161.65419172872;70172.29827701657;70218.64890675616;70463.2953670467;70517;15071.171085590398;15141.091534507965;15194.088354698753;15200.543983680507;15201.391944322324;11515.539378424937;11550.249233799776;11604.76790464186;11665.358405287621;11668.94165529184;19632.509187270432;19884.801151988584;19907.900460497603;19986.70019949702;20081.39755807328;7625.577165244145;7772.961135194288;7870.724524641724;7969.481983671043;8041;957.6504575829912;963.205355581648;990.9009099090177;993.4337427666305;1036.7926414717087;28893.56659650107;29176.124716258546;30964.22589435282;30998;32127;1052.610534102387;1066.4880857188593;1069.0165048155716;1112.449337577904;1159.7332613498775;13473.865261347457;13567;13600;13757.656058598615;13804.861951380357;247473;249352;249540;250327;251027;45208.773956130666;45267.54732452699;45319.09361812745;45360.3195952061;45568.772156139006;1308.5158491358259;1330.846952600444;1349.7637913365122;1373.8488766235905;1377.7313423882447;24890.128845490322;25612.615810763225;25853;26037;26172.214833555023;41034.38448423336;41534;41537.16925661409;41884.79057604692;42394.15211695687;293172;294368;294751;294956;295300;30657.540136897518;31753.68246317507;32096.518552222202;32161.67838321587;32204.355912881143;37366.62633373631;37668.62331376761;38125.237495249385;38235.61764382321;38561.80719096387;32079.518807218377;32418.67581324251;32672.836635816668;32709.836450817595;33052.66947330496;31964.68035319617;32030.519542207352;32498.512522312656;35438.64561354354;36775.816120919226;32374;32559;33165.668343316254;34713.479297811056;34900.127496811765;30713.539296910116;31524.842375787975;32128;32527;32648.510272346408;24705.25884223476;24792.380190495383;24846.25461236166;24934.251972440856;25134.748652513972 04:15:06 INFO - PROCESS | 18676 | |2;jquery.html;357.04312442653696;362.2176099624811;362.53052297275025;363.8399104394067;368.5282837967401;16017.519474415772;16485.50543483696;17221.483355499324;17347.04591247481;17982.100894955267;10829.945850270757;10840.728981775459;10918.50866710998;10990.505427255772;11001.669949901496;4385.627221686161;4823.083614113307;4849.4841240101;4922.753862306889;4934.185859333205;4967.950320496785;4979.253112033206;4985.750712464381;4991.425986011619;4995.5753760930365;4972.254161875711;4973.950260497403;5070.569001634865;5195.090859099661;5212.765425555859;5196.29849970253;5198.506141916512;5210.374755029383;5226.137687281594;5431.4840090191365;5278.181881808326;5297.12597421425;5300.0459917214885;5330.067238233293;5342.118550439173;19412.12645430959;19462.416127516197;19476.4157075288;19803.207871685114;19848.206071757257;2011.6278488479677;2088.9268875589432;2103.4531021934254;2169.425102347879;2225.187806450634;9289.814203715956;9414.764630884283;9440.2919781016;9478.431294122374;9647.421154730668;1854.1192933356683;1877.5681593233496;1892.7255547945608;1983.6726940055019;2018.4852862519963;56695;58914.41085589132;59021.40978590202;59288;59391.40608593945;10355.585776569003;10437.425941573287;10468.47657617116;10477.895221047844;10509.684709458728;13303.40134693941;13350.465981360638;13413.463461461432;13460.461581536825;13497.392617332243;7617.162112167657;7620.618969051525;7644;7655.540667559964;7722;7276.417886569062;7298.2701729826595;7298.4891057625455;7321.78034658961;7338.302861228175;4472.837062363744;4523.638108951342;4567.817287308537;4569.543045695404;4577.656675749332;1814.5191524246086;1874.6157037807218;1899.3542195653545;1909.8731748268588;1931.169597073272;435.33611242854266;436.11033491677256;441.9005723712139;468.9132510485503;471.2342443529265;10386.221033422524;10731.624393146203;10888.020078192842;11407.08743300534;11548.307101573933;453.1277291214399;471.0367298873811;891.7280229530055;915.3272344826547;919.7332773495611;8786.692465763668;9462.668806591737;9757.707268781947;9876.654317098866;9881.308308418485;527072;528655;534548;534708;540821;80412.59793701112;81504.59247703724;82584.17415825884;83505.58247208725;83859;1151.9862520981483;1173.9823902641467;1177.1465687376754;1180.4805885410392;1184.3959580613948;14466.493672721404;15785.28966196501;15797.526074217792;15891.682166356839;15892.443764468188;33853;33933.830330849174;35124.473132903535;35351.46972795359;35670.464943026396;39849.60150398575;39977.400338994354;40868.1826363477;41326.38010429906;41378.96552586209;9024.187823095954;9180.44917304964;9338.766530836783;10053.849192261976;10062.245331600305;16486.83513164853;17180;17492.212850421507;17528;17792.110394479965;13742;14350.569482915529;14566.417343306573;14638.707225855636;14672.3397447113;13721.382537785625;13981.091229070078;14035.92982035124;14121.08212966154;14617.488387906373;6342.714577843916;9439.19766819828;14980.475683351466;15097.622559435662;15306.617334566725;9544.713658590254;9705;9882.258830587878;9944.303898727308;9961.50192490387;14829;15004.624884377541;15055;15179.468718594797;15387.38450461969 04:15:06 INFO - PROCESS | 18676 | |3;mootools.html;1461.2474575593571;1516.3252352703053;1586.3733825139063;1664.5006498050582;1772.5391398236463;7203.243659415764;7216.386607138399;7454.291842274982;7501.924980750184;7519.473636845423;7446.329830315271;7451.1058672959325;7469.962650186755;7478.364339031175;7540.585267810282;2226.977730222697;2254.2448279826194;2266.829987750917;2268.7050683411135;2270.8523945943543;2231.85492942959;2247.3370355745014;2278.214016164429;2279.851809632377;2280.646499792535;2164.9242276520326;2210.4363387336207;2219.755826859044;2231.14101071088;2232.810211132056;2175.8368122390884;2206.1175529788134;2226.4879077812193;2248.168177774218;2260.3557985974085;2270.9886450567806;2292.873891935943;2293.6100862853186;2300.2524179641514;2302.6085565453914;7146.2496437874315;7262.891056634155;7271.600061996588;7272.16370117438;7273.018142550741;4457.130859482402;4518.457785065781;4526.253168227238;4526.841560545365;4527.388802511652;2967.8516074196204;2968.673445920947;3050.603421555206;3057.480228361184;3060.1125673554643;944.6788092048668;964.7829238421369;982.0719420147963;995.1789773436872;1002.644061358222;9761.755956101084;9765.609375624967;9797.922228554924;9814.362066465728;9836.06557377048;3897.2205558888336;3949.150932549516;3974.5627980922077;3984.023914141054;4056.51321841375;8040.919590804017;8101.959490202511;8106.229908158715;8122.228388303101;8124.22819832115;4427.75647339393;4451.243288640939;4455.1312494064;4465.933011004838;4481.551844815493;4047.757134571876;4060.2488539620263;4060.3706425504092;4067.654249388776;4089.386592011222;3332.966670333314;3342.1978725106287;3342.665733426638;3353.84907679155;3370.4944258361443;1023.3910823060417;1050.2805578178973;1055.488088277185;1061.6761887624348;1079.3955384984433;1034.379372376583;1035.1098055672117;1089.9782004359868;1195.9521619135312;1363.311527678516;6607.075009498674;6673.432758215606;6676.298988606223;6693;6698.631575263407;1129.949152288149;1133.484264659578;1136.852209212797;1139.641013080877;1157.4212893553224;5564.610477266633;5586;5601.131824567198;5607.551395888319;5612.214289999403;8580.65677372898;8653.307735381155;8826.823463530693;8877.289816814638;8892.510911899779;8694.826103477895;8699.043105258417;8716.346274029473;8744.475331480131;8775.824483510294;6715.39561439463;6817.488688348294;6852.383285504328;6882.070920425678;6897.7585784497305;6618.404343609098;6674.132362792806;6680.565763225569;6682.131322927989;6694.564853284521;7561.508501947355;7706.07527096752;7708.460407771402;7762.844743105219;7798.298153166243;7753.844923101619;7808.453408261367;7878.133405325524;7927.326177274997;7943.6822527100585;6107.84730381744;6123.326434092335;6174.753009879554;6189.597676151036;6193.256809182927;6874.381305682513;6894.24163342042;6923.688434020381;6958;6965.7213711453005;6490.870182596227;6552.967235163794;6575.24384695747;6634.9004764927595;6639.867202656016;6699.162604674416;6727.260001399744;6751.696173672099;6764.695588698619;6814.1482314710665;6570.737170513126;6654.101696270942;6678.198616166092;6715.56348837324;6732.562383445256;6197.752089916533;6231.9688401557705;6240.032794916795;6281.340459251713;6302.621842689453;6223.813285601439;6242.65665388408;6297.685115744286;6320.209973753281;6345.746170153327 04:15:06 INFO - PROCESS | 18676 | |4;prototype.html;341.53210102160034;344.9292894956533;350.58980992239077;352.4677736617708;352.7072529800266;6318.652474113922;6319.304876463591;6321.905171422421;6369.490440764739;6475.870482590345;6180.598261113036;6260.812175634727;6261.060840873871;6296.275928268251;6303;4836.250381190921;4857.489963553829;4859.684120532154;4866.780994855222;4878.585320247775;4866.124097662419;4866.951330486703;4870.293807397925;4871.951280487203;4874.610031197496;4709.9058018839605;4819.6867203631655;4821.421429428456;4826.203676393408;4844.442889067767;4797.208460604013;4801.639877009238;4823.469418363977;4824.17988941879;4839.05638400512;4225.429567008446;4232.492100947875;4232.830686772525;4233.809478573472;4239.660827133853;5921.467067963904;5950.137230101611;5952.523798096142;5961.254843144607;5967.970160149215;5509.917351239735;5629.155626655994;5649;5653.208550802891;5655.688937108457;6703.1285932828905;6709.563878347941;6716.83207919801;6724.764633237862;6728.529002969794;4671.649626278008;4676.812927482896;4684.0397718467975;4685.5314468553215;4686.08621318843;6871.072405225281;6911.723531058751;6963.721451141948;6979.022936788904;6980.546264492842;4788;4792.544708252711;4798.520147985174;4802.6638135330195;4817.445993710698;4870.6103511718975;4871.878203044952;4880.292357608127;4881.389826271716;4885.267209918541;5603.243562119062;5604.747786349624;5607.943920560824;5618.662880227118;5626.043572592669;6526.967365163144;6737.157855268091;6741.022551729971;6745.156855393076;6763.492738044568;1693.1195778195515;1706.2833609883878;1708.871834612409;1722.4057700093447;1722.6813039587717;1142.714321419645;1152.5793085523892;1155.5031336525208;1173.5775120956448;1175.2419689300352;6106.755729770848;6175.660338681416;6189.907151392733;6194.194754681863;6200.0699895016105;6756.695948682321;6770.593764374154;6778.254392016973;6790.49071319653;6796.25241223465;6067.605605635619;6130.63216207029;6150.384961503813;6184.381561843779;6187.288461826947;3713.721470889694;3742.85028598853;3743.9064023399633;3745.9063523412133;3747.569029561581;6988.44092472601;7013.579185248901;7013.824654383681;7045.189803172599;7049.541779784297;6920.8961865572055;7077.92922070783;7093.929060709327;7107.680154393065;7111.857762844714;6969.756058537927;6988.37104660583;7011.193712723102;7012.719491220294;7018.649067546704;6748.325167483213;6824.658767061528;6832.180138383425;6843.315668433117;6845.5550389224545;6644.4020038196795;6768.864622707617;6792.660366981532;6793.286704895915;6798.422134118655;6985.0220969065385;6996.930030699831;7000.8949865753075;7004.964975175091;7016.631756807374;4794.928076078932;4809.158397280532;4820.25286080658;4823.962847987559;4826.276058591099;6809.080774095632;6811.421029212573;6820.283870193757;6826.556273842184;6957.199922009034;6733.3939945405145;6761.966190169018;6779.694913728796;6783;6786.287439818748;6739.0902228198565;6742.898856517058;6748.392644662004;6752.5948443093575;6753.729850806109;6508.902366464412;6565;6630.171228596426;6634.137562116894;6646.9335306648245;6793.252742198255;6809.285025072296;6821.727130914708;6824.727010919706;6825.590464572141;6638.402543771083;6641.867162656817;6642.933570664425;6644.767433139817;6652.866942661217 04:15:06 INFO - PROCESS | 18676 | |5;yui.html;770.7071312901098;840.4495055738489;858.4463021351229;862.3446180902512;867.8708830809911;13466.46134154634;13689.520866769664;13768.105073170236;13862.02965792395;15242.390304387838;15046.849531504682;15108.848911510882;15146.84853151471;15149.924250378761;15164.090154590733;829.5893532701322;842.5450256861287;858.4291446188278;860.0883063952231;861.6639510590875;848.8429640516493;852.0797538658265;852.9445586036919;855.3926712034463;857.1171693156059;880.5377176982104;885.2608072259671;890.559173209259;890.7149712092133;891.1489527501253;878.5168157513342;882.9514376709278;885.1900511032397;887.8668199770021;890.2388457868494;646.5280345347875;647.5920170292733;651.6513665189149;655.1352215076101;658.8451713847242;13917.23455209963;14009.649758756012;14051.086679365808;14064.437422503088;14128.576142715736;11185.217034807567;11710.941445292805;12426.813597796041;12486.063545234143;12709.682257943532;10317.329373590692;10330.7417314567;10524.894751052469;10592.523336449802;10635.042846143806;3591.730620203495;3643.3988391915304;3666.450032495147;3759.830807613664;3783.0920579060826;45738.31392529115;46064;46140.30789538159;46198.76900615509;47544.52455475435;9093.863592046124;9294.209992150607;9351.53242337894;9455.52722363879;9729.805403891882;16025.679486410207;16113;16213.918930405272;16221.188940552925;16247.106409147375;7167.3549380556;7286.307800758919;7361.337479626859;7534.472586918863;7599;4226.408302837605;4363.738175709467;4368.7815609219415;4373.1472362888935;4419;3025.0924722583577;3042.3154790172475;3044.4519986402215;3062.7090426409454;3066.5400189971683;527.2065541360305;547.2475346398702;555.919391688203;556.1657513729406;557.2477155839584;585.4847733994143;611.1535523300183;623.4513628007415;630.8769789891019;676.1446769836062;8206.384521160937;8229;8243.670253189925;8259.21537453941;8588.656453741905;520.9244659524347;570.2842932120162;689.0431175461713;693.7051753004953;734.5409119300438;3728.3102626014274;3761.6426439488205;3894.201688653819;3935.2129574084724;4244.766537840448;56957.14564281539;59141.40858591359;59379;60583.69708151431;61431;48516.5148348512;49304;49324.75337623289;49994.75002624963;50004.49995500071;46039.76980115078;46229.30656040162;46984.76507617372;47263.29105063427;47453.10187592527;8160.469569477965;8184;8463.788405289672;8541.14588541141;8608.268297194809;34916.30167396587;35087.71929824496;35275.470867936485;35381.82309088438;35517;45108.77445612751;45681;45750.54249457463;45903.3114503276;46229.76885115553;10916.890831091587;11311.660650180507;11388.715282118013;11441.19911606213;11576.073914087021;12145.271283723005;12296.262224266573;12364.319962402154;12736.872631273569;12803.87196128064;11437.656870293904;11716;11796.351200684045;11955.043596512432;12291.201071930296;11232.550697972316;11712.531498740296;11735.76528469443;12001.1599188056;12081.456334465145;11230.887691123311;11261.7747645045;11455.942720286344;11609.419529023684;11680.47437865315;9673.177779888507;9786.951065244628;9807.215422766305;9866.062724041205;10206.336588121749;8574.185452382264;9317.589234872692;9498.430094194371;9891.455969921435;10060.899391006289 04:15:06 INFO - PROCESS | 18676 | __end_tp_report 04:15:06 INFO - PROCESS | 18676 | __start_cc_report 04:15:06 INFO - PROCESS | 18676 | _x_x_mozilla_cycle_collect,305 04:15:06 INFO - PROCESS | 18676 | __end_cc_report 04:15:06 INFO - PROCESS | 18676 | __startTimestamp1450786506192__endTimestamp 04:15:06 INFO - PROCESS | 18676 | 04:15:06 INFO - PROCESS | 18676 | ------- Summary: start ------- 04:15:06 INFO - PROCESS | 18676 | Number of tests: 6 04:15:06 INFO - PROCESS | 18676 | 04:15:06 INFO - PROCESS | 18676 | [#0] dojo.html Cycles:165 Average:5415.90 Median:5666.41 stddev:599.63 (10.6%) stddev-sans-first:575.43 04:15:06 INFO - PROCESS | 18676 | Values: 3187.8 3238.1 3254.9 3271.3 3279.6 5292.3 5441.5 5484.6 5512.7 5524.6 5371.1 5424.6 5461.6 5493.9 5516.6 4630.7 4936.4 4994.1 5020.5 5031.4 4819.3 5002.6 5025.0 5063.5 5079.7 4836.8 4886.2 4974.3 4982.5 4988.0 4956.1 5064.0 5071.1 5103.2 5106.5 4866.3 4949.0 5015.2 5024.3 5060.4 5138.2 5194.5 5209.1 5225.6 5285.2 5880.8 5935.9 5950.9 5960.1 5966.9 5809.8 5835.4 5904.6 6004.7 6017.4 5418.2 5437.9 5438.2 5444.3 5454.5 5953.9 5954.6 5958.3 5961.5 5970.2 5550.6 5649.8 5700.0 5758.2 5807.9 5779.8 5869.2 5875.3 5883.9 5889.0 5772.5 5801.4 5840.9 5849.8 5858.6 5719.0 5776.0 5822.6 5837.2 5882.5 4475.6 4487.5 4500.1 4522.4 4538.5 3931.2 4001.5 4004.0 4027.1 4045.7 5372.1 5384.7 5385.2 5394.0 5397.5 5834.9 5851.7 5873.1 5875.2 5985.8 5421.6 5430.0 5441.9 5449.3 5454.1 5081.2 5090.5 5093.9 5098.2 5122.2 5734.2 5830.9 5944.7 6079.9 6103.5 5661.8 5733.4 5740.0 5747.1 5766.8 5874.6 5883.4 5904.1 5916.6 5917.7 5666.4 5778.2 5781.4 5782.7 5786.5 5772.8 5837.7 5872.9 5873.4 5884.6 5751.9 5757.6 5760.6 5770.1 5770.3 5745.7 5765.0 5769.9 5812.4 5825.7 5424.9 5519.1 5566.9 5678.7 5682.5 5764.3 5769.7 5784.0 5803.0 5831.9 5367.7 5686.7 5690.0 5696.4 5704.9 04:15:06 INFO - PROCESS | 18676 | 04:15:06 INFO - PROCESS | 18676 | [#1] ext.html Cycles:180 Average:43577.39 Median:19039.81 stddev:69692.29 (366.0%) stddev-sans-first:69812.92 04:15:06 INFO - PROCESS | 18676 | Values: 551.0 566.7 594.6 603.2 607.3 36762.4 36790.4 36852.8 36890.4 37018.6 42317.0 42812.6 43092.1 43117.0 43235.0 8740.8 8880.7 8884.7 8910.4 8936.4 8648.4 8760.3 8776.2 8802.3 8808.2 8648.9 8774.2 8791.7 8829.2 8840.2 8716.5 8739.8 8755.5 8813.1 8823.0 8565.9 8669.4 8669.5 8682.3 8700.9 39734.0 39763.0 39794.6 40194.0 40292.0 3312.3 3315.1 3363.1 3366.1 3508.2 29036.0 29054.9 29181.3 30000.2 30330.1 3737.4 3748.3 3763.6 3784.2 3807.9 253335.0 255186.0 255188.0 255509.0 256747.0 56998.0 57019.4 57599.4 57758.4 57818.7 69161.7 70172.3 70218.6 70463.3 70517.0 15071.2 15141.1 15194.1 15200.5 15201.4 11515.5 11550.2 11604.8 11665.4 11668.9 19632.5 19884.8 19907.9 19986.7 20081.4 7625.6 7773.0 7870.7 7969.5 8041.0 957.7 963.2 990.9 993.4 1036.8 28893.6 29176.1 30964.2 30998.0 32127.0 1052.6 1066.5 1069.0 1112.4 1159.7 13473.9 13567.0 13600.0 13757.7 13804.9 247473.0 249352.0 249540.0 250327.0 251027.0 45208.8 45267.5 45319.1 45360.3 45568.8 1308.5 1330.8 1349.8 1373.8 1377.7 24890.1 25612.6 25853.0 26037.0 26172.2 41034.4 41534.0 41537.2 41884.8 42394.2 293172.0 294368.0 294751.0 294956.0 295300.0 30657.5 31753.7 32096.5 32161.7 32204.4 37366.6 37668.6 38125.2 38235.6 38561.8 32079.5 32418.7 32672.8 32709.8 33052.7 31964.7 32030.5 32498.5 35438.6 36775.8 32374.0 32559.0 33165.7 34713.5 34900.1 30713.5 31524.8 32128.0 32527.0 32648.5 24705.3 24792.4 24846.3 24934.3 25134.7 04:15:06 INFO - PROCESS | 18676 | 04:15:06 INFO - PROCESS | 18676 | [#2] jquery.html Cycles:180 Average:28128.43 Median:39913.50 stddev:87178.38 (218.4%) stddev-sans-first:87397.99 04:15:06 INFO - PROCESS | 18676 | Values: 357.0 362.2 362.5 363.8 368.5 16017.5 16485.5 17221.5 17347.0 17982.1 10829.9 10840.7 10918.5 10990.5 11001.7 4385.6 4823.1 4849.5 4922.8 4934.2 4968.0 4979.3 4985.8 4991.4 4995.6 4972.3 4974.0 5070.6 5195.1 5212.8 5196.3 5198.5 5210.4 5226.1 5431.5 5278.2 5297.1 5300.0 5330.1 5342.1 19412.1 19462.4 19476.4 19803.2 19848.2 2011.6 2088.9 2103.5 2169.4 2225.2 9289.8 9414.8 9440.3 9478.4 9647.4 1854.1 1877.6 1892.7 1983.7 2018.5 56695.0 58914.4 59021.4 59288.0 59391.4 10355.6 10437.4 10468.5 10477.9 10509.7 13303.4 13350.5 13413.5 13460.5 13497.4 7617.2 7620.6 7644.0 7655.5 7722.0 7276.4 7298.3 7298.5 7321.8 7338.3 4472.8 4523.6 4567.8 4569.5 4577.7 1814.5 1874.6 1899.4 1909.9 1931.2 435.3 436.1 441.9 468.9 471.2 10386.2 10731.6 10888.0 11407.1 11548.3 453.1 471.0 891.7 915.3 919.7 8786.7 9462.7 9757.7 9876.7 9881.3 527072.0 528655.0 534548.0 534708.0 540821.0 80412.6 81504.6 82584.2 83505.6 83859.0 1152.0 1174.0 1177.1 1180.5 1184.4 14466.5 15785.3 15797.5 15891.7 15892.4 33853.0 33933.8 35124.5 35351.5 35670.5 39849.6 39977.4 40868.2 41326.4 41379.0 9024.2 9180.4 9338.8 10053.8 10062.2 16486.8 17180.0 17492.2 17528.0 17792.1 13742.0 14350.6 14566.4 14638.7 14672.3 13721.4 13981.1 14035.9 14121.1 14617.5 6342.7 9439.2 14980.5 15097.6 15306.6 9544.7 9705.0 9882.3 9944.3 9961.5 14829.0 15004.6 15055.0 15179.5 15387.4 04:15:06 INFO - PROCESS | 18676 | 04:15:06 INFO - PROCESS | 18676 | [#3] mootools.html Cycles:180 Average:5138.36 Median:6262.00 stddev:2580.33 (41.2%) stddev-sans-first:2572.76 04:15:06 INFO - PROCESS | 18676 | Values: 1461.2 1516.3 1586.4 1664.5 1772.5 7203.2 7216.4 7454.3 7501.9 7519.5 7446.3 7451.1 7470.0 7478.4 7540.6 2227.0 2254.2 2266.8 2268.7 2270.9 2231.9 2247.3 2278.2 2279.9 2280.6 2164.9 2210.4 2219.8 2231.1 2232.8 2175.8 2206.1 2226.5 2248.2 2260.4 2271.0 2292.9 2293.6 2300.3 2302.6 7146.2 7262.9 7271.6 7272.2 7273.0 4457.1 4518.5 4526.3 4526.8 4527.4 2967.9 2968.7 3050.6 3057.5 3060.1 944.7 964.8 982.1 995.2 1002.6 9761.8 9765.6 9797.9 9814.4 9836.1 3897.2 3949.2 3974.6 3984.0 4056.5 8040.9 8102.0 8106.2 8122.2 8124.2 4427.8 4451.2 4455.1 4465.9 4481.6 4047.8 4060.2 4060.4 4067.7 4089.4 3333.0 3342.2 3342.7 3353.8 3370.5 1023.4 1050.3 1055.5 1061.7 1079.4 1034.4 1035.1 1090.0 1196.0 1363.3 6607.1 6673.4 6676.3 6693.0 6698.6 1129.9 1133.5 1136.9 1139.6 1157.4 5564.6 5586.0 5601.1 5607.6 5612.2 8580.7 8653.3 8826.8 8877.3 8892.5 8694.8 8699.0 8716.3 8744.5 8775.8 6715.4 6817.5 6852.4 6882.1 6897.8 6618.4 6674.1 6680.6 6682.1 6694.6 7561.5 7706.1 7708.5 7762.8 7798.3 7753.8 7808.5 7878.1 7927.3 7943.7 6107.8 6123.3 6174.8 6189.6 6193.3 6874.4 6894.2 6923.7 6958.0 6965.7 6490.9 6553.0 6575.2 6634.9 6639.9 6699.2 6727.3 6751.7 6764.7 6814.1 6570.7 6654.1 6678.2 6715.6 6732.6 6197.8 6232.0 6240.0 6281.3 6302.6 6223.8 6242.7 6297.7 6320.2 6345.7 04:15:06 INFO - PROCESS | 18676 | 04:15:06 INFO - PROCESS | 18676 | [#4] prototype.html Cycles:180 Average:5584.90 Median:6230.44 stddev:1661.75 (26.7%) stddev-sans-first:1619.14 04:15:06 INFO - PROCESS | 18676 | Values: 341.5 344.9 350.6 352.5 352.7 6318.7 6319.3 6321.9 6369.5 6475.9 6180.6 6260.8 6261.1 6296.3 6303.0 4836.3 4857.5 4859.7 4866.8 4878.6 4866.1 4867.0 4870.3 4872.0 4874.6 4709.9 4819.7 4821.4 4826.2 4844.4 4797.2 4801.6 4823.5 4824.2 4839.1 4225.4 4232.5 4232.8 4233.8 4239.7 5921.5 5950.1 5952.5 5961.3 5968.0 5509.9 5629.2 5649.0 5653.2 5655.7 6703.1 6709.6 6716.8 6724.8 6728.5 4671.6 4676.8 4684.0 4685.5 4686.1 6871.1 6911.7 6963.7 6979.0 6980.5 4788.0 4792.5 4798.5 4802.7 4817.4 4870.6 4871.9 4880.3 4881.4 4885.3 5603.2 5604.7 5607.9 5618.7 5626.0 6527.0 6737.2 6741.0 6745.2 6763.5 1693.1 1706.3 1708.9 1722.4 1722.7 1142.7 1152.6 1155.5 1173.6 1175.2 6106.8 6175.7 6189.9 6194.2 6200.1 6756.7 6770.6 6778.3 6790.5 6796.3 6067.6 6130.6 6150.4 6184.4 6187.3 3713.7 3742.9 3743.9 3745.9 3747.6 6988.4 7013.6 7013.8 7045.2 7049.5 6920.9 7077.9 7093.9 7107.7 7111.9 6969.8 6988.4 7011.2 7012.7 7018.6 6748.3 6824.7 6832.2 6843.3 6845.6 6644.4 6768.9 6792.7 6793.3 6798.4 6985.0 6996.9 7000.9 7005.0 7016.6 4794.9 4809.2 4820.3 4824.0 4826.3 6809.1 6811.4 6820.3 6826.6 6957.2 6733.4 6762.0 6779.7 6783.0 6786.3 6739.1 6742.9 6748.4 6752.6 6753.7 6508.9 6565.0 6630.2 6634.1 6646.9 6793.3 6809.3 6821.7 6824.7 6825.6 6638.4 6641.9 6642.9 6644.8 6652.9 04:15:06 INFO - PROCESS | 18676 | 04:15:06 INFO - PROCESS | 18676 | [#5] yui.html Cycles:180 Average:13843.57 Median:46214.04 stddev:15963.67 (34.5%) stddev-sans-first:15978.27 04:15:06 INFO - PROCESS | 18676 | Values: 770.7 840.4 858.4 862.3 867.9 13466.5 13689.5 13768.1 13862.0 15242.4 15046.8 15108.8 15146.8 15149.9 15164.1 829.6 842.5 858.4 860.1 861.7 848.8 852.1 852.9 855.4 857.1 880.5 885.3 890.6 890.7 891.1 878.5 883.0 885.2 887.9 890.2 646.5 647.6 651.7 655.1 658.8 13917.2 14009.6 14051.1 14064.4 14128.6 11185.2 11710.9 12426.8 12486.1 12709.7 10317.3 10330.7 10524.9 10592.5 10635.0 3591.7 3643.4 3666.5 3759.8 3783.1 45738.3 46064.0 46140.3 46198.8 47544.5 9093.9 9294.2 9351.5 9455.5 9729.8 16025.7 16113.0 16213.9 16221.2 16247.1 7167.4 7286.3 7361.3 7534.5 7599.0 4226.4 4363.7 4368.8 4373.1 4419.0 3025.1 3042.3 3044.5 3062.7 3066.5 527.2 547.2 555.9 556.2 557.2 585.5 611.2 623.5 630.9 676.1 8206.4 8229.0 8243.7 8259.2 8588.7 520.9 570.3 689.0 693.7 734.5 3728.3 3761.6 3894.2 3935.2 4244.8 56957.1 59141.4 59379.0 60583.7 61431.0 48516.5 49304.0 49324.8 49994.8 50004.5 46039.8 46229.3 46984.8 47263.3 47453.1 8160.5 8184.0 8463.8 8541.1 8608.3 34916.3 35087.7 35275.5 35381.8 35517.0 45108.8 45681.0 45750.5 45903.3 46229.8 10916.9 11311.7 11388.7 11441.2 11576.1 12145.3 12296.3 12364.3 12736.9 12803.9 11437.7 11716.0 11796.4 11955.0 12291.2 11232.6 11712.5 11735.8 12001.2 12081.5 11230.9 11261.8 11455.9 11609.4 11680.5 9673.2 9787.0 9807.2 9866.1 10206.3 8574.2 9317.6 9498.4 9891.5 10060.9 04:15:06 INFO - PROCESS | 18676 | -------- Summary: end -------- 04:15:06 INFO - PROCESS | 18676 | 04:15:06 INFO - TEST-INFO | 18676: exit 0 04:15:06 INFO - TEST-OK | dromaeo_css | took 1110689ms 04:15:06 INFO - TEST-START | kraken 04:15:06 INFO - operating with platform_type : linux_ 04:15:06 INFO - Initialising browser for kraken test... 04:15:06 INFO - TEST-INFO | started process 18914 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphPjOHE/profile http://localhost:56912/getInfo.html) 04:15:11 INFO - PROCESS | 18914 | __metrics Screen width/height:1600/1200 04:15:11 INFO - PROCESS | 18914 | colorDepth:24 04:15:11 INFO - PROCESS | 18914 | Browser inner width/height: 1024/697 04:15:11 INFO - PROCESS | 18914 | __metrics 04:15:11 INFO - PROCESS | 18914 | 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:12 INFO - TEST-INFO | 18914: exit 0 04:15:12 INFO - Browser initialized. 04:15:12 INFO - Running cycle 1/1 for kraken test... 04:15:12 INFO - TEST-INFO | started process 19038 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphPjOHE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:24 INFO - PROCESS | 19038 | RSS: Main: 151224320 04:15:24 INFO - PROCESS | 19038 | 04:15:26 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:56912/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56912/tests/kraken/driver.html?testName=audio-beat-detection) 04:15:27 INFO - PROCESS | 19038 | RSS: Main: 150933504 04:15:27 INFO - PROCESS | 19038 | 04:15:30 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:56912/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56912/tests/kraken/driver.html?testName=audio-dft) 04:15:30 INFO - PROCESS | 19038 | RSS: Main: 151285760 04:15:30 INFO - PROCESS | 19038 | 04:15:33 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:56912/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56912/tests/kraken/driver.html?testName=audio-fft) 04:15:34 INFO - PROCESS | 19038 | RSS: Main: 146079744 04:15:34 INFO - PROCESS | 19038 | 04:15:36 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:56912/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56912/tests/kraken/driver.html?testName=audio-oscillator) 04:15:36 INFO - PROCESS | 19038 | RSS: Main: 145588224 04:15:36 INFO - PROCESS | 19038 | 04:15:39 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:56912/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56912/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:15:39 INFO - PROCESS | 19038 | RSS: Main: 146583552 04:15:39 INFO - PROCESS | 19038 | 04:15:42 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:56912/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56912/tests/kraken/driver.html?testName=imaging-darkroom) 04:15:43 INFO - PROCESS | 19038 | RSS: Main: 147435520 04:15:43 INFO - PROCESS | 19038 | 04:15:46 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:56912/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56912/tests/kraken/driver.html?testName=imaging-desaturate) 04:15:47 INFO - PROCESS | 19038 | RSS: Main: 148652032 04:15:47 INFO - PROCESS | 19038 | 04:15:49 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:56912/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56912/tests/kraken/driver.html?testName=json-parse-financial) 04:15:50 INFO - PROCESS | 19038 | RSS: Main: 149225472 04:15:50 INFO - PROCESS | 19038 | 04:15:52 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:56912/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56912/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:15:52 INFO - PROCESS | 19038 | RSS: Main: 149114880 04:15:52 INFO - PROCESS | 19038 | 04:15:54 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:56912/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56912/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:15:55 INFO - PROCESS | 19038 | RSS: Main: 148131840 04:15:55 INFO - PROCESS | 19038 | 04:15:57 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:56912/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56912/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:15:57 INFO - PROCESS | 19038 | RSS: Main: 148549632 04:15:57 INFO - PROCESS | 19038 | 04:16:00 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:56912/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56912/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:16:00 INFO - PROCESS | 19038 | RSS: Main: 149512192 04:16:00 INFO - PROCESS | 19038 | 04:16:03 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:56912/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56912/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:16:04 INFO - PROCESS | 19038 | RSS: Main: 149643264 04:16:04 INFO - PROCESS | 19038 | 04:16:05 INFO - PROCESS | 19038 | Cycle 1(1): loaded http://localhost:56912/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56912/tests/kraken/driver.html?testName=ai-astar) 04:16:06 INFO - PROCESS | 19038 | RSS: Main: 148893696 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - PROCESS | 19038 | __start_tp_report 04:16:06 INFO - PROCESS | 19038 | _x_x_mozilla_page_load 04:16:06 INFO - PROCESS | 19038 | _x_x_mozilla_page_load_details 04:16:06 INFO - PROCESS | 19038 | |i|pagename|runs| 04:16:06 INFO - PROCESS | 19038 | |0;ai-astar;111;108;112;110;110;124;111;111;114;111 04:16:06 INFO - PROCESS | 19038 | |1;audio-beat-detection;150;125;153;162;127;151;155;127;157;127 04:16:06 INFO - PROCESS | 19038 | |2;audio-dft;161;162;164;162;168;162;163;163;181;162 04:16:06 INFO - PROCESS | 19038 | |3;audio-fft;72;71;72;71;71;73;153;72;71;72 04:16:06 INFO - PROCESS | 19038 | |4;audio-oscillator;94;93;142;94;93;94;137;94;93;146 04:16:06 INFO - PROCESS | 19038 | |5;imaging-gaussian-blur;110;110;110;109;109;110;111;110;109;110 04:16:06 INFO - PROCESS | 19038 | |6;imaging-darkroom;149;147;147;147;147;148;147;148;149;146 04:16:06 INFO - PROCESS | 19038 | |7;imaging-desaturate;95;96;96;97;96;96;96;96;96;97 04:16:06 INFO - PROCESS | 19038 | |8;json-parse-financial;62;58;58;58;58;58;62;60;59;57 04:16:06 INFO - PROCESS | 19038 | |9;json-stringify-tinderbox;68;72;68;68;68;69;67;67;67;68 04:16:06 INFO - PROCESS | 19038 | |10;stanford-crypto-aes;86;95;90;89;88;98;88;88;90;87 04:16:06 INFO - PROCESS | 19038 | |11;stanford-crypto-ccm;126;126;128;133;119;125;120;118;119;137 04:16:06 INFO - PROCESS | 19038 | |12;stanford-crypto-pbkdf2;143;169;149;155;157;145;160;151;158;150 04:16:06 INFO - PROCESS | 19038 | |13;stanford-crypto-sha256-iterative;67;68;68;68;66;70;68;70;67;67 04:16:06 INFO - PROCESS | 19038 | __end_tp_report 04:16:06 INFO - PROCESS | 19038 | __start_cc_report 04:16:06 INFO - PROCESS | 19038 | _x_x_mozilla_cycle_collect,739 04:16:06 INFO - PROCESS | 19038 | __end_cc_report 04:16:06 INFO - PROCESS | 19038 | __startTimestamp1450786566008__endTimestamp 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - PROCESS | 19038 | ------- Summary: start ------- 04:16:06 INFO - PROCESS | 19038 | Number of tests: 14 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - PROCESS | 19038 | [#0] ai-astar Cycles:10 Average:112.20 Median:111.00 stddev:4.42 (4.0%) stddev-sans-first:4.66 04:16:06 INFO - PROCESS | 19038 | Values: 111.0 108.0 112.0 110.0 110.0 124.0 111.0 111.0 114.0 111.0 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - PROCESS | 19038 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:152.00 stddev:14.92 (9.8%) stddev-sans-first:15.64 04:16:06 INFO - PROCESS | 19038 | Values: 150.0 125.0 153.0 162.0 127.0 151.0 155.0 127.0 157.0 127.0 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - PROCESS | 19038 | [#2] audio-dft Cycles:10 Average:164.80 Median:163.00 stddev:6.01 (3.7%) stddev-sans-first:6.22 04:16:06 INFO - PROCESS | 19038 | Values: 161.0 162.0 164.0 162.0 168.0 162.0 163.0 163.0 181.0 162.0 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - PROCESS | 19038 | [#3] audio-fft Cycles:10 Average:79.80 Median:72.00 stddev:25.73 (35.7%) stddev-sans-first:27.13 04:16:06 INFO - PROCESS | 19038 | Values: 72.0 71.0 72.0 71.0 71.0 73.0 153.0 72.0 71.0 72.0 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - PROCESS | 19038 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:93.50 stddev:23.33 (25.0%) stddev-sans-first:24.19 04:16:06 INFO - PROCESS | 19038 | Values: 94.0 93.0 142.0 94.0 93.0 94.0 137.0 94.0 93.0 146.0 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - PROCESS | 19038 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 04:16:06 INFO - PROCESS | 19038 | Values: 110.0 110.0 110.0 109.0 109.0 110.0 111.0 110.0 109.0 110.0 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - PROCESS | 19038 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.97 (0.7%) stddev-sans-first:0.87 04:16:06 INFO - PROCESS | 19038 | Values: 149.0 147.0 147.0 147.0 147.0 148.0 147.0 148.0 149.0 146.0 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - PROCESS | 19038 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 04:16:06 INFO - PROCESS | 19038 | Values: 95.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - PROCESS | 19038 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:58.50 stddev:1.76 (3.0%) stddev-sans-first:1.50 04:16:06 INFO - PROCESS | 19038 | Values: 62.0 58.0 58.0 58.0 58.0 58.0 62.0 60.0 59.0 57.0 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - PROCESS | 19038 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:1.48 (2.2%) stddev-sans-first:1.56 04:16:06 INFO - PROCESS | 19038 | Values: 68.0 72.0 68.0 68.0 68.0 69.0 67.0 67.0 67.0 68.0 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - PROCESS | 19038 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:89.50 stddev:3.75 (4.2%) stddev-sans-first:3.71 04:16:06 INFO - PROCESS | 19038 | Values: 86.0 95.0 90.0 89.0 88.0 98.0 88.0 88.0 90.0 87.0 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - PROCESS | 19038 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:126.00 stddev:6.37 (5.1%) stddev-sans-first:6.75 04:16:06 INFO - PROCESS | 19038 | Values: 126.0 126.0 128.0 133.0 119.0 125.0 120.0 118.0 119.0 137.0 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - PROCESS | 19038 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:156.00 stddev:7.73 (5.0%) stddev-sans-first:7.17 04:16:06 INFO - PROCESS | 19038 | Values: 143.0 169.0 149.0 155.0 157.0 145.0 160.0 151.0 158.0 150.0 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - PROCESS | 19038 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.29 (1.9%) stddev-sans-first:1.32 04:16:06 INFO - PROCESS | 19038 | Values: 67.0 68.0 68.0 68.0 66.0 70.0 68.0 70.0 67.0 67.0 04:16:06 INFO - PROCESS | 19038 | -------- Summary: end -------- 04:16:06 INFO - PROCESS | 19038 | 04:16:06 INFO - TEST-INFO | 19038: exit 0 04:16:06 INFO - TEST-OK | kraken | took 60036ms 04:16:06 INFO - TEST-START | v8_7 04:16:06 INFO - operating with platform_type : linux_ 04:16:06 INFO - Initialising browser for v8_7 test... 04:16:06 INFO - TEST-INFO | started process 19325 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkRTCzt/profile http://localhost:56912/getInfo.html) 04:16:11 INFO - PROCESS | 19325 | __metrics Screen width/height:1600/1200 04:16:11 INFO - PROCESS | 19325 | colorDepth:24 04:16:11 INFO - PROCESS | 19325 | Browser inner width/height: 1024/697 04:16:11 INFO - PROCESS | 19325 | __metrics 04:16:11 INFO - PROCESS | 19325 | 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:12 INFO - TEST-INFO | 19325: exit 0 04:16:12 INFO - Browser initialized. 04:16:12 INFO - Running cycle 1/1 for v8_7 test... 04:16:12 INFO - TEST-INFO | started process 19449 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkRTCzt/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:24 INFO - PROCESS | 19449 | RSS: Main: 150818816 04:16:24 INFO - PROCESS | 19449 | 04:16:45 INFO - PROCESS | 19449 | Cycle 1(1): loaded http://localhost:56912/tests/v8_7/run.html (next: http://localhost:56912/tests/v8_7/run.html) 04:16:46 INFO - PROCESS | 19449 | RSS: Main: 147075072 04:16:46 INFO - PROCESS | 19449 | 04:16:46 INFO - PROCESS | 19449 | __start_tp_report 04:16:46 INFO - PROCESS | 19449 | _x_x_mozilla_page_load 04:16:46 INFO - PROCESS | 19449 | _x_x_mozilla_page_load_details 04:16:46 INFO - PROCESS | 19449 | |i|pagename|runs| 04:16:46 INFO - PROCESS | 19449 | |0;Richards;166.5278934221482 04:16:46 INFO - PROCESS | 19449 | |1;DeltaBlue;193.98642095053347 04:16:46 INFO - PROCESS | 19449 | |2;Encrypt;282.9654782116582 04:16:46 INFO - PROCESS | 19449 | |3;Decrypt;5148.717948717948 04:16:46 INFO - PROCESS | 19449 | |4;RayTrace;1044.932079414838 04:16:46 INFO - PROCESS | 19449 | |5;Earley;702.7406886858749 04:16:46 INFO - PROCESS | 19449 | |6;Boyer;12219.512195121952 04:16:46 INFO - PROCESS | 19449 | |7;RegExp;25450 04:16:46 INFO - PROCESS | 19449 | |8;Splay;680.2721088435375 04:16:46 INFO - PROCESS | 19449 | |9;NavierStokes;4845.410628019324 04:16:46 INFO - PROCESS | 19449 | __end_tp_report 04:16:46 INFO - PROCESS | 19449 | __startTimestamp1450786606111__endTimestamp 04:16:46 INFO - PROCESS | 19449 | 04:16:46 INFO - PROCESS | 19449 | ------- Summary: start ------- 04:16:46 INFO - PROCESS | 19449 | Number of tests: 10 04:16:46 INFO - PROCESS | 19449 | 04:16:46 INFO - PROCESS | 19449 | [#0] Richards Cycles:1 Average:166.53 Median:166.53 stddev:0.00 (0.0%) 04:16:46 INFO - PROCESS | 19449 | Values: 166.5 04:16:46 INFO - PROCESS | 19449 | 04:16:46 INFO - PROCESS | 19449 | [#1] DeltaBlue Cycles:1 Average:193.99 Median:193.99 stddev:0.00 (0.0%) 04:16:46 INFO - PROCESS | 19449 | Values: 194.0 04:16:46 INFO - PROCESS | 19449 | 04:16:46 INFO - PROCESS | 19449 | [#2] Encrypt Cycles:1 Average:282.97 Median:282.97 stddev:0.00 (0.0%) 04:16:46 INFO - PROCESS | 19449 | Values: 283.0 04:16:46 INFO - PROCESS | 19449 | 04:16:46 INFO - PROCESS | 19449 | [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 04:16:46 INFO - PROCESS | 19449 | Values: 5148.7 04:16:46 INFO - PROCESS | 19449 | 04:16:46 INFO - PROCESS | 19449 | [#4] RayTrace Cycles:1 Average:1044.93 Median:1044.93 stddev:0.00 (0.0%) 04:16:46 INFO - PROCESS | 19449 | Values: 1044.9 04:16:46 INFO - PROCESS | 19449 | 04:16:46 INFO - PROCESS | 19449 | [#5] Earley Cycles:1 Average:702.74 Median:702.74 stddev:0.00 (0.0%) 04:16:46 INFO - PROCESS | 19449 | Values: 702.7 04:16:46 INFO - PROCESS | 19449 | 04:16:46 INFO - PROCESS | 19449 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 04:16:46 INFO - PROCESS | 19449 | Values: 12219.5 04:16:46 INFO - PROCESS | 19449 | 04:16:46 INFO - PROCESS | 19449 | [#7] RegExp Cycles:1 Average:25450.00 Median:25450.00 stddev:0.00 (0.0%) 04:16:46 INFO - PROCESS | 19449 | Values: 25450.0 04:16:46 INFO - PROCESS | 19449 | 04:16:46 INFO - PROCESS | 19449 | [#8] Splay Cycles:1 Average:680.27 Median:680.27 stddev:0.00 (0.0%) 04:16:46 INFO - PROCESS | 19449 | Values: 680.3 04:16:46 INFO - PROCESS | 19449 | 04:16:46 INFO - PROCESS | 19449 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 04:16:46 INFO - PROCESS | 19449 | Values: 4845.4 04:16:46 INFO - PROCESS | 19449 | -------- Summary: end -------- 04:16:46 INFO - PROCESS | 19449 | 04:16:47 INFO - TEST-INFO | 19449: exit 0 04:16:47 INFO - TEST-OK | v8_7 | took 40113ms 04:16:47 INFO - SUITE-END | took 1210s 04:16:47 INFO - Completed test suite (00:20:10) 04:16:47 INFO - Working with test: dromaeo_css 04:16:47 INFO - Generating results file: dromaeo_css 04:16:47 INFO - Working with test: kraken 04:16:47 INFO - Generating results file: kraken 04:16:47 INFO - javascript benchmark 04:16:47 INFO - Working with test: v8_7 04:16:47 INFO - Generating results file: v8_7 04:16:47 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:16:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 04:16:47 INFO - process_Request line: dromaeo_css 6932.54 graph.html#tests=[[72,63,43]] 04:16:47 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:16:47 INFO - process_Request line: kraken 1525.40 graph.html#tests=[[232,63,43]] 04:16:47 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:16:47 INFO - process_Request line: v8_7 21113.03 graph.html#tests=[[230,63,43]] 04:16:47 INFO - RETURN: dromaeo_css: 6932.54 04:16:47 INFO - RETURN: kraken: 1525.40 04:16:47 INFO - RETURN: v8_7: 21113.03 04:16:47 INFO - javascript benchmark 04:16:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3187.8246696431693, 3238.1418923985134, 3254.9349013019755, 3271.345730853829, 3279.622843373011, 5292.338457692788, 5441.537469315108, 5484.561235101192, 5512.696801675911, 5524.5856560758, 5371.140617501201, 5424.620276580641, 5461.563074954004, 5493.945060549393, 5516.613837031409, 4630.722156670594, 4936.432310284309, 4994.101061808873, 5020.548150666439, 5031.396232452093, 4819.277108433728, 5002.649814512967, 5024.974875125619, 5063.544281014708, 5079.746012699368, 4836.806527738886, 4886.193778026622, 4974.328465657126, 4982.451930287665, 4987.975060124712, 4956.083124621957, 5064.012517559077, 5071.087204303224, 5103.18349064148, 5106.489351064901, 4866.270059491069, 4949.0, 5015.1975683890405, 5024.296598476216, 5060.443351231362, 5138.229265610151, 5194.506521880416, 5209.088409528317, 5225.555827754645, 5285.207218917155, 5880.794172203995, 5935.91096133554, 5950.9107363389585, 5960.105984102376, 5966.940330596682, 5809.7676092956235, 5835.387284335126, 5904.61619994699, 6004.6997650117755, 6017.428344307284, 5418.187271909245, 5437.891242175135, 5438.211459338413, 5444.3194600674915, 5454.481824226732, 5953.880922381615, 5954.583179177503, 5958.255218097738, 5961.5230781537375, 5970.164177015221, 5550.611457197957, 5649.830505084854, 5699.971500142473, 5758.193852860602, 5807.88384232313, 5779.797707080232, 5869.20765696634, 5875.265591801025, 5883.911741323884, 5888.9705551472825, 5772.509336706343, 5801.419858014249, 5840.912386314209, 5849.795257165979, 5858.560607954335, 5718.970585294687, 5775.960327141155, 5822.621529600647, 5837.182794408786, 5882.49998750111, 4475.5748203920575, 4487.528809475023, 4500.054988452462, 4522.3668686383935, 4538.546145385501, 3931.233409485123, 4001.479807625048, 4004.039030632627, 4027.073773032219, 4045.696572757055, 5372.086745253317, 5384.6769193848495, 5385.192221166778, 5393.9730301348245, 5397.460253974571, 5834.941650583524, 5851.736671849777, 5873.119032145127, 5875.236219291465, 5985.760569577168, 5421.566274698014, 5430.049741295257, 5441.863953401117, 5449.264349312872, 5454.072807622713, 5081.187010078444, 5090.541851233407, 5093.9490605094215, 5098.1842905135, 5122.154844450624, 5734.197212390269, 5830.912536311958, 5944.673042982591, 6079.878402431927, 6103.542234332443, 5661.801836935688, 5733.426657334233, 5740.0, 5747.080467125407, 5766.826995190151, 5874.559408044328, 5883.352831188651, 5904.055351143968, 5916.615419997686, 5917.674527900835, 5666.405027472056, 5778.191053252464, 5781.392953739797, 5782.710864456844, 5786.479216870333, 5772.797952071657, 5837.737301821513, 5872.941270587239, 5873.4126587340925, 5884.6469211847425, 5751.9424805751405, 5757.596968212185, 5760.6255593386295, 5770.13447982806, 5770.307563092288, 5745.683987380567, 5765.019946609171, 5769.913451298318, 5812.360640329645, 5825.737841797214, 5424.891502170013, 5519.061759500814, 5566.944330556643, 5678.68767217807, 5682.488576028178, 5764.279465066867, 5769.653820770767, 5784.045632470596, 5803.0, 5831.94168058331, 5367.704776237344, 5686.687232202103, 5689.971550142222, 5696.401877802937, 5704.914426283692], "unit": "score", "name": "dojo.html", "value": 5377.097485150076}, {"lowerIsBetter": false, "replicates": [551.0411883323017, 566.7223060700259, 594.6016169166661, 603.2097951683295, 607.3380015782795, 36762.44856327154, 36790.44814327787, 36852.815735921286, 36890.44664330037, 37018.62981370189, 42317.0, 42812.571874281246, 43092.138157236834, 43117.0, 43235.0, 8740.781480462976, 8880.689175878846, 8884.73345799627, 8910.42082264654, 8936.374453788238, 8648.437851539662, 8760.299176065932, 8776.2101410873, 8802.339824513156, 8808.207261346477, 8648.870266946002, 8774.210321071103, 8791.736247912573, 8829.249513791336, 8840.160184782468, 8716.477011379338, 8739.781505462319, 8755.518446485472, 8813.074627164184, 8823.029466758651, 8565.914340856574, 8669.393142480028, 8669.479831210085, 8682.262007729287, 8700.869486957701, 39734.0, 39763.0, 39794.60205397967, 40193.97575303087, 40292.0, 3312.337532493487, 3315.088350703576, 3363.1423986883433, 3366.1416338833687, 3508.1580420698847, 29036.0, 29054.854725726236, 29181.27046823825, 30000.249993750112, 30330.090097297118, 3737.439384092381, 3748.287825313209, 3763.6424539668687, 3784.1674831537016, 3807.8667246646232, 253335.0, 255186.0, 255188.0, 255509.0, 256747.0, 56998.0, 57019.42980570141, 57599.424005760244, 57758.42241577614, 57818.7109064452, 69161.65419172872, 70172.29827701657, 70218.64890675616, 70463.2953670467, 70517.0, 15071.171085590398, 15141.091534507965, 15194.088354698753, 15200.543983680507, 15201.391944322324, 11515.539378424937, 11550.249233799776, 11604.76790464186, 11665.358405287621, 11668.94165529184, 19632.509187270432, 19884.801151988584, 19907.900460497603, 19986.70019949702, 20081.39755807328, 7625.577165244145, 7772.961135194288, 7870.724524641724, 7969.481983671043, 8041.0, 957.6504575829912, 963.205355581648, 990.9009099090177, 993.4337427666305, 1036.7926414717087, 28893.56659650107, 29176.124716258546, 30964.22589435282, 30998.0, 32127.0, 1052.610534102387, 1066.4880857188593, 1069.0165048155716, 1112.449337577904, 1159.7332613498775, 13473.865261347457, 13567.0, 13600.0, 13757.656058598615, 13804.861951380357, 247473.0, 249352.0, 249540.0, 250327.0, 251027.0, 45208.773956130666, 45267.54732452699, 45319.09361812745, 45360.3195952061, 45568.772156139006, 1308.5158491358259, 1330.846952600444, 1349.7637913365122, 1373.8488766235905, 1377.7313423882447, 24890.128845490322, 25612.615810763225, 25853.0, 26037.0, 26172.214833555023, 41034.38448423336, 41534.0, 41537.16925661409, 41884.79057604692, 42394.15211695687, 293172.0, 294368.0, 294751.0, 294956.0, 295300.0, 30657.540136897518, 31753.68246317507, 32096.518552222202, 32161.67838321587, 32204.355912881143, 37366.62633373631, 37668.62331376761, 38125.237495249385, 38235.61764382321, 38561.80719096387, 32079.518807218377, 32418.67581324251, 32672.836635816668, 32709.836450817595, 33052.66947330496, 31964.68035319617, 32030.519542207352, 32498.512522312656, 35438.64561354354, 36775.816120919226, 32374.0, 32559.0, 33165.668343316254, 34713.479297811056, 34900.127496811765, 30713.539296910116, 31524.842375787975, 32128.0, 32527.0, 32648.510272346408, 24705.25884223476, 24792.380190495383, 24846.25461236166, 24934.251972440856, 25134.748652513972], "unit": "score", "name": "ext.html", "value": 18001.71921590044}, {"lowerIsBetter": false, "replicates": [357.04312442653696, 362.2176099624811, 362.53052297275025, 363.8399104394067, 368.5282837967401, 16017.519474415772, 16485.50543483696, 17221.483355499324, 17347.04591247481, 17982.100894955267, 10829.945850270757, 10840.728981775459, 10918.50866710998, 10990.505427255772, 11001.669949901496, 4385.627221686161, 4823.083614113307, 4849.4841240101, 4922.753862306889, 4934.185859333205, 4967.950320496785, 4979.253112033206, 4985.750712464381, 4991.425986011619, 4995.5753760930365, 4972.254161875711, 4973.950260497403, 5070.569001634865, 5195.090859099661, 5212.765425555859, 5196.29849970253, 5198.506141916512, 5210.374755029383, 5226.137687281594, 5431.4840090191365, 5278.181881808326, 5297.12597421425, 5300.0459917214885, 5330.067238233293, 5342.118550439173, 19412.12645430959, 19462.416127516197, 19476.4157075288, 19803.207871685114, 19848.206071757257, 2011.6278488479677, 2088.9268875589432, 2103.4531021934254, 2169.425102347879, 2225.187806450634, 9289.814203715956, 9414.764630884283, 9440.2919781016, 9478.431294122374, 9647.421154730668, 1854.1192933356683, 1877.5681593233496, 1892.7255547945608, 1983.6726940055019, 2018.4852862519963, 56695.0, 58914.41085589132, 59021.40978590202, 59288.0, 59391.40608593945, 10355.585776569003, 10437.425941573287, 10468.47657617116, 10477.895221047844, 10509.684709458728, 13303.40134693941, 13350.465981360638, 13413.463461461432, 13460.461581536825, 13497.392617332243, 7617.162112167657, 7620.618969051525, 7644.0, 7655.540667559964, 7722.0, 7276.417886569062, 7298.2701729826595, 7298.4891057625455, 7321.78034658961, 7338.302861228175, 4472.837062363744, 4523.638108951342, 4567.817287308537, 4569.543045695404, 4577.656675749332, 1814.5191524246086, 1874.6157037807218, 1899.3542195653545, 1909.8731748268588, 1931.169597073272, 435.33611242854266, 436.11033491677256, 441.9005723712139, 468.9132510485503, 471.2342443529265, 10386.221033422524, 10731.624393146203, 10888.020078192842, 11407.08743300534, 11548.307101573933, 453.1277291214399, 471.0367298873811, 891.7280229530055, 915.3272344826547, 919.7332773495611, 8786.692465763668, 9462.668806591737, 9757.707268781947, 9876.654317098866, 9881.308308418485, 527072.0, 528655.0, 534548.0, 534708.0, 540821.0, 80412.59793701112, 81504.59247703724, 82584.17415825884, 83505.58247208725, 83859.0, 1151.9862520981483, 1173.9823902641467, 1177.1465687376754, 1180.4805885410392, 1184.3959580613948, 14466.493672721404, 15785.28966196501, 15797.526074217792, 15891.682166356839, 15892.443764468188, 33853.0, 33933.830330849174, 35124.473132903535, 35351.46972795359, 35670.464943026396, 39849.60150398575, 39977.400338994354, 40868.1826363477, 41326.38010429906, 41378.96552586209, 9024.187823095954, 9180.44917304964, 9338.766530836783, 10053.849192261976, 10062.245331600305, 16486.83513164853, 17180.0, 17492.212850421507, 17528.0, 17792.110394479965, 13742.0, 14350.569482915529, 14566.417343306573, 14638.707225855636, 14672.3397447113, 13721.382537785625, 13981.091229070078, 14035.92982035124, 14121.08212966154, 14617.488387906373, 6342.714577843916, 9439.19766819828, 14980.475683351466, 15097.622559435662, 15306.617334566725, 9544.713658590254, 9705.0, 9882.258830587878, 9944.303898727308, 9961.50192490387, 14829.0, 15004.624884377541, 15055.0, 15179.468718594797, 15387.38450461969], "unit": "score", "name": "jquery.html", "value": 8365.78343593352}, {"lowerIsBetter": false, "replicates": [1461.2474575593571, 1516.3252352703053, 1586.3733825139063, 1664.5006498050582, 1772.5391398236463, 7203.243659415764, 7216.386607138399, 7454.291842274982, 7501.924980750184, 7519.473636845423, 7446.329830315271, 7451.1058672959325, 7469.962650186755, 7478.364339031175, 7540.585267810282, 2226.977730222697, 2254.2448279826194, 2266.829987750917, 2268.7050683411135, 2270.8523945943543, 2231.85492942959, 2247.3370355745014, 2278.214016164429, 2279.851809632377, 2280.646499792535, 2164.9242276520326, 2210.4363387336207, 2219.755826859044, 2231.14101071088, 2232.810211132056, 2175.8368122390884, 2206.1175529788134, 2226.4879077812193, 2248.168177774218, 2260.3557985974085, 2270.9886450567806, 2292.873891935943, 2293.6100862853186, 2300.2524179641514, 2302.6085565453914, 7146.2496437874315, 7262.891056634155, 7271.600061996588, 7272.16370117438, 7273.018142550741, 4457.130859482402, 4518.457785065781, 4526.253168227238, 4526.841560545365, 4527.388802511652, 2967.8516074196204, 2968.673445920947, 3050.603421555206, 3057.480228361184, 3060.1125673554643, 944.6788092048668, 964.7829238421369, 982.0719420147963, 995.1789773436872, 1002.644061358222, 9761.755956101084, 9765.609375624967, 9797.922228554924, 9814.362066465728, 9836.06557377048, 3897.2205558888336, 3949.150932549516, 3974.5627980922077, 3984.023914141054, 4056.51321841375, 8040.919590804017, 8101.959490202511, 8106.229908158715, 8122.228388303101, 8124.22819832115, 4427.75647339393, 4451.243288640939, 4455.1312494064, 4465.933011004838, 4481.551844815493, 4047.757134571876, 4060.2488539620263, 4060.3706425504092, 4067.654249388776, 4089.386592011222, 3332.966670333314, 3342.1978725106287, 3342.665733426638, 3353.84907679155, 3370.4944258361443, 1023.3910823060417, 1050.2805578178973, 1055.488088277185, 1061.6761887624348, 1079.3955384984433, 1034.379372376583, 1035.1098055672117, 1089.9782004359868, 1195.9521619135312, 1363.311527678516, 6607.075009498674, 6673.432758215606, 6676.298988606223, 6693.0, 6698.631575263407, 1129.949152288149, 1133.484264659578, 1136.852209212797, 1139.641013080877, 1157.4212893553224, 5564.610477266633, 5586.0, 5601.131824567198, 5607.551395888319, 5612.214289999403, 8580.65677372898, 8653.307735381155, 8826.823463530693, 8877.289816814638, 8892.510911899779, 8694.826103477895, 8699.043105258417, 8716.346274029473, 8744.475331480131, 8775.824483510294, 6715.39561439463, 6817.488688348294, 6852.383285504328, 6882.070920425678, 6897.7585784497305, 6618.404343609098, 6674.132362792806, 6680.565763225569, 6682.131322927989, 6694.564853284521, 7561.508501947355, 7706.07527096752, 7708.460407771402, 7762.844743105219, 7798.298153166243, 7753.844923101619, 7808.453408261367, 7878.133405325524, 7927.326177274997, 7943.6822527100585, 6107.84730381744, 6123.326434092335, 6174.753009879554, 6189.597676151036, 6193.256809182927, 6874.381305682513, 6894.24163342042, 6923.688434020381, 6958.0, 6965.7213711453005, 6490.870182596227, 6552.967235163794, 6575.24384695747, 6634.9004764927595, 6639.867202656016, 6699.162604674416, 6727.260001399744, 6751.696173672099, 6764.695588698619, 6814.1482314710665, 6570.737170513126, 6654.101696270942, 6678.198616166092, 6715.56348837324, 6732.562383445256, 6197.752089916533, 6231.9688401557705, 6240.032794916795, 6281.340459251713, 6302.621842689453, 6223.813285601439, 6242.65665388408, 6297.685115744286, 6320.209973753281, 6345.746170153327], "unit": "score", "name": "mootools.html", "value": 4272.311958669028}, {"lowerIsBetter": false, "replicates": [341.53210102160034, 344.9292894956533, 350.58980992239077, 352.4677736617708, 352.7072529800266, 6318.652474113922, 6319.304876463591, 6321.905171422421, 6369.490440764739, 6475.870482590345, 6180.598261113036, 6260.812175634727, 6261.060840873871, 6296.275928268251, 6303.0, 4836.250381190921, 4857.489963553829, 4859.684120532154, 4866.780994855222, 4878.585320247775, 4866.124097662419, 4866.951330486703, 4870.293807397925, 4871.951280487203, 4874.610031197496, 4709.9058018839605, 4819.6867203631655, 4821.421429428456, 4826.203676393408, 4844.442889067767, 4797.208460604013, 4801.639877009238, 4823.469418363977, 4824.17988941879, 4839.05638400512, 4225.429567008446, 4232.492100947875, 4232.830686772525, 4233.809478573472, 4239.660827133853, 5921.467067963904, 5950.137230101611, 5952.523798096142, 5961.254843144607, 5967.970160149215, 5509.917351239735, 5629.155626655994, 5649.0, 5653.208550802891, 5655.688937108457, 6703.1285932828905, 6709.563878347941, 6716.83207919801, 6724.764633237862, 6728.529002969794, 4671.649626278008, 4676.812927482896, 4684.0397718467975, 4685.5314468553215, 4686.08621318843, 6871.072405225281, 6911.723531058751, 6963.721451141948, 6979.022936788904, 6980.546264492842, 4788.0, 4792.544708252711, 4798.520147985174, 4802.6638135330195, 4817.445993710698, 4870.6103511718975, 4871.878203044952, 4880.292357608127, 4881.389826271716, 4885.267209918541, 5603.243562119062, 5604.747786349624, 5607.943920560824, 5618.662880227118, 5626.043572592669, 6526.967365163144, 6737.157855268091, 6741.022551729971, 6745.156855393076, 6763.492738044568, 1693.1195778195515, 1706.2833609883878, 1708.871834612409, 1722.4057700093447, 1722.6813039587717, 1142.714321419645, 1152.5793085523892, 1155.5031336525208, 1173.5775120956448, 1175.2419689300352, 6106.755729770848, 6175.660338681416, 6189.907151392733, 6194.194754681863, 6200.0699895016105, 6756.695948682321, 6770.593764374154, 6778.254392016973, 6790.49071319653, 6796.25241223465, 6067.605605635619, 6130.63216207029, 6150.384961503813, 6184.381561843779, 6187.288461826947, 3713.721470889694, 3742.85028598853, 3743.9064023399633, 3745.9063523412133, 3747.569029561581, 6988.44092472601, 7013.579185248901, 7013.824654383681, 7045.189803172599, 7049.541779784297, 6920.8961865572055, 7077.92922070783, 7093.929060709327, 7107.680154393065, 7111.857762844714, 6969.756058537927, 6988.37104660583, 7011.193712723102, 7012.719491220294, 7018.649067546704, 6748.325167483213, 6824.658767061528, 6832.180138383425, 6843.315668433117, 6845.5550389224545, 6644.4020038196795, 6768.864622707617, 6792.660366981532, 6793.286704895915, 6798.422134118655, 6985.0220969065385, 6996.930030699831, 7000.8949865753075, 7004.964975175091, 7016.631756807374, 4794.928076078932, 4809.158397280532, 4820.25286080658, 4823.962847987559, 4826.276058591099, 6809.080774095632, 6811.421029212573, 6820.283870193757, 6826.556273842184, 6957.199922009034, 6733.3939945405145, 6761.966190169018, 6779.694913728796, 6783.0, 6786.287439818748, 6739.0902228198565, 6742.898856517058, 6748.392644662004, 6752.5948443093575, 6753.729850806109, 6508.902366464412, 6565.0, 6630.171228596426, 6634.137562116894, 6646.9335306648245, 6793.252742198255, 6809.285025072296, 6821.727130914708, 6824.727010919706, 6825.590464572141, 6638.402543771083, 6641.867162656817, 6642.933570664425, 6644.767433139817, 6652.866942661217], "unit": "score", "name": "prototype.html", "value": 5043.801895856246}, {"lowerIsBetter": false, "replicates": [770.7071312901098, 840.4495055738489, 858.4463021351229, 862.3446180902512, 867.8708830809911, 13466.46134154634, 13689.520866769664, 13768.105073170236, 13862.02965792395, 15242.390304387838, 15046.849531504682, 15108.848911510882, 15146.84853151471, 15149.924250378761, 15164.090154590733, 829.5893532701322, 842.5450256861287, 858.4291446188278, 860.0883063952231, 861.6639510590875, 848.8429640516493, 852.0797538658265, 852.9445586036919, 855.3926712034463, 857.1171693156059, 880.5377176982104, 885.2608072259671, 890.559173209259, 890.7149712092133, 891.1489527501253, 878.5168157513342, 882.9514376709278, 885.1900511032397, 887.8668199770021, 890.2388457868494, 646.5280345347875, 647.5920170292733, 651.6513665189149, 655.1352215076101, 658.8451713847242, 13917.23455209963, 14009.649758756012, 14051.086679365808, 14064.437422503088, 14128.576142715736, 11185.217034807567, 11710.941445292805, 12426.813597796041, 12486.063545234143, 12709.682257943532, 10317.329373590692, 10330.7417314567, 10524.894751052469, 10592.523336449802, 10635.042846143806, 3591.730620203495, 3643.3988391915304, 3666.450032495147, 3759.830807613664, 3783.0920579060826, 45738.31392529115, 46064.0, 46140.30789538159, 46198.76900615509, 47544.52455475435, 9093.863592046124, 9294.209992150607, 9351.53242337894, 9455.52722363879, 9729.805403891882, 16025.679486410207, 16113.0, 16213.918930405272, 16221.188940552925, 16247.106409147375, 7167.3549380556, 7286.307800758919, 7361.337479626859, 7534.472586918863, 7599.0, 4226.408302837605, 4363.738175709467, 4368.7815609219415, 4373.1472362888935, 4419.0, 3025.0924722583577, 3042.3154790172475, 3044.4519986402215, 3062.7090426409454, 3066.5400189971683, 527.2065541360305, 547.2475346398702, 555.919391688203, 556.1657513729406, 557.2477155839584, 585.4847733994143, 611.1535523300183, 623.4513628007415, 630.8769789891019, 676.1446769836062, 8206.384521160937, 8229.0, 8243.670253189925, 8259.21537453941, 8588.656453741905, 520.9244659524347, 570.2842932120162, 689.0431175461713, 693.7051753004953, 734.5409119300438, 3728.3102626014274, 3761.6426439488205, 3894.201688653819, 3935.2129574084724, 4244.766537840448, 56957.14564281539, 59141.40858591359, 59379.0, 60583.69708151431, 61431.0, 48516.5148348512, 49304.0, 49324.75337623289, 49994.75002624963, 50004.49995500071, 46039.76980115078, 46229.30656040162, 46984.76507617372, 47263.29105063427, 47453.10187592527, 8160.469569477965, 8184.0, 8463.788405289672, 8541.14588541141, 8608.268297194809, 34916.30167396587, 35087.71929824496, 35275.470867936485, 35381.82309088438, 35517.0, 45108.77445612751, 45681.0, 45750.54249457463, 45903.3114503276, 46229.76885115553, 10916.890831091587, 11311.660650180507, 11388.715282118013, 11441.19911606213, 11576.073914087021, 12145.271283723005, 12296.262224266573, 12364.319962402154, 12736.872631273569, 12803.87196128064, 11437.656870293904, 11716.0, 11796.351200684045, 11955.043596512432, 12291.201071930296, 11232.550697972316, 11712.531498740296, 11735.76528469443, 12001.1599188056, 12081.456334465145, 11230.887691123311, 11261.7747645045, 11455.942720286344, 11609.419529023684, 11680.47437865315, 9673.177779888507, 9786.951065244628, 9807.215422766305, 9866.062724041205, 10206.336588121749, 8574.185452382264, 9317.589234872692, 9498.430094194371, 9891.455969921435, 10060.899391006289], "unit": "score", "name": "yui.html", "value": 6361.041630162214}], "name": "dromaeo_css", "value": 6932.540998352055}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 112.0, 110.0, 110.0, 124.0, 111.0, 111.0, 114.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [150.0, 125.0, 153.0, 162.0, 127.0, 151.0, 155.0, 127.0, 157.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 143.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 164.0, 162.0, 168.0, 162.0, 163.0, 163.0, 181.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.8}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 71.0, 71.0, 73.0, 153.0, 72.0, 71.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 142.0, 94.0, 93.0, 94.0, 137.0, 94.0, 93.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 108.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 111.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 149.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [62.0, 58.0, 58.0, 58.0, 58.0, 58.0, 62.0, 60.0, 59.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.0}, {"lowerIsBetter": true, "replicates": [68.0, 72.0, 68.0, 68.0, 68.0, 69.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [86.0, 95.0, 90.0, 89.0, 88.0, 98.0, 88.0, 88.0, 90.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.9}, {"lowerIsBetter": true, "replicates": [126.0, 126.0, 128.0, 133.0, 119.0, 125.0, 120.0, 118.0, 119.0, 137.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.1}, {"lowerIsBetter": true, "replicates": [143.0, 169.0, 149.0, 155.0, 157.0, 145.0, 160.0, 151.0, 158.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 66.0, 70.0, 68.0, 70.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1525.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.5278934221482], "unit": "score", "name": "Richards", "value": 211.98851000000005}, {"lowerIsBetter": false, "replicates": [193.98642095053347], "unit": "score", "name": "DeltaBlue", "value": 340.8382899999999}, {"lowerIsBetter": false, "replicates": [282.9654782116582], "unit": "score", "name": "Encrypt", "value": 940.6836540000003}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [1044.932079414838], "unit": "score", "name": "RayTrace", "value": 708.1694730000004}, {"lowerIsBetter": false, "replicates": [702.7406886858749], "unit": "score", "name": "Earley", "value": 948.3768489999995}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [25450.0], "unit": "score", "name": "RegExp", "value": 35.79508840864438}, {"lowerIsBetter": false, "replicates": [680.2721088435375], "unit": "score", "name": "Splay", "value": 119.79176999999999}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21113.03385450812}]} 04:16:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21113.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1525.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6932.54"}}} 04:16:47 INFO - Return code: 0 04:16:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:16:47 INFO - # TBPL SUCCESS # 04:16:47 INFO - Running post-action listener: _resource_record_post_action 04:16:47 INFO - Running post-run listener: _resource_record_post_run 04:16:48 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8192; Write bytes: 557604864; Read time: 144; Write time: 714012 04:16:48 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 235171840; Read time: 136; Write time: 399756 04:16:48 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322433024; Read time: 8; Write time: 314256 04:16:48 INFO - Running post-run listener: _upload_blobber_files 04:16:48 INFO - Blob upload gear active. 04:16:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:16:48 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:48 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:48 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:48 INFO - (blobuploader) - INFO - Open directory for files ... 04:16:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:16:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:16:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:49 INFO - (blobuploader) - INFO - Done attempting. 04:16:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:16:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:16:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:50 INFO - (blobuploader) - INFO - Done attempting. 04:16:50 INFO - (blobuploader) - INFO - Iteration through files over. 04:16:50 INFO - Return code: 0 04:16:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:16:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:16:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3e222f486aa8d419be7d4c86eb96f66e97d45e4cc22212d5bee2d6bd757e8d7fb93f6350748acdf26ff1c0f06553cd825e8d6338b4b728f7d4283908963177bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cc1b24a41442f7ead4124b76e7525badc7b3e56ea8e26de62b3ea1dfba10ea893dcfdc1e3de17e5dfd842f03b925ad4e34019802fc0364c843aa5f8a72cdba04"} 04:16:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:16:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:16:50 INFO - Contents: 04:16:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3e222f486aa8d419be7d4c86eb96f66e97d45e4cc22212d5bee2d6bd757e8d7fb93f6350748acdf26ff1c0f06553cd825e8d6338b4b728f7d4283908963177bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cc1b24a41442f7ead4124b76e7525badc7b3e56ea8e26de62b3ea1dfba10ea893dcfdc1e3de17e5dfd842f03b925ad4e34019802fc0364c843aa5f8a72cdba04"} 04:16:50 INFO - Copying logs to upload dir... 04:16:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1280.395754 ========= 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:50.314693) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 04:16:50.317690) ========= 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=70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3e222f486aa8d419be7d4c86eb96f66e97d45e4cc22212d5bee2d6bd757e8d7fb93f6350748acdf26ff1c0f06553cd825e8d6338b4b728f7d4283908963177bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cc1b24a41442f7ead4124b76e7525badc7b3e56ea8e26de62b3ea1dfba10ea893dcfdc1e3de17e5dfd842f03b925ad4e34019802fc0364c843aa5f8a72cdba04"} 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.011329 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3e222f486aa8d419be7d4c86eb96f66e97d45e4cc22212d5bee2d6bd757e8d7fb93f6350748acdf26ff1c0f06553cd825e8d6338b4b728f7d4283908963177bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cc1b24a41442f7ead4124b76e7525badc7b3e56ea8e26de62b3ea1dfba10ea893dcfdc1e3de17e5dfd842f03b925ad4e34019802fc0364c843aa5f8a72cdba04"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 04:16:50.341758) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:16:50.342054) ========= 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=70a720fcaf18edea6683c2dc000001ad-1450785152.66803-864902002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:16:50.424126) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 04:16:50.424441) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 04:16:50.424720) ========= ========= Total master_lag: 0.24 =========