builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1452246509.03 results: success (0) buildid: 20160107233013 builduid: 8ad025628bed4c2bbd4e7f2a33ccbf3d revision: 54188f0b70da50f75f93da46c59330813ea6380d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.031899) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.032424) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.032743) ========= 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=82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006274 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.056078) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.056370) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.089816) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.090121) ========= 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=82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004667 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.141424) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.141691) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.142101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.142404) ========= 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=82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 01:48:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-01-08 01:48:29 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168510 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.324653) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.324969) ========= 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=82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016307 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.374585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.374896) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 54188f0b70da50f75f93da46c59330813ea6380d --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 54188f0b70da50f75f93da46c59330813ea6380d --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=82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 01:48:29,778 truncating revision to first 12 chars 2016-01-08 01:48:29,778 Setting DEBUG logging. 2016-01-08 01:48:29,778 attempt 1/10 2016-01-08 01:48:29,778 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/54188f0b70da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 01:48:30,044 unpacking tar archive at: b2g-inbound-54188f0b70da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.573002 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.961031) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.961337) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.971714) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.972049) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 01:48:29.972499) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-08 01:48:29.972794) ========= /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=82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:48:30 INFO - MultiFileLogger online at 20160108 01:48:30 in /builds/slave/test-pgo 01:48:30 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 01:48:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:48:30 INFO - {'append_to_log': False, 01:48:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:48:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 01:48:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:48:30 INFO - 'branch': 'B2G-Inbound', 01:48:30 INFO - 'buildbot_json_path': 'buildprops.json', 01:48:30 INFO - 'config_files': ('talos/linux_config.py',), 01:48:30 INFO - 'default_actions': ('clobber', 01:48:30 INFO - 'read-buildbot-config', 01:48:30 INFO - 'download-and-extract', 01:48:30 INFO - 'populate-webroot', 01:48:30 INFO - 'create-virtualenv', 01:48:30 INFO - 'install', 01:48:30 INFO - 'run-tests'), 01:48:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:48:30 INFO - 'download_minidump_stackwalk': True, 01:48:30 INFO - 'download_symbols': 'ondemand', 01:48:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:48:30 INFO - 'tooltool.py': '/tools/tooltool.py', 01:48:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:48:30 INFO - '/tools/misc-python/virtualenv.py')}, 01:48:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:48:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:48:30 INFO - 'installer_path': 'installer.exe', 01:48:30 INFO - 'log_level': 'info', 01:48:30 INFO - 'log_name': 'talos', 01:48:30 INFO - 'log_to_console': True, 01:48:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:48:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:48:30 INFO - 'opt_config_files': (), 01:48:30 INFO - 'pip_index': False, 01:48:30 INFO - 'sps_profile': False, 01:48:30 INFO - 'sps_profile_interval': 0, 01:48:30 INFO - 'suite': 'dromaeojs', 01:48:30 INFO - 'system_bits': '32', 01:48:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:48:30 INFO - 'title': 'talos-linux64-ix-055', 01:48:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:48:30 INFO - 'use_talos_json': True, 01:48:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:48:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:48:30 INFO - 'work_dir': 'build'} 01:48:30 INFO - ##### 01:48:30 INFO - ##### Running clobber step. 01:48:30 INFO - ##### 01:48:30 INFO - Running pre-action listener: _resource_record_pre_action 01:48:30 INFO - Running main action method: clobber 01:48:30 INFO - rmtree: /builds/slave/test-pgo/build 01:48:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:48:30 INFO - Running post-action listener: _resource_record_post_action 01:48:30 INFO - ##### 01:48:30 INFO - ##### Running read-buildbot-config step. 01:48:30 INFO - ##### 01:48:30 INFO - Running pre-action listener: _resource_record_pre_action 01:48:30 INFO - Running main action method: read_buildbot_config 01:48:30 INFO - Using buildbot properties: 01:48:30 INFO - { 01:48:30 INFO - "project": "", 01:48:30 INFO - "product": "firefox", 01:48:30 INFO - "script_repo_revision": "production", 01:48:30 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 01:48:30 INFO - "repository": "", 01:48:30 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 01:48:30 INFO - "buildid": "20160107233013", 01:48:30 INFO - "pgo_build": "True", 01:48:30 INFO - "basedir": "/builds/slave/test-pgo", 01:48:30 INFO - "buildnumber": 195, 01:48:30 INFO - "slavename": "talos-linux64-ix-055", 01:48:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:48:30 INFO - "platform": "ubuntu64_hw", 01:48:30 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 01:48:30 INFO - "branch": "b2g-inbound", 01:48:30 INFO - "repo_path": "integration/b2g-inbound", 01:48:30 INFO - "revision": "54188f0b70da50f75f93da46c59330813ea6380d", 01:48:30 INFO - "stage_platform": "linux64-pgo", 01:48:30 INFO - "builduid": "8ad025628bed4c2bbd4e7f2a33ccbf3d", 01:48:30 INFO - "slavebuilddir": "test" 01:48:30 INFO - } 01:48:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:48:30 INFO - Running post-action listener: _resource_record_post_action 01:48:30 INFO - ##### 01:48:30 INFO - ##### Running download-and-extract step. 01:48:30 INFO - ##### 01:48:30 INFO - Running pre-action listener: _resource_record_pre_action 01:48:30 INFO - Running main action method: download_and_extract 01:48:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:30 INFO - https://queue.taskcluster.net/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:48:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/test_packages.json 01:48:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/test_packages.json 01:48:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:48:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:48:32 INFO - Downloaded 1302 bytes. 01:48:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:48:32 INFO - Using the following test package requirements: 01:48:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:48:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:48:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:48:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:48:32 INFO - u'jsshell-linux-x86_64.zip'], 01:48:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:48:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:48:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:48:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:48:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:48:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:48:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:48:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:48:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:48:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:48:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:48:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:48:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:48:32 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')]} 01:48:32 INFO - https://queue.taskcluster.net/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:48:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:48:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:48:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/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 01:48:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/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 01:48:34 INFO - Downloaded 24018252 bytes. 01:48:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:48:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:48:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:48:35 INFO - Return code: 0 01:48:35 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 01:48:35 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')]} 01:48:35 INFO - https://queue.taskcluster.net/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:48:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:48:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:48:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/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 01:48:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/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 01:48:38 INFO - Downloaded 24018252 bytes. 01:48:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:48:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:48:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:48:40 INFO - Return code: 0 01:48:40 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')]} 01:48:40 INFO - https://queue.taskcluster.net/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/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 01:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/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 01:48:43 INFO - Downloaded 11132285 bytes. 01:48:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 01:48:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:48:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 01:48:44 INFO - Return code: 0 01:48:44 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')]} 01:48:44 INFO - https://queue.taskcluster.net/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:48:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:48:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:48:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/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 01:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acZ-NGj9StCr79Lo8CF2Xw/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 01:48:47 INFO - Downloaded 55894659 bytes. 01:48:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:48:47 INFO - mkdir: /builds/slave/test-pgo/properties 01:48:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:48:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:48:47 INFO - Contents: 01:48:47 INFO - build_url:https://queue.taskcluster.net/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:48:47 INFO - Running post-action listener: _resource_record_post_action 01:48:47 INFO - Running post-action listener: set_extra_try_arguments 01:48:47 INFO - ##### 01:48:47 INFO - ##### Running populate-webroot step. 01:48:47 INFO - ##### 01:48:47 INFO - Running pre-action listener: _resource_record_pre_action 01:48:47 INFO - Running main action method: populate_webroot 01:48:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:48:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:48:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:48:47 INFO - '--tppagecycles', 01:48:47 INFO - '7'], 01:48:47 INFO - 'tests': ['tsvgm']}}, 01:48:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:48:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:48:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:48:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:48:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:48:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:47 INFO - 'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:48:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:47 INFO - 'tests': ['damp', 'tps']}, 01:48:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:47 INFO - 'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['damp', 'tps']}, 01:48:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:48:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:48:47 INFO - 'other': {'tests': ['a11yr', 01:48:47 INFO - 'ts_paint', 01:48:47 INFO - 'tpaint', 01:48:47 INFO - 'sessionrestore', 01:48:47 INFO - 'sessionrestore_no_auto_restore']}, 01:48:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['a11yr', 01:48:47 INFO - 'ts_paint', 01:48:47 INFO - 'tpaint', 01:48:47 INFO - 'sessionrestore', 01:48:47 INFO - 'sessionrestore_no_auto_restore']}, 01:48:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['a11yr', 01:48:47 INFO - 'ts_paint', 01:48:47 INFO - 'tpaint', 01:48:47 INFO - 'sessionrestore', 01:48:47 INFO - 'sessionrestore_no_auto_restore']}, 01:48:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['a11yr', 01:48:47 INFO - 'ts_paint', 01:48:47 INFO - 'tpaint', 01:48:47 INFO - 'sessionrestore', 01:48:47 INFO - 'sessionrestore_no_auto_restore']}, 01:48:47 INFO - 'other_l64': {'tests': ['a11yr', 01:48:47 INFO - 'ts_paint', 01:48:47 INFO - 'tpaint', 01:48:47 INFO - 'sessionrestore', 01:48:47 INFO - 'sessionrestore_no_auto_restore']}, 01:48:47 INFO - 'other_nol64': {'tests': ['a11yr', 01:48:47 INFO - 'ts_paint', 01:48:47 INFO - 'tpaint', 01:48:47 INFO - 'sessionrestore', 01:48:47 INFO - 'sessionrestore_no_auto_restore']}, 01:48:47 INFO - 'svgr': {'tests': ['tsvgx', 01:48:47 INFO - 'tsvgr_opacity', 01:48:47 INFO - 'tart', 01:48:47 INFO - 'tscrollx', 01:48:47 INFO - 'cart']}, 01:48:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['tsvgx', 01:48:47 INFO - 'tsvgr_opacity', 01:48:47 INFO - 'tart', 01:48:47 INFO - 'tscrollx', 01:48:47 INFO - 'cart']}, 01:48:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:47 INFO - 'tests': ['tp5o']}, 01:48:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:47 INFO - 'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['tp5o']}, 01:48:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:47 INFO - 'talos_options': ['--xperf_path', 01:48:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:48:47 INFO - 'tests': ['tp5n']}, 01:48:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:47 INFO - 'talos_options': ['--e10s', 01:48:47 INFO - '--xperf_path', 01:48:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:48:47 INFO - 'tests': ['tp5n']}}, 01:48:47 INFO - 'talos.zip': {'path': '', 01:48:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:48:47 INFO - Running post-action listener: _resource_record_post_action 01:48:47 INFO - ##### 01:48:47 INFO - ##### Running create-virtualenv step. 01:48:47 INFO - ##### 01:48:47 INFO - Running pre-action listener: _resource_record_pre_action 01:48:47 INFO - Running main action method: create_virtualenv 01:48:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:48:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 01:48:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:48:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:48:47 INFO - Using real prefix '/usr' 01:48:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:48:47 INFO - Installing distribute.............................................................................................................................................................................................done. 01:48:49 INFO - Installing pip.................done. 01:48:49 INFO - Return code: 0 01:48:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:49 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 0x7f3ec757cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76840>, '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 0x19e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e3b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', '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 01:48:49 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 01:48:49 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 01:48:49 INFO - Using env: {'DISPLAY': ':0', 01:48:49 INFO - 'HOME': '/home/cltbld', 01:48:49 INFO - 'LANG': 'en_US.UTF-8', 01:48:49 INFO - 'LANGUAGE': 'en_US:en', 01:48:49 INFO - 'LOGNAME': 'cltbld', 01:48:49 INFO - 'MAIL': '/var/mail/cltbld', 01:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:49 INFO - 'MOZ_NO_REMOTE': '1', 01:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:49 INFO - 'NO_EM_RESTART': '1', 01:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:48:49 INFO - 'PWD': '/builds/slave/test-pgo', 01:48:49 INFO - 'SHELL': '/bin/bash', 01:48:49 INFO - 'SHLVL': '1', 01:48:49 INFO - 'TERM': 'linux', 01:48:49 INFO - 'TMOUT': '86400', 01:48:49 INFO - 'USER': 'cltbld', 01:48:49 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', 01:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:49 INFO - '_': '/tools/buildbot/bin/python'} 01:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:49 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 01:48:49 INFO - Cleaning up... 01:48:49 INFO - Return code: 0 01:48:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:49 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 0x7f3ec757cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76840>, '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 0x19e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e3b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', '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 01:48:49 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 01:48:49 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 01:48:49 INFO - Using env: {'DISPLAY': ':0', 01:48:49 INFO - 'HOME': '/home/cltbld', 01:48:49 INFO - 'LANG': 'en_US.UTF-8', 01:48:49 INFO - 'LANGUAGE': 'en_US:en', 01:48:49 INFO - 'LOGNAME': 'cltbld', 01:48:49 INFO - 'MAIL': '/var/mail/cltbld', 01:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:49 INFO - 'MOZ_NO_REMOTE': '1', 01:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:49 INFO - 'NO_EM_RESTART': '1', 01:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:48:49 INFO - 'PWD': '/builds/slave/test-pgo', 01:48:49 INFO - 'SHELL': '/bin/bash', 01:48:49 INFO - 'SHLVL': '1', 01:48:49 INFO - 'TERM': 'linux', 01:48:49 INFO - 'TMOUT': '86400', 01:48:49 INFO - 'USER': 'cltbld', 01:48:49 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', 01:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:49 INFO - '_': '/tools/buildbot/bin/python'} 01:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:50 INFO - Downloading/unpacking psutil>=0.7.1 01:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:48:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:48:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:48:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:48:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:48:51 INFO - Installing collected packages: psutil 01:48:51 INFO - Running setup.py install for psutil 01:48:51 INFO - building 'psutil._psutil_linux' extension 01:48:51 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 01:48:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:48:52 INFO - building 'psutil._psutil_posix' extension 01:48:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:48:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:48:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:48:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:48:52 INFO - Successfully installed psutil 01:48:52 INFO - Cleaning up... 01:48:52 INFO - Return code: 0 01:48:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:48:52 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')]} 01:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:52 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')]} 01:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:52 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 0x7f3ec757cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76840>, '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 0x19e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e3b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', '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 01:48:52 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 01:48:52 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 01:48:52 INFO - Using env: {'DISPLAY': ':0', 01:48:52 INFO - 'HOME': '/home/cltbld', 01:48:52 INFO - 'LANG': 'en_US.UTF-8', 01:48:52 INFO - 'LANGUAGE': 'en_US:en', 01:48:52 INFO - 'LOGNAME': 'cltbld', 01:48:52 INFO - 'MAIL': '/var/mail/cltbld', 01:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:52 INFO - 'MOZ_NO_REMOTE': '1', 01:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:52 INFO - 'NO_EM_RESTART': '1', 01:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:48:52 INFO - 'PWD': '/builds/slave/test-pgo', 01:48:52 INFO - 'SHELL': '/bin/bash', 01:48:52 INFO - 'SHLVL': '1', 01:48:52 INFO - 'TERM': 'linux', 01:48:52 INFO - 'TMOUT': '86400', 01:48:52 INFO - 'USER': 'cltbld', 01:48:52 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', 01:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:52 INFO - '_': '/tools/buildbot/bin/python'} 01:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:48:52 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 01:48:52 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 01:48:52 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 01:48:52 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 01:48:52 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 01:48:52 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 01:48:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:48:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:48:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:48:54 INFO - Installing collected packages: mozsystemmonitor 01:48:54 INFO - Running setup.py install for mozsystemmonitor 01:48:54 INFO - Successfully installed mozsystemmonitor 01:48:54 INFO - Cleaning up... 01:48:54 INFO - Return code: 0 01:48:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:48: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')]} 01:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48: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')]} 01:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3ec757cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76840>, '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 0x19e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e3b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', '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 01:48:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 01:48:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:48:54 INFO - Using env: {'DISPLAY': ':0', 01:48:54 INFO - 'HOME': '/home/cltbld', 01:48:54 INFO - 'LANG': 'en_US.UTF-8', 01:48:54 INFO - 'LANGUAGE': 'en_US:en', 01:48:54 INFO - 'LOGNAME': 'cltbld', 01:48:54 INFO - 'MAIL': '/var/mail/cltbld', 01:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:54 INFO - 'MOZ_NO_REMOTE': '1', 01:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:54 INFO - 'NO_EM_RESTART': '1', 01:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:48:54 INFO - 'PWD': '/builds/slave/test-pgo', 01:48:54 INFO - 'SHELL': '/bin/bash', 01:48:54 INFO - 'SHLVL': '1', 01:48:54 INFO - 'TERM': 'linux', 01:48:54 INFO - 'TMOUT': '86400', 01:48:54 INFO - 'USER': 'cltbld', 01:48:54 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', 01:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:54 INFO - '_': '/tools/buildbot/bin/python'} 01:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:54 INFO - Downloading/unpacking blobuploader==1.2.4 01:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:56 INFO - Downloading blobuploader-1.2.4.tar.gz 01:48:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:48:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:48:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:48:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:48:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:57 INFO - Downloading docopt-0.6.1.tar.gz 01:48:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:48:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:48:57 INFO - Installing collected packages: blobuploader, requests, docopt 01:48:57 INFO - Running setup.py install for blobuploader 01:48:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:48:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:48:57 INFO - Running setup.py install for requests 01:48:57 INFO - Running setup.py install for docopt 01:48:57 INFO - Successfully installed blobuploader requests docopt 01:48:57 INFO - Cleaning up... 01:48:57 INFO - Return code: 0 01:48:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:57 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 0x7f3ec757cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76840>, '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 0x19e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e3b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', '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 01:48:57 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 01:48:57 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 01:48:57 INFO - Using env: {'DISPLAY': ':0', 01:48:57 INFO - 'HOME': '/home/cltbld', 01:48:57 INFO - 'LANG': 'en_US.UTF-8', 01:48:57 INFO - 'LANGUAGE': 'en_US:en', 01:48:57 INFO - 'LOGNAME': 'cltbld', 01:48:57 INFO - 'MAIL': '/var/mail/cltbld', 01:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:57 INFO - 'MOZ_NO_REMOTE': '1', 01:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:57 INFO - 'NO_EM_RESTART': '1', 01:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:48:57 INFO - 'PWD': '/builds/slave/test-pgo', 01:48:57 INFO - 'SHELL': '/bin/bash', 01:48:57 INFO - 'SHLVL': '1', 01:48:57 INFO - 'TERM': 'linux', 01:48:57 INFO - 'TMOUT': '86400', 01:48:57 INFO - 'USER': 'cltbld', 01:48:57 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', 01:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:57 INFO - '_': '/tools/buildbot/bin/python'} 01:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:48:58 INFO - Running setup.py (path:/tmp/pip-zDlhF5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:48:58 INFO - Running setup.py (path:/tmp/pip-7P93mS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:48:58 INFO - Running setup.py (path:/tmp/pip-Jwq5eu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:48:58 INFO - Running setup.py (path:/tmp/pip-mNioyI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:48:58 INFO - Running setup.py (path:/tmp/pip-x8fmpp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:48:58 INFO - Running setup.py (path:/tmp/pip-MeCOrd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:48:58 INFO - Running setup.py (path:/tmp/pip-tdnTr1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:48:58 INFO - Running setup.py (path:/tmp/pip-POTjdV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:48:58 INFO - Running setup.py (path:/tmp/pip-PkuViy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:48:58 INFO - Running setup.py (path:/tmp/pip-sRAjLO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:48:58 INFO - Running setup.py (path:/tmp/pip-qR09ce-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:48:58 INFO - Running setup.py (path:/tmp/pip-saw_OD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:48:59 INFO - Running setup.py (path:/tmp/pip-_SXKQr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:48:59 INFO - Running setup.py (path:/tmp/pip-tnulBy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:48:59 INFO - Running setup.py (path:/tmp/pip-QT4cxR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:48:59 INFO - Running setup.py (path:/tmp/pip-h9ucUa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:48:59 INFO - Running setup.py (path:/tmp/pip-bLB3O0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:48:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:48:59 INFO - Running setup.py install for manifestparser 01:48:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:48:59 INFO - Running setup.py install for mozcrash 01:48:59 INFO - Running setup.py install for mozdebug 01:48:59 INFO - Running setup.py install for mozdevice 01:48:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:48:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:48:59 INFO - Running setup.py install for mozfile 01:48:59 INFO - Running setup.py install for mozhttpd 01:48:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:48:59 INFO - Running setup.py install for mozinfo 01:49:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:49:00 INFO - Running setup.py install for mozInstall 01:49:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:49:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:49:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:49:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:49:00 INFO - Running setup.py install for mozleak 01:49:00 INFO - Running setup.py install for mozlog 01:49:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:49:00 INFO - Running setup.py install for moznetwork 01:49:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:49:00 INFO - Running setup.py install for mozprocess 01:49:00 INFO - Running setup.py install for mozprofile 01:49:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:49:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:49:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:49:00 INFO - Running setup.py install for mozrunner 01:49:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:49:00 INFO - Running setup.py install for mozscreenshot 01:49:00 INFO - Running setup.py install for moztest 01:49:01 INFO - Running setup.py install for mozversion 01:49:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:49:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:49:01 INFO - Cleaning up... 01:49:01 INFO - Return code: 0 01:49:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ec757cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76840>, '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 0x19e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e3b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', '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 01:49:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 01:49:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:49:01 INFO - Using env: {'DISPLAY': ':0', 01:49:01 INFO - 'HOME': '/home/cltbld', 01:49:01 INFO - 'LANG': 'en_US.UTF-8', 01:49:01 INFO - 'LANGUAGE': 'en_US:en', 01:49:01 INFO - 'LOGNAME': 'cltbld', 01:49:01 INFO - 'MAIL': '/var/mail/cltbld', 01:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:01 INFO - 'MOZ_NO_REMOTE': '1', 01:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:01 INFO - 'NO_EM_RESTART': '1', 01:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:49:01 INFO - 'PWD': '/builds/slave/test-pgo', 01:49:01 INFO - 'SHELL': '/bin/bash', 01:49:01 INFO - 'SHLVL': '1', 01:49:01 INFO - 'TERM': 'linux', 01:49:01 INFO - 'TMOUT': '86400', 01:49:01 INFO - 'USER': 'cltbld', 01:49:01 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', 01:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:01 INFO - '_': '/tools/buildbot/bin/python'} 01:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:49:01 INFO - Running setup.py (path:/tmp/pip-6EtFmT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 01:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:49:01 INFO - Running setup.py (path:/tmp/pip-Y9XqNA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:49:01 INFO - Running setup.py (path:/tmp/pip-jDtk98-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:49:01 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)) 01:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:49:01 INFO - Running setup.py (path:/tmp/pip-YBgfzv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:49:01 INFO - Running setup.py (path:/tmp/pip-SF8Ex9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:49:01 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)) 01:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:49:01 INFO - Running setup.py (path:/tmp/pip-5Plamq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:49:01 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)) 01:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:49:01 INFO - Running setup.py (path:/tmp/pip-926eqr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:49:01 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)) 01:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:49:01 INFO - Running setup.py (path:/tmp/pip-rIYNnW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:49:01 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)) 01:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:49:01 INFO - Running setup.py (path:/tmp/pip-mdIigf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:49:01 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)) 01:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:49:01 INFO - Running setup.py (path:/tmp/pip-xlJ5yN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:49:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:49:02 INFO - Running setup.py (path:/tmp/pip-4Q_KPM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:49:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 01:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:49:02 INFO - Running setup.py (path:/tmp/pip-chPwFa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:49:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 01:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:49:02 INFO - Running setup.py (path:/tmp/pip-SrnzGw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:49:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 01:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:49:02 INFO - Running setup.py (path:/tmp/pip-qBUsGf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:49:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 01:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:49:02 INFO - Running setup.py (path:/tmp/pip-lvyLQa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:49:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 01:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:49:02 INFO - Running setup.py (path:/tmp/pip-k8J6mK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:49:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 01:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:49:02 INFO - Running setup.py (path:/tmp/pip-MBLnjt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:49:02 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)) 01:49:02 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)) 01:49:02 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)) 01:49:02 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)) 01:49:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:49:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:49:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:49:02 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 01:49:02 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 01:49:02 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 01:49:02 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 01:49:02 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 01:49:02 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 01:49:04 INFO - Downloading blessings-1.5.1.tar.gz 01:49:04 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 01:49:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:49:04 INFO - Installing collected packages: blessings 01:49:04 INFO - Running setup.py install for blessings 01:49:04 INFO - Successfully installed blessings 01:49:04 INFO - Cleaning up... 01:49:04 INFO - Return code: 0 01:49:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:49:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:49:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:49:04 INFO - Reading from file tmpfile_stdout 01:49:04 INFO - Current package versions: 01:49:04 INFO - argparse == 1.2.1 01:49:04 INFO - blessings == 1.5.1 01:49:04 INFO - blobuploader == 1.2.4 01:49:04 INFO - docopt == 0.6.1 01:49:04 INFO - manifestparser == 1.1 01:49:04 INFO - mozInstall == 1.12 01:49:04 INFO - mozcrash == 0.16 01:49:04 INFO - mozdebug == 0.1 01:49:04 INFO - mozdevice == 0.47 01:49:04 INFO - mozfile == 1.2 01:49:04 INFO - mozhttpd == 0.7 01:49:04 INFO - mozinfo == 0.9 01:49:04 INFO - mozleak == 0.1 01:49:04 INFO - mozlog == 3.1 01:49:04 INFO - moznetwork == 0.27 01:49:04 INFO - mozprocess == 0.22 01:49:04 INFO - mozprofile == 0.28 01:49:04 INFO - mozrunner == 6.11 01:49:04 INFO - mozscreenshot == 0.1 01:49:04 INFO - mozsystemmonitor == 0.0 01:49:04 INFO - moztest == 0.7 01:49:04 INFO - mozversion == 1.4 01:49:04 INFO - psutil == 3.1.1 01:49:04 INFO - requests == 1.2.3 01:49:04 INFO - wsgiref == 0.1.2 01:49:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:49:04 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')]} 01:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:04 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')]} 01:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:04 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 0x7f3ec757cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76840>, '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 0x19e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e3b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', '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 01:49:04 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 01:49:04 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 01:49:04 INFO - Using env: {'DISPLAY': ':0', 01:49:04 INFO - 'HOME': '/home/cltbld', 01:49:04 INFO - 'LANG': 'en_US.UTF-8', 01:49:04 INFO - 'LANGUAGE': 'en_US:en', 01:49:04 INFO - 'LOGNAME': 'cltbld', 01:49:04 INFO - 'MAIL': '/var/mail/cltbld', 01:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:04 INFO - 'MOZ_NO_REMOTE': '1', 01:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:04 INFO - 'NO_EM_RESTART': '1', 01:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:49:04 INFO - 'PWD': '/builds/slave/test-pgo', 01:49:04 INFO - 'SHELL': '/bin/bash', 01:49:04 INFO - 'SHLVL': '1', 01:49:04 INFO - 'TERM': 'linux', 01:49:04 INFO - 'TMOUT': '86400', 01:49:04 INFO - 'USER': 'cltbld', 01:49:04 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', 01:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:04 INFO - '_': '/tools/buildbot/bin/python'} 01:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:04 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)) 01:49:04 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)) 01:49:04 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)) 01:49:04 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)) 01:49:04 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)) 01:49:04 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)) 01:49:04 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)) 01:49:04 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)) 01:49:04 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)) 01:49:04 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)) 01:49:04 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)) 01:49:04 INFO - Cleaning up... 01:49:04 INFO - Return code: 0 01:49:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:49:04 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')]} 01:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:04 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')]} 01:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:04 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 0x7f3ec757cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76840>, '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 0x19e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e3b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', '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 01:49:04 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 01:49:04 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 01:49:04 INFO - Using env: {'DISPLAY': ':0', 01:49:04 INFO - 'HOME': '/home/cltbld', 01:49:04 INFO - 'LANG': 'en_US.UTF-8', 01:49:04 INFO - 'LANGUAGE': 'en_US:en', 01:49:04 INFO - 'LOGNAME': 'cltbld', 01:49:04 INFO - 'MAIL': '/var/mail/cltbld', 01:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:04 INFO - 'MOZ_NO_REMOTE': '1', 01:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:04 INFO - 'NO_EM_RESTART': '1', 01:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:49:04 INFO - 'PWD': '/builds/slave/test-pgo', 01:49:04 INFO - 'SHELL': '/bin/bash', 01:49:04 INFO - 'SHLVL': '1', 01:49:04 INFO - 'TERM': 'linux', 01:49:04 INFO - 'TMOUT': '86400', 01:49:04 INFO - 'USER': 'cltbld', 01:49:04 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', 01:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:04 INFO - '_': '/tools/buildbot/bin/python'} 01:49:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:05 INFO - Downloading/unpacking jsonschema 01:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:49:06 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 01:49:06 INFO - Downloading/unpacking functools32 (from jsonschema) 01:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:07 INFO - Downloading functools32-3.2.3-2.tar.gz 01:49:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:49:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:49:07 INFO - warning: no files found matching '*.txt' 01:49:07 INFO - no previously-included directories found matching 'build' 01:49:07 INFO - no previously-included directories found matching 'dist' 01:49:07 INFO - no previously-included directories found matching '.git*' 01:49:07 INFO - Installing collected packages: jsonschema, functools32 01:49:07 INFO - Running setup.py install for functools32 01:49:07 INFO - warning: no files found matching '*.txt' 01:49:07 INFO - no previously-included directories found matching 'build' 01:49:07 INFO - no previously-included directories found matching 'dist' 01:49:07 INFO - no previously-included directories found matching '.git*' 01:49:07 INFO - Successfully installed jsonschema functools32 01:49:07 INFO - Cleaning up... 01:49:07 INFO - Return code: 0 01:49:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ec757cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76840>, '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 0x19e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e3b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', '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 01:49:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 01:49:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:49:07 INFO - Using env: {'DISPLAY': ':0', 01:49:07 INFO - 'HOME': '/home/cltbld', 01:49:07 INFO - 'LANG': 'en_US.UTF-8', 01:49:07 INFO - 'LANGUAGE': 'en_US:en', 01:49:07 INFO - 'LOGNAME': 'cltbld', 01:49:07 INFO - 'MAIL': '/var/mail/cltbld', 01:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:07 INFO - 'MOZ_NO_REMOTE': '1', 01:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:07 INFO - 'NO_EM_RESTART': '1', 01:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:49:07 INFO - 'PWD': '/builds/slave/test-pgo', 01:49:07 INFO - 'SHELL': '/bin/bash', 01:49:07 INFO - 'SHLVL': '1', 01:49:07 INFO - 'TERM': 'linux', 01:49:07 INFO - 'TMOUT': '86400', 01:49:07 INFO - 'USER': 'cltbld', 01:49:07 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', 01:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:07 INFO - '_': '/tools/buildbot/bin/python'} 01:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:07 INFO - Downloading/unpacking flake8 01:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:49:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 01:49:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:49:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 01:49:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:09 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 01:49:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:49:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:49:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:49:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:49:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:49:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:49:10 INFO - no previously-included directories found matching 'docs/_build' 01:49:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:49:10 INFO - Running setup.py install for pep8 01:49:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:49:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:49:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:49:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:49:10 INFO - no previously-included directories found matching 'docs/_build' 01:49:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:49:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:49:10 INFO - Cleaning up... 01:49:10 INFO - Return code: 0 01:49:10 INFO - Running post-action listener: _resource_record_post_action 01:49:10 INFO - Running post-action listener: _start_resource_monitoring 01:49:10 INFO - Starting resource monitoring. 01:49:10 INFO - ##### 01:49:10 INFO - ##### Running install step. 01:49:10 INFO - ##### 01:49:10 INFO - Running pre-action listener: _resource_record_pre_action 01:49:10 INFO - Running main action method: install 01:49:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:49:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:49:10 INFO - Reading from file tmpfile_stdout 01:49:10 INFO - Detecting whether we're running mozinstall >=1.0... 01:49:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:49:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:49:10 INFO - Reading from file tmpfile_stdout 01:49:10 INFO - Output received: 01:49:10 INFO - Usage: mozinstall [options] installer 01:49:10 INFO - Options: 01:49:10 INFO - -h, --help show this help message and exit 01:49:10 INFO - -d DEST, --destination=DEST 01:49:10 INFO - Directory to install application into. [default: 01:49:10 INFO - "/builds/slave/test-pgo"] 01:49:10 INFO - --app=APP Application being installed. [default: firefox] 01:49:10 INFO - mkdir: /builds/slave/test-pgo/build/application 01:49:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 01:49:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 01:49:26 INFO - Reading from file tmpfile_stdout 01:49:26 INFO - Output received: 01:49:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:49:26 INFO - Running post-action listener: _resource_record_post_action 01:49:26 INFO - ##### 01:49:26 INFO - ##### Running run-tests step. 01:49:26 INFO - ##### 01:49:26 INFO - Running pre-action listener: _resource_record_pre_action 01:49:26 INFO - Running main action method: run_tests 01:49:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:49:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:49:26 INFO - Python 2.7.3 01:49:26 INFO - Return code: 0 01:49:26 INFO - grabbing minidump binary from tooltool 01:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a76840>, '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 0x19e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e3b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:49:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 01:49:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:49:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:49:27 INFO - Return code: 0 01:49:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:49:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:49:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:49:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:49:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:49:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:49:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:49:27 INFO - Return code: 0 01:49:27 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/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 01:49:27 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/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 01:49:27 INFO - Using env: {'DISPLAY': ':0', 01:49:27 INFO - 'HOME': '/home/cltbld', 01:49:27 INFO - 'LANG': 'en_US.UTF-8', 01:49:27 INFO - 'LANGUAGE': 'en_US:en', 01:49:27 INFO - 'LOGNAME': 'cltbld', 01:49:27 INFO - 'MAIL': '/var/mail/cltbld', 01:49:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:49:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:27 INFO - 'MOZ_NO_REMOTE': '1', 01:49:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:27 INFO - 'NO_EM_RESTART': '1', 01:49:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:49:27 INFO - 'PWD': '/builds/slave/test-pgo', 01:49:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:49:27 INFO - 'SHELL': '/bin/bash', 01:49:27 INFO - 'SHLVL': '1', 01:49:27 INFO - 'TERM': 'linux', 01:49:27 INFO - 'TMOUT': '86400', 01:49:27 INFO - 'USER': 'cltbld', 01:49:27 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431', 01:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:27 INFO - '_': '/tools/buildbot/bin/python'} 01:49:27 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/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 01:49:28 INFO - mozversion application_buildid: 20160107233013 01:49:28 INFO - mozversion application_changeset: 54188f0b70da50f75f93da46c59330813ea6380d 01:49:28 INFO - mozversion application_display_name: Nightly 01:49:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:49:28 INFO - mozversion application_name: Firefox 01:49:28 INFO - mozversion application_remotingname: firefox 01:49:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 01:49:28 INFO - mozversion application_vendor: Mozilla 01:49:28 INFO - mozversion application_version: 46.0a1 01:49:28 INFO - mozversion platform_buildid: 20160107233013 01:49:28 INFO - mozversion platform_changeset: 54188f0b70da50f75f93da46c59330813ea6380d 01:49:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 01:49:28 INFO - mozversion platform_version: 46.0a1 01:49:28 INFO - using testdate: 1452246568 01:49:28 INFO - actual date: 1452246568 01:49:28 INFO - starting webserver on 'localhost:33486' 01:49:28 INFO - SUITE-START | Running 3 tests 01:49:28 INFO - TEST-START | dromaeo_css 01:49:28 INFO - operating with platform_type : linux_ 01:49:28 INFO - Initialising browser for dromaeo_css test... 01:49:28 INFO - TEST-INFO | started process 28089 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdhw9HQ/profile http://localhost:33486/getInfo.html) 01:49:32 INFO - PROCESS | 28089 | __metrics Screen width/height:1600/1200 01:49:32 INFO - PROCESS | 28089 | colorDepth:24 01:49:32 INFO - PROCESS | 28089 | Browser inner width/height: 1024/697 01:49:32 INFO - PROCESS | 28089 | __metrics 01:49:32 INFO - PROCESS | 28089 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:49:32 INFO - PROCESS | 28089 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:49:33 INFO - TEST-INFO | 28089: exit 0 01:49:33 INFO - Browser initialized. 01:49:33 INFO - Running cycle 1/1 for dromaeo_css test... 01:49:33 INFO - TEST-INFO | started process 28182 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdhw9HQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:49:45 INFO - PROCESS | 28182 | RSS: Main: 149532672 01:49:45 INFO - PROCESS | 28182 | 01:50:36 INFO - PROCESS | 28182 | 1452246636453 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] 01:52:44 INFO - PROCESS | 28182 | Cycle 1(1): loaded http://localhost:33486/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33486/tests/dromaeo/cssquery-ext.html) 01:52:45 INFO - PROCESS | 28182 | RSS: Main: 274874368 01:52:45 INFO - PROCESS | 28182 | 01:55:48 INFO - PROCESS | 28182 | Cycle 1(1): loaded http://localhost:33486/tests/dromaeo/cssquery-ext.html (next: http://localhost:33486/tests/dromaeo/cssquery-jquery.html) 01:55:48 INFO - PROCESS | 28182 | RSS: Main: 233525248 01:55:48 INFO - PROCESS | 28182 | 01:58:50 INFO - PROCESS | 28182 | Cycle 1(1): loaded http://localhost:33486/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33486/tests/dromaeo/cssquery-mootools.html) 01:58:51 INFO - PROCESS | 28182 | RSS: Main: 236679168 01:58:51 INFO - PROCESS | 28182 | 02:01:53 INFO - PROCESS | 28182 | Cycle 1(1): loaded http://localhost:33486/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33486/tests/dromaeo/cssquery-prototype.html) 02:01:53 INFO - PROCESS | 28182 | RSS: Main: 212733952 02:01:53 INFO - PROCESS | 28182 | 02:04:56 INFO - PROCESS | 28182 | Cycle 1(1): loaded http://localhost:33486/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33486/tests/dromaeo/cssquery-yui.html) 02:04:56 INFO - PROCESS | 28182 | RSS: Main: 217718784 02:04:56 INFO - PROCESS | 28182 | 02:07:59 INFO - PROCESS | 28182 | Cycle 1(1): loaded http://localhost:33486/tests/dromaeo/cssquery-yui.html (next: http://localhost:33486/tests/dromaeo/cssquery-dojo.html) 02:07:59 INFO - PROCESS | 28182 | RSS: Main: 258592768 02:07:59 INFO - PROCESS | 28182 | 02:07:59 INFO - PROCESS | 28182 | __start_tp_report 02:07:59 INFO - PROCESS | 28182 | _x_x_mozilla_page_load 02:07:59 INFO - PROCESS | 28182 | _x_x_mozilla_page_load_details 02:07:59 INFO - PROCESS | 28182 | |i|pagename|runs| 02:07:59 INFO - PROCESS | 28182 | |0;dojo.html;3039.8480075996204;3106.4563701352286;3148.7795854290193;3150.5746724192227;3174.6666600007006;4942.703437793735;5004.374453193351;5005.824796132131;5012.573931215842;5057.08972384971;4960.553550180483;4985.227289770082;4995.125852975724;5074.644774865761;5080.085584594781;4599.8390056348035;4619.676622636425;4646.303054541812;4661.254199328108;4755.453122890877;4701.882452938669;4714.127886341038;4761.452432970201;4770.475247722748;4801.903961920777;4517.390152329459;4553.2942393929;4600.746958917258;4670.136024835399;4730.195866702652;4654.976725116387;4661.487236403993;4664.766761661937;4677.74272415017;4702.952970470285;4640.373549570799;4645.744484053375;4649.18639238132;4650.0932318197965;4673.088747694201;4779.80880764769;4793.32893394925;4880;4888.804447822083;4914.754262286907;5399.514043736082;5399.78400863965;5409.810656627039;5410.431904650034;5428.972855135738;5432.511074003359;5442.673439593597;5443.972780136113;5449.155380915964;5453.400125986138;4936.358273424467;4997.50024997501;5032.220005899091;5107.948920510822;5144.588432925357;5485.396606373296;5520.834374968677;5526.834194974157;5528.253685752372;5573.219749235111;5320.467953204726;5322.14845624706;5328;5328.0675881720545;5330.253764472977;5297.894042119136;5374.355077390738;5403.675779453245;5414.83755487336;5485.50630443262;5341.946580534145;5345.064613692588;5345.973270133624;5351.625386223005;5354.303940487712;5195.350581177353;5379.462053794589;5387.622866399314;5390.380106287748;5439.48324909133;4149.128682976609;4150.667946564267;4159.9792001039805;4201.7268877522865;4246.8725938221905;3786.4320351946876;3809.276237514863;3814.6566808987322;3844.6732027777953;3849.1339448623835;4907.386576677915;5025.095482813129;5056.974715126401;5070.974645126751;5121.667091639031;5326;5334.626576139633;5352;5397.865053373697;5452.182172674131;4973.403191617029;5034.622403319692;5035;5036.244563315532;5077.1876499759865;4574.862754117382;4619.792109355087;4629.7222166669435;4637.8840528986375;4676.08816280822;5480.588955828329;5570.108782594765;5637.7181140942785;5641.041023026095;5684.090545512699;5385.973070134624;5419.2413062170535;5422.945770542402;5430.8099216527235;5432.538234249975;5343.4389389113585;5437.673739575638;5550.69471179089;5604.495595396434;5678.14827775837;5282;5335.653182543122;5386.272853164929;5397.649152805055;5423.5932305076485;5433.293671822637;5447.809326673548;5454.781808727606;5459.454054594509;5462.207979842821;5127.1540195867265;5171.00652970211;5334.06653835585;5345;5363.946360536344;5191.143461328989;5214.5567626750635;5284.920726189187;5325.068113080273;5332.30680011596;5116.948830511647;5118.129917914038;5120.974395128001;5125.410577783454;5171.534561889448;5131.717755523482;5259.500347466985;5261.394939581844;5271.051210782096;5287.180487024518;5043.818107496389;5097.515736005073;5125.5387015167325;5198.948010519997;5248.422673505987 02:07:59 INFO - PROCESS | 28182 | |1;ext.html;530.0644362699833;535.2105644174843;553.4907884746038;564.6978866306524;596.1207219351458;28531.572026419595;29111.56332655009;36133.638663613354;36261.81869090658;36402.27195456089;38463.61536384635;38906.61093389065;38910;38922.80538597303;38978.41532377017;7382.077240344957;8501.999999999984;8679.522626255553;8682.782930426727;8697.391182617219;7474;7611.847763044736;10137.645182418617;10371.11845493134;10378.896211037907;10124;10159.949200253988;10200.744981375488;10210.183185345155;10219.591216351337;7475.140358858746;7670;10025.44860032698;10131.746706332327;10132.746681332952;9992.200623950066;10254.384736915808;10262.897371026269;10268.589256429734;10269.28115031948;39001.60998390008;39563.8021809892;39596;39684.801575991936;39715.801420993;3284.359549887773;3298.422776014188;3346.1467325832;3364.4616861302075;3366.562346894888;30262.24344391386;30405.087847364615;30700.38599228025;30840;31374.05877823669;3832.8083595820376;3880.146367799108;4004.9199016019807;4048.898777530556;4074.7147699661036;275836.999999998;276213;276664.2333576659;277863;278341;55546.444535554125;56696.71651641798;57830.421695782505;58015.129773053435;59176.704116479144;52903;52936.735316323175;52973.205401919;53106.46893531015;53209.467905321224;15644.92177539105;15749.291281892343;15889.52331430059;15897.602559936095;15917.681646367007;11861;11900.226485278428;11917;11933.52265909354;12050.517979280907;19448.319308824124;19690.40928772139;19697.310594129136;19706.113224904915;19751.506212344808;7340.37606803417;7501.5874126923545;7522.924770752332;7551.131619863676;7552.509086909334;888.9022207557164;918.5223683684446;946.4699768129869;989.2135752077116;1050.3277902142636;27355.86322068377;27508.312292192455;27610.031854277768;27959.72040279612;27992.72007279942;1094.1684319916922;1101.4217535793612;1107.2526044919807;1118.3122379736567;1128.373752567333;14373.353199106064;14489.565313040415;14603.488877889224;14742.63143421423;14750.926245368919;286294;292376;293501;293974;294107;49238;49269.75365123151;49539.50460495421;49681.50318496769;49702.25446618304;1284.9229046257067;1305.7519071376407;1313.7635225659474;1329.993350033263;1331.547273926889;26134.86932565401;27221.319467013484;27265;27273.59089613618;27385.863070684518;40611;41653.375199371425;42239.366409503265;42864.78567607142;42901;277654;289933;291878;292551;293722;28682.42635147327;29031.274218144714;29056.27359316034;29056.564151538165;29118.417631647673;38026.809865951596;39044;39145.8042709796;39434.21131577295;39473.80263098666;33303.50044749282;33934.83032584821;34676;35187.472187917716;35964.28071438609;33873.3225335487;34136.31727365489;34435.483467748505;34555.30889382248;34708.65291347155;33889.83055084709;34508.48237276392;34552.30895382028;34582;34721.652783472855;30077.699223008367;31488;31914.52128218125;31964.68035319617;31987.840060800478;23562.29313120609;23641.172558960352;24102.758972410753;24128.396790080387;24293.878530607235 02:07:59 INFO - PROCESS | 28182 | |2;jquery.html;353.9132912436452;355.9857605695772;357.07161380410935;359.7104331013535;362.069481432718;13322.40049197786;13790.793138102936;16264.43074492393;16817;18157.818421815777;14713.779293310608;15304.540863774104;15696.764548531753;16008.919955400235;16009.27958241879;5089.720065396402;5276.2085687146855;5276.762545685434;5280.815171468999;5282.3096609085105;3963.64327210551;4103.38449232616;5321.973390133044;5378;5627.577931655122;5728.05487094631;5813.244278243822;5862.853428664296;5863.149843272744;5865.912011319833;5657.20799088128;5790;5805.448482394166;5809.3900140485275;5810.157527158581;5046.924296135561;5148.3821941366905;5152.124138896396;5313.840584782462;5322.760475778599;19474.513137171543;19657.508562285915;19835.10742016613;19845.702314465296;19891;2127.5425783456476;2222.2777597280947;2258.096761295495;2413.179518963543;2486.2168416948602;12069.155159138863;12508.896885716675;12564.874351256462;12696.936515317457;12961.935190324082;1719.6904557179703;1780.5548612846787;1824.781026276842;1837.5406148462885;1862.608852141052;52314.47685523134;54290.45709542894;54569.72715136439;55450.16824747632;55954.44045559533;9455.952720236492;9589.664361747306;9788.608455661693;9803.607855685836;9895.703128906145;12700.18325233047;12783.041271904644;12869.935650321688;12886.420111095023;12891.871081289255;7437.590932498656;7481.289277518627;7488.138864030706;7499.400047996147;7504.437167212481;7186.461015423864;7313.89029164563;7316.743913962986;7319.74380896666;7358.337749602454;5938.8218353449465;5951.137085122633;5958.85102872423;5986.3714309997695;6015.729292181863;1655.6440365321514;1691.6024734187456;1731.186342419061;1743.145858529337;1766.4788887278285;880.2429910277157;902.3999040637902;933.869258303838;1005.1104772276587;1026.958921643141;14065.859341406454;15213.695726085638;16246.918765406097;16527.091009994565;16691.332346705996;828.1221904780951;884.7566919097171;939.7086903060073;1008.8991100889853;1030.2067408095725;8824.955875220583;9004.099590041074;9006.729798106067;9034.367594268339;9221.631134754669;368073;370186;528103;528433;546145;66536.66731666311;69219.26951826244;70295.64852175706;70573.2942670577;73259.63370183115;1136.3522792008641;1144.3076938452116;1156.150229581257;1186.3178672263482;1186.3890096600257;9787.85318220213;10139.64511242103;14576.781348279996;14661.120332780067;15074.170920599472;31588.052358429282;32080;33917.83041084877;34901.8254908734;36306.63693363138;43171.13657726891;45586;45717.314240285756;46782.53217467918;46893;9398.295127865575;9631.181349585364;9799.608015679292;9811.852822207815;9823.852642210515;10597.523111460157;10636.255462117577;10842.457877106272;10980.780384392427;11239.66281011571;9096.49969251671;9247.72256832296;9490.383125096847;9563.808723825623;9612;3203.503456964081;5596.0206963780365;8400.243978042006;9889.604415823575;10012.148967337858;7262.874239632216;8063.919360806317;9009.684661036832;9426;9457.588314979635;8584.442011269248;8888.822223555622;9038.186563209343;9088.500132492512;9961.900380996098;8319.209675080858;8327.583620818814;8500.61747221389;8504.659813607386;8511.829763404574 02:07:59 INFO - PROCESS | 28182 | |3;mootools.html;1277.2591896699914;1417.6455886028493;1445.8987870849041;1553.3398305720073;1704.5312539051752;6489.156409666743;6934.237233904273;7003.719851205952;7032.191298000732;7057.89413158803;6944;7106.928930710691;7126.643667816615;7138.535995160311;7148.606826624534;1898.1173754204292;1937.2444746548858;2081.157131361801;2108.546662467569;2110.5884352551257;2074.1288658763356;2075.2321640992777;2079.677649964258;2080.625487412265;2081.42760740796;2065.876047437151;2067.1111422088497;2097.5175709586806;2107.778683238261;2108.0303060592146;2058.2178772066595;2076.1591555420005;2079.6152711748373;2128.1274677382353;2190.2772085212;2098.5383215692523;2114.112072929358;2118.05746442833;2120.68189771534;2127.4574983379293;7263.055802745662;7268.127824661022;7309;7333.1933487316355;7333.413326933885;4396.274614688573;4547.204239258117;4548.295014272793;4551.635869130461;4556.883563526957;2842.559403292493;2932.662743784471;2940.8235505869716;2946.749526290268;2985.6118704568485;987;988.9950550247203;998.0368943969032;1014.4015031131668;1032.7160030991463;9793.657221997197;9813.165880900133;9838.606455741761;9840.11438970496;9857.901420985841;4033.1731994940965;4116.773577453268;4147.336426171798;4164.083901541717;4184.267753143188;8478.23695867375;8496.957515212507;8523.957380213184;8547.487150770974;8561.44350617208;4555.2256116460285;4596.47140578831;4603.700759450625;4603.700759450625;4610.861674149781;4186.7278626889765;4202.663786897041;4206.095689426788;4220.240356735756;4225.535191128974;3255.511673248984;3306.3056758080593;3481.8259087046054;3488;3567.839447224881;1052.7473406382412;1070.325694812279;1072.8176210044312;1092.082650573522;1095.5508241620896;1232.9815052774215;1246.4577908609604;1272.1413046193782;1311.206719934445;1312.2454588611586;6826.112605361371;6868.141482314711;6868.416184624363;6871.244163142051;6871.965640171868;1063.3141623652855;1074.387599068539;1088.2327958789035;1092.3609688332256;1103.8454616353717;5419.701916394557;5465.945340546623;5466.91799622998;5471.808486703026;5473.233747275384;8440.957795210985;8487.10885357041;8592.226699597066;8692.478451292942;8719.38964272495;8492.447990880573;8571.914280857236;8597.828043439096;8600.784980375416;8602.35482338827;6587.637679927554;6605.966970165118;6871.553349032397;6941.826454338682;6944.791656250321;6499.675016249074;6527.15147030883;6536.7712130077125;6548.738050478118;6548.83627909287;7579.431542634435;7580.734674286374;7614.543127412373;7777.222277772177;7810.765677029698;7786.18245084258;7959.80100497469;7965.163657815846;8017.63920623585;8088.79778005531;6451.1290975717675;6521.250056243593;6521.315261897622;6530.738770449128;6530.8040758777315;6721;6796.048553202457;6826.897596536155;6849.828754281183;6854.383105520527;6285.5600107992;6416.230052393743;6434.099226108442;6463.7737679181;6595.109660196004;6269.310375858743;6323.20959880015;6369.8726025480155;6409.551331406757;6556.213254409501;6358.586691865014;6377.202849643794;6379.936200637934;6402.615843049246;6418.261899881387;6044.848878778066;6079.270487541523;6079.787207447895;6083.878322433615;6086.6348019119;6018.7291571878495;6059.303180134341;6123.938760612336;6132.41742034506;6134.2332208473945 02:07:59 INFO - PROCESS | 28182 | |4;prototype.html;323.21942508841147;331.66170506083796;335.7649645248325;340.4790670274481;347.56207178954526;5848.795292164775;5924.970375148124;5925.140854576084;5963.552733544985;5993.430624090715;5850.531957443405;5856.238688970428;5863.7686085921905;5865.794697185599;5879.0593505039205;4572.8399506017295;4585.174668559658;4585.380973568575;4588.449386073676;4593.081383723252;4378.824847006132;4486.842960496383;4491.079328737601;4492.236319825637;4586.7477288749105;4422.336649502568;4450.1767173073085;4452.8441504547345;4452.933206001912;4456;4307.935380969288;4424.40270563473;4433.113377324532;4444.444444444444;4458.308962110878;3875.0506125999027;3932.390479475686;3933.5083114610675;3943.4479172915817;3946.8026598669953;5561.4716601923155;5562.02664533705;5578.107502799573;5578.30271216098;5583.4974852263085;4991.3511243538105;5114.105031619451;5122.769475373617;5223.738813059332;5267.157254839246;6202.596831205957;6212.223472065992;6223.657698826562;6228.5951413158;6238.251409830849;4366.716163449366;4369.038811461473;4369.191699535596;4370.803313850853;4373.497047839475;6338.873222535523;6440.581362211441;6508.381703738138;6513.93486065138;6516.218053833571;4421;4427.955720442755;4429.335599660077;4430.091831174602;4440.134173836071;4482.7534485602955;4487.192305384997;4487.416635837386;4488.304312831517;4493.730376177375;5192.091384007859;5194.740262986836;5201.947980520222;5205.765740541685;5209.817656382009;6126.326104128542;6203.348648391944;6242.500599951993;6254.74981000764;6267.811965641038;1571.9842801572067;1608.2039390501777;1609.1954022988505;1609.59760059985;1611.7582362645696;1037.678319720889;1072.4048153275007;1073.2540884085643;1091.7826623314947;1099.2854644480992;5943.286805583358;5961;5961.701914904237;5963.135345374896;5972.074328479092;6444.967775161094;6453.483721302285;6454.031895215755;6459.354064593503;6462.289148193695;5928.703564821828;5936.079907614327;5937.673427961504;5941.138534912414;5941.643501389931;3389.2035371687634;3506.368853606324;3511.841967111486;3518.3666939951054;3526.400511912981;6725.092112564839;6728.461723062143;6730.394264516119;6730.562513436611;6730.899036514456;6392.296847346881;6635.6350400728425;6650.767223147167;6679.966600166968;6686.53194276396;6213.937860621426;6626.337366263335;6728.764493242811;6743.494237932076;6746.797596072126;6513.4463570595135;6514.315996820455;6527.477801775942;6528.151340325728;6533.934660653523;6411.903821442589;6427.132337134614;6428.260750013621;6432.35676432353;6433.388828061326;6616.040674102324;6682.766103186365;6714.127163468718;6720.630365329954;6726;4408.250597398386;4459.152760975404;4472.39622650938;4473.843415480443;4476.171908196994;6528.445082168069;6532.183477065367;6539.934600654123;6542.280349161493;6544.4764418845425;6200.503959683305;6284.905726414199;6340.809775706736;6351.523635727432;6357.205349331333;6311.558190926591;6331.556791024768;6336.809895703136;6343.397377249154;6375.394337537927;6170.043643235305;6175.660338681416;6178.691065446799;6187.752489900354;6190.535709821691;6222.657753823402;6314.179156709598;6337.493000559852;6358.0780786784735;6396.360363963567;6199.5660303780105;6214.782482613087;6215;6215.81352559424;6245 02:07:59 INFO - PROCESS | 28182 | |5;yui.html;747.1855677311729;773.6363908962787;831.6008316008317;859.4456575508797;890.9910900890993;12793.360331983398;12831.101822872402;12849.614511564669;12931.676708082303;12942.805857912139;12278.754424911496;12312.445939932702;12314.81527777084;12326;12329.321887296195;654.4731491149622;662.9436497897684;666.8099591616391;781.8670825959572;805.6898094233703;797.2266901105918;800.7237503061434;804.1877703519458;804.7143264141233;806.3911746631285;833.3416600885294;833.4457585705499;835.6824406725436;840.1430540848331;841.6086519768306;683.3644710419308;691.8650863081701;828.4201059258543;830.2610676497922;837.459838404232;615.3477314047125;615.8244900203465;615.9322474527798;617.5707883021302;619.9256089269317;12966.546170883974;12975.416106275241;13029.218246905217;13032.087753857139;13067.673308167372;12441;12787.808182877265;12871.42078606465;13129.737405251937;13148;9544.95227523865;9610.135087842127;9652.131308182226;9690.515474226331;9844.310898237127;3524.788512689221;3574;3639.8908032758795;3692.612275711065;3718.3864662330684;43090.78454607707;43105.784471077444;43565.34651980191;43576.12847743028;43681;9039.276857851357;9991.200703943667;10245.231607629457;10332.793344133226;10470.947645261725;16735.330586776392;16753.664926701396;16875.831241687672;16919.661606767797;16927.830721692626;7209.747658831916;7357.889631655529;7382.22486638906;7587.279208475186;7745.806354841061;4171.690258944434;4198.874033778991;4271.124419493996;4300.935485967713;4341.110072435144;2894.956575651367;2923.8099523530905;2925.3417980954114;2930.6519001259658;2934.1637633274413;532.2681313194357;533.7251315572483;561.8061768689795;569.487461284847;588.5262363797099;506.5213373362211;522.2688236468974;591.600669548062;627.4259052966576;639.9872002559923;7841.764747057598;7877.527348359117;8042.162989161155;8113.5131892086665;8250.669973201006;523.5079025715814;576.8413686236319;620.4097891303788;665.9600423974578;669.9598024118471;3556.5732112146193;3687.502187204747;3716.18243986328;4059.411385349108;4133.132042271157;53786.462135378926;53827;53868.730656346466;53943;54480.727596361765;46642;47989.76005120022;48386.032279354215;48397.75801120972;48661.75669121702;40601.1879762409;41762.1647567053;42575.99999999938;43573.564264357585;43896.78051609721;8183.304419124441;8368.874466883124;8403.369747268856;8429;8678.262347700516;30566.541501877044;30579.01567335583;30882.227944301572;31272.21819454532;31411.84294078515;37703;37833.432498513095;37927.62072379241;41636;41976.37035444532;10237.48812559384;10707.946460267649;10743.946280268548;11028.117750580095;11085.889141108486;11516.366599837089;11547;11568.421578920852;11617.6514704559;11808.878156575112;10675.252732308663;10921.235513514295;11208.607698730506;11290.661280161608;11314.20800543987;10699.518521666389;10798.838017429587;11022;11144.2199046066;11499.827502587636;8829.337799664921;9610.646129904399;9962.501874906371;9983.950080249553;10747.731306717395;8732.432391894507;9140;9208.217301529445;9651.469169195481;9779.119879210904;9295.349325547148;9335.533223338942;9421.85867212006;9434.716958491255;9579.377340472847 02:07:59 INFO - PROCESS | 28182 | __end_tp_report 02:07:59 INFO - PROCESS | 28182 | __start_cc_report 02:07:59 INFO - PROCESS | 28182 | _x_x_mozilla_cycle_collect,975 02:07:59 INFO - PROCESS | 28182 | __end_cc_report 02:07:59 INFO - PROCESS | 28182 | __startTimestamp1452247679920__endTimestamp 02:07:59 INFO - PROCESS | 28182 | 02:07:59 INFO - PROCESS | 28182 | ------- Summary: start ------- 02:07:59 INFO - PROCESS | 28182 | Number of tests: 6 02:07:59 INFO - PROCESS | 28182 | 02:07:59 INFO - PROCESS | 28182 | [#0] dojo.html Cycles:165 Average:5020.61 Median:5131.72 stddev:525.68 (10.2%) stddev-sans-first:503.80 02:07:59 INFO - PROCESS | 28182 | Values: 3039.8 3106.5 3148.8 3150.6 3174.7 4942.7 5004.4 5005.8 5012.6 5057.1 4960.6 4985.2 4995.1 5074.6 5080.1 4599.8 4619.7 4646.3 4661.3 4755.5 4701.9 4714.1 4761.5 4770.5 4801.9 4517.4 4553.3 4600.7 4670.1 4730.2 4655.0 4661.5 4664.8 4677.7 4703.0 4640.4 4645.7 4649.2 4650.1 4673.1 4779.8 4793.3 4880.0 4888.8 4914.8 5399.5 5399.8 5409.8 5410.4 5429.0 5432.5 5442.7 5444.0 5449.2 5453.4 4936.4 4997.5 5032.2 5107.9 5144.6 5485.4 5520.8 5526.8 5528.3 5573.2 5320.5 5322.1 5328.0 5328.1 5330.3 5297.9 5374.4 5403.7 5414.8 5485.5 5341.9 5345.1 5346.0 5351.6 5354.3 5195.4 5379.5 5387.6 5390.4 5439.5 4149.1 4150.7 4160.0 4201.7 4246.9 3786.4 3809.3 3814.7 3844.7 3849.1 4907.4 5025.1 5057.0 5071.0 5121.7 5326.0 5334.6 5352.0 5397.9 5452.2 4973.4 5034.6 5035.0 5036.2 5077.2 4574.9 4619.8 4629.7 4637.9 4676.1 5480.6 5570.1 5637.7 5641.0 5684.1 5386.0 5419.2 5422.9 5430.8 5432.5 5343.4 5437.7 5550.7 5604.5 5678.1 5282.0 5335.7 5386.3 5397.6 5423.6 5433.3 5447.8 5454.8 5459.5 5462.2 5127.2 5171.0 5334.1 5345.0 5363.9 5191.1 5214.6 5284.9 5325.1 5332.3 5116.9 5118.1 5121.0 5125.4 5171.5 5131.7 5259.5 5261.4 5271.1 5287.2 5043.8 5097.5 5125.5 5198.9 5248.4 02:07:59 INFO - PROCESS | 28182 | 02:07:59 INFO - PROCESS | 28182 | [#1] ext.html Cycles:180 Average:44776.25 Median:31939.60 stddev:74645.43 (233.7%) stddev-sans-first:74780.91 02:07:59 INFO - PROCESS | 28182 | Values: 530.1 535.2 553.5 564.7 596.1 28531.6 29111.6 36133.6 36261.8 36402.3 38463.6 38906.6 38910.0 38922.8 38978.4 7382.1 8502.0 8679.5 8682.8 8697.4 7474.0 7611.8 10137.6 10371.1 10378.9 10124.0 10159.9 10200.7 10210.2 10219.6 7475.1 7670.0 10025.4 10131.7 10132.7 9992.2 10254.4 10262.9 10268.6 10269.3 39001.6 39563.8 39596.0 39684.8 39715.8 3284.4 3298.4 3346.1 3364.5 3366.6 30262.2 30405.1 30700.4 30840.0 31374.1 3832.8 3880.1 4004.9 4048.9 4074.7 275837.0 276213.0 276664.2 277863.0 278341.0 55546.4 56696.7 57830.4 58015.1 59176.7 52903.0 52936.7 52973.2 53106.5 53209.5 15644.9 15749.3 15889.5 15897.6 15917.7 11861.0 11900.2 11917.0 11933.5 12050.5 19448.3 19690.4 19697.3 19706.1 19751.5 7340.4 7501.6 7522.9 7551.1 7552.5 888.9 918.5 946.5 989.2 1050.3 27355.9 27508.3 27610.0 27959.7 27992.7 1094.2 1101.4 1107.3 1118.3 1128.4 14373.4 14489.6 14603.5 14742.6 14750.9 286294.0 292376.0 293501.0 293974.0 294107.0 49238.0 49269.8 49539.5 49681.5 49702.3 1284.9 1305.8 1313.8 1330.0 1331.5 26134.9 27221.3 27265.0 27273.6 27385.9 40611.0 41653.4 42239.4 42864.8 42901.0 277654.0 289933.0 291878.0 292551.0 293722.0 28682.4 29031.3 29056.3 29056.6 29118.4 38026.8 39044.0 39145.8 39434.2 39473.8 33303.5 33934.8 34676.0 35187.5 35964.3 33873.3 34136.3 34435.5 34555.3 34708.7 33889.8 34508.5 34552.3 34582.0 34721.7 30077.7 31488.0 31914.5 31964.7 31987.8 23562.3 23641.2 24102.8 24128.4 24293.9 02:07:59 INFO - PROCESS | 28182 | 02:07:59 INFO - PROCESS | 28182 | [#2] jquery.html Cycles:180 Average:25450.03 Median:5278.79 stddev:77723.44 (1472.4%) stddev-sans-first:77918.62 02:07:59 INFO - PROCESS | 28182 | Values: 353.9 356.0 357.1 359.7 362.1 13322.4 13790.8 16264.4 16817.0 18157.8 14713.8 15304.5 15696.8 16008.9 16009.3 5089.7 5276.2 5276.8 5280.8 5282.3 3963.6 4103.4 5322.0 5378.0 5627.6 5728.1 5813.2 5862.9 5863.1 5865.9 5657.2 5790.0 5805.4 5809.4 5810.2 5046.9 5148.4 5152.1 5313.8 5322.8 19474.5 19657.5 19835.1 19845.7 19891.0 2127.5 2222.3 2258.1 2413.2 2486.2 12069.2 12508.9 12564.9 12696.9 12961.9 1719.7 1780.6 1824.8 1837.5 1862.6 52314.5 54290.5 54569.7 55450.2 55954.4 9456.0 9589.7 9788.6 9803.6 9895.7 12700.2 12783.0 12869.9 12886.4 12891.9 7437.6 7481.3 7488.1 7499.4 7504.4 7186.5 7313.9 7316.7 7319.7 7358.3 5938.8 5951.1 5958.9 5986.4 6015.7 1655.6 1691.6 1731.2 1743.1 1766.5 880.2 902.4 933.9 1005.1 1027.0 14065.9 15213.7 16246.9 16527.1 16691.3 828.1 884.8 939.7 1008.9 1030.2 8825.0 9004.1 9006.7 9034.4 9221.6 368073.0 370186.0 528103.0 528433.0 546145.0 66536.7 69219.3 70295.6 70573.3 73259.6 1136.4 1144.3 1156.2 1186.3 1186.4 9787.9 10139.6 14576.8 14661.1 15074.2 31588.1 32080.0 33917.8 34901.8 36306.6 43171.1 45586.0 45717.3 46782.5 46893.0 9398.3 9631.2 9799.6 9811.9 9823.9 10597.5 10636.3 10842.5 10980.8 11239.7 9096.5 9247.7 9490.4 9563.8 9612.0 3203.5 5596.0 8400.2 9889.6 10012.1 7262.9 8063.9 9009.7 9426.0 9457.6 8584.4 8888.8 9038.2 9088.5 9961.9 8319.2 8327.6 8500.6 8504.7 8511.8 02:07:59 INFO - PROCESS | 28182 | 02:07:59 INFO - PROCESS | 28182 | [#3] mootools.html Cycles:180 Average:5081.28 Median:6133.33 stddev:2576.44 (42.0%) stddev-sans-first:2567.80 02:07:59 INFO - PROCESS | 28182 | Values: 1277.3 1417.6 1445.9 1553.3 1704.5 6489.2 6934.2 7003.7 7032.2 7057.9 6944.0 7106.9 7126.6 7138.5 7148.6 1898.1 1937.2 2081.2 2108.5 2110.6 2074.1 2075.2 2079.7 2080.6 2081.4 2065.9 2067.1 2097.5 2107.8 2108.0 2058.2 2076.2 2079.6 2128.1 2190.3 2098.5 2114.1 2118.1 2120.7 2127.5 7263.1 7268.1 7309.0 7333.2 7333.4 4396.3 4547.2 4548.3 4551.6 4556.9 2842.6 2932.7 2940.8 2946.7 2985.6 987.0 989.0 998.0 1014.4 1032.7 9793.7 9813.2 9838.6 9840.1 9857.9 4033.2 4116.8 4147.3 4164.1 4184.3 8478.2 8497.0 8524.0 8547.5 8561.4 4555.2 4596.5 4603.7 4603.7 4610.9 4186.7 4202.7 4206.1 4220.2 4225.5 3255.5 3306.3 3481.8 3488.0 3567.8 1052.7 1070.3 1072.8 1092.1 1095.6 1233.0 1246.5 1272.1 1311.2 1312.2 6826.1 6868.1 6868.4 6871.2 6872.0 1063.3 1074.4 1088.2 1092.4 1103.8 5419.7 5465.9 5466.9 5471.8 5473.2 8441.0 8487.1 8592.2 8692.5 8719.4 8492.4 8571.9 8597.8 8600.8 8602.4 6587.6 6606.0 6871.6 6941.8 6944.8 6499.7 6527.2 6536.8 6548.7 6548.8 7579.4 7580.7 7614.5 7777.2 7810.8 7786.2 7959.8 7965.2 8017.6 8088.8 6451.1 6521.3 6521.3 6530.7 6530.8 6721.0 6796.0 6826.9 6849.8 6854.4 6285.6 6416.2 6434.1 6463.8 6595.1 6269.3 6323.2 6369.9 6409.6 6556.2 6358.6 6377.2 6379.9 6402.6 6418.3 6044.8 6079.3 6079.8 6083.9 6086.6 6018.7 6059.3 6123.9 6132.4 6134.2 02:07:59 INFO - PROCESS | 28182 | 02:07:59 INFO - PROCESS | 28182 | [#4] prototype.html Cycles:180 Average:5238.20 Median:5939.41 stddev:1581.04 (26.6%) stddev-sans-first:1541.83 02:07:59 INFO - PROCESS | 28182 | Values: 323.2 331.7 335.8 340.5 347.6 5848.8 5925.0 5925.1 5963.6 5993.4 5850.5 5856.2 5863.8 5865.8 5879.1 4572.8 4585.2 4585.4 4588.4 4593.1 4378.8 4486.8 4491.1 4492.2 4586.7 4422.3 4450.2 4452.8 4452.9 4456.0 4307.9 4424.4 4433.1 4444.4 4458.3 3875.1 3932.4 3933.5 3943.4 3946.8 5561.5 5562.0 5578.1 5578.3 5583.5 4991.4 5114.1 5122.8 5223.7 5267.2 6202.6 6212.2 6223.7 6228.6 6238.3 4366.7 4369.0 4369.2 4370.8 4373.5 6338.9 6440.6 6508.4 6513.9 6516.2 4421.0 4428.0 4429.3 4430.1 4440.1 4482.8 4487.2 4487.4 4488.3 4493.7 5192.1 5194.7 5201.9 5205.8 5209.8 6126.3 6203.3 6242.5 6254.7 6267.8 1572.0 1608.2 1609.2 1609.6 1611.8 1037.7 1072.4 1073.3 1091.8 1099.3 5943.3 5961.0 5961.7 5963.1 5972.1 6445.0 6453.5 6454.0 6459.4 6462.3 5928.7 5936.1 5937.7 5941.1 5941.6 3389.2 3506.4 3511.8 3518.4 3526.4 6725.1 6728.5 6730.4 6730.6 6730.9 6392.3 6635.6 6650.8 6680.0 6686.5 6213.9 6626.3 6728.8 6743.5 6746.8 6513.4 6514.3 6527.5 6528.2 6533.9 6411.9 6427.1 6428.3 6432.4 6433.4 6616.0 6682.8 6714.1 6720.6 6726.0 4408.3 4459.2 4472.4 4473.8 4476.2 6528.4 6532.2 6539.9 6542.3 6544.5 6200.5 6284.9 6340.8 6351.5 6357.2 6311.6 6331.6 6336.8 6343.4 6375.4 6170.0 6175.7 6178.7 6187.8 6190.5 6222.7 6314.2 6337.5 6358.1 6396.4 6199.6 6214.8 6215.0 6215.8 6245.0 02:07:59 INFO - PROCESS | 28182 | 02:07:59 INFO - PROCESS | 28182 | [#5] yui.html Cycles:180 Average:12880.92 Median:48187.90 stddev:14570.05 (30.2%) stddev-sans-first:14582.43 02:07:59 INFO - PROCESS | 28182 | Values: 747.2 773.6 831.6 859.4 891.0 12793.4 12831.1 12849.6 12931.7 12942.8 12278.8 12312.4 12314.8 12326.0 12329.3 654.5 662.9 666.8 781.9 805.7 797.2 800.7 804.2 804.7 806.4 833.3 833.4 835.7 840.1 841.6 683.4 691.9 828.4 830.3 837.5 615.3 615.8 615.9 617.6 619.9 12966.5 12975.4 13029.2 13032.1 13067.7 12441.0 12787.8 12871.4 13129.7 13148.0 9545.0 9610.1 9652.1 9690.5 9844.3 3524.8 3574.0 3639.9 3692.6 3718.4 43090.8 43105.8 43565.3 43576.1 43681.0 9039.3 9991.2 10245.2 10332.8 10470.9 16735.3 16753.7 16875.8 16919.7 16927.8 7209.7 7357.9 7382.2 7587.3 7745.8 4171.7 4198.9 4271.1 4300.9 4341.1 2895.0 2923.8 2925.3 2930.7 2934.2 532.3 533.7 561.8 569.5 588.5 506.5 522.3 591.6 627.4 640.0 7841.8 7877.5 8042.2 8113.5 8250.7 523.5 576.8 620.4 666.0 670.0 3556.6 3687.5 3716.2 4059.4 4133.1 53786.5 53827.0 53868.7 53943.0 54480.7 46642.0 47989.8 48386.0 48397.8 48661.8 40601.2 41762.2 42576.0 43573.6 43896.8 8183.3 8368.9 8403.4 8429.0 8678.3 30566.5 30579.0 30882.2 31272.2 31411.8 37703.0 37833.4 37927.6 41636.0 41976.4 10237.5 10707.9 10743.9 11028.1 11085.9 11516.4 11547.0 11568.4 11617.7 11808.9 10675.3 10921.2 11208.6 11290.7 11314.2 10699.5 10798.8 11022.0 11144.2 11499.8 8829.3 9610.6 9962.5 9984.0 10747.7 8732.4 9140.0 9208.2 9651.5 9779.1 9295.3 9335.5 9421.9 9434.7 9579.4 02:07:59 INFO - PROCESS | 28182 | -------- Summary: end -------- 02:07:59 INFO - PROCESS | 28182 | 02:08:00 INFO - TEST-INFO | 28182: exit 0 02:08:00 INFO - TEST-OK | dromaeo_css | took 1112471ms 02:08:00 INFO - TEST-START | kraken 02:08:00 INFO - operating with platform_type : linux_ 02:08:00 INFO - Initialising browser for kraken test... 02:08:00 INFO - TEST-INFO | started process 28375 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpx71j0I/profile http://localhost:33486/getInfo.html) 02:08:04 INFO - PROCESS | 28375 | __metrics Screen width/height:1600/1200 02:08:04 INFO - PROCESS | 28375 | colorDepth:24 02:08:04 INFO - PROCESS | 28375 | Browser inner width/height: 1024/697 02:08:04 INFO - PROCESS | 28375 | __metrics 02:08:04 INFO - PROCESS | 28375 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:08:04 INFO - PROCESS | 28375 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:08:05 INFO - TEST-INFO | 28375: exit 0 02:08:05 INFO - Browser initialized. 02:08:05 INFO - Running cycle 1/1 for kraken test... 02:08:05 INFO - TEST-INFO | started process 28455 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpx71j0I/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:17 INFO - PROCESS | 28455 | RSS: Main: 150274048 02:08:17 INFO - PROCESS | 28455 | 02:08:19 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:33486/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33486/tests/kraken/driver.html?testName=audio-beat-detection) 02:08:20 INFO - PROCESS | 28455 | RSS: Main: 187301888 02:08:20 INFO - PROCESS | 28455 | 02:08:22 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:33486/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33486/tests/kraken/driver.html?testName=audio-dft) 02:08:23 INFO - PROCESS | 28455 | RSS: Main: 178679808 02:08:23 INFO - PROCESS | 28455 | 02:08:26 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:33486/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33486/tests/kraken/driver.html?testName=audio-fft) 02:08:26 INFO - PROCESS | 28455 | RSS: Main: 161734656 02:08:26 INFO - PROCESS | 28455 | 02:08:28 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:33486/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33486/tests/kraken/driver.html?testName=audio-oscillator) 02:08:29 INFO - PROCESS | 28455 | RSS: Main: 163622912 02:08:29 INFO - PROCESS | 28455 | 02:08:31 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:33486/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33486/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:08:32 INFO - PROCESS | 28455 | RSS: Main: 167157760 02:08:32 INFO - PROCESS | 28455 | 02:08:35 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:33486/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33486/tests/kraken/driver.html?testName=imaging-darkroom) 02:08:35 INFO - PROCESS | 28455 | RSS: Main: 166678528 02:08:35 INFO - PROCESS | 28455 | 02:08:39 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:33486/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33486/tests/kraken/driver.html?testName=imaging-desaturate) 02:08:39 INFO - PROCESS | 28455 | RSS: Main: 167292928 02:08:39 INFO - PROCESS | 28455 | 02:08:42 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:33486/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33486/tests/kraken/driver.html?testName=json-parse-financial) 02:08:43 INFO - PROCESS | 28455 | RSS: Main: 167448576 02:08:43 INFO - PROCESS | 28455 | 02:08:44 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:33486/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33486/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:08:45 INFO - PROCESS | 28455 | RSS: Main: 176189440 02:08:45 INFO - PROCESS | 28455 | 02:08:46 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:33486/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33486/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:08:47 INFO - PROCESS | 28455 | RSS: Main: 173424640 02:08:47 INFO - PROCESS | 28455 | 02:08:49 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:33486/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33486/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:08:50 INFO - PROCESS | 28455 | RSS: Main: 185241600 02:08:50 INFO - PROCESS | 28455 | 02:08:52 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:33486/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33486/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:08:53 INFO - PROCESS | 28455 | RSS: Main: 193781760 02:08:53 INFO - PROCESS | 28455 | 02:08:55 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:33486/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33486/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:08:56 INFO - PROCESS | 28455 | RSS: Main: 192491520 02:08:56 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:33486/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33486/tests/kraken/driver.html?testName=ai-astar) 02:08:58 INFO - PROCESS | 28455 | RSS: Main: 250695680 02:08:58 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | __start_tp_report 02:08:58 INFO - PROCESS | 28455 | _x_x_mozilla_page_load 02:08:58 INFO - PROCESS | 28455 | _x_x_mozilla_page_load_details 02:08:58 INFO - PROCESS | 28455 | |i|pagename|runs| 02:08:58 INFO - PROCESS | 28455 | |0;ai-astar;109;109;104;109;110;111;100;111;111;110 02:08:58 INFO - PROCESS | 28455 | |1;audio-beat-detection;153;125;153;172;125;150;153;127;174;128 02:08:58 INFO - PROCESS | 28455 | |2;audio-dft;161;160;162;160;160;165;162;161;161;161 02:08:58 INFO - PROCESS | 28455 | |3;audio-fft;71;73;81;97;70;71;74;103;87;72 02:08:58 INFO - PROCESS | 28455 | |4;audio-oscillator;96;96;143;96;97;96;143;96;94;136 02:08:58 INFO - PROCESS | 28455 | |5;imaging-gaussian-blur;108;109;109;110;110;109;109;109;109;109 02:08:58 INFO - PROCESS | 28455 | |6;imaging-darkroom;145;145;146;145;145;145;145;145;147;145 02:08:58 INFO - PROCESS | 28455 | |7;imaging-desaturate;97;96;96;96;95;96;96;96;96;96 02:08:58 INFO - PROCESS | 28455 | |8;json-parse-financial;55;56;61;56;55;56;55;64;56;54 02:08:58 INFO - PROCESS | 28455 | |9;json-stringify-tinderbox;66;66;66;67;67;67;66;67;67;66 02:08:58 INFO - PROCESS | 28455 | |10;stanford-crypto-aes;85;84;85;84;84;85;87;83;87;84 02:08:58 INFO - PROCESS | 28455 | |11;stanford-crypto-ccm;116;114;116;117;113;122;118;129;115;122 02:08:58 INFO - PROCESS | 28455 | |12;stanford-crypto-pbkdf2;161;138;149;149;149;147;148;148;147;141 02:08:58 INFO - PROCESS | 28455 | |13;stanford-crypto-sha256-iterative;70;68;68;66;66;65;66;67;67;66 02:08:58 INFO - PROCESS | 28455 | __end_tp_report 02:08:58 INFO - PROCESS | 28455 | __start_cc_report 02:08:58 INFO - PROCESS | 28455 | _x_x_mozilla_cycle_collect,961 02:08:58 INFO - PROCESS | 28455 | __end_cc_report 02:08:58 INFO - PROCESS | 28455 | __startTimestamp1452247738263__endTimestamp 02:08:58 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | ------- Summary: start ------- 02:08:58 INFO - PROCESS | 28455 | Number of tests: 14 02:08:58 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:3.60 (3.3%) stddev-sans-first:3.81 02:08:58 INFO - PROCESS | 28455 | Values: 109.0 109.0 104.0 109.0 110.0 111.0 100.0 111.0 111.0 110.0 02:08:58 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:153.00 stddev:18.83 (12.3%) stddev-sans-first:19.80 02:08:58 INFO - PROCESS | 28455 | Values: 153.0 125.0 153.0 172.0 125.0 150.0 153.0 127.0 174.0 128.0 02:08:58 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 02:08:58 INFO - PROCESS | 28455 | Values: 161.0 160.0 162.0 160.0 160.0 165.0 162.0 161.0 161.0 161.0 02:08:58 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | [#3] audio-fft Cycles:10 Average:79.90 Median:73.50 stddev:11.92 (16.2%) stddev-sans-first:12.20 02:08:58 INFO - PROCESS | 28455 | Values: 71.0 73.0 81.0 97.0 70.0 71.0 74.0 103.0 87.0 72.0 02:08:58 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:96.00 stddev:21.74 (22.6%) stddev-sans-first:22.52 02:08:58 INFO - PROCESS | 28455 | Values: 96.0 96.0 143.0 96.0 97.0 96.0 143.0 96.0 94.0 136.0 02:08:58 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 02:08:58 INFO - PROCESS | 28455 | Values: 108.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 02:08:58 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 02:08:58 INFO - PROCESS | 28455 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 147.0 145.0 02:08:58 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 02:08:58 INFO - PROCESS | 28455 | Values: 97.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 02:08:58 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.00 stddev:3.16 (5.6%) stddev-sans-first:3.28 02:08:58 INFO - PROCESS | 28455 | Values: 55.0 56.0 61.0 56.0 55.0 56.0 55.0 64.0 56.0 54.0 02:08:58 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 02:08:58 INFO - PROCESS | 28455 | Values: 66.0 66.0 66.0 67.0 67.0 67.0 66.0 67.0 67.0 66.0 02:08:58 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:1.32 (1.5%) stddev-sans-first:1.39 02:08:58 INFO - PROCESS | 28455 | Values: 85.0 84.0 85.0 84.0 84.0 85.0 87.0 83.0 87.0 84.0 02:08:58 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:117.50 stddev:4.85 (4.1%) stddev-sans-first:5.08 02:08:58 INFO - PROCESS | 28455 | Values: 116.0 114.0 116.0 117.0 113.0 122.0 118.0 129.0 115.0 122.0 02:08:58 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:148.50 stddev:5.98 (4.0%) stddev-sans-first:3.96 02:08:58 INFO - PROCESS | 28455 | Values: 161.0 138.0 149.0 149.0 149.0 147.0 148.0 148.0 147.0 141.0 02:08:58 INFO - PROCESS | 28455 | 02:08:58 INFO - PROCESS | 28455 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.45 (2.2%) stddev-sans-first:1.01 02:08:58 INFO - PROCESS | 28455 | Values: 70.0 68.0 68.0 66.0 66.0 65.0 66.0 67.0 67.0 66.0 02:08:58 INFO - PROCESS | 28455 | -------- Summary: end -------- 02:08:58 INFO - PROCESS | 28455 | 02:08:59 INFO - TEST-INFO | 28455: exit 0 02:08:59 INFO - TEST-OK | kraken | took 58542ms 02:08:59 INFO - TEST-START | v8_7 02:08:59 INFO - operating with platform_type : linux_ 02:08:59 INFO - Initialising browser for v8_7 test... 02:08:59 INFO - TEST-INFO | started process 28704 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpG2wzJ0/profile http://localhost:33486/getInfo.html) 02:09:03 INFO - PROCESS | 28704 | __metrics Screen width/height:1600/1200 02:09:03 INFO - PROCESS | 28704 | colorDepth:24 02:09:03 INFO - PROCESS | 28704 | Browser inner width/height: 1024/697 02:09:03 INFO - PROCESS | 28704 | __metrics 02:09:03 INFO - PROCESS | 28704 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:09:03 INFO - PROCESS | 28704 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:09:03 INFO - PROCESS | 28704 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 02:09:04 INFO - TEST-INFO | 28704: exit 0 02:09:04 INFO - Browser initialized. 02:09:04 INFO - Running cycle 1/1 for v8_7 test... 02:09:04 INFO - TEST-INFO | started process 28789 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpG2wzJ0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:09:15 INFO - PROCESS | 28789 | RSS: Main: 147144704 02:09:15 INFO - PROCESS | 28789 | 02:09:38 INFO - PROCESS | 28789 | Cycle 1(1): loaded http://localhost:33486/tests/v8_7/run.html (next: http://localhost:33486/tests/v8_7/run.html) 02:09:38 INFO - PROCESS | 28789 | RSS: Main: 519733248 02:09:38 INFO - PROCESS | 28789 | 02:09:38 INFO - PROCESS | 28789 | __start_tp_report 02:09:38 INFO - PROCESS | 28789 | _x_x_mozilla_page_load 02:09:38 INFO - PROCESS | 28789 | _x_x_mozilla_page_load_details 02:09:38 INFO - PROCESS | 28789 | |i|pagename|runs| 02:09:38 INFO - PROCESS | 28789 | |0;Richards;169.72165648336727 02:09:38 INFO - PROCESS | 28789 | |1;DeltaBlue;197.39439399921042 02:09:38 INFO - PROCESS | 28789 | |2;Encrypt;283.7684449489217 02:09:38 INFO - PROCESS | 28789 | |3;Decrypt;5246.073298429319 02:09:38 INFO - PROCESS | 28789 | |4;RayTrace;1106.1946902654868 02:09:38 INFO - PROCESS | 28789 | |5;Earley;794.912559618442 02:09:38 INFO - PROCESS | 28789 | |6;Boyer;12419.753086419752 02:09:38 INFO - PROCESS | 28789 | |7;RegExp;43083.333333333336 02:09:38 INFO - PROCESS | 28789 | |8;Splay;591.9574216439977 02:09:38 INFO - PROCESS | 28789 | |9;NavierStokes;4830.917874396136 02:09:38 INFO - PROCESS | 28789 | __end_tp_report 02:09:38 INFO - PROCESS | 28789 | __startTimestamp1452247778641__endTimestamp 02:09:38 INFO - PROCESS | 28789 | 02:09:38 INFO - PROCESS | 28789 | ------- Summary: start ------- 02:09:38 INFO - PROCESS | 28789 | Number of tests: 10 02:09:38 INFO - PROCESS | 28789 | 02:09:38 INFO - PROCESS | 28789 | [#0] Richards Cycles:1 Average:169.72 Median:169.72 stddev:0.00 (0.0%) 02:09:38 INFO - PROCESS | 28789 | Values: 169.7 02:09:38 INFO - PROCESS | 28789 | 02:09:38 INFO - PROCESS | 28789 | [#1] DeltaBlue Cycles:1 Average:197.39 Median:197.39 stddev:0.00 (0.0%) 02:09:38 INFO - PROCESS | 28789 | Values: 197.4 02:09:38 INFO - PROCESS | 28789 | 02:09:38 INFO - PROCESS | 28789 | [#2] Encrypt Cycles:1 Average:283.77 Median:283.77 stddev:0.00 (0.0%) 02:09:38 INFO - PROCESS | 28789 | Values: 283.8 02:09:38 INFO - PROCESS | 28789 | 02:09:38 INFO - PROCESS | 28789 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 02:09:38 INFO - PROCESS | 28789 | Values: 5246.1 02:09:38 INFO - PROCESS | 28789 | 02:09:38 INFO - PROCESS | 28789 | [#4] RayTrace Cycles:1 Average:1106.19 Median:1106.19 stddev:0.00 (0.0%) 02:09:38 INFO - PROCESS | 28789 | Values: 1106.2 02:09:38 INFO - PROCESS | 28789 | 02:09:38 INFO - PROCESS | 28789 | [#5] Earley Cycles:1 Average:794.91 Median:794.91 stddev:0.00 (0.0%) 02:09:38 INFO - PROCESS | 28789 | Values: 794.9 02:09:38 INFO - PROCESS | 28789 | 02:09:38 INFO - PROCESS | 28789 | [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 02:09:38 INFO - PROCESS | 28789 | Values: 12419.8 02:09:38 INFO - PROCESS | 28789 | 02:09:38 INFO - PROCESS | 28789 | [#7] RegExp Cycles:1 Average:43083.33 Median:43083.33 stddev:0.00 (0.0%) 02:09:38 INFO - PROCESS | 28789 | Values: 43083.3 02:09:38 INFO - PROCESS | 28789 | 02:09:38 INFO - PROCESS | 28789 | [#8] Splay Cycles:1 Average:591.96 Median:591.96 stddev:0.00 (0.0%) 02:09:38 INFO - PROCESS | 28789 | Values: 592.0 02:09:38 INFO - PROCESS | 28789 | 02:09:38 INFO - PROCESS | 28789 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 02:09:38 INFO - PROCESS | 28789 | Values: 4830.9 02:09:38 INFO - PROCESS | 28789 | -------- Summary: end -------- 02:09:38 INFO - PROCESS | 28789 | 02:09:39 INFO - TEST-INFO | 28789: exit 0 02:09:39 INFO - TEST-OK | v8_7 | took 40251ms 02:09:39 INFO - SUITE-END | took 1211s 02:09:39 INFO - Completed test suite (00:20:11) 02:09:39 INFO - Working with test: dromaeo_css 02:09:39 INFO - Generating results file: dromaeo_css 02:09:39 INFO - Working with test: kraken 02:09:39 INFO - Generating results file: kraken 02:09:39 INFO - javascript benchmark 02:09:39 INFO - Working with test: v8_7 02:09:39 INFO - Generating results file: v8_7 02:09:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:09:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 02:09:39 INFO - process_Request line: dromaeo_css 6672.96 graph.html#tests=[[72,201,35]] 02:09:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:09:39 INFO - process_Request line: kraken 1496.20 graph.html#tests=[[232,201,35]] 02:09:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:09:39 INFO - process_Request line: v8_7 19837.31 graph.html#tests=[[230,201,35]] 02:09:39 INFO - RETURN: dromaeo_css: 6672.96 02:09:39 INFO - RETURN: kraken: 1496.20 02:09:39 INFO - RETURN: v8_7: 19837.31 02:09:39 INFO - javascript benchmark 02:09:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3039.8480075996204, 3106.4563701352286, 3148.7795854290193, 3150.5746724192227, 3174.6666600007006, 4942.703437793735, 5004.374453193351, 5005.824796132131, 5012.573931215842, 5057.08972384971, 4960.553550180483, 4985.227289770082, 4995.125852975724, 5074.644774865761, 5080.085584594781, 4599.8390056348035, 4619.676622636425, 4646.303054541812, 4661.254199328108, 4755.453122890877, 4701.882452938669, 4714.127886341038, 4761.452432970201, 4770.475247722748, 4801.903961920777, 4517.390152329459, 4553.2942393929, 4600.746958917258, 4670.136024835399, 4730.195866702652, 4654.976725116387, 4661.487236403993, 4664.766761661937, 4677.74272415017, 4702.952970470285, 4640.373549570799, 4645.744484053375, 4649.18639238132, 4650.0932318197965, 4673.088747694201, 4779.80880764769, 4793.32893394925, 4880.0, 4888.804447822083, 4914.754262286907, 5399.514043736082, 5399.78400863965, 5409.810656627039, 5410.431904650034, 5428.972855135738, 5432.511074003359, 5442.673439593597, 5443.972780136113, 5449.155380915964, 5453.400125986138, 4936.358273424467, 4997.50024997501, 5032.220005899091, 5107.948920510822, 5144.588432925357, 5485.396606373296, 5520.834374968677, 5526.834194974157, 5528.253685752372, 5573.219749235111, 5320.467953204726, 5322.14845624706, 5328.0, 5328.0675881720545, 5330.253764472977, 5297.894042119136, 5374.355077390738, 5403.675779453245, 5414.83755487336, 5485.50630443262, 5341.946580534145, 5345.064613692588, 5345.973270133624, 5351.625386223005, 5354.303940487712, 5195.350581177353, 5379.462053794589, 5387.622866399314, 5390.380106287748, 5439.48324909133, 4149.128682976609, 4150.667946564267, 4159.9792001039805, 4201.7268877522865, 4246.8725938221905, 3786.4320351946876, 3809.276237514863, 3814.6566808987322, 3844.6732027777953, 3849.1339448623835, 4907.386576677915, 5025.095482813129, 5056.974715126401, 5070.974645126751, 5121.667091639031, 5326.0, 5334.626576139633, 5352.0, 5397.865053373697, 5452.182172674131, 4973.403191617029, 5034.622403319692, 5035.0, 5036.244563315532, 5077.1876499759865, 4574.862754117382, 4619.792109355087, 4629.7222166669435, 4637.8840528986375, 4676.08816280822, 5480.588955828329, 5570.108782594765, 5637.7181140942785, 5641.041023026095, 5684.090545512699, 5385.973070134624, 5419.2413062170535, 5422.945770542402, 5430.8099216527235, 5432.538234249975, 5343.4389389113585, 5437.673739575638, 5550.69471179089, 5604.495595396434, 5678.14827775837, 5282.0, 5335.653182543122, 5386.272853164929, 5397.649152805055, 5423.5932305076485, 5433.293671822637, 5447.809326673548, 5454.781808727606, 5459.454054594509, 5462.207979842821, 5127.1540195867265, 5171.00652970211, 5334.06653835585, 5345.0, 5363.946360536344, 5191.143461328989, 5214.5567626750635, 5284.920726189187, 5325.068113080273, 5332.30680011596, 5116.948830511647, 5118.129917914038, 5120.974395128001, 5125.410577783454, 5171.534561889448, 5131.717755523482, 5259.500347466985, 5261.394939581844, 5271.051210782096, 5287.180487024518, 5043.818107496389, 5097.515736005073, 5125.5387015167325, 5198.948010519997, 5248.422673505987], "unit": "score", "name": "dojo.html", "value": 4988.935718280961}, {"lowerIsBetter": false, "replicates": [530.0644362699833, 535.2105644174843, 553.4907884746038, 564.6978866306524, 596.1207219351458, 28531.572026419595, 29111.56332655009, 36133.638663613354, 36261.81869090658, 36402.27195456089, 38463.61536384635, 38906.61093389065, 38910.0, 38922.80538597303, 38978.41532377017, 7382.077240344957, 8501.999999999984, 8679.522626255553, 8682.782930426727, 8697.391182617219, 7474.0, 7611.847763044736, 10137.645182418617, 10371.11845493134, 10378.896211037907, 10124.0, 10159.949200253988, 10200.744981375488, 10210.183185345155, 10219.591216351337, 7475.140358858746, 7670.0, 10025.44860032698, 10131.746706332327, 10132.746681332952, 9992.200623950066, 10254.384736915808, 10262.897371026269, 10268.589256429734, 10269.28115031948, 39001.60998390008, 39563.8021809892, 39596.0, 39684.801575991936, 39715.801420993, 3284.359549887773, 3298.422776014188, 3346.1467325832, 3364.4616861302075, 3366.562346894888, 30262.24344391386, 30405.087847364615, 30700.38599228025, 30840.0, 31374.05877823669, 3832.8083595820376, 3880.146367799108, 4004.9199016019807, 4048.898777530556, 4074.7147699661036, 275836.999999998, 276213.0, 276664.2333576659, 277863.0, 278341.0, 55546.444535554125, 56696.71651641798, 57830.421695782505, 58015.129773053435, 59176.704116479144, 52903.0, 52936.735316323175, 52973.205401919, 53106.46893531015, 53209.467905321224, 15644.92177539105, 15749.291281892343, 15889.52331430059, 15897.602559936095, 15917.681646367007, 11861.0, 11900.226485278428, 11917.0, 11933.52265909354, 12050.517979280907, 19448.319308824124, 19690.40928772139, 19697.310594129136, 19706.113224904915, 19751.506212344808, 7340.37606803417, 7501.5874126923545, 7522.924770752332, 7551.131619863676, 7552.509086909334, 888.9022207557164, 918.5223683684446, 946.4699768129869, 989.2135752077116, 1050.3277902142636, 27355.86322068377, 27508.312292192455, 27610.031854277768, 27959.72040279612, 27992.72007279942, 1094.1684319916922, 1101.4217535793612, 1107.2526044919807, 1118.3122379736567, 1128.373752567333, 14373.353199106064, 14489.565313040415, 14603.488877889224, 14742.63143421423, 14750.926245368919, 286294.0, 292376.0, 293501.0, 293974.0, 294107.0, 49238.0, 49269.75365123151, 49539.50460495421, 49681.50318496769, 49702.25446618304, 1284.9229046257067, 1305.7519071376407, 1313.7635225659474, 1329.993350033263, 1331.547273926889, 26134.86932565401, 27221.319467013484, 27265.0, 27273.59089613618, 27385.863070684518, 40611.0, 41653.375199371425, 42239.366409503265, 42864.78567607142, 42901.0, 277654.0, 289933.0, 291878.0, 292551.0, 293722.0, 28682.42635147327, 29031.274218144714, 29056.27359316034, 29056.564151538165, 29118.417631647673, 38026.809865951596, 39044.0, 39145.8042709796, 39434.21131577295, 39473.80263098666, 33303.50044749282, 33934.83032584821, 34676.0, 35187.472187917716, 35964.28071438609, 33873.3225335487, 34136.31727365489, 34435.483467748505, 34555.30889382248, 34708.65291347155, 33889.83055084709, 34508.48237276392, 34552.30895382028, 34582.0, 34721.652783472855, 30077.699223008367, 31488.0, 31914.52128218125, 31964.68035319617, 31987.840060800478, 23562.29313120609, 23641.172558960352, 24102.758972410753, 24128.396790080387, 24293.878530607235], "unit": "score", "name": "ext.html", "value": 18091.231741165364}, {"lowerIsBetter": false, "replicates": [353.9132912436452, 355.9857605695772, 357.07161380410935, 359.7104331013535, 362.069481432718, 13322.40049197786, 13790.793138102936, 16264.43074492393, 16817.0, 18157.818421815777, 14713.779293310608, 15304.540863774104, 15696.764548531753, 16008.919955400235, 16009.27958241879, 5089.720065396402, 5276.2085687146855, 5276.762545685434, 5280.815171468999, 5282.3096609085105, 3963.64327210551, 4103.38449232616, 5321.973390133044, 5378.0, 5627.577931655122, 5728.05487094631, 5813.244278243822, 5862.853428664296, 5863.149843272744, 5865.912011319833, 5657.20799088128, 5790.0, 5805.448482394166, 5809.3900140485275, 5810.157527158581, 5046.924296135561, 5148.3821941366905, 5152.124138896396, 5313.840584782462, 5322.760475778599, 19474.513137171543, 19657.508562285915, 19835.10742016613, 19845.702314465296, 19891.0, 2127.5425783456476, 2222.2777597280947, 2258.096761295495, 2413.179518963543, 2486.2168416948602, 12069.155159138863, 12508.896885716675, 12564.874351256462, 12696.936515317457, 12961.935190324082, 1719.6904557179703, 1780.5548612846787, 1824.781026276842, 1837.5406148462885, 1862.608852141052, 52314.47685523134, 54290.45709542894, 54569.72715136439, 55450.16824747632, 55954.44045559533, 9455.952720236492, 9589.664361747306, 9788.608455661693, 9803.607855685836, 9895.703128906145, 12700.18325233047, 12783.041271904644, 12869.935650321688, 12886.420111095023, 12891.871081289255, 7437.590932498656, 7481.289277518627, 7488.138864030706, 7499.400047996147, 7504.437167212481, 7186.461015423864, 7313.89029164563, 7316.743913962986, 7319.74380896666, 7358.337749602454, 5938.8218353449465, 5951.137085122633, 5958.85102872423, 5986.3714309997695, 6015.729292181863, 1655.6440365321514, 1691.6024734187456, 1731.186342419061, 1743.145858529337, 1766.4788887278285, 880.2429910277157, 902.3999040637902, 933.869258303838, 1005.1104772276587, 1026.958921643141, 14065.859341406454, 15213.695726085638, 16246.918765406097, 16527.091009994565, 16691.332346705996, 828.1221904780951, 884.7566919097171, 939.7086903060073, 1008.8991100889853, 1030.2067408095725, 8824.955875220583, 9004.099590041074, 9006.729798106067, 9034.367594268339, 9221.631134754669, 368073.0, 370186.0, 528103.0, 528433.0, 546145.0, 66536.66731666311, 69219.26951826244, 70295.64852175706, 70573.2942670577, 73259.63370183115, 1136.3522792008641, 1144.3076938452116, 1156.150229581257, 1186.3178672263482, 1186.3890096600257, 9787.85318220213, 10139.64511242103, 14576.781348279996, 14661.120332780067, 15074.170920599472, 31588.052358429282, 32080.0, 33917.83041084877, 34901.8254908734, 36306.63693363138, 43171.13657726891, 45586.0, 45717.314240285756, 46782.53217467918, 46893.0, 9398.295127865575, 9631.181349585364, 9799.608015679292, 9811.852822207815, 9823.852642210515, 10597.523111460157, 10636.255462117577, 10842.457877106272, 10980.780384392427, 11239.66281011571, 9096.49969251671, 9247.72256832296, 9490.383125096847, 9563.808723825623, 9612.0, 3203.503456964081, 5596.0206963780365, 8400.243978042006, 9889.604415823575, 10012.148967337858, 7262.874239632216, 8063.919360806317, 9009.684661036832, 9426.0, 9457.588314979635, 8584.442011269248, 8888.822223555622, 9038.186563209343, 9088.500132492512, 9961.900380996098, 8319.209675080858, 8327.583620818814, 8500.61747221389, 8504.659813607386, 8511.829763404574], "unit": "score", "name": "jquery.html", "value": 8177.109032867489}, {"lowerIsBetter": false, "replicates": [1277.2591896699914, 1417.6455886028493, 1445.8987870849041, 1553.3398305720073, 1704.5312539051752, 6489.156409666743, 6934.237233904273, 7003.719851205952, 7032.191298000732, 7057.89413158803, 6944.0, 7106.928930710691, 7126.643667816615, 7138.535995160311, 7148.606826624534, 1898.1173754204292, 1937.2444746548858, 2081.157131361801, 2108.546662467569, 2110.5884352551257, 2074.1288658763356, 2075.2321640992777, 2079.677649964258, 2080.625487412265, 2081.42760740796, 2065.876047437151, 2067.1111422088497, 2097.5175709586806, 2107.778683238261, 2108.0303060592146, 2058.2178772066595, 2076.1591555420005, 2079.6152711748373, 2128.1274677382353, 2190.2772085212, 2098.5383215692523, 2114.112072929358, 2118.05746442833, 2120.68189771534, 2127.4574983379293, 7263.055802745662, 7268.127824661022, 7309.0, 7333.1933487316355, 7333.413326933885, 4396.274614688573, 4547.204239258117, 4548.295014272793, 4551.635869130461, 4556.883563526957, 2842.559403292493, 2932.662743784471, 2940.8235505869716, 2946.749526290268, 2985.6118704568485, 987.0, 988.9950550247203, 998.0368943969032, 1014.4015031131668, 1032.7160030991463, 9793.657221997197, 9813.165880900133, 9838.606455741761, 9840.11438970496, 9857.901420985841, 4033.1731994940965, 4116.773577453268, 4147.336426171798, 4164.083901541717, 4184.267753143188, 8478.23695867375, 8496.957515212507, 8523.957380213184, 8547.487150770974, 8561.44350617208, 4555.2256116460285, 4596.47140578831, 4603.700759450625, 4603.700759450625, 4610.861674149781, 4186.7278626889765, 4202.663786897041, 4206.095689426788, 4220.240356735756, 4225.535191128974, 3255.511673248984, 3306.3056758080593, 3481.8259087046054, 3488.0, 3567.839447224881, 1052.7473406382412, 1070.325694812279, 1072.8176210044312, 1092.082650573522, 1095.5508241620896, 1232.9815052774215, 1246.4577908609604, 1272.1413046193782, 1311.206719934445, 1312.2454588611586, 6826.112605361371, 6868.141482314711, 6868.416184624363, 6871.244163142051, 6871.965640171868, 1063.3141623652855, 1074.387599068539, 1088.2327958789035, 1092.3609688332256, 1103.8454616353717, 5419.701916394557, 5465.945340546623, 5466.91799622998, 5471.808486703026, 5473.233747275384, 8440.957795210985, 8487.10885357041, 8592.226699597066, 8692.478451292942, 8719.38964272495, 8492.447990880573, 8571.914280857236, 8597.828043439096, 8600.784980375416, 8602.35482338827, 6587.637679927554, 6605.966970165118, 6871.553349032397, 6941.826454338682, 6944.791656250321, 6499.675016249074, 6527.15147030883, 6536.7712130077125, 6548.738050478118, 6548.83627909287, 7579.431542634435, 7580.734674286374, 7614.543127412373, 7777.222277772177, 7810.765677029698, 7786.18245084258, 7959.80100497469, 7965.163657815846, 8017.63920623585, 8088.79778005531, 6451.1290975717675, 6521.250056243593, 6521.315261897622, 6530.738770449128, 6530.8040758777315, 6721.0, 6796.048553202457, 6826.897596536155, 6849.828754281183, 6854.383105520527, 6285.5600107992, 6416.230052393743, 6434.099226108442, 6463.7737679181, 6595.109660196004, 6269.310375858743, 6323.20959880015, 6369.8726025480155, 6409.551331406757, 6556.213254409501, 6358.586691865014, 6377.202849643794, 6379.936200637934, 6402.615843049246, 6418.261899881387, 6044.848878778066, 6079.270487541523, 6079.787207447895, 6083.878322433615, 6086.6348019119, 6018.7291571878495, 6059.303180134341, 6123.938760612336, 6132.41742034506, 6134.2332208473945], "unit": "score", "name": "mootools.html", "value": 4212.115206717139}, {"lowerIsBetter": false, "replicates": [323.21942508841147, 331.66170506083796, 335.7649645248325, 340.4790670274481, 347.56207178954526, 5848.795292164775, 5924.970375148124, 5925.140854576084, 5963.552733544985, 5993.430624090715, 5850.531957443405, 5856.238688970428, 5863.7686085921905, 5865.794697185599, 5879.0593505039205, 4572.8399506017295, 4585.174668559658, 4585.380973568575, 4588.449386073676, 4593.081383723252, 4378.824847006132, 4486.842960496383, 4491.079328737601, 4492.236319825637, 4586.7477288749105, 4422.336649502568, 4450.1767173073085, 4452.8441504547345, 4452.933206001912, 4456.0, 4307.935380969288, 4424.40270563473, 4433.113377324532, 4444.444444444444, 4458.308962110878, 3875.0506125999027, 3932.390479475686, 3933.5083114610675, 3943.4479172915817, 3946.8026598669953, 5561.4716601923155, 5562.02664533705, 5578.107502799573, 5578.30271216098, 5583.4974852263085, 4991.3511243538105, 5114.105031619451, 5122.769475373617, 5223.738813059332, 5267.157254839246, 6202.596831205957, 6212.223472065992, 6223.657698826562, 6228.5951413158, 6238.251409830849, 4366.716163449366, 4369.038811461473, 4369.191699535596, 4370.803313850853, 4373.497047839475, 6338.873222535523, 6440.581362211441, 6508.381703738138, 6513.93486065138, 6516.218053833571, 4421.0, 4427.955720442755, 4429.335599660077, 4430.091831174602, 4440.134173836071, 4482.7534485602955, 4487.192305384997, 4487.416635837386, 4488.304312831517, 4493.730376177375, 5192.091384007859, 5194.740262986836, 5201.947980520222, 5205.765740541685, 5209.817656382009, 6126.326104128542, 6203.348648391944, 6242.500599951993, 6254.74981000764, 6267.811965641038, 1571.9842801572067, 1608.2039390501777, 1609.1954022988505, 1609.59760059985, 1611.7582362645696, 1037.678319720889, 1072.4048153275007, 1073.2540884085643, 1091.7826623314947, 1099.2854644480992, 5943.286805583358, 5961.0, 5961.701914904237, 5963.135345374896, 5972.074328479092, 6444.967775161094, 6453.483721302285, 6454.031895215755, 6459.354064593503, 6462.289148193695, 5928.703564821828, 5936.079907614327, 5937.673427961504, 5941.138534912414, 5941.643501389931, 3389.2035371687634, 3506.368853606324, 3511.841967111486, 3518.3666939951054, 3526.400511912981, 6725.092112564839, 6728.461723062143, 6730.394264516119, 6730.562513436611, 6730.899036514456, 6392.296847346881, 6635.6350400728425, 6650.767223147167, 6679.966600166968, 6686.53194276396, 6213.937860621426, 6626.337366263335, 6728.764493242811, 6743.494237932076, 6746.797596072126, 6513.4463570595135, 6514.315996820455, 6527.477801775942, 6528.151340325728, 6533.934660653523, 6411.903821442589, 6427.132337134614, 6428.260750013621, 6432.35676432353, 6433.388828061326, 6616.040674102324, 6682.766103186365, 6714.127163468718, 6720.630365329954, 6726.0, 4408.250597398386, 4459.152760975404, 4472.39622650938, 4473.843415480443, 4476.171908196994, 6528.445082168069, 6532.183477065367, 6539.934600654123, 6542.280349161493, 6544.4764418845425, 6200.503959683305, 6284.905726414199, 6340.809775706736, 6351.523635727432, 6357.205349331333, 6311.558190926591, 6331.556791024768, 6336.809895703136, 6343.397377249154, 6375.394337537927, 6170.043643235305, 6175.660338681416, 6178.691065446799, 6187.752489900354, 6190.535709821691, 6222.657753823402, 6314.179156709598, 6337.493000559852, 6358.0780786784735, 6396.360363963567, 6199.5660303780105, 6214.782482613087, 6215.0, 6215.81352559424, 6245.0], "unit": "score", "name": "prototype.html", "value": 4727.090780276683}, {"lowerIsBetter": false, "replicates": [747.1855677311729, 773.6363908962787, 831.6008316008317, 859.4456575508797, 890.9910900890993, 12793.360331983398, 12831.101822872402, 12849.614511564669, 12931.676708082303, 12942.805857912139, 12278.754424911496, 12312.445939932702, 12314.81527777084, 12326.0, 12329.321887296195, 654.4731491149622, 662.9436497897684, 666.8099591616391, 781.8670825959572, 805.6898094233703, 797.2266901105918, 800.7237503061434, 804.1877703519458, 804.7143264141233, 806.3911746631285, 833.3416600885294, 833.4457585705499, 835.6824406725436, 840.1430540848331, 841.6086519768306, 683.3644710419308, 691.8650863081701, 828.4201059258543, 830.2610676497922, 837.459838404232, 615.3477314047125, 615.8244900203465, 615.9322474527798, 617.5707883021302, 619.9256089269317, 12966.546170883974, 12975.416106275241, 13029.218246905217, 13032.087753857139, 13067.673308167372, 12441.0, 12787.808182877265, 12871.42078606465, 13129.737405251937, 13148.0, 9544.95227523865, 9610.135087842127, 9652.131308182226, 9690.515474226331, 9844.310898237127, 3524.788512689221, 3574.0, 3639.8908032758795, 3692.612275711065, 3718.3864662330684, 43090.78454607707, 43105.784471077444, 43565.34651980191, 43576.12847743028, 43681.0, 9039.276857851357, 9991.200703943667, 10245.231607629457, 10332.793344133226, 10470.947645261725, 16735.330586776392, 16753.664926701396, 16875.831241687672, 16919.661606767797, 16927.830721692626, 7209.747658831916, 7357.889631655529, 7382.22486638906, 7587.279208475186, 7745.806354841061, 4171.690258944434, 4198.874033778991, 4271.124419493996, 4300.935485967713, 4341.110072435144, 2894.956575651367, 2923.8099523530905, 2925.3417980954114, 2930.6519001259658, 2934.1637633274413, 532.2681313194357, 533.7251315572483, 561.8061768689795, 569.487461284847, 588.5262363797099, 506.5213373362211, 522.2688236468974, 591.600669548062, 627.4259052966576, 639.9872002559923, 7841.764747057598, 7877.527348359117, 8042.162989161155, 8113.5131892086665, 8250.669973201006, 523.5079025715814, 576.8413686236319, 620.4097891303788, 665.9600423974578, 669.9598024118471, 3556.5732112146193, 3687.502187204747, 3716.18243986328, 4059.411385349108, 4133.132042271157, 53786.462135378926, 53827.0, 53868.730656346466, 53943.0, 54480.727596361765, 46642.0, 47989.76005120022, 48386.032279354215, 48397.75801120972, 48661.75669121702, 40601.1879762409, 41762.1647567053, 42575.99999999938, 43573.564264357585, 43896.78051609721, 8183.304419124441, 8368.874466883124, 8403.369747268856, 8429.0, 8678.262347700516, 30566.541501877044, 30579.01567335583, 30882.227944301572, 31272.21819454532, 31411.84294078515, 37703.0, 37833.432498513095, 37927.62072379241, 41636.0, 41976.37035444532, 10237.48812559384, 10707.946460267649, 10743.946280268548, 11028.117750580095, 11085.889141108486, 11516.366599837089, 11547.0, 11568.421578920852, 11617.6514704559, 11808.878156575112, 10675.252732308663, 10921.235513514295, 11208.607698730506, 11290.661280161608, 11314.20800543987, 10699.518521666389, 10798.838017429587, 11022.0, 11144.2199046066, 11499.827502587636, 8829.337799664921, 9610.646129904399, 9962.501874906371, 9983.950080249553, 10747.731306717395, 8732.432391894507, 9140.0, 9208.217301529445, 9651.469169195481, 9779.119879210904, 9295.349325547148, 9335.533223338942, 9421.85867212006, 9434.716958491255, 9579.377340472847], "unit": "score", "name": "yui.html", "value": 6007.603913885401}], "name": "dromaeo_css", "value": 6672.962844638292}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 104.0, 109.0, 110.0, 111.0, 100.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [153.0, 125.0, 153.0, 172.0, 125.0, 150.0, 153.0, 127.0, 174.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 160.0, 160.0, 165.0, 162.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 81.0, 97.0, 70.0, 71.0, 74.0, 103.0, 87.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 143.0, 96.0, 97.0, 96.0, 143.0, 96.0, 94.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 61.0, 56.0, 55.0, 56.0, 55.0, 64.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 87.0, 83.0, 87.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [116.0, 114.0, 116.0, 117.0, 113.0, 122.0, 118.0, 129.0, 115.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.2}, {"lowerIsBetter": true, "replicates": [161.0, 138.0, 149.0, 149.0, 149.0, 147.0, 148.0, 148.0, 147.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 68.0, 66.0, 66.0, 65.0, 66.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1496.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.72165648336727], "unit": "score", "name": "Richards", "value": 207.99938400000008}, {"lowerIsBetter": false, "replicates": [197.39439399921042], "unit": "score", "name": "DeltaBlue", "value": 334.953788}, {"lowerIsBetter": false, "replicates": [283.7684449489217], "unit": "score", "name": "Encrypt", "value": 938.0218440000002}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1106.1946902654868], "unit": "score", "name": "RayTrace", "value": 668.9500559999998}, {"lowerIsBetter": false, "replicates": [794.912559618442], "unit": "score", "name": "Earley", "value": 838.4104539999996}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [43083.333333333336], "unit": "score", "name": "RegExp", "value": 21.144719535783352}, {"lowerIsBetter": false, "replicates": [591.9574216439977], "unit": "score", "name": "Splay", "value": 137.66361738261742}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19837.312231892683}]} 02:09:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19837.31"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1496.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6672.96"}}} 02:09:39 INFO - Return code: 0 02:09:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:09:39 INFO - # TBPL SUCCESS # 02:09:39 INFO - Running post-action listener: _resource_record_post_action 02:09:39 INFO - Running post-run listener: _resource_record_post_run 02:09:40 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 482504704; Read time: 0; Write time: 305836 02:09:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 171065344; Read time: 0; Write time: 114652 02:09:40 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 311439360; Read time: 0; Write time: 191184 02:09:40 INFO - Running post-run listener: _upload_blobber_files 02:09:40 INFO - Blob upload gear active. 02:09:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:09:40 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:09:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 02:09:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 02:09:41 INFO - (blobuploader) - INFO - Open directory for files ... 02:09:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:09:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:09:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:09:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:09:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:09:42 INFO - (blobuploader) - INFO - Done attempting. 02:09:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:09:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:09:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:09:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:09:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:09:43 INFO - (blobuploader) - INFO - Done attempting. 02:09:43 INFO - (blobuploader) - INFO - Iteration through files over. 02:09:43 INFO - Return code: 0 02:09:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:09:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:09:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d88c6274ba783724b1c8bc47f1499a84b25e4b3b3f9d0c994c89f8733c4f260f989c4679fe10bf2421b31feaa0f35ed7e4bc472e6d02e33f28be3c3a160951ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ae5207f0884ed7072776ea4b50a38f3640ec2204ec2360fb8cfafb34e0d4d6a53607687f2611c1f1f1b5efe57328225f95d5143071ffbcd00672c5091f2a4f48"} 02:09:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:09:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:09:43 INFO - Contents: 02:09:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d88c6274ba783724b1c8bc47f1499a84b25e4b3b3f9d0c994c89f8733c4f260f989c4679fe10bf2421b31feaa0f35ed7e4bc472e6d02e33f28be3c3a160951ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ae5207f0884ed7072776ea4b50a38f3640ec2204ec2360fb8cfafb34e0d4d6a53607687f2611c1f1f1b5efe57328225f95d5143071ffbcd00672c5091f2a4f48"} 02:09:43 INFO - Copying logs to upload dir... 02:09:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.947985 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-08 02:09:42.932004) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 02:09:42.935413) ========= 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=82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431 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/d88c6274ba783724b1c8bc47f1499a84b25e4b3b3f9d0c994c89f8733c4f260f989c4679fe10bf2421b31feaa0f35ed7e4bc472e6d02e33f28be3c3a160951ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ae5207f0884ed7072776ea4b50a38f3640ec2204ec2360fb8cfafb34e0d4d6a53607687f2611c1f1f1b5efe57328225f95d5143071ffbcd00672c5091f2a4f48"} build_url:https://queue.taskcluster.net/v1/task/acZ-NGj9StCr79Lo8CF2Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011396 build_url: 'https://queue.taskcluster.net/v1/task/acZ-NGj9StCr79Lo8CF2Xw/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/d88c6274ba783724b1c8bc47f1499a84b25e4b3b3f9d0c994c89f8733c4f260f989c4679fe10bf2421b31feaa0f35ed7e4bc472e6d02e33f28be3c3a160951ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ae5207f0884ed7072776ea4b50a38f3640ec2204ec2360fb8cfafb34e0d4d6a53607687f2611c1f1f1b5efe57328225f95d5143071ffbcd00672c5091f2a4f48"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 02:09:42.959737) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 02:09:42.960068) ========= 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=82e07478c745e68b1fe4678a000001bc-1452245156.213970-871512431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 02:09:43.044760) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 02:09:43.045083) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 02:09:43.045359) ========= ========= Total master_lag: 0.23 =========