builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1452829611.22 results: success (0) buildid: 20160114173009 builduid: 94ea44a3899a4e339bf82a9956cedcc8 revision: 8fbf073773f141e4305875532d04ec02f564c91b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:51.219334) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:51.219818) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:51.220191) ========= 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=cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006449 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:51.258910) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:51.259225) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:51.294126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:51.294374) ========= 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=cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.029159 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:51.350825) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:51.351099) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:51.351490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:51.351806) ========= 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=cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 19:46:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 205M=0s 2016-01-14 19:46:51 (205 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112986 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:51.477814) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:51.478131) ========= 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=cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.119148 ========= master_lag: 0.15 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:51.742823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:51.743195) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 8fbf073773f141e4305875532d04ec02f564c91b --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/b2g-inbound --rev 8fbf073773f141e4305875532d04ec02f564c91b --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=cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 19:46:51,835 truncating revision to first 12 chars 2016-01-14 19:46:51,835 Setting DEBUG logging. 2016-01-14 19:46:51,835 attempt 1/10 2016-01-14 19:46:51,835 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/8fbf073773f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 19:46:52,107 unpacking tar archive at: b2g-inbound-8fbf073773f1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609404 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:52.365741) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:52.366039) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:52.376079) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:52.376368) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 19:46:52.376756) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-14 19:46:52.377047) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:46:52 INFO - MultiFileLogger online at 20160114 19:46:52 in /builds/slave/test-pgo 19:46:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 19:46:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:46:52 INFO - {'append_to_log': False, 19:46:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:46:52 INFO - 'blob_upload_branch': 'B2G-Inbound', 19:46:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:46:52 INFO - 'branch': 'B2G-Inbound', 19:46:52 INFO - 'buildbot_json_path': 'buildprops.json', 19:46:52 INFO - 'config_files': ('talos/linux_config.py',), 19:46:52 INFO - 'default_actions': ('clobber', 19:46:52 INFO - 'read-buildbot-config', 19:46:52 INFO - 'download-and-extract', 19:46:52 INFO - 'populate-webroot', 19:46:52 INFO - 'create-virtualenv', 19:46:52 INFO - 'install', 19:46:52 INFO - 'run-tests'), 19:46:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:46:52 INFO - 'download_minidump_stackwalk': True, 19:46:52 INFO - 'download_symbols': 'ondemand', 19:46:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:46:52 INFO - 'tooltool.py': '/tools/tooltool.py', 19:46:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:46:52 INFO - '/tools/misc-python/virtualenv.py')}, 19:46:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:46:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:46:52 INFO - 'installer_path': 'installer.exe', 19:46:52 INFO - 'log_level': 'info', 19:46:52 INFO - 'log_name': 'talos', 19:46:52 INFO - 'log_to_console': True, 19:46:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:46:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:46:52 INFO - 'opt_config_files': (), 19:46:52 INFO - 'pip_index': False, 19:46:52 INFO - 'sps_profile': False, 19:46:52 INFO - 'sps_profile_interval': 0, 19:46:52 INFO - 'suite': 'dromaeojs', 19:46:52 INFO - 'system_bits': '32', 19:46:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:46:52 INFO - 'title': 'talos-linux64-ix-054', 19:46:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:46:52 INFO - 'use_talos_json': True, 19:46:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:46:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:46:52 INFO - 'work_dir': 'build'} 19:46:52 INFO - ##### 19:46:52 INFO - ##### Running clobber step. 19:46:52 INFO - ##### 19:46:52 INFO - Running pre-action listener: _resource_record_pre_action 19:46:52 INFO - Running main action method: clobber 19:46:52 INFO - rmtree: /builds/slave/test-pgo/build 19:46:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:46:53 INFO - Running post-action listener: _resource_record_post_action 19:46:53 INFO - ##### 19:46:53 INFO - ##### Running read-buildbot-config step. 19:46:53 INFO - ##### 19:46:53 INFO - Running pre-action listener: _resource_record_pre_action 19:46:53 INFO - Running main action method: read_buildbot_config 19:46:53 INFO - Using buildbot properties: 19:46:53 INFO - { 19:46:53 INFO - "project": "", 19:46:53 INFO - "product": "firefox", 19:46:53 INFO - "script_repo_revision": "production", 19:46:53 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 19:46:53 INFO - "repository": "", 19:46:53 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 19:46:53 INFO - "buildid": "20160114173009", 19:46:53 INFO - "pgo_build": "True", 19:46:53 INFO - "basedir": "/builds/slave/test-pgo", 19:46:53 INFO - "buildnumber": 1113, 19:46:53 INFO - "slavename": "talos-linux64-ix-054", 19:46:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:46:53 INFO - "platform": "ubuntu64_hw", 19:46:53 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 19:46:53 INFO - "branch": "b2g-inbound", 19:46:53 INFO - "repo_path": "integration/b2g-inbound", 19:46:53 INFO - "revision": "8fbf073773f141e4305875532d04ec02f564c91b", 19:46:53 INFO - "stage_platform": "linux64-pgo", 19:46:53 INFO - "builduid": "94ea44a3899a4e339bf82a9956cedcc8", 19:46:53 INFO - "slavebuilddir": "test" 19:46:53 INFO - } 19:46:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:46:53 INFO - Running post-action listener: _resource_record_post_action 19:46:53 INFO - ##### 19:46:53 INFO - ##### Running download-and-extract step. 19:46:53 INFO - ##### 19:46:53 INFO - Running pre-action listener: _resource_record_pre_action 19:46:53 INFO - Running main action method: download_and_extract 19:46:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:46: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')]} 19:46:53 INFO - https://queue.taskcluster.net/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:46:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/test_packages.json 19:46:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/test_packages.json 19:46:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:46:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:46:54 INFO - Downloaded 1448 bytes. 19:46:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:46:54 INFO - Using the following test package requirements: 19:46:54 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:46:54 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:46:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:46:54 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:46:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:46:54 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:46:54 INFO - u'jsshell-linux-x86_64.zip'], 19:46:54 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:46:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:46:54 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:46:54 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:46:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:46:54 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:46:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:46:54 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:46:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:46:54 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:46:54 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:46:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:46:54 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:46: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')]} 19:46:54 INFO - https://queue.taskcluster.net/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:46:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:46:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:46:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/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 19:46:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/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 19:46:57 INFO - Downloaded 24030808 bytes. 19:46:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:46:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:46:58 INFO - Return code: 0 19:46:58 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 19:46: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')]} 19:46:58 INFO - https://queue.taskcluster.net/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:46:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:46:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:46:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/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 19:46:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/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 19:47:02 INFO - Downloaded 24030808 bytes. 19:47:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:47:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:47:03 INFO - Return code: 0 19:47: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')]} 19:47:03 INFO - https://queue.taskcluster.net/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:47:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:47:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:47:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/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 19:47:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/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 19:47:06 INFO - Downloaded 11132144 bytes. 19:47:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:47:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 19:47:06 INFO - Return code: 0 19:47: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')]} 19:47:06 INFO - https://queue.taskcluster.net/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:47:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:47:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:47:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/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 19:47:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUt3zyDeQ2eB5WtSundk3Q/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 19:47:09 INFO - Downloaded 55880912 bytes. 19:47:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:47:09 INFO - mkdir: /builds/slave/test-pgo/properties 19:47:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:47:09 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:47:09 INFO - Contents: 19:47:09 INFO - build_url:https://queue.taskcluster.net/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:47:09 INFO - Running post-action listener: _resource_record_post_action 19:47:09 INFO - Running post-action listener: set_extra_try_arguments 19:47:09 INFO - ##### 19:47:09 INFO - ##### Running populate-webroot step. 19:47:09 INFO - ##### 19:47:09 INFO - Running pre-action listener: _resource_record_pre_action 19:47:09 INFO - Running main action method: populate_webroot 19:47:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:47:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:47:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:47:09 INFO - '--tppagecycles', 19:47:09 INFO - '7'], 19:47:09 INFO - 'tests': ['tsvgm']}}, 19:47:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:47:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:47:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:47:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:47:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:47:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:47:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:47:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:09 INFO - 'talos_options': ['--e10s'], 19:47:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:47:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:09 INFO - 'tests': ['damp', 'tps']}, 19:47:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:09 INFO - 'talos_options': ['--e10s'], 19:47:09 INFO - 'tests': ['damp', 'tps']}, 19:47:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:47:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:47:09 INFO - 'other': {'tests': ['a11yr', 19:47:09 INFO - 'ts_paint', 19:47:09 INFO - 'tpaint', 19:47:09 INFO - 'sessionrestore', 19:47:09 INFO - 'sessionrestore_no_auto_restore']}, 19:47:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:47:09 INFO - 'tests': ['a11yr', 19:47:09 INFO - 'ts_paint', 19:47:09 INFO - 'tpaint', 19:47:09 INFO - 'sessionrestore', 19:47:09 INFO - 'sessionrestore_no_auto_restore']}, 19:47:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:47:09 INFO - 'tests': ['a11yr', 19:47:09 INFO - 'ts_paint', 19:47:09 INFO - 'tpaint', 19:47:09 INFO - 'sessionrestore', 19:47:09 INFO - 'sessionrestore_no_auto_restore']}, 19:47:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:47:09 INFO - 'tests': ['a11yr', 19:47:09 INFO - 'ts_paint', 19:47:09 INFO - 'tpaint', 19:47:09 INFO - 'sessionrestore', 19:47:09 INFO - 'sessionrestore_no_auto_restore']}, 19:47:09 INFO - 'other_l64': {'tests': ['a11yr', 19:47:09 INFO - 'ts_paint', 19:47:09 INFO - 'tpaint', 19:47:09 INFO - 'sessionrestore', 19:47:09 INFO - 'sessionrestore_no_auto_restore']}, 19:47:09 INFO - 'other_nol64': {'tests': ['a11yr', 19:47:09 INFO - 'ts_paint', 19:47:09 INFO - 'tpaint', 19:47:09 INFO - 'sessionrestore', 19:47:09 INFO - 'sessionrestore_no_auto_restore']}, 19:47:09 INFO - 'svgr': {'tests': ['tsvgx', 19:47:09 INFO - 'tsvgr_opacity', 19:47:09 INFO - 'tart', 19:47:09 INFO - 'tscrollx', 19:47:09 INFO - 'cart']}, 19:47:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:47:09 INFO - 'tests': ['tsvgx', 19:47:09 INFO - 'tsvgr_opacity', 19:47:09 INFO - 'tart', 19:47:09 INFO - 'tscrollx', 19:47:09 INFO - 'cart']}, 19:47:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:09 INFO - 'tests': ['tp5o']}, 19:47:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:09 INFO - 'talos_options': ['--e10s'], 19:47:09 INFO - 'tests': ['tp5o']}, 19:47:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:09 INFO - 'talos_options': ['--xperf_path', 19:47:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:47:09 INFO - 'tests': ['tp5n']}, 19:47:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:09 INFO - 'talos_options': ['--e10s', 19:47:09 INFO - '--xperf_path', 19:47:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:47:09 INFO - 'tests': ['tp5n']}}, 19:47:09 INFO - 'talos.zip': {'path': '', 19:47:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:47:09 INFO - Running post-action listener: _resource_record_post_action 19:47:09 INFO - ##### 19:47:09 INFO - ##### Running create-virtualenv step. 19:47:09 INFO - ##### 19:47:09 INFO - Running pre-action listener: _resource_record_pre_action 19:47:09 INFO - Running main action method: create_virtualenv 19:47:09 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:47:09 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 19:47:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:47:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:47:09 INFO - Using real prefix '/usr' 19:47:09 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:47:10 INFO - Installing distribute.............................................................................................................................................................................................done. 19:47:13 INFO - Installing pip.................done. 19:47:13 INFO - Return code: 0 19:47:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:47: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')]} 19:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47: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')]} 19:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa822775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2226630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b7840>, '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 0x22246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2224b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', '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 19:47: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:47: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 pip>=1.5 19:47:13 INFO - Using env: {'DISPLAY': ':0', 19:47:13 INFO - 'HOME': '/home/cltbld', 19:47:13 INFO - 'LANG': 'en_US.UTF-8', 19:47:13 INFO - 'LANGUAGE': 'en_US:en', 19:47:13 INFO - 'LOGNAME': 'cltbld', 19:47:13 INFO - 'MAIL': '/var/mail/cltbld', 19:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:13 INFO - 'MOZ_NO_REMOTE': '1', 19:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:13 INFO - 'NO_EM_RESTART': '1', 19:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:13 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:13 INFO - 'SHELL': '/bin/bash', 19:47:13 INFO - 'SHLVL': '1', 19:47:13 INFO - 'TERM': 'linux', 19:47:13 INFO - 'TMOUT': '86400', 19:47:13 INFO - 'USER': 'cltbld', 19:47:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', 19:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:13 INFO - '_': '/tools/buildbot/bin/python'} 19:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:47:13 INFO - Cleaning up... 19:47:13 INFO - Return code: 0 19:47:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:47: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')]} 19:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47: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')]} 19:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa822775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2226630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b7840>, '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 0x22246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2224b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', '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 19:47:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:47:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:47:13 INFO - Using env: {'DISPLAY': ':0', 19:47:13 INFO - 'HOME': '/home/cltbld', 19:47:13 INFO - 'LANG': 'en_US.UTF-8', 19:47:13 INFO - 'LANGUAGE': 'en_US:en', 19:47:13 INFO - 'LOGNAME': 'cltbld', 19:47:13 INFO - 'MAIL': '/var/mail/cltbld', 19:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:13 INFO - 'MOZ_NO_REMOTE': '1', 19:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:13 INFO - 'NO_EM_RESTART': '1', 19:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:13 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:13 INFO - 'SHELL': '/bin/bash', 19:47:13 INFO - 'SHLVL': '1', 19:47:13 INFO - 'TERM': 'linux', 19:47:13 INFO - 'TMOUT': '86400', 19:47:13 INFO - 'USER': 'cltbld', 19:47:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', 19:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:13 INFO - '_': '/tools/buildbot/bin/python'} 19:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:13 INFO - Downloading/unpacking psutil>=0.7.1 19:47: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 19:47: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 19:47: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 19:47: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 19:47: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 19:47: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 19:47:15 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:47:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:47:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:47:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:47:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:47:15 INFO - Installing collected packages: psutil 19:47:15 INFO - Running setup.py install for psutil 19:47:15 INFO - building 'psutil._psutil_linux' extension 19:47:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:47:15 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 19:47:15 INFO - building 'psutil._psutil_posix' extension 19:47:15 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 19:47:15 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 19:47:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:47:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:47:16 INFO - Successfully installed psutil 19:47:16 INFO - Cleaning up... 19:47:16 INFO - Return code: 0 19:47:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:47: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')]} 19:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47: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')]} 19:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47: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', '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 0x7fa822775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2226630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b7840>, '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 0x22246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2224b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', '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 19:47: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:47: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 mozsystemmonitor==0.0.0 19:47:16 INFO - Using env: {'DISPLAY': ':0', 19:47:16 INFO - 'HOME': '/home/cltbld', 19:47:16 INFO - 'LANG': 'en_US.UTF-8', 19:47:16 INFO - 'LANGUAGE': 'en_US:en', 19:47:16 INFO - 'LOGNAME': 'cltbld', 19:47:16 INFO - 'MAIL': '/var/mail/cltbld', 19:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:16 INFO - 'MOZ_NO_REMOTE': '1', 19:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:16 INFO - 'NO_EM_RESTART': '1', 19:47:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:16 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:16 INFO - 'SHELL': '/bin/bash', 19:47:16 INFO - 'SHLVL': '1', 19:47:16 INFO - 'TERM': 'linux', 19:47:16 INFO - 'TMOUT': '86400', 19:47:16 INFO - 'USER': 'cltbld', 19:47:16 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', 19:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:16 INFO - '_': '/tools/buildbot/bin/python'} 19:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:47: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 19:47: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 19:47: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 19:47: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 19:47: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 19:47: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 19:47:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:47:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:47:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:47:18 INFO - Installing collected packages: mozsystemmonitor 19:47:18 INFO - Running setup.py install for mozsystemmonitor 19:47:18 INFO - Successfully installed mozsystemmonitor 19:47:18 INFO - Cleaning up... 19:47:18 INFO - Return code: 0 19:47:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:47:18 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')]} 19:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:18 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')]} 19:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:18 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 0x7fa822775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2226630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b7840>, '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 0x22246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2224b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', '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 19:47:18 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 19:47:18 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 19:47:18 INFO - Using env: {'DISPLAY': ':0', 19:47:18 INFO - 'HOME': '/home/cltbld', 19:47:18 INFO - 'LANG': 'en_US.UTF-8', 19:47:18 INFO - 'LANGUAGE': 'en_US:en', 19:47:18 INFO - 'LOGNAME': 'cltbld', 19:47:18 INFO - 'MAIL': '/var/mail/cltbld', 19:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:18 INFO - 'MOZ_NO_REMOTE': '1', 19:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:18 INFO - 'NO_EM_RESTART': '1', 19:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:18 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:18 INFO - 'SHELL': '/bin/bash', 19:47:18 INFO - 'SHLVL': '1', 19:47:18 INFO - 'TERM': 'linux', 19:47:18 INFO - 'TMOUT': '86400', 19:47:18 INFO - 'USER': 'cltbld', 19:47:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', 19:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:18 INFO - '_': '/tools/buildbot/bin/python'} 19:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:18 INFO - Downloading/unpacking blobuploader==1.2.4 19:47: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 19:47: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 19:47: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 19:47: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 19:47: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 19:47: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 19:47:20 INFO - Downloading blobuploader-1.2.4.tar.gz 19:47:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:47:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:47:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:47:20 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 19:47:20 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 19:47:20 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 19:47:20 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 19:47:20 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 19:47:20 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 19:47:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:47:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:47:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:47:20 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 19:47:20 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 19:47:20 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 19:47:20 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 19:47:20 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 19:47:20 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 19:47:21 INFO - Downloading docopt-0.6.1.tar.gz 19:47:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:47:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:47:21 INFO - Installing collected packages: blobuploader, requests, docopt 19:47:21 INFO - Running setup.py install for blobuploader 19:47:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:47:21 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:47:21 INFO - Running setup.py install for requests 19:47:21 INFO - Running setup.py install for docopt 19:47:21 INFO - Successfully installed blobuploader requests docopt 19:47:21 INFO - Cleaning up... 19:47:21 INFO - Return code: 0 19:47:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:47:21 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')]} 19:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:21 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')]} 19:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:21 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 0x7fa822775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2226630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b7840>, '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 0x22246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2224b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', '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 19:47:21 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 19:47:21 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 19:47:21 INFO - Using env: {'DISPLAY': ':0', 19:47:21 INFO - 'HOME': '/home/cltbld', 19:47:21 INFO - 'LANG': 'en_US.UTF-8', 19:47:21 INFO - 'LANGUAGE': 'en_US:en', 19:47:21 INFO - 'LOGNAME': 'cltbld', 19:47:21 INFO - 'MAIL': '/var/mail/cltbld', 19:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:21 INFO - 'MOZ_NO_REMOTE': '1', 19:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:21 INFO - 'NO_EM_RESTART': '1', 19:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:21 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:21 INFO - 'SHELL': '/bin/bash', 19:47:21 INFO - 'SHLVL': '1', 19:47:21 INFO - 'TERM': 'linux', 19:47:21 INFO - 'TMOUT': '86400', 19:47:21 INFO - 'USER': 'cltbld', 19:47:21 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', 19:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:21 INFO - '_': '/tools/buildbot/bin/python'} 19:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:47:21 INFO - Running setup.py (path:/tmp/pip-Cy_bKW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:47:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:47:22 INFO - Running setup.py (path:/tmp/pip-3FUsJh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:47:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:47:22 INFO - Running setup.py (path:/tmp/pip-9OC7Sw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:47:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:47:22 INFO - Running setup.py (path:/tmp/pip-WvwYXM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:47:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:47:22 INFO - Running setup.py (path:/tmp/pip-wRoIqg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:47:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:47:22 INFO - Running setup.py (path:/tmp/pip-ND_Lxa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:47:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:47:22 INFO - Running setup.py (path:/tmp/pip-EYtxDh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:47:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:47:22 INFO - Running setup.py (path:/tmp/pip-x8jQsQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:47:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:47:22 INFO - Running setup.py (path:/tmp/pip-MRSpUv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:47:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:47:22 INFO - Running setup.py (path:/tmp/pip-lUTcpk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:47:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:47:22 INFO - Running setup.py (path:/tmp/pip-ObMKId-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:47:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:47:22 INFO - Running setup.py (path:/tmp/pip-bQZsE5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:47:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:47:22 INFO - Running setup.py (path:/tmp/pip-LAloBe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:47:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:47:22 INFO - Running setup.py (path:/tmp/pip-b_u07z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:47:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:47:22 INFO - Running setup.py (path:/tmp/pip-l6mjAy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:47:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:47:23 INFO - Running setup.py (path:/tmp/pip-XLTgw5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:47:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:47:23 INFO - Running setup.py (path:/tmp/pip-ZW3opJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:47:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:47:23 INFO - Running setup.py install for manifestparser 19:47:23 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:47:23 INFO - Running setup.py install for mozcrash 19:47:23 INFO - Running setup.py install for mozdebug 19:47:23 INFO - Running setup.py install for mozdevice 19:47:23 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:47:23 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:47:23 INFO - Running setup.py install for mozfile 19:47:23 INFO - Running setup.py install for mozhttpd 19:47:23 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:47:23 INFO - Running setup.py install for mozinfo 19:47:23 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:47:23 INFO - Running setup.py install for mozInstall 19:47:23 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:47:23 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:47:23 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:47:23 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:47:23 INFO - Running setup.py install for mozleak 19:47:24 INFO - Running setup.py install for mozlog 19:47:24 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:47:24 INFO - Running setup.py install for moznetwork 19:47:24 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:47:24 INFO - Running setup.py install for mozprocess 19:47:24 INFO - Running setup.py install for mozprofile 19:47:24 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:47:24 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:47:24 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:47:24 INFO - Running setup.py install for mozrunner 19:47:24 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:47:24 INFO - Running setup.py install for mozscreenshot 19:47:24 INFO - Running setup.py install for moztest 19:47:24 INFO - Running setup.py install for mozversion 19:47:24 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:47:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:47:24 INFO - Cleaning up... 19:47:24 INFO - Return code: 0 19:47:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:47:24 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')]} 19:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:24 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')]} 19:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:24 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 0x7fa822775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2226630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b7840>, '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 0x22246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2224b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', '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 19:47:24 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 19:47:24 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 19:47:24 INFO - Using env: {'DISPLAY': ':0', 19:47:24 INFO - 'HOME': '/home/cltbld', 19:47:24 INFO - 'LANG': 'en_US.UTF-8', 19:47:24 INFO - 'LANGUAGE': 'en_US:en', 19:47:24 INFO - 'LOGNAME': 'cltbld', 19:47:24 INFO - 'MAIL': '/var/mail/cltbld', 19:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:24 INFO - 'MOZ_NO_REMOTE': '1', 19:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:24 INFO - 'NO_EM_RESTART': '1', 19:47:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:24 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:24 INFO - 'SHELL': '/bin/bash', 19:47:24 INFO - 'SHLVL': '1', 19:47:24 INFO - 'TERM': 'linux', 19:47:24 INFO - 'TMOUT': '86400', 19:47:24 INFO - 'USER': 'cltbld', 19:47:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', 19:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:24 INFO - '_': '/tools/buildbot/bin/python'} 19:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:47:25 INFO - Running setup.py (path:/tmp/pip-GwN0Yb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:47:25 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)) 19:47:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:47:25 INFO - Running setup.py (path:/tmp/pip-EYghsP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:47:25 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)) 19:47:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:47:25 INFO - Running setup.py (path:/tmp/pip-N6Bwi_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:47:25 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)) 19:47:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:47:25 INFO - Running setup.py (path:/tmp/pip-SwE4Md-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 19:47:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:47:25 INFO - Running setup.py (path:/tmp/pip-lXefEu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:47:25 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)) 19:47:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:47:25 INFO - Running setup.py (path:/tmp/pip-bXbzds-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:47:25 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)) 19:47:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:47:25 INFO - Running setup.py (path:/tmp/pip-KAZQaG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:47:25 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)) 19:47:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:47:25 INFO - Running setup.py (path:/tmp/pip-q92kw9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:47:25 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)) 19:47:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:47:25 INFO - Running setup.py (path:/tmp/pip-fqG0Dk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:47:25 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)) 19:47:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:47:25 INFO - Running setup.py (path:/tmp/pip-yLKX6w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:47:25 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)) 19:47:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:47:25 INFO - Running setup.py (path:/tmp/pip-T4Y005-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:47:25 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)) 19:47:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:47:25 INFO - Running setup.py (path:/tmp/pip-_ntk9E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:47:26 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)) 19:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:47:26 INFO - Running setup.py (path:/tmp/pip-tMNf3U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:47:26 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)) 19:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:47:26 INFO - Running setup.py (path:/tmp/pip-VVDvYA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:47:26 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)) 19:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:47:26 INFO - Running setup.py (path:/tmp/pip-AXe_67-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:47:26 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)) 19:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:47:26 INFO - Running setup.py (path:/tmp/pip-b5kVvD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:47:26 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)) 19:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:47:26 INFO - Running setup.py (path:/tmp/pip-ewURvO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:47:26 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)) 19:47:26 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)) 19:47:26 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)) 19:47:26 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)) 19:47:26 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:47:26 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:47:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:47:26 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 19:47:26 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 19:47:26 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 19:47:26 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 19:47:26 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 19:47:26 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 19:47:28 INFO - Downloading blessings-1.5.1.tar.gz 19:47:28 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 19:47:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:47:28 INFO - Installing collected packages: blessings 19:47:28 INFO - Running setup.py install for blessings 19:47:28 INFO - Successfully installed blessings 19:47:28 INFO - Cleaning up... 19:47:28 INFO - Return code: 0 19:47:28 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:47:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:47:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:47:28 INFO - Reading from file tmpfile_stdout 19:47:28 INFO - Current package versions: 19:47:28 INFO - argparse == 1.2.1 19:47:28 INFO - blessings == 1.5.1 19:47:28 INFO - blobuploader == 1.2.4 19:47:28 INFO - docopt == 0.6.1 19:47:28 INFO - manifestparser == 1.1 19:47:28 INFO - mozInstall == 1.12 19:47:28 INFO - mozcrash == 0.16 19:47:28 INFO - mozdebug == 0.1 19:47:28 INFO - mozdevice == 0.48 19:47:28 INFO - mozfile == 1.2 19:47:28 INFO - mozhttpd == 0.7 19:47:28 INFO - mozinfo == 0.9 19:47:28 INFO - mozleak == 0.1 19:47:28 INFO - mozlog == 3.1 19:47:28 INFO - moznetwork == 0.27 19:47:28 INFO - mozprocess == 0.22 19:47:28 INFO - mozprofile == 0.28 19:47:28 INFO - mozrunner == 6.11 19:47:28 INFO - mozscreenshot == 0.1 19:47:28 INFO - mozsystemmonitor == 0.0 19:47:28 INFO - moztest == 0.7 19:47:28 INFO - mozversion == 1.4 19:47:28 INFO - psutil == 3.1.1 19:47:28 INFO - requests == 1.2.3 19:47:28 INFO - wsgiref == 0.1.2 19:47:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:47:28 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')]} 19:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:28 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')]} 19:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:28 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 0x7fa822775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2226630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b7840>, '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 0x22246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2224b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', '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 19:47:28 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 19:47:28 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 19:47:28 INFO - Using env: {'DISPLAY': ':0', 19:47:28 INFO - 'HOME': '/home/cltbld', 19:47:28 INFO - 'LANG': 'en_US.UTF-8', 19:47:28 INFO - 'LANGUAGE': 'en_US:en', 19:47:28 INFO - 'LOGNAME': 'cltbld', 19:47:28 INFO - 'MAIL': '/var/mail/cltbld', 19:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:28 INFO - 'MOZ_NO_REMOTE': '1', 19:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:28 INFO - 'NO_EM_RESTART': '1', 19:47:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:28 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:28 INFO - 'SHELL': '/bin/bash', 19:47:28 INFO - 'SHLVL': '1', 19:47:28 INFO - 'TERM': 'linux', 19:47:28 INFO - 'TMOUT': '86400', 19:47:28 INFO - 'USER': 'cltbld', 19:47:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', 19:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:28 INFO - '_': '/tools/buildbot/bin/python'} 19:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:28 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)) 19:47:28 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)) 19:47:28 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)) 19:47:28 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)) 19:47:28 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)) 19:47:28 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)) 19:47:28 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)) 19:47:28 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)) 19:47:28 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)) 19:47:28 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)) 19:47:28 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)) 19:47:28 INFO - Cleaning up... 19:47:28 INFO - Return code: 0 19:47:28 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:47:28 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')]} 19:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:28 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')]} 19:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:28 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 0x7fa822775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2226630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b7840>, '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 0x22246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2224b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', '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 19:47:28 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 19:47:28 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 19:47:28 INFO - Using env: {'DISPLAY': ':0', 19:47:28 INFO - 'HOME': '/home/cltbld', 19:47:28 INFO - 'LANG': 'en_US.UTF-8', 19:47:28 INFO - 'LANGUAGE': 'en_US:en', 19:47:28 INFO - 'LOGNAME': 'cltbld', 19:47:28 INFO - 'MAIL': '/var/mail/cltbld', 19:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:28 INFO - 'MOZ_NO_REMOTE': '1', 19:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:28 INFO - 'NO_EM_RESTART': '1', 19:47:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:28 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:28 INFO - 'SHELL': '/bin/bash', 19:47:28 INFO - 'SHLVL': '1', 19:47:28 INFO - 'TERM': 'linux', 19:47:28 INFO - 'TMOUT': '86400', 19:47:28 INFO - 'USER': 'cltbld', 19:47:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', 19:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:28 INFO - '_': '/tools/buildbot/bin/python'} 19:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:29 INFO - Downloading/unpacking jsonschema 19:47:29 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 19:47:29 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 19:47:29 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 19:47:29 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 19:47:29 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 19:47:29 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 19:47:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:47:30 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 19:47:30 INFO - Downloading/unpacking functools32 (from jsonschema) 19:47:30 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 19:47:30 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 19:47:30 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 19:47:30 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 19:47:30 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 19:47:30 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 19:47:30 INFO - Downloading functools32-3.2.3-2.tar.gz 19:47:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:47:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:47:30 INFO - warning: no files found matching '*.txt' 19:47:30 INFO - no previously-included directories found matching 'build' 19:47:30 INFO - no previously-included directories found matching 'dist' 19:47:30 INFO - no previously-included directories found matching '.git*' 19:47:31 INFO - Installing collected packages: jsonschema, functools32 19:47:31 INFO - Running setup.py install for functools32 19:47:31 INFO - warning: no files found matching '*.txt' 19:47:31 INFO - no previously-included directories found matching 'build' 19:47:31 INFO - no previously-included directories found matching 'dist' 19:47:31 INFO - no previously-included directories found matching '.git*' 19:47:31 INFO - Successfully installed jsonschema functools32 19:47:31 INFO - Cleaning up... 19:47:31 INFO - Return code: 0 19:47:31 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:31 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 0x7fa822775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2226630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b7840>, '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 0x22246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2224b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', '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 19:47:31 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 19:47:31 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 19:47:31 INFO - Using env: {'DISPLAY': ':0', 19:47:31 INFO - 'HOME': '/home/cltbld', 19:47:31 INFO - 'LANG': 'en_US.UTF-8', 19:47:31 INFO - 'LANGUAGE': 'en_US:en', 19:47:31 INFO - 'LOGNAME': 'cltbld', 19:47:31 INFO - 'MAIL': '/var/mail/cltbld', 19:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:31 INFO - 'MOZ_NO_REMOTE': '1', 19:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:31 INFO - 'NO_EM_RESTART': '1', 19:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:31 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:31 INFO - 'SHELL': '/bin/bash', 19:47:31 INFO - 'SHLVL': '1', 19:47:31 INFO - 'TERM': 'linux', 19:47:31 INFO - 'TMOUT': '86400', 19:47:31 INFO - 'USER': 'cltbld', 19:47:31 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', 19:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:31 INFO - '_': '/tools/buildbot/bin/python'} 19:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:31 INFO - Downloading/unpacking flake8 19:47:31 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 19:47:31 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 19:47:31 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 19:47:31 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 19:47:31 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 19:47:31 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 19:47:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:47:33 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 19:47:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:47:33 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 19:47:33 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 19:47:33 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 19:47:33 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 19:47:33 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 19:47:33 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 19:47:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:47:33 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 19:47:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:47:33 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 19:47:33 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 19:47:33 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 19:47:33 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 19:47:33 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 19:47:33 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 19:47:33 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 19:47:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:47:33 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 19:47:33 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 19:47:33 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 19:47:33 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 19:47:33 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 19:47:33 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 19:47:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:47:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:47:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:47:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:47:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:47:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:47:33 INFO - no previously-included directories found matching 'docs/_build' 19:47:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:47:33 INFO - Running setup.py install for pep8 19:47:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:47:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:47:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:47:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:47:33 INFO - no previously-included directories found matching 'docs/_build' 19:47:34 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:47:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:47:34 INFO - Cleaning up... 19:47:34 INFO - Return code: 0 19:47:34 INFO - Running post-action listener: _resource_record_post_action 19:47:34 INFO - Running post-action listener: _start_resource_monitoring 19:47:34 INFO - Starting resource monitoring. 19:47:34 INFO - ##### 19:47:34 INFO - ##### Running install step. 19:47:34 INFO - ##### 19:47:34 INFO - Running pre-action listener: _resource_record_pre_action 19:47:34 INFO - Running main action method: install 19:47:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:47:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:47:34 INFO - Reading from file tmpfile_stdout 19:47:34 INFO - Detecting whether we're running mozinstall >=1.0... 19:47:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:47:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:47:34 INFO - Reading from file tmpfile_stdout 19:47:34 INFO - Output received: 19:47:34 INFO - Usage: mozinstall [options] installer 19:47:34 INFO - Options: 19:47:34 INFO - -h, --help show this help message and exit 19:47:34 INFO - -d DEST, --destination=DEST 19:47:34 INFO - Directory to install application into. [default: 19:47:34 INFO - "/builds/slave/test-pgo"] 19:47:34 INFO - --app=APP Application being installed. [default: firefox] 19:47:34 INFO - mkdir: /builds/slave/test-pgo/build/application 19:47:34 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'] 19:47:34 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 19:47:50 INFO - Reading from file tmpfile_stdout 19:47:50 INFO - Output received: 19:47:50 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:47:50 INFO - Running post-action listener: _resource_record_post_action 19:47:50 INFO - ##### 19:47:50 INFO - ##### Running run-tests step. 19:47:50 INFO - ##### 19:47:50 INFO - Running pre-action listener: _resource_record_pre_action 19:47:50 INFO - Running main action method: run_tests 19:47:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:47:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:47:50 INFO - Python 2.7.3 19:47:50 INFO - Return code: 0 19:47:50 INFO - grabbing minidump binary from tooltool 19:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:50 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 0x22b7840>, '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 0x22246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2224b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:47:50 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 19:47:50 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 19:47:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:47:50 INFO - Return code: 0 19:47:50 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:47:50 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:47:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:47:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:47:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:47:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:47:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:47:51 INFO - Return code: 0 19:47:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 19:47:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 19:47:51 INFO - Using env: {'DISPLAY': ':0', 19:47:51 INFO - 'HOME': '/home/cltbld', 19:47:51 INFO - 'LANG': 'en_US.UTF-8', 19:47:51 INFO - 'LANGUAGE': 'en_US:en', 19:47:51 INFO - 'LOGNAME': 'cltbld', 19:47:51 INFO - 'MAIL': '/var/mail/cltbld', 19:47:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:47:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:51 INFO - 'MOZ_NO_REMOTE': '1', 19:47:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:51 INFO - 'NO_EM_RESTART': '1', 19:47:51 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:51 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:51 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:47:51 INFO - 'SHELL': '/bin/bash', 19:47:51 INFO - 'SHLVL': '1', 19:47:51 INFO - 'TERM': 'linux', 19:47:51 INFO - 'TMOUT': '86400', 19:47:51 INFO - 'USER': 'cltbld', 19:47:51 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292', 19:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:51 INFO - '_': '/tools/buildbot/bin/python'} 19:47:51 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:47:51 INFO - mozversion application_buildid: 20160114173009 19:47:51 INFO - mozversion application_changeset: 8fbf073773f141e4305875532d04ec02f564c91b 19:47:51 INFO - mozversion application_display_name: Nightly 19:47:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:47:51 INFO - mozversion application_name: Firefox 19:47:51 INFO - mozversion application_remotingname: firefox 19:47:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 19:47:51 INFO - mozversion application_vendor: Mozilla 19:47:51 INFO - mozversion application_version: 46.0a1 19:47:51 INFO - mozversion platform_buildid: 20160114173009 19:47:51 INFO - mozversion platform_changeset: 8fbf073773f141e4305875532d04ec02f564c91b 19:47:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 19:47:51 INFO - mozversion platform_version: 46.0a1 19:47:51 INFO - using testdate: 1452829671 19:47:51 INFO - actual date: 1452829671 19:47:51 INFO - starting webserver on 'localhost:44123' 19:47:51 INFO - SUITE-START | Running 3 tests 19:47:51 INFO - TEST-START | dromaeo_css 19:47:51 INFO - operating with platform_type : linux_ 19:47:51 INFO - Initialising browser for dromaeo_css test... 19:47:51 INFO - TEST-INFO | started process 9019 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbIi4Gu/profile http://localhost:44123/getInfo.html) 19:47:55 INFO - PROCESS | 9019 | __metrics Screen width/height:1600/1200 19:47:55 INFO - PROCESS | 9019 | colorDepth:24 19:47:55 INFO - PROCESS | 9019 | Browser inner width/height: 1024/697 19:47:55 INFO - PROCESS | 9019 | __metrics 19:47:56 INFO - PROCESS | 9019 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:47:56 INFO - PROCESS | 9019 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:47:57 INFO - TEST-INFO | 9019: exit 0 19:47:57 INFO - Browser initialized. 19:47:57 INFO - Running cycle 1/1 for dromaeo_css test... 19:47:57 INFO - TEST-INFO | started process 9113 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbIi4Gu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:48:09 INFO - PROCESS | 9113 | RSS: Main: 151281664 19:48:09 INFO - PROCESS | 9113 | 19:49:00 INFO - PROCESS | 9113 | 1452829740440 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] 19:51:08 INFO - PROCESS | 9113 | Cycle 1(1): loaded http://localhost:44123/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44123/tests/dromaeo/cssquery-ext.html) 19:51:09 INFO - PROCESS | 9113 | RSS: Main: 281731072 19:51:09 INFO - PROCESS | 9113 | 19:54:12 INFO - PROCESS | 9113 | Cycle 1(1): loaded http://localhost:44123/tests/dromaeo/cssquery-ext.html (next: http://localhost:44123/tests/dromaeo/cssquery-jquery.html) 19:54:12 INFO - PROCESS | 9113 | RSS: Main: 239456256 19:54:12 INFO - PROCESS | 9113 | 19:57:14 INFO - PROCESS | 9113 | Cycle 1(1): loaded http://localhost:44123/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44123/tests/dromaeo/cssquery-mootools.html) 19:57:15 INFO - PROCESS | 9113 | RSS: Main: 235577344 19:57:15 INFO - PROCESS | 9113 | 20:00:17 INFO - PROCESS | 9113 | Cycle 1(1): loaded http://localhost:44123/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44123/tests/dromaeo/cssquery-prototype.html) 20:00:17 INFO - PROCESS | 9113 | RSS: Main: 210837504 20:00:17 INFO - PROCESS | 9113 | 20:03:20 INFO - PROCESS | 9113 | Cycle 1(1): loaded http://localhost:44123/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44123/tests/dromaeo/cssquery-yui.html) 20:03:21 INFO - PROCESS | 9113 | RSS: Main: 214765568 20:03:21 INFO - PROCESS | 9113 | 20:06:23 INFO - PROCESS | 9113 | Cycle 1(1): loaded http://localhost:44123/tests/dromaeo/cssquery-yui.html (next: http://localhost:44123/tests/dromaeo/cssquery-dojo.html) 20:06:23 INFO - PROCESS | 9113 | RSS: Main: 263344128 20:06:23 INFO - PROCESS | 9113 | 20:06:23 INFO - PROCESS | 9113 | __start_tp_report 20:06:23 INFO - PROCESS | 9113 | _x_x_mozilla_page_load 20:06:23 INFO - PROCESS | 9113 | _x_x_mozilla_page_load_details 20:06:23 INFO - PROCESS | 9113 | |i|pagename|runs| 20:06:23 INFO - PROCESS | 9113 | |0;dojo.html;3125.437421264173;3128.1710346758127;3170.873165073397;3180.8727650893966;3206.7274281686055;4991.700497970124;5038.924416133761;5061.29141920131;5095.388553373591;5101.872453188667;5106.744662766856;5148.330717006793;5188.351456067991;5202.3497062867145;5214.973925130378;4495.550444955495;4593.908121837578;4630.328602352648;4693.084848454553;4809.51904809518;4591.540845915399;4660.627149828023;4773.18855794514;4773.71357718538;4863.392075990501;4654.348391225231;4657.184992626294;4666.510016448258;4677.6491763117565;4677.929831052537;4693.436787585478;4694.600958918496;4721.409823772028;4731.716097034189;4739.241721324572;4581.427321584802;4675.111728771522;4676.69601475903;4697.812087516495;4700.952990470086;5002;5017.096922553938;5020.196768517057;5020.849374518771;5028.5977121830165;5501.05482601607;5507.339119305669;5510.173473978895;5510.972445137789;5556.972215138939;5383.542398896098;5460.290162278918;5477.917831232535;5531.640443371168;5536.944630553683;5271.999999999962;5275.472452754732;5277.8416647500635;5289.841304760864;5295.232191332235;5707.6290041147195;5722.942770572325;5725.2843394575675;5727.05503591911;5730.36965933747;5354.598405119632;5423.132298832168;5423.918641220384;5471.206675032177;5493.093639549509;5527.55779537636;5535.723213839292;5537.667739935617;5545.611807173459;5573.247611572467;5456.945430545723;5486.177073439016;5500.119980803052;5508.862278443071;5560.916586251209;5442.91835622466;5469.56243500519;5494.478024587658;5551.444855514497;5576.553875689935;4304.569543045671;4309.288967320357;4321.395004699345;4335.067960388532;4340.934885976713;3876.8449262029767;3883.61163883615;3886.514185726784;3913.5108111486065;3917.6278253565865;5033.068882256721;5107.387113546398;5115.283860259567;5127.102757017507;5131.384233891882;5447.727613619303;5475.397706252309;5497.862553436196;5520.447955204448;5546.473085056913;5076.923846142311;5102;5103.106956282636;5110.770015349318;5153.716545589954;4592.402987611589;4673.7429441381055;4709.152352576569;4738.147133515931;4837.733924634109;5699.344575373885;5700.743466544015;5715.199872017921;5717.914231286534;5721.685307308138;5523.475269849358;5533.501984821385;5534.889302214014;5539;5582.330120385417;5602.915956260741;5638.154276858504;5691.174779657009;5691.857703557444;5721.914171287517;5508.697021663686;5536.7231638418725;5543.833684989457;5545.916811247916;5547.639403438763;5562.360328562268;5574;5614.466625670718;5621.072523033818;5631.943680563142;5314.176302673091;5400.2439658447065;5424.294841670558;5498.670079795225;5509.9806535791;5356.116240820221;5358.517733404013;5365.436629154039;5365.758540865592;5389.8113566025;5272.7100009499845;5275.366955965309;5276.551493123127;5283.445238250082;5296.576273898002;5342.385625652944;5360.731963401737;5364.678119312854;5413.296271484839;5413.621046526705;5337.146056630921;5387.515123638891;5392.245085688085;5408.7566059526625;5431.131019036935 20:06:23 INFO - PROCESS | 9113 | |1;ext.html;499.88002879308965;503.6625460941169;512.7769420302169;527.5094162428942;607.2773399654413;28778.856105719467;29246.561301580467;29277.560836587443;35353.292934141304;35785;39090.21819563607;39469.80265098678;39521.40717889234;39583.80208098955;39639.20721585566;8481.787955301135;8695.21743043126;8701.390902636818;8703.042665306812;8709.477431354107;8380.8742868857;8456.365772567051;8522.105178956213;8524.104968978261;8525.360597955147;8503.829923401529;8571.742847714579;8577.614007369682;8578.914210857905;8579.227869491744;8478.279346255576;8511.021232558272;8531.616077276538;8543.658253669877;8545.615447304886;8291.58542072894;8349.582520873993;8414.74755757322;8416.326693864476;8416.621252043673;38381.23237535234;38503.61496385057;38676.22647547061;38797.22405551873;38831.8058409709;3133.833536904545;3224.91937701557;3462.792232466035;3722.7766334019775;3805.9238815223816;29006.709932900823;29172.416551668848;29284.267893302836;29719.25701857449;30203.395932081454;3460.757746957714;3485.42490489069;3495.755297129202;3581.247937933037;3668.4313931340685;200078;201010;201422;201973;202220;50169;53673.46326536763;54397.45602544003;54475.45524544783;54477.45522544803;48531.5146848527;59936.700316498136;61212;61272.387276127556;61322.0801687975;13233.53682621123;13487.932560337136;13491.460341586422;13515.121517101554;13529.255890926093;9545.52272386378;9650.227981761582;9760.511974401252;10003.349782264275;10029.69910902674;17896.284148634168;18138.183781729855;18166.18252178655;18284.17721202549;18291.72562411565;6797.388235058868;7021.89467157993;7024.332688394595;7058.223595404502;7076.4692648051605;851.8892543969245;929.8419268724333;951.2083722223331;969.3553786731885;1049.976273133704;25640.230793076236;27542.311442214104;27850.303742406602;27861;28048.579271310948;993.4536005197112;1011.6813203840767;1039.3036665434176;1052.736815796051;1101.0805977009127;12806.107174932567;13540.322983850769;13601.387937542835;13790.241536715577;13872;340011;341457;343235;344680;345521;42933.35599966003;43537.78231108888;49832.750836245585;49992.750036249585;50122.24816627753;1287.414226526928;1300.1873828856965;1302.5375991523063;1307.9215247085206;1327.1240980952525;25894.223173304832;26270.605940911282;26527;26562.203133906012;26801.731982679925;41201;41676.37485437781;41783.37324940189;42865.571344287404;46578.53421465742;213574;214278;214704;214750;214960;28647;28897.277568060967;29002;29031.274218144714;29078.27304317409;37462.8126859364;38913.8054309738;39169.2166156681;39585.60414395819;39597.60402395939;32923;35156.64843351534;35438.11404714903;35565.82217088898;36542;35383.646163539066;36088.63911360958;36231;36279.637203628685;36294;34594.135146621535;35458;35506.644933550335;35577.644223557436;35702;28975;32017.519737203496;32146.67853321437;32304.35391292208;32310.19224519406;23492.29801635231;23630;23649.52700945937;23712.170074047324;24104.276871693877 20:06:23 INFO - PROCESS | 9113 | |2;jquery.html;365.36426617685237;365.5887126982145;365.6106246847108;366.8477581803552;367.19584110797337;13755.174689518612;13859.099158554687;15802.288896999635;16969.151542422875;18026.549336266584;14267.928660356709;14284.92857535711;14573.781393279109;14598.416063357454;15245.847541524581;5283.8150664726745;5484.945150548503;5486.478784515464;5489.066858634022;5490.80782172624;3987.3022221111332;4116.012157082294;5389.946100538984;5477.780888764445;5694.373618901917;5711.343195532505;5845.269341332333;5893.086571581412;5897.528197744192;5900.291964964189;5904.468597826195;5944.881102377972;5975.19334889793;5975.850603734898;5977.1034344848185;4894.412670479565;5086.54221120101;5092.337996060525;5252.1596544552685;5270.104082305978;12002.939985300105;12359.876401236052;15548.378064877392;20092.1963121475;20101.899490502456;2013.4664313956814;2030.056023948871;2092.2677063027973;2116.9364919052455;2202.878841663708;9591.184749296319;10478.79042419155;10841.566337346496;12099.334536600483;12553.058520610899;1802.6665066962653;1817.1186974317445;1856.4616261284211;1976.8122028407279;1988.1311567126854;51978.48021519774;52504.212436813476;53227.467725323026;53467.19799203015;53949;9702.320837541305;9935.453550054672;9949.204063674888;9961.850572241423;10023.599056037678;12942.741145177044;13025.609231723063;13026.934865325613;13038.80441793374;13070.803937940938;6783.457323414115;6960.443164546824;7016.403605693573;7074.327938845801;7085.82285442868;6605.678864227174;6647.501437392215;6672.833179170462;6682.699278532477;6691.063251144844;4409.801558929792;4463.821447142078;4480.977595112004;4514.45826500822;4525.818967241274;1712.8800983931255;1771.5659663382553;1781.7683701118772;1863.3509344230454;1890.8676392652658;841.9831603367899;842.4818736477145;872.9563521823883;904.4669285561042;920.9263258939269;13858;16383.214853474938;16504.17479126039;16710.916445417693;17119.400820971205;899.2670973156856;904.204300215819;931.8741969834122;941.096547314572;967.1150896929231;9155.45067295951;9372.484513351696;9420.717378478657;9446.763830904283;9634.855477167848;400952;407870;409685;541082;548588;72237;75511;76871.61564192254;77030.61484692541;77686.61156694293;1120.2102517724984;1135.5230803062734;1147.5467190459556;1157.0965761322577;1158;14796.112233266038;15080.849191508383;15245.223753006616;15272.541823745305;15360.769588456405;30981.690183097882;31389.52915706312;31447.84276078605;31944.52083218707;32158.19604509906;41681.79159104185;41867.7906610465;42051;44448.33327500025;45647.77176114098;7068.646567671699;7288.052553168266;7363.8159046024275;7364.374028207662;7368.115826100688;9005.864912026456;10954.397508137128;11114.666560003212;11349.432528373383;11622.535098595961;8989.595468203815;9592.568334424828;9686.370385924893;10195.388276703421;10266.127379172854;9331.766705832408;9732.756681082747;9893.35693179941;9911.405315681082;10090.54592543352;7461.552306861606;9025.729228123168;9548.618055277711;9908.900910990798;10019.699409017741;6871.312868713088;7061.540999834994;7234.5659260444545;7242;7361.926380736124;9282.257419406566;9451.716448506555;9510.95244523773;9606.759831004281;9730.318877678777 20:06:23 INFO - PROCESS | 9113 | |3;mootools.html;1342.8321459817523;1439.6976634906669;1464.7949287099807;1594.8325425830287;1773.6896043192437;6678.098456708343;7233.565986040835;7372.3364897159245;7372.668229929653;7372.889406658897;7209.747658831942;7379.557226566396;7397.445191610624;7406.037215162021;7418.072740907387;1974.5655955689726;2014.6977953306975;2015.042854644047;2280.133549251282;2300.2754132448226;2300.7469178390365;2361.055577768889;2363.7163540375177;2364.0661938534267;2364.728056273533;2266.2634643740766;2272.5114100468395;2321.6749655048307;2323.384303159664;2324.2213858357472;2252.279270633406;2274.306336567346;2276.271593090212;2298.8620682759088;2303.9884800576056;2287.2795069553204;2288.8512246703913;2298.482841360697;2301.8503797253125;2307.411610039429;7458.254174582553;7506.13679426862;7536.208698086732;7546.69813207471;7560.092788865371;4447.510773814878;4627.907441851178;4632.513586073481;4636.884077898046;4642.535746425364;2969.5694124352062;3059.72462478378;3091.613548306462;3104.518799586068;3134.5611614374006;1013.5996281468779;1026.3380119822748;1055.176961969665;1062.8299472084507;1078.4338222433207;9682.951585242028;9841.261905357127;9864.852027219598;9875.506224688737;9884.901150988542;3978.9403158952637;4104.281750693676;4108.6918481114035;4347.06538094305;4354.673399494987;8683.782905427288;8685.913140868637;8691.782705432288;8695.391322607356;8700.912990870136;4586.97706511472;4591.44902611682;4619.630429565626;4627.120847039052;4628.39830821991;4145.937810932838;4155.58444155588;4159.022629682022;4176.1230141670585;4176.77027763476;3347.9665203347654;3442.569678790151;3527.664871837171;3642.0712718256673;3683.097641077953;1210.189173253922;1230.563150081726;1231.58741821489;1236.33238051453;1247.1270110922392;981.5386768218925;987.2990176974286;998.2662742883974;1024.636254129788;1025.348903446302;6996.615186164708;7011.228764835864;7024.894626580605;7032.226455089936;7041.5775053496955;618.2735286038886;621.3382747374033;629.2260519560965;631.0880777276883;632;5516.9448305517235;5580.91628625571;5586.413426590231;5588.888222235614;5594.524465420403;8870.86693699595;8962.32782541312;9159.633614655339;9175.77060573491;9180.908190918006;9012.369134160677;9024.503652299056;9029.593668284942;9111.038912353379;9127.178553930178;6915.550489218184;7043.943408488768;7087.787366379017;7171.175314838756;7175.425965922714;6843.213030501556;6858.3141685831015;6864.176298844171;6870.072540207008;6880.174379074543;7838.960805195938;8084.151164127918;8194.590270486571;8209.712660057108;8212.17878212174;8258.926339575817;8423.789405264917;8519.148085191431;8520.573971301534;8524.573771311285;6590.7693230736695;6616.371444712745;6711.731530738716;6728.259891411843;6771.627560484024;6397.584157029778;6571.704273307617;6790.45676345901;6983.44132469391;6997;6559.672016399066;6573.408393244631;6629.46964242869;6642.3025582315095;6765.188177418741;6513.250976137805;6579.111819904251;6583.979483180115;6680.83297917556;6693.297203793726;6657.467402607683;6714.2278637955305;6716.429103526255;6717;6726.3609957054005;6020.849478763066;6212;6253.5622506424115;6256.249250090018;6263.96868015657;6222.875542489215;6289.591176573508;6298.527610429328;6298.716557755004;6303.023031430135 20:06:23 INFO - PROCESS | 9113 | |4;prototype.html;335.40465673429657;337.75681509313296;344.18084957800426;344.82758620689657;348.5190437196668;5790.942090579093;5805.883882322351;5811.418858114186;5812.651240925542;5813.2152159458465;5517.586181036419;5523.226748255248;5607.551395888329;5691.060974939141;5726.914096288559;4426.889327766799;4430.9778451107695;4452.354408610766;4458.955410445887;4468.240399132155;4282.657387409015;4469.798859051334;4479.305707615308;4481.439820022497;4485.842995495142;4349.673774466912;4362.258416069276;4443.5556444355625;4451.688381813275;4469.664775141861;4432.180046691356;4453.55464453552;4455.287154055368;4455.910881782379;4458.621017213541;3963.8414463421427;3973.086190176247;3976.065624578222;3976.602339766029;3980.402939559089;5388.326459192601;5459.153831156177;5501.092319767234;5505.862353441156;5516.448355164452;5189.870253243661;5190.06578815813;5190.662606930538;5198.92201616976;5199.14214154664;6055.455009049163;6071.574989750719;6071.787487437919;6072.180255665473;6080.543959203077;4399.758013309267;4400.669949753749;4401.625861801751;4402.801873915681;4410.823567057314;6206.968965155191;6292.150559674431;6347.682615869188;6347.714352854133;6358.77744278948;4507.368968344369;4509.053098849278;4509.909801803946;4510.526394728572;4514.029483661028;4575.153596584642;4582.702124361906;4585.060062687141;4588.724676519353;4589.632829373642;5200.869978250574;5202.3497062867145;5211.765470553834;5211.791528338824;5212.5569326607665;5965.701714914237;6127.908081378783;6139.693015349304;6142.262928448615;6151.200343955257;1560.40704532277;1577.2271586922325;1580.6364536156748;1582.5410630917136;1582.5885269829928;1054.6730513540826;1065.925385223027;1068.316277582348;1069.5989004123453;1071.5874388360382;5807.94192058074;5814.970925145347;5817.360090390053;5817.7382017809305;5820.30156381237;6312;6337.493000559944;6338.968305158444;6340.397662222082;6346.11154438379;5629.408912064257;5712.600117991784;5746.310442746813;5757.0788673811985;5769.163471296639;3415.197428604276;3441.7246620270316;3447.2760720248525;3447.3450044491465;3447.7069449096607;6591.242007169237;6591.242007169237;6610.107635469246;6612.107365505692;6618.30507796684;6330.493560515148;6519.478441724651;6599.505037122235;6604.339566043357;6610.933890661128;6499;6506.642134682544;6508.056331831953;6512.772052978123;6525.771597994048;6367.3314301997625;6394.136791533269;6403;6406.231252249573;6420.486361091195;6155.292141403616;6286.937130628635;6314.084457753508;6315.90526142099;6331.715072821642;6636.938089905785;6644.269130395749;6649.335066493312;6651.301613330531;6655.101561289164;4462.419885414875;4497.168023915586;4498.527654596221;4500.707454015478;4501.707389019703;6230.376962303733;6363.5227357947415;6388.39310265524;6402.423781859655;6404.679766011587;6214.9067763984485;6222.937770622236;6230.283517395557;6236.781712640036;6238.313785483502;6211.3478084800445;6219.253689557282;6223.190985171898;6224.844378890564;6230.470410015199;5887.911681324869;6042.395760423922;6046.54650901193;6059.424354686298;6075.726592303446;6195.845103872439;6216.533759968111;6219.440250377488;6229.5327850410495;6242.063690446288;6075.878482430238;6087.965045942289;6092.969535152296;6106.175666284995;6107.694615269308 20:06:23 INFO - PROCESS | 9113 | |5;yui.html;631.3717850738514;737.450599303519;782.2568559868125;790.9723159689412;791.7505985614531;12839.29383883886;12972.221666700005;13004.154729942547;13016.804747928789;13021.739565208702;14297.71404571908;14655.193964331958;14667.413303467849;14726.116433014027;14749.557513274593;650.5868773328923;774.3108633316353;785.8506883692108;786.0685088170536;787.1184273613561;653.0791583866749;769.7267470048137;776.7980325115483;783.3967844759532;784.5684873319651;813.5932033983008;821.1255013410698;826.5330088500008;827.5407149032285;828.5608627427443;674.5210900260845;681.8125015620744;802.6267785479722;822.3626689315798;822.428412253481;597.3578403216516;600.8828278485697;601.2574470528893;601.6961434475562;602.0728078758706;12697.873021269761;12699.174553653984;12766.61700148997;12778.61664150077;12790.552330668475;11846.822297665542;12044.45799938996;12059.216150950248;12413.193142445713;12594.81107783384;10142.239332050125;10301.79396412075;10326.793464130751;10428.478576071242;10473.731254345004;3518.3842827505086;3522.929541409183;3575.6424357564297;3588.2644057968055;3668.706503479715;47139.52860471386;48353.51646483525;48406;48576.75711621455;48918.266226006635;9481.194098501705;9526.90473095274;9768.609255629837;9774.16919561831;9868.555914983843;17144.914275428542;17214.39749608758;17227.741583876254;17285.56786080333;17289.394871179447;6957.65211739411;7153.570785752871;7193.712251509985;7250.891236631454;7411.629418529052;4022.959770402317;4137.379393091001;4142.647874930604;4156.355764856452;4197.286461301586;2976.1964269647074;2992.177151283371;3000.744936680363;3006.068118883153;3015.231116065433;535.3655917737493;537.3122403323752;540.4677738611003;545.6835035679296;562.1848319936109;615.6060121522229;634.6985182038587;645.6932956845461;653.8888388973886;692.4702602509085;8469.3647976402;8835.955820220857;8865.290776737975;8969.372143949991;9011.710725585113;515.409855715204;650.632392698124;662.4667142949875;665.9866802664017;667.839718467574;3925.9214815703526;3961.742486738353;3962.5443074046275;4094.406311084876;4160.687948403821;52964;53612.46387536075;53931.73034134804;53941;53942.190867137026;47239.76380118077;48040;48189;48485.27272090921;49702;43370.566294336655;43589.346159807625;43669.563304367184;43884;44209.115817683465;7808.180141085331;8080.9191908080165;8201.917980820115;8214.917850821415;8223.629936652746;33502.4873134511;33745.32509349848;33770.493442597886;33869.47587358525;34436.82781586076;38687.80656096814;39253.214935700555;41725.58274417217;42161.789191053846;42270.57729422666;9756.609735610497;9915.058069483388;10045.296829221885;10103.09072183507;10181.643642472478;11067.833982490109;11225.775484490101;11281.266717663326;11328.433578321215;11413;10161;10366.948165259126;10388.792224155324;10484.056434920894;10734.14126869833;9933.65232216869;10107.444090575089;10219.795604087727;10299.639512617323;10306.278560500992;9453.196478299422;9843.557039933077;9910.801783964425;9989.350692204984;10247.38515689061;8486.236238738544;8857.424267422597;8898.599563019809;8906.376553641183;9006.81986360256;8151.959240203761;8209.425340226127;8572.314214862921;8614.91385086141;8724.520151391735 20:06:23 INFO - PROCESS | 9113 | __end_tp_report 20:06:23 INFO - PROCESS | 9113 | __start_cc_report 20:06:23 INFO - PROCESS | 9113 | _x_x_mozilla_cycle_collect,1085 20:06:23 INFO - PROCESS | 9113 | __end_cc_report 20:06:23 INFO - PROCESS | 9113 | __startTimestamp1452830783732__endTimestamp 20:06:23 INFO - PROCESS | 9113 | 20:06:23 INFO - PROCESS | 9113 | ------- Summary: start ------- 20:06:23 INFO - PROCESS | 9113 | Number of tests: 6 20:06:23 INFO - PROCESS | 9113 | 20:06:23 INFO - PROCESS | 9113 | [#0] dojo.html Cycles:165 Average:5132.39 Median:5342.39 stddev:555.05 (10.4%) stddev-sans-first:533.96 20:06:23 INFO - PROCESS | 9113 | Values: 3125.4 3128.2 3170.9 3180.9 3206.7 4991.7 5038.9 5061.3 5095.4 5101.9 5106.7 5148.3 5188.4 5202.3 5215.0 4495.6 4593.9 4630.3 4693.1 4809.5 4591.5 4660.6 4773.2 4773.7 4863.4 4654.3 4657.2 4666.5 4677.6 4677.9 4693.4 4694.6 4721.4 4731.7 4739.2 4581.4 4675.1 4676.7 4697.8 4701.0 5002.0 5017.1 5020.2 5020.8 5028.6 5501.1 5507.3 5510.2 5511.0 5557.0 5383.5 5460.3 5477.9 5531.6 5536.9 5272.0 5275.5 5277.8 5289.8 5295.2 5707.6 5722.9 5725.3 5727.1 5730.4 5354.6 5423.1 5423.9 5471.2 5493.1 5527.6 5535.7 5537.7 5545.6 5573.2 5456.9 5486.2 5500.1 5508.9 5560.9 5442.9 5469.6 5494.5 5551.4 5576.6 4304.6 4309.3 4321.4 4335.1 4340.9 3876.8 3883.6 3886.5 3913.5 3917.6 5033.1 5107.4 5115.3 5127.1 5131.4 5447.7 5475.4 5497.9 5520.4 5546.5 5076.9 5102.0 5103.1 5110.8 5153.7 4592.4 4673.7 4709.2 4738.1 4837.7 5699.3 5700.7 5715.2 5717.9 5721.7 5523.5 5533.5 5534.9 5539.0 5582.3 5602.9 5638.2 5691.2 5691.9 5721.9 5508.7 5536.7 5543.8 5545.9 5547.6 5562.4 5574.0 5614.5 5621.1 5631.9 5314.2 5400.2 5424.3 5498.7 5510.0 5356.1 5358.5 5365.4 5365.8 5389.8 5272.7 5275.4 5276.6 5283.4 5296.6 5342.4 5360.7 5364.7 5413.3 5413.6 5337.1 5387.5 5392.2 5408.8 5431.1 20:06:23 INFO - PROCESS | 9113 | 20:06:23 INFO - PROCESS | 9113 | [#1] ext.html Cycles:180 Average:41635.79 Median:35639.82 stddev:68393.12 (191.9%) stddev-sans-first:68515.24 20:06:23 INFO - PROCESS | 9113 | Values: 499.9 503.7 512.8 527.5 607.3 28778.9 29246.6 29277.6 35353.3 35785.0 39090.2 39469.8 39521.4 39583.8 39639.2 8481.8 8695.2 8701.4 8703.0 8709.5 8380.9 8456.4 8522.1 8524.1 8525.4 8503.8 8571.7 8577.6 8578.9 8579.2 8478.3 8511.0 8531.6 8543.7 8545.6 8291.6 8349.6 8414.7 8416.3 8416.6 38381.2 38503.6 38676.2 38797.2 38831.8 3133.8 3224.9 3462.8 3722.8 3805.9 29006.7 29172.4 29284.3 29719.3 30203.4 3460.8 3485.4 3495.8 3581.2 3668.4 200078.0 201010.0 201422.0 201973.0 202220.0 50169.0 53673.5 54397.5 54475.5 54477.5 48531.5 59936.7 61212.0 61272.4 61322.1 13233.5 13487.9 13491.5 13515.1 13529.3 9545.5 9650.2 9760.5 10003.3 10029.7 17896.3 18138.2 18166.2 18284.2 18291.7 6797.4 7021.9 7024.3 7058.2 7076.5 851.9 929.8 951.2 969.4 1050.0 25640.2 27542.3 27850.3 27861.0 28048.6 993.5 1011.7 1039.3 1052.7 1101.1 12806.1 13540.3 13601.4 13790.2 13872.0 340011.0 341457.0 343235.0 344680.0 345521.0 42933.4 43537.8 49832.8 49992.8 50122.2 1287.4 1300.2 1302.5 1307.9 1327.1 25894.2 26270.6 26527.0 26562.2 26801.7 41201.0 41676.4 41783.4 42865.6 46578.5 213574.0 214278.0 214704.0 214750.0 214960.0 28647.0 28897.3 29002.0 29031.3 29078.3 37462.8 38913.8 39169.2 39585.6 39597.6 32923.0 35156.6 35438.1 35565.8 36542.0 35383.6 36088.6 36231.0 36279.6 36294.0 34594.1 35458.0 35506.6 35577.6 35702.0 28975.0 32017.5 32146.7 32304.4 32310.2 23492.3 23630.0 23649.5 23712.2 24104.3 20:06:23 INFO - PROCESS | 9113 | 20:06:23 INFO - PROCESS | 9113 | [#2] jquery.html Cycles:180 Average:25119.37 Median:28535.41 stddev:76411.10 (267.8%) stddev-sans-first:76602.85 20:06:23 INFO - PROCESS | 9113 | Values: 365.4 365.6 365.6 366.8 367.2 13755.2 13859.1 15802.3 16969.2 18026.5 14267.9 14284.9 14573.8 14598.4 15245.8 5283.8 5484.9 5486.5 5489.1 5490.8 3987.3 4116.0 5389.9 5477.8 5694.4 5711.3 5845.3 5893.1 5897.5 5900.3 5904.5 5944.9 5975.2 5975.9 5977.1 4894.4 5086.5 5092.3 5252.2 5270.1 12002.9 12359.9 15548.4 20092.2 20101.9 2013.5 2030.1 2092.3 2116.9 2202.9 9591.2 10478.8 10841.6 12099.3 12553.1 1802.7 1817.1 1856.5 1976.8 1988.1 51978.5 52504.2 53227.5 53467.2 53949.0 9702.3 9935.5 9949.2 9961.9 10023.6 12942.7 13025.6 13026.9 13038.8 13070.8 6783.5 6960.4 7016.4 7074.3 7085.8 6605.7 6647.5 6672.8 6682.7 6691.1 4409.8 4463.8 4481.0 4514.5 4525.8 1712.9 1771.6 1781.8 1863.4 1890.9 842.0 842.5 873.0 904.5 920.9 13858.0 16383.2 16504.2 16710.9 17119.4 899.3 904.2 931.9 941.1 967.1 9155.5 9372.5 9420.7 9446.8 9634.9 400952.0 407870.0 409685.0 541082.0 548588.0 72237.0 75511.0 76871.6 77030.6 77686.6 1120.2 1135.5 1147.5 1157.1 1158.0 14796.1 15080.8 15245.2 15272.5 15360.8 30981.7 31389.5 31447.8 31944.5 32158.2 41681.8 41867.8 42051.0 44448.3 45647.8 7068.6 7288.1 7363.8 7364.4 7368.1 9005.9 10954.4 11114.7 11349.4 11622.5 8989.6 9592.6 9686.4 10195.4 10266.1 9331.8 9732.8 9893.4 9911.4 10090.5 7461.6 9025.7 9548.6 9908.9 10019.7 6871.3 7061.5 7234.6 7242.0 7361.9 9282.3 9451.7 9511.0 9606.8 9730.3 20:06:23 INFO - PROCESS | 9113 | 20:06:23 INFO - PROCESS | 9113 | [#3] mootools.html Cycles:180 Average:5239.75 Median:631.54 stddev:2683.90 (425.0%) stddev-sans-first:2675.44 20:06:23 INFO - PROCESS | 9113 | Values: 1342.8 1439.7 1464.8 1594.8 1773.7 6678.1 7233.6 7372.3 7372.7 7372.9 7209.7 7379.6 7397.4 7406.0 7418.1 1974.6 2014.7 2015.0 2280.1 2300.3 2300.7 2361.1 2363.7 2364.1 2364.7 2266.3 2272.5 2321.7 2323.4 2324.2 2252.3 2274.3 2276.3 2298.9 2304.0 2287.3 2288.9 2298.5 2301.9 2307.4 7458.3 7506.1 7536.2 7546.7 7560.1 4447.5 4627.9 4632.5 4636.9 4642.5 2969.6 3059.7 3091.6 3104.5 3134.6 1013.6 1026.3 1055.2 1062.8 1078.4 9683.0 9841.3 9864.9 9875.5 9884.9 3978.9 4104.3 4108.7 4347.1 4354.7 8683.8 8685.9 8691.8 8695.4 8700.9 4587.0 4591.4 4619.6 4627.1 4628.4 4145.9 4155.6 4159.0 4176.1 4176.8 3348.0 3442.6 3527.7 3642.1 3683.1 1210.2 1230.6 1231.6 1236.3 1247.1 981.5 987.3 998.3 1024.6 1025.3 6996.6 7011.2 7024.9 7032.2 7041.6 618.3 621.3 629.2 631.1 632.0 5516.9 5580.9 5586.4 5588.9 5594.5 8870.9 8962.3 9159.6 9175.8 9180.9 9012.4 9024.5 9029.6 9111.0 9127.2 6915.6 7043.9 7087.8 7171.2 7175.4 6843.2 6858.3 6864.2 6870.1 6880.2 7839.0 8084.2 8194.6 8209.7 8212.2 8258.9 8423.8 8519.1 8520.6 8524.6 6590.8 6616.4 6711.7 6728.3 6771.6 6397.6 6571.7 6790.5 6983.4 6997.0 6559.7 6573.4 6629.5 6642.3 6765.2 6513.3 6579.1 6584.0 6680.8 6693.3 6657.5 6714.2 6716.4 6717.0 6726.4 6020.8 6212.0 6253.6 6256.2 6264.0 6222.9 6289.6 6298.5 6298.7 6303.0 20:06:23 INFO - PROCESS | 9113 | 20:06:23 INFO - PROCESS | 9113 | [#4] prototype.html Cycles:180 Average:5164.39 Median:5798.41 stddev:1533.90 (26.5%) stddev-sans-first:1494.77 20:06:23 INFO - PROCESS | 9113 | Values: 335.4 337.8 344.2 344.8 348.5 5790.9 5805.9 5811.4 5812.7 5813.2 5517.6 5523.2 5607.6 5691.1 5726.9 4426.9 4431.0 4452.4 4459.0 4468.2 4282.7 4469.8 4479.3 4481.4 4485.8 4349.7 4362.3 4443.6 4451.7 4469.7 4432.2 4453.6 4455.3 4455.9 4458.6 3963.8 3973.1 3976.1 3976.6 3980.4 5388.3 5459.2 5501.1 5505.9 5516.4 5189.9 5190.1 5190.7 5198.9 5199.1 6055.5 6071.6 6071.8 6072.2 6080.5 4399.8 4400.7 4401.6 4402.8 4410.8 6207.0 6292.2 6347.7 6347.7 6358.8 4507.4 4509.1 4509.9 4510.5 4514.0 4575.2 4582.7 4585.1 4588.7 4589.6 5200.9 5202.3 5211.8 5211.8 5212.6 5965.7 6127.9 6139.7 6142.3 6151.2 1560.4 1577.2 1580.6 1582.5 1582.6 1054.7 1065.9 1068.3 1069.6 1071.6 5807.9 5815.0 5817.4 5817.7 5820.3 6312.0 6337.5 6339.0 6340.4 6346.1 5629.4 5712.6 5746.3 5757.1 5769.2 3415.2 3441.7 3447.3 3447.3 3447.7 6591.2 6591.2 6610.1 6612.1 6618.3 6330.5 6519.5 6599.5 6604.3 6610.9 6499.0 6506.6 6508.1 6512.8 6525.8 6367.3 6394.1 6403.0 6406.2 6420.5 6155.3 6286.9 6314.1 6315.9 6331.7 6636.9 6644.3 6649.3 6651.3 6655.1 4462.4 4497.2 4498.5 4500.7 4501.7 6230.4 6363.5 6388.4 6402.4 6404.7 6214.9 6222.9 6230.3 6236.8 6238.3 6211.3 6219.3 6223.2 6224.8 6230.5 5887.9 6042.4 6046.5 6059.4 6075.7 6195.8 6216.5 6219.4 6229.5 6242.1 6075.9 6088.0 6093.0 6106.2 6107.7 20:06:23 INFO - PROCESS | 9113 | 20:06:23 INFO - PROCESS | 9113 | [#5] yui.html Cycles:180 Average:13129.37 Median:48747.51 stddev:15139.10 (31.1%) stddev-sans-first:15152.47 20:06:23 INFO - PROCESS | 9113 | Values: 631.4 737.5 782.3 791.0 791.8 12839.3 12972.2 13004.2 13016.8 13021.7 14297.7 14655.2 14667.4 14726.1 14749.6 650.6 774.3 785.9 786.1 787.1 653.1 769.7 776.8 783.4 784.6 813.6 821.1 826.5 827.5 828.6 674.5 681.8 802.6 822.4 822.4 597.4 600.9 601.3 601.7 602.1 12697.9 12699.2 12766.6 12778.6 12790.6 11846.8 12044.5 12059.2 12413.2 12594.8 10142.2 10301.8 10326.8 10428.5 10473.7 3518.4 3522.9 3575.6 3588.3 3668.7 47139.5 48353.5 48406.0 48576.8 48918.3 9481.2 9526.9 9768.6 9774.2 9868.6 17144.9 17214.4 17227.7 17285.6 17289.4 6957.7 7153.6 7193.7 7250.9 7411.6 4023.0 4137.4 4142.6 4156.4 4197.3 2976.2 2992.2 3000.7 3006.1 3015.2 535.4 537.3 540.5 545.7 562.2 615.6 634.7 645.7 653.9 692.5 8469.4 8836.0 8865.3 8969.4 9011.7 515.4 650.6 662.5 666.0 667.8 3925.9 3961.7 3962.5 4094.4 4160.7 52964.0 53612.5 53931.7 53941.0 53942.2 47239.8 48040.0 48189.0 48485.3 49702.0 43370.6 43589.3 43669.6 43884.0 44209.1 7808.2 8080.9 8201.9 8214.9 8223.6 33502.5 33745.3 33770.5 33869.5 34436.8 38687.8 39253.2 41725.6 42161.8 42270.6 9756.6 9915.1 10045.3 10103.1 10181.6 11067.8 11225.8 11281.3 11328.4 11413.0 10161.0 10366.9 10388.8 10484.1 10734.1 9933.7 10107.4 10219.8 10299.6 10306.3 9453.2 9843.6 9910.8 9989.4 10247.4 8486.2 8857.4 8898.6 8906.4 9006.8 8152.0 8209.4 8572.3 8614.9 8724.5 20:06:23 INFO - PROCESS | 9113 | -------- Summary: end -------- 20:06:23 INFO - PROCESS | 9113 | 20:06:24 INFO - TEST-INFO | 9113: exit 0 20:06:24 INFO - TEST-OK | dromaeo_css | took 1112757ms 20:06:24 INFO - TEST-START | kraken 20:06:24 INFO - operating with platform_type : linux_ 20:06:24 INFO - Initialising browser for kraken test... 20:06:24 INFO - TEST-INFO | started process 9304 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7MIcaH/profile http://localhost:44123/getInfo.html) 20:06:28 INFO - PROCESS | 9304 | __metrics Screen width/height:1600/1200 20:06:28 INFO - PROCESS | 9304 | colorDepth:24 20:06:28 INFO - PROCESS | 9304 | Browser inner width/height: 1024/697 20:06:28 INFO - PROCESS | 9304 | __metrics 20:06:28 INFO - PROCESS | 9304 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:06:28 INFO - PROCESS | 9304 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:06:29 INFO - TEST-INFO | 9304: exit 0 20:06:29 INFO - Browser initialized. 20:06:29 INFO - Running cycle 1/1 for kraken test... 20:06:29 INFO - TEST-INFO | started process 9389 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7MIcaH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:41 INFO - PROCESS | 9389 | RSS: Main: 150028288 20:06:41 INFO - PROCESS | 9389 | 20:06:43 INFO - PROCESS | 9389 | Cycle 1(1): loaded http://localhost:44123/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44123/tests/kraken/driver.html?testName=audio-beat-detection) 20:06:44 INFO - PROCESS | 9389 | RSS: Main: 185610240 20:06:44 INFO - PROCESS | 9389 | 20:06:47 INFO - PROCESS | 9389 | Cycle 1(1): loaded http://localhost:44123/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44123/tests/kraken/driver.html?testName=audio-dft) 20:06:47 INFO - PROCESS | 9389 | RSS: Main: 176824320 20:06:47 INFO - PROCESS | 9389 | 20:06:50 INFO - PROCESS | 9389 | Cycle 1(1): loaded http://localhost:44123/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44123/tests/kraken/driver.html?testName=audio-fft) 20:06:51 INFO - PROCESS | 9389 | RSS: Main: 161759232 20:06:51 INFO - PROCESS | 9389 | 20:06:53 INFO - PROCESS | 9389 | Cycle 1(1): loaded http://localhost:44123/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44123/tests/kraken/driver.html?testName=audio-oscillator) 20:06:53 INFO - PROCESS | 9389 | RSS: Main: 162615296 20:06:53 INFO - PROCESS | 9389 | 20:06:55 INFO - PROCESS | 9389 | Cycle 1(1): loaded http://localhost:44123/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44123/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:06:56 INFO - PROCESS | 9389 | RSS: Main: 165711872 20:06:56 INFO - PROCESS | 9389 | 20:06:59 INFO - PROCESS | 9389 | Cycle 1(1): loaded http://localhost:44123/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44123/tests/kraken/driver.html?testName=imaging-darkroom) 20:06:59 INFO - PROCESS | 9389 | RSS: Main: 165302272 20:06:59 INFO - PROCESS | 9389 | 20:07:03 INFO - PROCESS | 9389 | Cycle 1(1): loaded http://localhost:44123/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44123/tests/kraken/driver.html?testName=imaging-desaturate) 20:07:03 INFO - PROCESS | 9389 | RSS: Main: 165683200 20:07:03 INFO - PROCESS | 9389 | 20:07:06 INFO - PROCESS | 9389 | Cycle 1(1): loaded http://localhost:44123/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44123/tests/kraken/driver.html?testName=json-parse-financial) 20:07:07 INFO - PROCESS | 9389 | RSS: Main: 166920192 20:07:07 INFO - PROCESS | 9389 | 20:07:08 INFO - PROCESS | 9389 | Cycle 1(1): loaded http://localhost:44123/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44123/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:07:09 INFO - PROCESS | 9389 | RSS: Main: 177262592 20:07:09 INFO - PROCESS | 9389 | 20:07:11 INFO - PROCESS | 9389 | Cycle 1(1): loaded http://localhost:44123/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44123/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:07:11 INFO - PROCESS | 9389 | RSS: Main: 176582656 20:07:11 INFO - PROCESS | 9389 | 20:07:13 INFO - PROCESS | 9389 | Cycle 1(1): loaded http://localhost:44123/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44123/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:07:14 INFO - PROCESS | 9389 | RSS: Main: 186576896 20:07:14 INFO - PROCESS | 9389 | 20:07:16 INFO - PROCESS | 9389 | Cycle 1(1): loaded http://localhost:44123/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44123/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:07:17 INFO - PROCESS | 9389 | RSS: Main: 192196608 20:07:17 INFO - PROCESS | 9389 | 20:07:19 INFO - PROCESS | 9389 | Cycle 1(1): loaded http://localhost:44123/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44123/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:07:20 INFO - PROCESS | 9389 | RSS: Main: 188690432 20:07:20 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | Cycle 1(1): loaded http://localhost:44123/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44123/tests/kraken/driver.html?testName=ai-astar) 20:07:22 INFO - PROCESS | 9389 | RSS: Main: 245833728 20:07:22 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | __start_tp_report 20:07:22 INFO - PROCESS | 9389 | _x_x_mozilla_page_load 20:07:22 INFO - PROCESS | 9389 | _x_x_mozilla_page_load_details 20:07:22 INFO - PROCESS | 9389 | |i|pagename|runs| 20:07:22 INFO - PROCESS | 9389 | |0;ai-astar;110;110;106;110;112;110;100;110;111;110 20:07:22 INFO - PROCESS | 9389 | |1;audio-beat-detection;154;124;146;169;127;158;152;131;162;126 20:07:22 INFO - PROCESS | 9389 | |2;audio-dft;161;161;161;161;161;163;161;163;164;162 20:07:22 INFO - PROCESS | 9389 | |3;audio-fft;73;73;95;104;71;72;72;117;96;73 20:07:22 INFO - PROCESS | 9389 | |4;audio-oscillator;100;96;138;96;96;97;137;96;95;140 20:07:22 INFO - PROCESS | 9389 | |5;imaging-gaussian-blur;109;109;109;110;109;109;109;109;110;109 20:07:22 INFO - PROCESS | 9389 | |6;imaging-darkroom;147;145;145;145;146;146;146;145;146;146 20:07:22 INFO - PROCESS | 9389 | |7;imaging-desaturate;96;97;95;95;96;96;96;95;96;96 20:07:22 INFO - PROCESS | 9389 | |8;json-parse-financial;57;56;55;56;56;65;54;63;53;54 20:07:22 INFO - PROCESS | 9389 | |9;json-stringify-tinderbox;67;67;69;68;68;69;68;69;69;69 20:07:22 INFO - PROCESS | 9389 | |10;stanford-crypto-aes;80;81;81;90;82;81;82;83;82;81 20:07:22 INFO - PROCESS | 9389 | |11;stanford-crypto-ccm;121;115;126;114;127;120;114;112;114;114 20:07:22 INFO - PROCESS | 9389 | |12;stanford-crypto-pbkdf2;140;133;141;148;133;135;130;140;154;138 20:07:22 INFO - PROCESS | 9389 | |13;stanford-crypto-sha256-iterative;68;67;66;66;65;67;65;66;66;66 20:07:22 INFO - PROCESS | 9389 | __end_tp_report 20:07:22 INFO - PROCESS | 9389 | __start_cc_report 20:07:22 INFO - PROCESS | 9389 | _x_x_mozilla_cycle_collect,954 20:07:22 INFO - PROCESS | 9389 | __end_cc_report 20:07:22 INFO - PROCESS | 9389 | __startTimestamp1452830842349__endTimestamp 20:07:22 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | ------- Summary: start ------- 20:07:22 INFO - PROCESS | 9389 | Number of tests: 14 20:07:22 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:3.48 (3.2%) stddev-sans-first:3.67 20:07:22 INFO - PROCESS | 9389 | Values: 110.0 110.0 106.0 110.0 112.0 110.0 100.0 110.0 111.0 110.0 20:07:22 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:153.00 stddev:16.62 (10.9%) stddev-sans-first:17.30 20:07:22 INFO - PROCESS | 9389 | Values: 154.0 124.0 146.0 169.0 127.0 158.0 152.0 131.0 162.0 126.0 20:07:22 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | [#2] audio-dft Cycles:10 Average:161.80 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 20:07:22 INFO - PROCESS | 9389 | Values: 161.0 161.0 161.0 161.0 161.0 163.0 161.0 163.0 164.0 162.0 20:07:22 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | [#3] audio-fft Cycles:10 Average:84.60 Median:73.00 stddev:16.90 (23.2%) stddev-sans-first:17.40 20:07:22 INFO - PROCESS | 9389 | Values: 73.0 73.0 95.0 104.0 71.0 72.0 72.0 117.0 96.0 73.0 20:07:22 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:96.00 stddev:20.23 (21.1%) stddev-sans-first:21.19 20:07:22 INFO - PROCESS | 9389 | Values: 100.0 96.0 138.0 96.0 96.0 97.0 137.0 96.0 95.0 140.0 20:07:22 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:07:22 INFO - PROCESS | 9389 | Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 20:07:22 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 20:07:22 INFO - PROCESS | 9389 | Values: 147.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 20:07:22 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 20:07:22 INFO - PROCESS | 9389 | Values: 96.0 97.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 20:07:22 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:56.00 stddev:3.96 (7.1%) stddev-sans-first:4.20 20:07:22 INFO - PROCESS | 9389 | Values: 57.0 56.0 55.0 56.0 56.0 65.0 54.0 63.0 53.0 54.0 20:07:22 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 20:07:22 INFO - PROCESS | 9389 | Values: 67.0 67.0 69.0 68.0 68.0 69.0 68.0 69.0 69.0 69.0 20:07:22 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:2.83 (3.5%) stddev-sans-first:2.88 20:07:22 INFO - PROCESS | 9389 | Values: 80.0 81.0 81.0 90.0 82.0 81.0 82.0 83.0 82.0 81.0 20:07:22 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | [#11] stanford-crypto-ccm Cycles:10 Average:117.70 Median:117.50 stddev:5.44 (4.6%) stddev-sans-first:5.63 20:07:22 INFO - PROCESS | 9389 | Values: 121.0 115.0 126.0 114.0 127.0 120.0 114.0 112.0 114.0 114.0 20:07:22 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.20 Median:140.00 stddev:7.32 (5.2%) stddev-sans-first:7.75 20:07:22 INFO - PROCESS | 9389 | Values: 140.0 133.0 141.0 148.0 133.0 135.0 130.0 140.0 154.0 138.0 20:07:22 INFO - PROCESS | 9389 | 20:07:22 INFO - PROCESS | 9389 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.71 20:07:22 INFO - PROCESS | 9389 | Values: 68.0 67.0 66.0 66.0 65.0 67.0 65.0 66.0 66.0 66.0 20:07:22 INFO - PROCESS | 9389 | -------- Summary: end -------- 20:07:22 INFO - PROCESS | 9389 | 20:07:23 INFO - TEST-INFO | 9389: exit 0 20:07:23 INFO - TEST-OK | kraken | took 58831ms 20:07:23 INFO - TEST-START | v8_7 20:07:23 INFO - operating with platform_type : linux_ 20:07:23 INFO - Initialising browser for v8_7 test... 20:07:23 INFO - TEST-INFO | started process 9637 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzr4a1I/profile http://localhost:44123/getInfo.html) 20:07:27 INFO - PROCESS | 9637 | __metrics Screen width/height:1600/1200 20:07:27 INFO - PROCESS | 9637 | colorDepth:24 20:07:27 INFO - PROCESS | 9637 | Browser inner width/height: 1024/697 20:07:27 INFO - PROCESS | 9637 | __metrics 20:07:27 INFO - PROCESS | 9637 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:07:27 INFO - PROCESS | 9637 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:07:28 INFO - TEST-INFO | 9637: exit 0 20:07:28 INFO - Browser initialized. 20:07:28 INFO - Running cycle 1/1 for v8_7 test... 20:07:28 INFO - TEST-INFO | started process 9719 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzr4a1I/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:40 INFO - PROCESS | 9719 | RSS: Main: 149532672 20:07:40 INFO - PROCESS | 9719 | 20:08:02 INFO - PROCESS | 9719 | Cycle 1(1): loaded http://localhost:44123/tests/v8_7/run.html (next: http://localhost:44123/tests/v8_7/run.html) 20:08:03 INFO - PROCESS | 9719 | RSS: Main: 562909184 20:08:03 INFO - PROCESS | 9719 | 20:08:03 INFO - PROCESS | 9719 | __start_tp_report 20:08:03 INFO - PROCESS | 9719 | _x_x_mozilla_page_load 20:08:03 INFO - PROCESS | 9719 | _x_x_mozilla_page_load_details 20:08:03 INFO - PROCESS | 9719 | |i|pagename|runs| 20:08:03 INFO - PROCESS | 9719 | |0;Richards;167.95431642593215 20:08:03 INFO - PROCESS | 9719 | |1;DeltaBlue;188.78610534264678 20:08:03 INFO - PROCESS | 9719 | |2;Encrypt;279.79854504756577 20:08:03 INFO - PROCESS | 9719 | |3;Decrypt;5240.837696335078 20:08:03 INFO - PROCESS | 9719 | |4;RayTrace;1996.007984031936 20:08:03 INFO - PROCESS | 9719 | |5;Earley;788.6435331230284 20:08:03 INFO - PROCESS | 9719 | |6;Boyer;12219.512195121952 20:08:03 INFO - PROCESS | 9719 | |7;RegExp;42520.833333333336 20:08:03 INFO - PROCESS | 9719 | |8;Splay;597.1394517282479 20:08:03 INFO - PROCESS | 9719 | |9;NavierStokes;4873.78640776699 20:08:03 INFO - PROCESS | 9719 | __end_tp_report 20:08:03 INFO - PROCESS | 9719 | __startTimestamp1452830883015__endTimestamp 20:08:03 INFO - PROCESS | 9719 | 20:08:03 INFO - PROCESS | 9719 | ------- Summary: start ------- 20:08:03 INFO - PROCESS | 9719 | Number of tests: 10 20:08:03 INFO - PROCESS | 9719 | 20:08:03 INFO - PROCESS | 9719 | [#0] Richards Cycles:1 Average:167.95 Median:167.95 stddev:0.00 (0.0%) 20:08:03 INFO - PROCESS | 9719 | Values: 168.0 20:08:03 INFO - PROCESS | 9719 | 20:08:03 INFO - PROCESS | 9719 | [#1] DeltaBlue Cycles:1 Average:188.79 Median:188.79 stddev:0.00 (0.0%) 20:08:03 INFO - PROCESS | 9719 | Values: 188.8 20:08:03 INFO - PROCESS | 9719 | 20:08:03 INFO - PROCESS | 9719 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 20:08:03 INFO - PROCESS | 9719 | Values: 279.8 20:08:03 INFO - PROCESS | 9719 | 20:08:03 INFO - PROCESS | 9719 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 20:08:03 INFO - PROCESS | 9719 | Values: 5240.8 20:08:03 INFO - PROCESS | 9719 | 20:08:03 INFO - PROCESS | 9719 | [#4] RayTrace Cycles:1 Average:1996.01 Median:1996.01 stddev:0.00 (0.0%) 20:08:03 INFO - PROCESS | 9719 | Values: 1996.0 20:08:03 INFO - PROCESS | 9719 | 20:08:03 INFO - PROCESS | 9719 | [#5] Earley Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 20:08:03 INFO - PROCESS | 9719 | Values: 788.6 20:08:03 INFO - PROCESS | 9719 | 20:08:03 INFO - PROCESS | 9719 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 20:08:03 INFO - PROCESS | 9719 | Values: 12219.5 20:08:03 INFO - PROCESS | 9719 | 20:08:03 INFO - PROCESS | 9719 | [#7] RegExp Cycles:1 Average:42520.83 Median:42520.83 stddev:0.00 (0.0%) 20:08:03 INFO - PROCESS | 9719 | Values: 42520.8 20:08:03 INFO - PROCESS | 9719 | 20:08:03 INFO - PROCESS | 9719 | [#8] Splay Cycles:1 Average:597.14 Median:597.14 stddev:0.00 (0.0%) 20:08:03 INFO - PROCESS | 9719 | Values: 597.1 20:08:03 INFO - PROCESS | 9719 | 20:08:03 INFO - PROCESS | 9719 | [#9] NavierStokes Cycles:1 Average:4873.79 Median:4873.79 stddev:0.00 (0.0%) 20:08:03 INFO - PROCESS | 9719 | Values: 4873.8 20:08:03 INFO - PROCESS | 9719 | -------- Summary: end -------- 20:08:03 INFO - PROCESS | 9719 | 20:08:03 INFO - TEST-INFO | 9719: exit 0 20:08:03 INFO - TEST-OK | v8_7 | took 40664ms 20:08:03 INFO - SUITE-END | took 1212s 20:08:04 INFO - Completed test suite (00:20:12) 20:08:04 INFO - Working with test: dromaeo_css 20:08:04 INFO - Generating results file: dromaeo_css 20:08:04 INFO - Working with test: kraken 20:08:04 INFO - Generating results file: kraken 20:08:04 INFO - javascript benchmark 20:08:04 INFO - Working with test: v8_7 20:08:04 INFO - Generating results file: v8_7 20:08:04 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:08:04 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 20:08:04 INFO - process_Request line: dromaeo_css 6627.07 graph.html#tests=[[72,201,35]] 20:08:04 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:08:04 INFO - process_Request line: kraken 1490.60 graph.html#tests=[[232,201,35]] 20:08:04 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:08:04 INFO - process_Request line: v8_7 18864.71 graph.html#tests=[[230,201,35]] 20:08:04 INFO - RETURN: dromaeo_css: 6627.07 20:08:04 INFO - RETURN: kraken: 1490.60 20:08:04 INFO - RETURN: v8_7: 18864.71 20:08:04 INFO - javascript benchmark 20:08:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3125.437421264173, 3128.1710346758127, 3170.873165073397, 3180.8727650893966, 3206.7274281686055, 4991.700497970124, 5038.924416133761, 5061.29141920131, 5095.388553373591, 5101.872453188667, 5106.744662766856, 5148.330717006793, 5188.351456067991, 5202.3497062867145, 5214.973925130378, 4495.550444955495, 4593.908121837578, 4630.328602352648, 4693.084848454553, 4809.51904809518, 4591.540845915399, 4660.627149828023, 4773.18855794514, 4773.71357718538, 4863.392075990501, 4654.348391225231, 4657.184992626294, 4666.510016448258, 4677.6491763117565, 4677.929831052537, 4693.436787585478, 4694.600958918496, 4721.409823772028, 4731.716097034189, 4739.241721324572, 4581.427321584802, 4675.111728771522, 4676.69601475903, 4697.812087516495, 4700.952990470086, 5002.0, 5017.096922553938, 5020.196768517057, 5020.849374518771, 5028.5977121830165, 5501.05482601607, 5507.339119305669, 5510.173473978895, 5510.972445137789, 5556.972215138939, 5383.542398896098, 5460.290162278918, 5477.917831232535, 5531.640443371168, 5536.944630553683, 5271.999999999962, 5275.472452754732, 5277.8416647500635, 5289.841304760864, 5295.232191332235, 5707.6290041147195, 5722.942770572325, 5725.2843394575675, 5727.05503591911, 5730.36965933747, 5354.598405119632, 5423.132298832168, 5423.918641220384, 5471.206675032177, 5493.093639549509, 5527.55779537636, 5535.723213839292, 5537.667739935617, 5545.611807173459, 5573.247611572467, 5456.945430545723, 5486.177073439016, 5500.119980803052, 5508.862278443071, 5560.916586251209, 5442.91835622466, 5469.56243500519, 5494.478024587658, 5551.444855514497, 5576.553875689935, 4304.569543045671, 4309.288967320357, 4321.395004699345, 4335.067960388532, 4340.934885976713, 3876.8449262029767, 3883.61163883615, 3886.514185726784, 3913.5108111486065, 3917.6278253565865, 5033.068882256721, 5107.387113546398, 5115.283860259567, 5127.102757017507, 5131.384233891882, 5447.727613619303, 5475.397706252309, 5497.862553436196, 5520.447955204448, 5546.473085056913, 5076.923846142311, 5102.0, 5103.106956282636, 5110.770015349318, 5153.716545589954, 4592.402987611589, 4673.7429441381055, 4709.152352576569, 4738.147133515931, 4837.733924634109, 5699.344575373885, 5700.743466544015, 5715.199872017921, 5717.914231286534, 5721.685307308138, 5523.475269849358, 5533.501984821385, 5534.889302214014, 5539.0, 5582.330120385417, 5602.915956260741, 5638.154276858504, 5691.174779657009, 5691.857703557444, 5721.914171287517, 5508.697021663686, 5536.7231638418725, 5543.833684989457, 5545.916811247916, 5547.639403438763, 5562.360328562268, 5574.0, 5614.466625670718, 5621.072523033818, 5631.943680563142, 5314.176302673091, 5400.2439658447065, 5424.294841670558, 5498.670079795225, 5509.9806535791, 5356.116240820221, 5358.517733404013, 5365.436629154039, 5365.758540865592, 5389.8113566025, 5272.7100009499845, 5275.366955965309, 5276.551493123127, 5283.445238250082, 5296.576273898002, 5342.385625652944, 5360.731963401737, 5364.678119312854, 5413.296271484839, 5413.621046526705, 5337.146056630921, 5387.515123638891, 5392.245085688085, 5408.7566059526625, 5431.131019036935], "unit": "score", "name": "dojo.html", "value": 5097.795817926914}, {"lowerIsBetter": false, "replicates": [499.88002879308965, 503.6625460941169, 512.7769420302169, 527.5094162428942, 607.2773399654413, 28778.856105719467, 29246.561301580467, 29277.560836587443, 35353.292934141304, 35785.0, 39090.21819563607, 39469.80265098678, 39521.40717889234, 39583.80208098955, 39639.20721585566, 8481.787955301135, 8695.21743043126, 8701.390902636818, 8703.042665306812, 8709.477431354107, 8380.8742868857, 8456.365772567051, 8522.105178956213, 8524.104968978261, 8525.360597955147, 8503.829923401529, 8571.742847714579, 8577.614007369682, 8578.914210857905, 8579.227869491744, 8478.279346255576, 8511.021232558272, 8531.616077276538, 8543.658253669877, 8545.615447304886, 8291.58542072894, 8349.582520873993, 8414.74755757322, 8416.326693864476, 8416.621252043673, 38381.23237535234, 38503.61496385057, 38676.22647547061, 38797.22405551873, 38831.8058409709, 3133.833536904545, 3224.91937701557, 3462.792232466035, 3722.7766334019775, 3805.9238815223816, 29006.709932900823, 29172.416551668848, 29284.267893302836, 29719.25701857449, 30203.395932081454, 3460.757746957714, 3485.42490489069, 3495.755297129202, 3581.247937933037, 3668.4313931340685, 200078.0, 201010.0, 201422.0, 201973.0, 202220.0, 50169.0, 53673.46326536763, 54397.45602544003, 54475.45524544783, 54477.45522544803, 48531.5146848527, 59936.700316498136, 61212.0, 61272.387276127556, 61322.0801687975, 13233.53682621123, 13487.932560337136, 13491.460341586422, 13515.121517101554, 13529.255890926093, 9545.52272386378, 9650.227981761582, 9760.511974401252, 10003.349782264275, 10029.69910902674, 17896.284148634168, 18138.183781729855, 18166.18252178655, 18284.17721202549, 18291.72562411565, 6797.388235058868, 7021.89467157993, 7024.332688394595, 7058.223595404502, 7076.4692648051605, 851.8892543969245, 929.8419268724333, 951.2083722223331, 969.3553786731885, 1049.976273133704, 25640.230793076236, 27542.311442214104, 27850.303742406602, 27861.0, 28048.579271310948, 993.4536005197112, 1011.6813203840767, 1039.3036665434176, 1052.736815796051, 1101.0805977009127, 12806.107174932567, 13540.322983850769, 13601.387937542835, 13790.241536715577, 13872.0, 340011.0, 341457.0, 343235.0, 344680.0, 345521.0, 42933.35599966003, 43537.78231108888, 49832.750836245585, 49992.750036249585, 50122.24816627753, 1287.414226526928, 1300.1873828856965, 1302.5375991523063, 1307.9215247085206, 1327.1240980952525, 25894.223173304832, 26270.605940911282, 26527.0, 26562.203133906012, 26801.731982679925, 41201.0, 41676.37485437781, 41783.37324940189, 42865.571344287404, 46578.53421465742, 213574.0, 214278.0, 214704.0, 214750.0, 214960.0, 28647.0, 28897.277568060967, 29002.0, 29031.274218144714, 29078.27304317409, 37462.8126859364, 38913.8054309738, 39169.2166156681, 39585.60414395819, 39597.60402395939, 32923.0, 35156.64843351534, 35438.11404714903, 35565.82217088898, 36542.0, 35383.646163539066, 36088.63911360958, 36231.0, 36279.637203628685, 36294.0, 34594.135146621535, 35458.0, 35506.644933550335, 35577.644223557436, 35702.0, 28975.0, 32017.519737203496, 32146.67853321437, 32304.35391292208, 32310.19224519406, 23492.29801635231, 23630.0, 23649.52700945937, 23712.170074047324, 24104.276871693877], "unit": "score", "name": "ext.html", "value": 17217.161304643385}, {"lowerIsBetter": false, "replicates": [365.36426617685237, 365.5887126982145, 365.6106246847108, 366.8477581803552, 367.19584110797337, 13755.174689518612, 13859.099158554687, 15802.288896999635, 16969.151542422875, 18026.549336266584, 14267.928660356709, 14284.92857535711, 14573.781393279109, 14598.416063357454, 15245.847541524581, 5283.8150664726745, 5484.945150548503, 5486.478784515464, 5489.066858634022, 5490.80782172624, 3987.3022221111332, 4116.012157082294, 5389.946100538984, 5477.780888764445, 5694.373618901917, 5711.343195532505, 5845.269341332333, 5893.086571581412, 5897.528197744192, 5900.291964964189, 5904.468597826195, 5944.881102377972, 5975.19334889793, 5975.850603734898, 5977.1034344848185, 4894.412670479565, 5086.54221120101, 5092.337996060525, 5252.1596544552685, 5270.104082305978, 12002.939985300105, 12359.876401236052, 15548.378064877392, 20092.1963121475, 20101.899490502456, 2013.4664313956814, 2030.056023948871, 2092.2677063027973, 2116.9364919052455, 2202.878841663708, 9591.184749296319, 10478.79042419155, 10841.566337346496, 12099.334536600483, 12553.058520610899, 1802.6665066962653, 1817.1186974317445, 1856.4616261284211, 1976.8122028407279, 1988.1311567126854, 51978.48021519774, 52504.212436813476, 53227.467725323026, 53467.19799203015, 53949.0, 9702.320837541305, 9935.453550054672, 9949.204063674888, 9961.850572241423, 10023.599056037678, 12942.741145177044, 13025.609231723063, 13026.934865325613, 13038.80441793374, 13070.803937940938, 6783.457323414115, 6960.443164546824, 7016.403605693573, 7074.327938845801, 7085.82285442868, 6605.678864227174, 6647.501437392215, 6672.833179170462, 6682.699278532477, 6691.063251144844, 4409.801558929792, 4463.821447142078, 4480.977595112004, 4514.45826500822, 4525.818967241274, 1712.8800983931255, 1771.5659663382553, 1781.7683701118772, 1863.3509344230454, 1890.8676392652658, 841.9831603367899, 842.4818736477145, 872.9563521823883, 904.4669285561042, 920.9263258939269, 13858.0, 16383.214853474938, 16504.17479126039, 16710.916445417693, 17119.400820971205, 899.2670973156856, 904.204300215819, 931.8741969834122, 941.096547314572, 967.1150896929231, 9155.45067295951, 9372.484513351696, 9420.717378478657, 9446.763830904283, 9634.855477167848, 400952.0, 407870.0, 409685.0, 541082.0, 548588.0, 72237.0, 75511.0, 76871.61564192254, 77030.61484692541, 77686.61156694293, 1120.2102517724984, 1135.5230803062734, 1147.5467190459556, 1157.0965761322577, 1158.0, 14796.112233266038, 15080.849191508383, 15245.223753006616, 15272.541823745305, 15360.769588456405, 30981.690183097882, 31389.52915706312, 31447.84276078605, 31944.52083218707, 32158.19604509906, 41681.79159104185, 41867.7906610465, 42051.0, 44448.33327500025, 45647.77176114098, 7068.646567671699, 7288.052553168266, 7363.8159046024275, 7364.374028207662, 7368.115826100688, 9005.864912026456, 10954.397508137128, 11114.666560003212, 11349.432528373383, 11622.535098595961, 8989.595468203815, 9592.568334424828, 9686.370385924893, 10195.388276703421, 10266.127379172854, 9331.766705832408, 9732.756681082747, 9893.35693179941, 9911.405315681082, 10090.54592543352, 7461.552306861606, 9025.729228123168, 9548.618055277711, 9908.900910990798, 10019.699409017741, 6871.312868713088, 7061.540999834994, 7234.5659260444545, 7242.0, 7361.926380736124, 9282.257419406566, 9451.716448506555, 9510.95244523773, 9606.759831004281, 9730.318877678777], "unit": "score", "name": "jquery.html", "value": 8017.374577654473}, {"lowerIsBetter": false, "replicates": [1342.8321459817523, 1439.6976634906669, 1464.7949287099807, 1594.8325425830287, 1773.6896043192437, 6678.098456708343, 7233.565986040835, 7372.3364897159245, 7372.668229929653, 7372.889406658897, 7209.747658831942, 7379.557226566396, 7397.445191610624, 7406.037215162021, 7418.072740907387, 1974.5655955689726, 2014.6977953306975, 2015.042854644047, 2280.133549251282, 2300.2754132448226, 2300.7469178390365, 2361.055577768889, 2363.7163540375177, 2364.0661938534267, 2364.728056273533, 2266.2634643740766, 2272.5114100468395, 2321.6749655048307, 2323.384303159664, 2324.2213858357472, 2252.279270633406, 2274.306336567346, 2276.271593090212, 2298.8620682759088, 2303.9884800576056, 2287.2795069553204, 2288.8512246703913, 2298.482841360697, 2301.8503797253125, 2307.411610039429, 7458.254174582553, 7506.13679426862, 7536.208698086732, 7546.69813207471, 7560.092788865371, 4447.510773814878, 4627.907441851178, 4632.513586073481, 4636.884077898046, 4642.535746425364, 2969.5694124352062, 3059.72462478378, 3091.613548306462, 3104.518799586068, 3134.5611614374006, 1013.5996281468779, 1026.3380119822748, 1055.176961969665, 1062.8299472084507, 1078.4338222433207, 9682.951585242028, 9841.261905357127, 9864.852027219598, 9875.506224688737, 9884.901150988542, 3978.9403158952637, 4104.281750693676, 4108.6918481114035, 4347.06538094305, 4354.673399494987, 8683.782905427288, 8685.913140868637, 8691.782705432288, 8695.391322607356, 8700.912990870136, 4586.97706511472, 4591.44902611682, 4619.630429565626, 4627.120847039052, 4628.39830821991, 4145.937810932838, 4155.58444155588, 4159.022629682022, 4176.1230141670585, 4176.77027763476, 3347.9665203347654, 3442.569678790151, 3527.664871837171, 3642.0712718256673, 3683.097641077953, 1210.189173253922, 1230.563150081726, 1231.58741821489, 1236.33238051453, 1247.1270110922392, 981.5386768218925, 987.2990176974286, 998.2662742883974, 1024.636254129788, 1025.348903446302, 6996.615186164708, 7011.228764835864, 7024.894626580605, 7032.226455089936, 7041.5775053496955, 618.2735286038886, 621.3382747374033, 629.2260519560965, 631.0880777276883, 632.0, 5516.9448305517235, 5580.91628625571, 5586.413426590231, 5588.888222235614, 5594.524465420403, 8870.86693699595, 8962.32782541312, 9159.633614655339, 9175.77060573491, 9180.908190918006, 9012.369134160677, 9024.503652299056, 9029.593668284942, 9111.038912353379, 9127.178553930178, 6915.550489218184, 7043.943408488768, 7087.787366379017, 7171.175314838756, 7175.425965922714, 6843.213030501556, 6858.3141685831015, 6864.176298844171, 6870.072540207008, 6880.174379074543, 7838.960805195938, 8084.151164127918, 8194.590270486571, 8209.712660057108, 8212.17878212174, 8258.926339575817, 8423.789405264917, 8519.148085191431, 8520.573971301534, 8524.573771311285, 6590.7693230736695, 6616.371444712745, 6711.731530738716, 6728.259891411843, 6771.627560484024, 6397.584157029778, 6571.704273307617, 6790.45676345901, 6983.44132469391, 6997.0, 6559.672016399066, 6573.408393244631, 6629.46964242869, 6642.3025582315095, 6765.188177418741, 6513.250976137805, 6579.111819904251, 6583.979483180115, 6680.83297917556, 6693.297203793726, 6657.467402607683, 6714.2278637955305, 6716.429103526255, 6717.0, 6726.3609957054005, 6020.849478763066, 6212.0, 6253.5622506424115, 6256.249250090018, 6263.96868015657, 6222.875542489215, 6289.591176573508, 6298.527610429328, 6298.716557755004, 6303.023031430135], "unit": "score", "name": "mootools.html", "value": 4284.456271755919}, {"lowerIsBetter": false, "replicates": [335.40465673429657, 337.75681509313296, 344.18084957800426, 344.82758620689657, 348.5190437196668, 5790.942090579093, 5805.883882322351, 5811.418858114186, 5812.651240925542, 5813.2152159458465, 5517.586181036419, 5523.226748255248, 5607.551395888329, 5691.060974939141, 5726.914096288559, 4426.889327766799, 4430.9778451107695, 4452.354408610766, 4458.955410445887, 4468.240399132155, 4282.657387409015, 4469.798859051334, 4479.305707615308, 4481.439820022497, 4485.842995495142, 4349.673774466912, 4362.258416069276, 4443.5556444355625, 4451.688381813275, 4469.664775141861, 4432.180046691356, 4453.55464453552, 4455.287154055368, 4455.910881782379, 4458.621017213541, 3963.8414463421427, 3973.086190176247, 3976.065624578222, 3976.602339766029, 3980.402939559089, 5388.326459192601, 5459.153831156177, 5501.092319767234, 5505.862353441156, 5516.448355164452, 5189.870253243661, 5190.06578815813, 5190.662606930538, 5198.92201616976, 5199.14214154664, 6055.455009049163, 6071.574989750719, 6071.787487437919, 6072.180255665473, 6080.543959203077, 4399.758013309267, 4400.669949753749, 4401.625861801751, 4402.801873915681, 4410.823567057314, 6206.968965155191, 6292.150559674431, 6347.682615869188, 6347.714352854133, 6358.77744278948, 4507.368968344369, 4509.053098849278, 4509.909801803946, 4510.526394728572, 4514.029483661028, 4575.153596584642, 4582.702124361906, 4585.060062687141, 4588.724676519353, 4589.632829373642, 5200.869978250574, 5202.3497062867145, 5211.765470553834, 5211.791528338824, 5212.5569326607665, 5965.701714914237, 6127.908081378783, 6139.693015349304, 6142.262928448615, 6151.200343955257, 1560.40704532277, 1577.2271586922325, 1580.6364536156748, 1582.5410630917136, 1582.5885269829928, 1054.6730513540826, 1065.925385223027, 1068.316277582348, 1069.5989004123453, 1071.5874388360382, 5807.94192058074, 5814.970925145347, 5817.360090390053, 5817.7382017809305, 5820.30156381237, 6312.0, 6337.493000559944, 6338.968305158444, 6340.397662222082, 6346.11154438379, 5629.408912064257, 5712.600117991784, 5746.310442746813, 5757.0788673811985, 5769.163471296639, 3415.197428604276, 3441.7246620270316, 3447.2760720248525, 3447.3450044491465, 3447.7069449096607, 6591.242007169237, 6591.242007169237, 6610.107635469246, 6612.107365505692, 6618.30507796684, 6330.493560515148, 6519.478441724651, 6599.505037122235, 6604.339566043357, 6610.933890661128, 6499.0, 6506.642134682544, 6508.056331831953, 6512.772052978123, 6525.771597994048, 6367.3314301997625, 6394.136791533269, 6403.0, 6406.231252249573, 6420.486361091195, 6155.292141403616, 6286.937130628635, 6314.084457753508, 6315.90526142099, 6331.715072821642, 6636.938089905785, 6644.269130395749, 6649.335066493312, 6651.301613330531, 6655.101561289164, 4462.419885414875, 4497.168023915586, 4498.527654596221, 4500.707454015478, 4501.707389019703, 6230.376962303733, 6363.5227357947415, 6388.39310265524, 6402.423781859655, 6404.679766011587, 6214.9067763984485, 6222.937770622236, 6230.283517395557, 6236.781712640036, 6238.313785483502, 6211.3478084800445, 6219.253689557282, 6223.190985171898, 6224.844378890564, 6230.470410015199, 5887.911681324869, 6042.395760423922, 6046.54650901193, 6059.424354686298, 6075.726592303446, 6195.845103872439, 6216.533759968111, 6219.440250377488, 6229.5327850410495, 6242.063690446288, 6075.878482430238, 6087.965045942289, 6092.969535152296, 6106.175666284995, 6107.694615269308], "unit": "score", "name": "prototype.html", "value": 4671.1748901085775}, {"lowerIsBetter": false, "replicates": [631.3717850738514, 737.450599303519, 782.2568559868125, 790.9723159689412, 791.7505985614531, 12839.29383883886, 12972.221666700005, 13004.154729942547, 13016.804747928789, 13021.739565208702, 14297.71404571908, 14655.193964331958, 14667.413303467849, 14726.116433014027, 14749.557513274593, 650.5868773328923, 774.3108633316353, 785.8506883692108, 786.0685088170536, 787.1184273613561, 653.0791583866749, 769.7267470048137, 776.7980325115483, 783.3967844759532, 784.5684873319651, 813.5932033983008, 821.1255013410698, 826.5330088500008, 827.5407149032285, 828.5608627427443, 674.5210900260845, 681.8125015620744, 802.6267785479722, 822.3626689315798, 822.428412253481, 597.3578403216516, 600.8828278485697, 601.2574470528893, 601.6961434475562, 602.0728078758706, 12697.873021269761, 12699.174553653984, 12766.61700148997, 12778.61664150077, 12790.552330668475, 11846.822297665542, 12044.45799938996, 12059.216150950248, 12413.193142445713, 12594.81107783384, 10142.239332050125, 10301.79396412075, 10326.793464130751, 10428.478576071242, 10473.731254345004, 3518.3842827505086, 3522.929541409183, 3575.6424357564297, 3588.2644057968055, 3668.706503479715, 47139.52860471386, 48353.51646483525, 48406.0, 48576.75711621455, 48918.266226006635, 9481.194098501705, 9526.90473095274, 9768.609255629837, 9774.16919561831, 9868.555914983843, 17144.914275428542, 17214.39749608758, 17227.741583876254, 17285.56786080333, 17289.394871179447, 6957.65211739411, 7153.570785752871, 7193.712251509985, 7250.891236631454, 7411.629418529052, 4022.959770402317, 4137.379393091001, 4142.647874930604, 4156.355764856452, 4197.286461301586, 2976.1964269647074, 2992.177151283371, 3000.744936680363, 3006.068118883153, 3015.231116065433, 535.3655917737493, 537.3122403323752, 540.4677738611003, 545.6835035679296, 562.1848319936109, 615.6060121522229, 634.6985182038587, 645.6932956845461, 653.8888388973886, 692.4702602509085, 8469.3647976402, 8835.955820220857, 8865.290776737975, 8969.372143949991, 9011.710725585113, 515.409855715204, 650.632392698124, 662.4667142949875, 665.9866802664017, 667.839718467574, 3925.9214815703526, 3961.742486738353, 3962.5443074046275, 4094.406311084876, 4160.687948403821, 52964.0, 53612.46387536075, 53931.73034134804, 53941.0, 53942.190867137026, 47239.76380118077, 48040.0, 48189.0, 48485.27272090921, 49702.0, 43370.566294336655, 43589.346159807625, 43669.563304367184, 43884.0, 44209.115817683465, 7808.180141085331, 8080.9191908080165, 8201.917980820115, 8214.917850821415, 8223.629936652746, 33502.4873134511, 33745.32509349848, 33770.493442597886, 33869.47587358525, 34436.82781586076, 38687.80656096814, 39253.214935700555, 41725.58274417217, 42161.789191053846, 42270.57729422666, 9756.609735610497, 9915.058069483388, 10045.296829221885, 10103.09072183507, 10181.643642472478, 11067.833982490109, 11225.775484490101, 11281.266717663326, 11328.433578321215, 11413.0, 10161.0, 10366.948165259126, 10388.792224155324, 10484.056434920894, 10734.14126869833, 9933.65232216869, 10107.444090575089, 10219.795604087727, 10299.639512617323, 10306.278560500992, 9453.196478299422, 9843.557039933077, 9910.801783964425, 9989.350692204984, 10247.38515689061, 8486.236238738544, 8857.424267422597, 8898.599563019809, 8906.376553641183, 9006.81986360256, 8151.959240203761, 8209.425340226127, 8572.314214862921, 8614.91385086141, 8724.520151391735], "unit": "score", "name": "yui.html", "value": 6014.421048845662}], "name": "dromaeo_css", "value": 6627.071030379325}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 106.0, 110.0, 112.0, 110.0, 100.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 146.0, 169.0, 127.0, 158.0, 152.0, 131.0, 162.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.9}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 163.0, 161.0, 163.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 95.0, 104.0, 71.0, 72.0, 72.0, 117.0, 96.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [100.0, 96.0, 138.0, 96.0, 96.0, 97.0, 137.0, 96.0, 95.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 55.0, 56.0, 56.0, 65.0, 54.0, 63.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 69.0, 68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 81.0, 90.0, 82.0, 81.0, 82.0, 83.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [121.0, 115.0, 126.0, 114.0, 127.0, 120.0, 114.0, 112.0, 114.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.7}, {"lowerIsBetter": true, "replicates": [140.0, 133.0, 141.0, 148.0, 133.0, 135.0, 130.0, 140.0, 154.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 66.0, 65.0, 67.0, 65.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1490.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.95431642593215], "unit": "score", "name": "Richards", "value": 210.18810800000006}, {"lowerIsBetter": false, "replicates": [188.78610534264678], "unit": "score", "name": "DeltaBlue", "value": 350.22704600000003}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1996.007984031936], "unit": "score", "name": "RayTrace", "value": 370.73448899999994}, {"lowerIsBetter": false, "replicates": [788.6435331230284], "unit": "score", "name": "Earley", "value": 845.075084}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [42520.833333333336], "unit": "score", "name": "RegExp", "value": 21.42443900048995}, {"lowerIsBetter": false, "replicates": [597.1394517282479], "unit": "score", "name": "Splay", "value": 136.46896007984037}, {"lowerIsBetter": false, "replicates": [4873.78640776699], "unit": "score", "name": "NavierStokes", "value": 304.48605577689233}], "name": "v8_7", "value": 18864.707714840195}]} 20:08:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "18864.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1490.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6627.07"}}} 20:08:04 INFO - Return code: 0 20:08:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:08:04 INFO - # TBPL SUCCESS # 20:08:04 INFO - Running post-action listener: _resource_record_post_action 20:08:04 INFO - Running post-run listener: _resource_record_post_run 20:08:05 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 434176; Write bytes: 305246208; Read time: 376; Write time: 174636 20:08:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5447680; Read time: 0; Write time: 444 20:08:05 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 434176; Write bytes: 299798528; Read time: 376; Write time: 174192 20:08:05 INFO - Running post-run listener: _upload_blobber_files 20:08:05 INFO - Blob upload gear active. 20:08:05 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:08:05 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 20:08:05 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:08:05 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:08:06 INFO - (blobuploader) - INFO - Open directory for files ... 20:08:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:08:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:08:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:08:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:08:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:08:07 INFO - (blobuploader) - INFO - Done attempting. 20:08:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:08:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:08:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:08:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:08:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:08:07 INFO - (blobuploader) - INFO - Done attempting. 20:08:07 INFO - (blobuploader) - INFO - Iteration through files over. 20:08:07 INFO - Return code: 0 20:08:07 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:08:07 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:08:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/62fc64d5505040e770b0f2330ca738b1b3eb1080d018e57b488e5f8108f46c2989fa6b9ab43246d11d40ad457cd841bd03ee7169b3baf5187b595a0e48566f1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/31455765000b1de933eed7edde625905f90029a5caa81609c360aefe541c6a425999af507a51116cbd207a30c2b93f03ca71a94cf6b548e2f30e33951237a131"} 20:08:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:08:07 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:08:07 INFO - Contents: 20:08:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/62fc64d5505040e770b0f2330ca738b1b3eb1080d018e57b488e5f8108f46c2989fa6b9ab43246d11d40ad457cd841bd03ee7169b3baf5187b595a0e48566f1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/31455765000b1de933eed7edde625905f90029a5caa81609c360aefe541c6a425999af507a51116cbd207a30c2b93f03ca71a94cf6b548e2f30e33951237a131"} 20:08:07 INFO - Copying logs to upload dir... 20:08:07 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.597418 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-14 20:08:07.986962) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 20:08:07.990646) ========= 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=cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/62fc64d5505040e770b0f2330ca738b1b3eb1080d018e57b488e5f8108f46c2989fa6b9ab43246d11d40ad457cd841bd03ee7169b3baf5187b595a0e48566f1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/31455765000b1de933eed7edde625905f90029a5caa81609c360aefe541c6a425999af507a51116cbd207a30c2b93f03ca71a94cf6b548e2f30e33951237a131"} build_url:https://queue.taskcluster.net/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011377 build_url: 'https://queue.taskcluster.net/v1/task/TUt3zyDeQ2eB5WtSundk3Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/62fc64d5505040e770b0f2330ca738b1b3eb1080d018e57b488e5f8108f46c2989fa6b9ab43246d11d40ad457cd841bd03ee7169b3baf5187b595a0e48566f1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/31455765000b1de933eed7edde625905f90029a5caa81609c360aefe541c6a425999af507a51116cbd207a30c2b93f03ca71a94cf6b548e2f30e33951237a131"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 20:08:08.016479) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 20:08:08.016856) ========= 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=cbe409c6de289db6ac707de3000001d4-1452828983.694797-1647741292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004404 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 20:08:08.100389) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 20:08:08.100769) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 20:08:08.101096) ========= ========= Total master_lag: 0.34 =========