builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1452657752.0 results: success (0) buildid: 20160112173002 builduid: ea30df7d1997477f84cd633c460c62a6 revision: c60cb3b3bf83ea6fc8faccddf56965b1e279422d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:31.997896) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.002614) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.003205) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006329 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.029839) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.030252) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.049352) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.049658) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.098281) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.098647) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.099087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.099448) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 20:02:32-- 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% 224M=0s 2016-01-12 20:02:32 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102620 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.217323) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.217708) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022321 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.267930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.268294) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c60cb3b3bf83ea6fc8faccddf56965b1e279422d --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/fx-team --rev c60cb3b3bf83ea6fc8faccddf56965b1e279422d --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=934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 20:02:32,803 truncating revision to first 12 chars 2016-01-12 20:02:32,803 Setting DEBUG logging. 2016-01-12 20:02:32,803 attempt 1/10 2016-01-12 20:02:32,803 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c60cb3b3bf83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 20:02:33,069 unpacking tar archive at: fx-team-c60cb3b3bf83/testing/mozharness/ program finished with exit code 0 elapsedTime=0.596992 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.879294) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.879686) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.889359) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.889689) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.890148) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-12 20:02:32.890469) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:02:33 INFO - MultiFileLogger online at 20160112 20:02:33 in /builds/slave/test-pgo 20:02:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:02:33 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:02:33 INFO - {'append_to_log': False, 20:02:33 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:02:33 INFO - 'blob_upload_branch': 'Fx-Team', 20:02:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:02:33 INFO - 'branch': 'Fx-Team', 20:02:33 INFO - 'buildbot_json_path': 'buildprops.json', 20:02:33 INFO - 'config_files': ('talos/linux_config.py',), 20:02:33 INFO - 'default_actions': ('clobber', 20:02:33 INFO - 'read-buildbot-config', 20:02:33 INFO - 'download-and-extract', 20:02:33 INFO - 'populate-webroot', 20:02:33 INFO - 'create-virtualenv', 20:02:33 INFO - 'install', 20:02:33 INFO - 'run-tests'), 20:02:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:02:33 INFO - 'download_minidump_stackwalk': True, 20:02:33 INFO - 'download_symbols': 'ondemand', 20:02:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:02:33 INFO - 'tooltool.py': '/tools/tooltool.py', 20:02:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:02:33 INFO - '/tools/misc-python/virtualenv.py')}, 20:02:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:02:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:02:33 INFO - 'installer_path': 'installer.exe', 20:02:33 INFO - 'log_level': 'info', 20:02:33 INFO - 'log_name': 'talos', 20:02:33 INFO - 'log_to_console': True, 20:02:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:02:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:02:33 INFO - 'opt_config_files': (), 20:02:33 INFO - 'pip_index': False, 20:02:33 INFO - 'sps_profile': False, 20:02:33 INFO - 'sps_profile_interval': 0, 20:02:33 INFO - 'suite': 'dromaeojs', 20:02:33 INFO - 'system_bits': '32', 20:02:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:02:33 INFO - 'title': 'talos-linux64-ix-057', 20:02:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:02:33 INFO - 'use_talos_json': True, 20:02:33 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:02:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:02:33 INFO - 'work_dir': 'build'} 20:02:33 INFO - ##### 20:02:33 INFO - ##### Running clobber step. 20:02:33 INFO - ##### 20:02:33 INFO - Running pre-action listener: _resource_record_pre_action 20:02:33 INFO - Running main action method: clobber 20:02:33 INFO - rmtree: /builds/slave/test-pgo/build 20:02:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:02:34 INFO - Running post-action listener: _resource_record_post_action 20:02:34 INFO - ##### 20:02:34 INFO - ##### Running read-buildbot-config step. 20:02:34 INFO - ##### 20:02:34 INFO - Running pre-action listener: _resource_record_pre_action 20:02:34 INFO - Running main action method: read_buildbot_config 20:02:34 INFO - Using buildbot properties: 20:02:34 INFO - { 20:02:34 INFO - "project": "", 20:02:34 INFO - "product": "firefox", 20:02:34 INFO - "script_repo_revision": "production", 20:02:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:02:34 INFO - "repository": "", 20:02:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:02:34 INFO - "buildid": "20160112173002", 20:02:34 INFO - "pgo_build": "True", 20:02:34 INFO - "basedir": "/builds/slave/test-pgo", 20:02:34 INFO - "buildnumber": 414, 20:02:34 INFO - "slavename": "talos-linux64-ix-057", 20:02:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:02:34 INFO - "platform": "ubuntu64_hw", 20:02:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:02:34 INFO - "branch": "fx-team", 20:02:34 INFO - "repo_path": "integration/fx-team", 20:02:34 INFO - "revision": "c60cb3b3bf83ea6fc8faccddf56965b1e279422d", 20:02:34 INFO - "stage_platform": "linux64-pgo", 20:02:34 INFO - "builduid": "ea30df7d1997477f84cd633c460c62a6", 20:02:34 INFO - "slavebuilddir": "test" 20:02:34 INFO - } 20:02:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 20:02:34 INFO - Running post-action listener: _resource_record_post_action 20:02:34 INFO - ##### 20:02:34 INFO - ##### Running download-and-extract step. 20:02:34 INFO - ##### 20:02:34 INFO - Running pre-action listener: _resource_record_pre_action 20:02:34 INFO - Running main action method: download_and_extract 20:02:34 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:34 INFO - https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:02:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/test_packages.json 20:02:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/test_packages.json 20:02:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:02:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:02:36 INFO - Downloaded 1302 bytes. 20:02:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:02:36 INFO - Using the following test package requirements: 20:02:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:02:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:02:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:36 INFO - u'jsshell-linux-x86_64.zip'], 20:02:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:02:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:02:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:02:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:02:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:02:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:02:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:02:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:36 INFO - https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:02:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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 20:02:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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 20:02:39 INFO - Downloaded 24027162 bytes. 20:02:39 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 20:02:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:39 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 20:02:40 INFO - Return code: 0 20:02:40 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 20:02: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')]} 20:02:40 INFO - https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:02:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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 20:02:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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 20:02:42 INFO - Downloaded 24027162 bytes. 20:02:42 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 20:02:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:42 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 20:02:43 INFO - Return code: 0 20:02:43 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')]} 20:02:43 INFO - https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:02:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:02:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:02:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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 20:02:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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 20:02:46 INFO - Downloaded 11132285 bytes. 20:02:46 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 20:02:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:02:46 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 20:02:46 INFO - Return code: 0 20:02:46 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')]} 20:02:46 INFO - https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:02:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:02:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:02:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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 20:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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 20:03:04 INFO - Downloaded 55746442 bytes. 20:03:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:03:04 INFO - mkdir: /builds/slave/test-pgo/properties 20:03:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:03:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:03:04 INFO - Contents: 20:03:04 INFO - build_url:https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:03:04 INFO - Running post-action listener: _resource_record_post_action 20:03:04 INFO - Running post-action listener: set_extra_try_arguments 20:03:04 INFO - ##### 20:03:04 INFO - ##### Running populate-webroot step. 20:03:04 INFO - ##### 20:03:04 INFO - Running pre-action listener: _resource_record_pre_action 20:03:04 INFO - Running main action method: populate_webroot 20:03:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:03:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:03:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:03:04 INFO - '--tppagecycles', 20:03:04 INFO - '7'], 20:03:04 INFO - 'tests': ['tsvgm']}}, 20:03:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:03:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:03:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:03:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:03:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:03:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:03:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:04 INFO - 'talos_options': ['--e10s'], 20:03:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:04 INFO - 'tests': ['damp', 'tps']}, 20:03:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:04 INFO - 'talos_options': ['--e10s'], 20:03:04 INFO - 'tests': ['damp', 'tps']}, 20:03:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:03:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:03:04 INFO - 'other': {'tests': ['a11yr', 20:03:04 INFO - 'ts_paint', 20:03:04 INFO - 'tpaint', 20:03:04 INFO - 'sessionrestore', 20:03:04 INFO - 'sessionrestore_no_auto_restore']}, 20:03:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:03:04 INFO - 'tests': ['a11yr', 20:03:04 INFO - 'ts_paint', 20:03:04 INFO - 'tpaint', 20:03:04 INFO - 'sessionrestore', 20:03:04 INFO - 'sessionrestore_no_auto_restore']}, 20:03:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:03:04 INFO - 'tests': ['a11yr', 20:03:04 INFO - 'ts_paint', 20:03:04 INFO - 'tpaint', 20:03:04 INFO - 'sessionrestore', 20:03:04 INFO - 'sessionrestore_no_auto_restore']}, 20:03:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:03:04 INFO - 'tests': ['a11yr', 20:03:04 INFO - 'ts_paint', 20:03:04 INFO - 'tpaint', 20:03:04 INFO - 'sessionrestore', 20:03:04 INFO - 'sessionrestore_no_auto_restore']}, 20:03:04 INFO - 'other_l64': {'tests': ['a11yr', 20:03:04 INFO - 'ts_paint', 20:03:04 INFO - 'tpaint', 20:03:04 INFO - 'sessionrestore', 20:03:04 INFO - 'sessionrestore_no_auto_restore']}, 20:03:04 INFO - 'other_nol64': {'tests': ['a11yr', 20:03:04 INFO - 'ts_paint', 20:03:04 INFO - 'tpaint', 20:03:04 INFO - 'sessionrestore', 20:03:04 INFO - 'sessionrestore_no_auto_restore']}, 20:03:04 INFO - 'svgr': {'tests': ['tsvgx', 20:03:04 INFO - 'tsvgr_opacity', 20:03:04 INFO - 'tart', 20:03:04 INFO - 'tscrollx', 20:03:04 INFO - 'cart']}, 20:03:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:03:04 INFO - 'tests': ['tsvgx', 20:03:04 INFO - 'tsvgr_opacity', 20:03:04 INFO - 'tart', 20:03:04 INFO - 'tscrollx', 20:03:04 INFO - 'cart']}, 20:03:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:04 INFO - 'tests': ['tp5o']}, 20:03:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:04 INFO - 'talos_options': ['--e10s'], 20:03:04 INFO - 'tests': ['tp5o']}, 20:03:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:04 INFO - 'talos_options': ['--xperf_path', 20:03:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:04 INFO - 'tests': ['tp5n']}, 20:03:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:04 INFO - 'talos_options': ['--e10s', 20:03:04 INFO - '--xperf_path', 20:03:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:04 INFO - 'tests': ['tp5n']}}, 20:03:04 INFO - 'talos.zip': {'path': '', 20:03:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:03:04 INFO - Running post-action listener: _resource_record_post_action 20:03:04 INFO - ##### 20:03:04 INFO - ##### Running create-virtualenv step. 20:03:04 INFO - ##### 20:03:04 INFO - Running pre-action listener: _resource_record_pre_action 20:03:04 INFO - Running main action method: create_virtualenv 20:03:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:03:04 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 20:03:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:03:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:03:04 INFO - Using real prefix '/usr' 20:03:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:03:04 INFO - Installing distribute.............................................................................................................................................................................................done. 20:03:06 INFO - Installing pip.................done. 20:03:06 INFO - Return code: 0 20:03:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa10ba1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afb840>, '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 0x2a686b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a68b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', '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 20:03:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 20:03:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:03:06 INFO - Using env: {'DISPLAY': ':0', 20:03:06 INFO - 'HOME': '/home/cltbld', 20:03:06 INFO - 'LANG': 'en_US.UTF-8', 20:03:06 INFO - 'LANGUAGE': 'en_US:en', 20:03:06 INFO - 'LOGNAME': 'cltbld', 20:03:06 INFO - 'MAIL': '/var/mail/cltbld', 20:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:06 INFO - 'MOZ_NO_REMOTE': '1', 20:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:06 INFO - 'NO_EM_RESTART': '1', 20:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:06 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:06 INFO - 'SHELL': '/bin/bash', 20:03:06 INFO - 'SHLVL': '1', 20:03:06 INFO - 'TERM': 'linux', 20:03:06 INFO - 'TMOUT': '86400', 20:03:06 INFO - 'USER': 'cltbld', 20:03:06 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', 20:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:06 INFO - '_': '/tools/buildbot/bin/python'} 20:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:06 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 20:03:06 INFO - Cleaning up... 20:03:06 INFO - Return code: 0 20:03:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa10ba1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afb840>, '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 0x2a686b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a68b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', '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 20:03:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 20:03:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:03:06 INFO - Using env: {'DISPLAY': ':0', 20:03:06 INFO - 'HOME': '/home/cltbld', 20:03:06 INFO - 'LANG': 'en_US.UTF-8', 20:03:06 INFO - 'LANGUAGE': 'en_US:en', 20:03:06 INFO - 'LOGNAME': 'cltbld', 20:03:06 INFO - 'MAIL': '/var/mail/cltbld', 20:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:06 INFO - 'MOZ_NO_REMOTE': '1', 20:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:06 INFO - 'NO_EM_RESTART': '1', 20:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:06 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:06 INFO - 'SHELL': '/bin/bash', 20:03:06 INFO - 'SHLVL': '1', 20:03:06 INFO - 'TERM': 'linux', 20:03:06 INFO - 'TMOUT': '86400', 20:03:06 INFO - 'USER': 'cltbld', 20:03:06 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', 20:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:06 INFO - '_': '/tools/buildbot/bin/python'} 20:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:07 INFO - Downloading/unpacking psutil>=0.7.1 20:03: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 20:03: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 20:03: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 20:03: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 20:03: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 20:03: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 20:03:08 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 20:03:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:03:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:03:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:08 INFO - Installing collected packages: psutil 20:03:08 INFO - Running setup.py install for psutil 20:03:08 INFO - building 'psutil._psutil_linux' extension 20:03:08 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 20:03:09 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 20:03:09 INFO - building 'psutil._psutil_posix' extension 20:03:09 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 20:03:09 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 20:03:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:09 INFO - Successfully installed psutil 20:03:09 INFO - Cleaning up... 20:03:09 INFO - Return code: 0 20:03:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa10ba1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afb840>, '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 0x2a686b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a68b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', '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 20:03:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 20:03:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:03:09 INFO - Using env: {'DISPLAY': ':0', 20:03:09 INFO - 'HOME': '/home/cltbld', 20:03:09 INFO - 'LANG': 'en_US.UTF-8', 20:03:09 INFO - 'LANGUAGE': 'en_US:en', 20:03:09 INFO - 'LOGNAME': 'cltbld', 20:03:09 INFO - 'MAIL': '/var/mail/cltbld', 20:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:09 INFO - 'MOZ_NO_REMOTE': '1', 20:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:09 INFO - 'NO_EM_RESTART': '1', 20:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:09 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:09 INFO - 'SHELL': '/bin/bash', 20:03:09 INFO - 'SHLVL': '1', 20:03:09 INFO - 'TERM': 'linux', 20:03:09 INFO - 'TMOUT': '86400', 20:03:09 INFO - 'USER': 'cltbld', 20:03:09 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', 20:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:09 INFO - '_': '/tools/buildbot/bin/python'} 20:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:03: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 20:03: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 20:03: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 20:03: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 20:03: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 20:03: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 20:03:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:03:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:03:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:03:11 INFO - Installing collected packages: mozsystemmonitor 20:03:11 INFO - Running setup.py install for mozsystemmonitor 20:03:11 INFO - Successfully installed mozsystemmonitor 20:03:11 INFO - Cleaning up... 20:03:11 INFO - Return code: 0 20:03:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:03:11 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')]} 20:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:11 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')]} 20:03:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:11 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 0x7fa10ba1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afb840>, '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 0x2a686b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a68b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', '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 20:03:11 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 20:03:11 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 20:03:11 INFO - Using env: {'DISPLAY': ':0', 20:03:11 INFO - 'HOME': '/home/cltbld', 20:03:11 INFO - 'LANG': 'en_US.UTF-8', 20:03:11 INFO - 'LANGUAGE': 'en_US:en', 20:03:11 INFO - 'LOGNAME': 'cltbld', 20:03:11 INFO - 'MAIL': '/var/mail/cltbld', 20:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:11 INFO - 'MOZ_NO_REMOTE': '1', 20:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:11 INFO - 'NO_EM_RESTART': '1', 20:03:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:11 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:11 INFO - 'SHELL': '/bin/bash', 20:03:11 INFO - 'SHLVL': '1', 20:03:11 INFO - 'TERM': 'linux', 20:03:11 INFO - 'TMOUT': '86400', 20:03:11 INFO - 'USER': 'cltbld', 20:03:11 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', 20:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:11 INFO - '_': '/tools/buildbot/bin/python'} 20:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:11 INFO - Downloading/unpacking blobuploader==1.2.4 20:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:13 INFO - Downloading blobuploader-1.2.4.tar.gz 20:03:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:03:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:03:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:03:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:03:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:14 INFO - Downloading docopt-0.6.1.tar.gz 20:03:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:03:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:03:14 INFO - Installing collected packages: blobuploader, requests, docopt 20:03:14 INFO - Running setup.py install for blobuploader 20:03:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:03:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:03:14 INFO - Running setup.py install for requests 20:03:14 INFO - Running setup.py install for docopt 20:03:14 INFO - Successfully installed blobuploader requests docopt 20:03:14 INFO - Cleaning up... 20:03:14 INFO - Return code: 0 20:03:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:03:14 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')]} 20:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:14 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')]} 20:03:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:14 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 0x7fa10ba1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afb840>, '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 0x2a686b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a68b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', '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 20:03:14 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 20:03:14 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 20:03:14 INFO - Using env: {'DISPLAY': ':0', 20:03:14 INFO - 'HOME': '/home/cltbld', 20:03:14 INFO - 'LANG': 'en_US.UTF-8', 20:03:14 INFO - 'LANGUAGE': 'en_US:en', 20:03:14 INFO - 'LOGNAME': 'cltbld', 20:03:14 INFO - 'MAIL': '/var/mail/cltbld', 20:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:14 INFO - 'MOZ_NO_REMOTE': '1', 20:03:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:14 INFO - 'NO_EM_RESTART': '1', 20:03:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:14 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:14 INFO - 'SHELL': '/bin/bash', 20:03:14 INFO - 'SHLVL': '1', 20:03:14 INFO - 'TERM': 'linux', 20:03:14 INFO - 'TMOUT': '86400', 20:03:14 INFO - 'USER': 'cltbld', 20:03:14 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', 20:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:14 INFO - '_': '/tools/buildbot/bin/python'} 20:03:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:03:14 INFO - Running setup.py (path:/tmp/pip-dBioVz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:03:15 INFO - Running setup.py (path:/tmp/pip-42MpI6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:03:15 INFO - Running setup.py (path:/tmp/pip-X6SDjc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:03:15 INFO - Running setup.py (path:/tmp/pip-GWsWj_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:03:15 INFO - Running setup.py (path:/tmp/pip-QHbfG9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:03:15 INFO - Running setup.py (path:/tmp/pip-5eMB7N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:03:15 INFO - Running setup.py (path:/tmp/pip-APUg_p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:03:15 INFO - Running setup.py (path:/tmp/pip-optIcI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:03:15 INFO - Running setup.py (path:/tmp/pip-oq9j85-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:03:15 INFO - Running setup.py (path:/tmp/pip-RsNARS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:03:15 INFO - Running setup.py (path:/tmp/pip-Gb7JhY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:03:15 INFO - Running setup.py (path:/tmp/pip-YtP72o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:03:15 INFO - Running setup.py (path:/tmp/pip-sbFk6D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:03:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:03:15 INFO - Running setup.py (path:/tmp/pip-rHB0hk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:03:16 INFO - Running setup.py (path:/tmp/pip-GWlznA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:03:16 INFO - Running setup.py (path:/tmp/pip-kCXurT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:03:16 INFO - Running setup.py (path:/tmp/pip-JbceaV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:03:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:03:16 INFO - Running setup.py install for manifestparser 20:03:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:03:16 INFO - Running setup.py install for mozcrash 20:03:16 INFO - Running setup.py install for mozdebug 20:03:16 INFO - Running setup.py install for mozdevice 20:03:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:03:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:03:16 INFO - Running setup.py install for mozfile 20:03:16 INFO - Running setup.py install for mozhttpd 20:03:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:03:16 INFO - Running setup.py install for mozinfo 20:03:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:03:16 INFO - Running setup.py install for mozInstall 20:03:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:03:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:03:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:03:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:03:17 INFO - Running setup.py install for mozleak 20:03:17 INFO - Running setup.py install for mozlog 20:03:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:03:17 INFO - Running setup.py install for moznetwork 20:03:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:03:17 INFO - Running setup.py install for mozprocess 20:03:17 INFO - Running setup.py install for mozprofile 20:03:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:03:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:03:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:03:17 INFO - Running setup.py install for mozrunner 20:03:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:03:17 INFO - Running setup.py install for mozscreenshot 20:03:17 INFO - Running setup.py install for moztest 20:03:17 INFO - Running setup.py install for mozversion 20:03:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:03:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:03:17 INFO - Cleaning up... 20:03:17 INFO - Return code: 0 20:03:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:03:17 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')]} 20:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:17 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')]} 20:03:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:17 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 0x7fa10ba1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afb840>, '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 0x2a686b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a68b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', '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 20:03:17 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 20:03:17 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 20:03:17 INFO - Using env: {'DISPLAY': ':0', 20:03:17 INFO - 'HOME': '/home/cltbld', 20:03:17 INFO - 'LANG': 'en_US.UTF-8', 20:03:17 INFO - 'LANGUAGE': 'en_US:en', 20:03:17 INFO - 'LOGNAME': 'cltbld', 20:03:17 INFO - 'MAIL': '/var/mail/cltbld', 20:03:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:17 INFO - 'MOZ_NO_REMOTE': '1', 20:03:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:17 INFO - 'NO_EM_RESTART': '1', 20:03:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:17 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:17 INFO - 'SHELL': '/bin/bash', 20:03:17 INFO - 'SHLVL': '1', 20:03:17 INFO - 'TERM': 'linux', 20:03:17 INFO - 'TMOUT': '86400', 20:03:17 INFO - 'USER': 'cltbld', 20:03:17 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', 20:03:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:17 INFO - '_': '/tools/buildbot/bin/python'} 20:03:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:03:18 INFO - Running setup.py (path:/tmp/pip-uy6Mt2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:03:18 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)) 20:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:03:18 INFO - Running setup.py (path:/tmp/pip-Ztxwwh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:03:18 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)) 20:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:03:18 INFO - Running setup.py (path:/tmp/pip-WbOTSI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:03:18 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)) 20:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:03:18 INFO - Running setup.py (path:/tmp/pip-vMVUKZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:03:18 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)) 20:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:03:18 INFO - Running setup.py (path:/tmp/pip-KdMC1p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:03:18 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)) 20:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:03:18 INFO - Running setup.py (path:/tmp/pip-lfRsP4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:03:18 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)) 20:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:03:18 INFO - Running setup.py (path:/tmp/pip-v7yWwi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:03:18 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)) 20:03:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:03:18 INFO - Running setup.py (path:/tmp/pip-dEX1Ux-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:03:19 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)) 20:03:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:03:19 INFO - Running setup.py (path:/tmp/pip-VyitYX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:03:19 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)) 20:03:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:03:19 INFO - Running setup.py (path:/tmp/pip-lvBLtR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:03:19 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)) 20:03:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:03:19 INFO - Running setup.py (path:/tmp/pip-sZWT3O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:03:19 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)) 20:03:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:03:19 INFO - Running setup.py (path:/tmp/pip-sdXsUu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:03:20 INFO - Running setup.py (path:/tmp/pip-5g_y6B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:03:20 INFO - Running setup.py (path:/tmp/pip-t6g2bY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:03:20 INFO - Running setup.py (path:/tmp/pip-rlPuQn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:03:20 INFO - Running setup.py (path:/tmp/pip-Pknqc7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:03:20 INFO - Running setup.py (path:/tmp/pip-bUpS78-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:03:20 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)) 20:03:20 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)) 20:03:20 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)) 20:03:20 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)) 20:03:20 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)) 20:03:20 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)) 20:03:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:22 INFO - Downloading blessings-1.5.1.tar.gz 20:03:22 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 20:03:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:03:22 INFO - Installing collected packages: blessings 20:03:22 INFO - Running setup.py install for blessings 20:03:22 INFO - Successfully installed blessings 20:03:22 INFO - Cleaning up... 20:03:22 INFO - Return code: 0 20:03:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:03:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:03:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:03:22 INFO - Reading from file tmpfile_stdout 20:03:22 INFO - Current package versions: 20:03:22 INFO - argparse == 1.2.1 20:03:22 INFO - blessings == 1.5.1 20:03:22 INFO - blobuploader == 1.2.4 20:03:22 INFO - docopt == 0.6.1 20:03:22 INFO - manifestparser == 1.1 20:03:22 INFO - mozInstall == 1.12 20:03:22 INFO - mozcrash == 0.16 20:03:22 INFO - mozdebug == 0.1 20:03:22 INFO - mozdevice == 0.47 20:03:22 INFO - mozfile == 1.2 20:03:22 INFO - mozhttpd == 0.7 20:03:22 INFO - mozinfo == 0.9 20:03:22 INFO - mozleak == 0.1 20:03:22 INFO - mozlog == 3.1 20:03:22 INFO - moznetwork == 0.27 20:03:22 INFO - mozprocess == 0.22 20:03:22 INFO - mozprofile == 0.28 20:03:22 INFO - mozrunner == 6.11 20:03:22 INFO - mozscreenshot == 0.1 20:03:22 INFO - mozsystemmonitor == 0.0 20:03:22 INFO - moztest == 0.7 20:03:22 INFO - mozversion == 1.4 20:03:22 INFO - psutil == 3.1.1 20:03:22 INFO - requests == 1.2.3 20:03:22 INFO - wsgiref == 0.1.2 20:03:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:03:22 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')]} 20:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:22 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')]} 20:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:22 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 0x7fa10ba1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afb840>, '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 0x2a686b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a68b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', '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 20:03:22 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 20:03:22 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 20:03:22 INFO - Using env: {'DISPLAY': ':0', 20:03:22 INFO - 'HOME': '/home/cltbld', 20:03:22 INFO - 'LANG': 'en_US.UTF-8', 20:03:22 INFO - 'LANGUAGE': 'en_US:en', 20:03:22 INFO - 'LOGNAME': 'cltbld', 20:03:22 INFO - 'MAIL': '/var/mail/cltbld', 20:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:22 INFO - 'MOZ_NO_REMOTE': '1', 20:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:22 INFO - 'NO_EM_RESTART': '1', 20:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:22 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:22 INFO - 'SHELL': '/bin/bash', 20:03:22 INFO - 'SHLVL': '1', 20:03:22 INFO - 'TERM': 'linux', 20:03:22 INFO - 'TMOUT': '86400', 20:03:22 INFO - 'USER': 'cltbld', 20:03:22 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', 20:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:22 INFO - '_': '/tools/buildbot/bin/python'} 20:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:22 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)) 20:03:22 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)) 20:03:22 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)) 20:03:22 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)) 20:03:22 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)) 20:03:22 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)) 20:03:22 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)) 20:03:22 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)) 20:03:22 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)) 20:03:22 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)) 20:03:22 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)) 20:03:22 INFO - Cleaning up... 20:03:22 INFO - Return code: 0 20:03:22 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:03:22 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')]} 20:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:22 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')]} 20:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:22 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 0x7fa10ba1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afb840>, '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 0x2a686b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a68b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', '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 20:03:22 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 20:03:22 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 20:03:22 INFO - Using env: {'DISPLAY': ':0', 20:03:22 INFO - 'HOME': '/home/cltbld', 20:03:22 INFO - 'LANG': 'en_US.UTF-8', 20:03:22 INFO - 'LANGUAGE': 'en_US:en', 20:03:22 INFO - 'LOGNAME': 'cltbld', 20:03:22 INFO - 'MAIL': '/var/mail/cltbld', 20:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:22 INFO - 'MOZ_NO_REMOTE': '1', 20:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:22 INFO - 'NO_EM_RESTART': '1', 20:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:22 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:22 INFO - 'SHELL': '/bin/bash', 20:03:22 INFO - 'SHLVL': '1', 20:03:22 INFO - 'TERM': 'linux', 20:03:22 INFO - 'TMOUT': '86400', 20:03:22 INFO - 'USER': 'cltbld', 20:03:22 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', 20:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:22 INFO - '_': '/tools/buildbot/bin/python'} 20:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:23 INFO - Downloading/unpacking jsonschema 20:03:23 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 20:03:23 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 20:03:23 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 20:03:23 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 20:03:23 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 20:03:23 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 20:03:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:03:24 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 20:03:24 INFO - Downloading/unpacking functools32 (from jsonschema) 20:03:24 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 20:03:24 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 20:03:24 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 20:03:24 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 20:03:24 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 20:03:24 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 20:03:24 INFO - Downloading functools32-3.2.3-2.tar.gz 20:03:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:03:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:03:24 INFO - warning: no files found matching '*.txt' 20:03:24 INFO - no previously-included directories found matching 'build' 20:03:24 INFO - no previously-included directories found matching 'dist' 20:03:24 INFO - no previously-included directories found matching '.git*' 20:03:25 INFO - Installing collected packages: jsonschema, functools32 20:03:25 INFO - Running setup.py install for functools32 20:03:25 INFO - warning: no files found matching '*.txt' 20:03:25 INFO - no previously-included directories found matching 'build' 20:03:25 INFO - no previously-included directories found matching 'dist' 20:03:25 INFO - no previously-included directories found matching '.git*' 20:03:25 INFO - Successfully installed jsonschema functools32 20:03:25 INFO - Cleaning up... 20:03:25 INFO - Return code: 0 20:03:25 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:03:25 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')]} 20:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:25 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')]} 20:03:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:25 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 0x7fa10ba1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afb840>, '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 0x2a686b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a68b60>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', '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 20:03:25 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 20:03:25 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 20:03:25 INFO - Using env: {'DISPLAY': ':0', 20:03:25 INFO - 'HOME': '/home/cltbld', 20:03:25 INFO - 'LANG': 'en_US.UTF-8', 20:03:25 INFO - 'LANGUAGE': 'en_US:en', 20:03:25 INFO - 'LOGNAME': 'cltbld', 20:03:25 INFO - 'MAIL': '/var/mail/cltbld', 20:03:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:25 INFO - 'MOZ_NO_REMOTE': '1', 20:03:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:25 INFO - 'NO_EM_RESTART': '1', 20:03:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:25 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:25 INFO - 'SHELL': '/bin/bash', 20:03:25 INFO - 'SHLVL': '1', 20:03:25 INFO - 'TERM': 'linux', 20:03:25 INFO - 'TMOUT': '86400', 20:03:25 INFO - 'USER': 'cltbld', 20:03:25 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', 20:03:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:25 INFO - '_': '/tools/buildbot/bin/python'} 20:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:25 INFO - Downloading/unpacking flake8 20:03:25 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 20:03:25 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 20:03:25 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 20:03:25 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 20:03:25 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 20:03:25 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 20:03:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:03:27 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 20:03:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:03:27 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 20:03:27 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 20:03:27 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 20:03:27 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 20:03:27 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 20:03:27 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 20:03:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:03:27 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 20:03:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:03:27 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 20:03:27 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 20:03:27 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 20:03:27 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 20:03:27 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 20:03:27 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 20:03:27 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 20:03:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:03:27 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 20:03:27 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 20:03:27 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 20:03:27 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 20:03:27 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 20:03:27 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 20:03:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:03:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:03:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:03:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:03:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:03:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:03:27 INFO - no previously-included directories found matching 'docs/_build' 20:03:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:03:27 INFO - Running setup.py install for pep8 20:03:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:03:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:03:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:03:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:03:27 INFO - no previously-included directories found matching 'docs/_build' 20:03:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:03:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:03:27 INFO - Cleaning up... 20:03:28 INFO - Return code: 0 20:03:28 INFO - Running post-action listener: _resource_record_post_action 20:03:28 INFO - Running post-action listener: _start_resource_monitoring 20:03:28 INFO - Starting resource monitoring. 20:03:28 INFO - ##### 20:03:28 INFO - ##### Running install step. 20:03:28 INFO - ##### 20:03:28 INFO - Running pre-action listener: _resource_record_pre_action 20:03:28 INFO - Running main action method: install 20:03:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:03:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:03:28 INFO - Reading from file tmpfile_stdout 20:03:28 INFO - Detecting whether we're running mozinstall >=1.0... 20:03:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:03:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:03:28 INFO - Reading from file tmpfile_stdout 20:03:28 INFO - Output received: 20:03:28 INFO - Usage: mozinstall [options] installer 20:03:28 INFO - Options: 20:03:28 INFO - -h, --help show this help message and exit 20:03:28 INFO - -d DEST, --destination=DEST 20:03:28 INFO - Directory to install application into. [default: 20:03:28 INFO - "/builds/slave/test-pgo"] 20:03:28 INFO - --app=APP Application being installed. [default: firefox] 20:03:28 INFO - mkdir: /builds/slave/test-pgo/build/application 20:03:28 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'] 20:03:28 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 20:03:44 INFO - Reading from file tmpfile_stdout 20:03:44 INFO - Output received: 20:03:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:03:44 INFO - Running post-action listener: _resource_record_post_action 20:03:44 INFO - ##### 20:03:44 INFO - ##### Running run-tests step. 20:03:44 INFO - ##### 20:03:44 INFO - Running pre-action listener: _resource_record_pre_action 20:03:44 INFO - Running main action method: run_tests 20:03:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:03:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:03:44 INFO - Python 2.7.3 20:03:44 INFO - Return code: 0 20:03:44 INFO - grabbing minidump binary from tooltool 20:03: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')]} 20:03:44 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 0x2afb840>, '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 0x2a686b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a68b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:03:44 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 20:03:44 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 20:03:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:03:44 INFO - Return code: 0 20:03:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:03:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:03:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:03:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:03:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:03:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:03:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:03:45 INFO - Return code: 0 20:03:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 20:03:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 20:03:45 INFO - Using env: {'DISPLAY': ':0', 20:03:45 INFO - 'HOME': '/home/cltbld', 20:03:45 INFO - 'LANG': 'en_US.UTF-8', 20:03:45 INFO - 'LANGUAGE': 'en_US:en', 20:03:45 INFO - 'LOGNAME': 'cltbld', 20:03:45 INFO - 'MAIL': '/var/mail/cltbld', 20:03:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:03:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:45 INFO - 'MOZ_NO_REMOTE': '1', 20:03:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:45 INFO - 'NO_EM_RESTART': '1', 20:03:45 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:45 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:45 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:03:45 INFO - 'SHELL': '/bin/bash', 20:03:45 INFO - 'SHLVL': '1', 20:03:45 INFO - 'TERM': 'linux', 20:03:45 INFO - 'TMOUT': '86400', 20:03:45 INFO - 'USER': 'cltbld', 20:03:45 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032', 20:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:45 INFO - '_': '/tools/buildbot/bin/python'} 20:03:45 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 20:03:45 INFO - mozversion application_buildid: 20160112173002 20:03:45 INFO - mozversion application_changeset: c60cb3b3bf83ea6fc8faccddf56965b1e279422d 20:03:45 INFO - mozversion application_display_name: Nightly 20:03:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:03:45 INFO - mozversion application_name: Firefox 20:03:45 INFO - mozversion application_remotingname: firefox 20:03:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:03:45 INFO - mozversion application_vendor: Mozilla 20:03:45 INFO - mozversion application_version: 46.0a1 20:03:45 INFO - mozversion platform_buildid: 20160112173002 20:03:45 INFO - mozversion platform_changeset: c60cb3b3bf83ea6fc8faccddf56965b1e279422d 20:03:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:03:45 INFO - mozversion platform_version: 46.0a1 20:03:45 INFO - using testdate: 1452657825 20:03:45 INFO - actual date: 1452657825 20:03:45 INFO - starting webserver on 'localhost:51740' 20:03:45 INFO - SUITE-START | Running 3 tests 20:03:45 INFO - TEST-START | dromaeo_css 20:03:45 INFO - operating with platform_type : linux_ 20:03:45 INFO - Initialising browser for dromaeo_css test... 20:03:45 INFO - TEST-INFO | started process 15495 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIwlAH4/profile http://localhost:51740/getInfo.html) 20:03:49 INFO - PROCESS | 15495 | __metrics Screen width/height:1600/1200 20:03:49 INFO - PROCESS | 15495 | colorDepth:24 20:03:49 INFO - PROCESS | 15495 | Browser inner width/height: 1024/697 20:03:49 INFO - PROCESS | 15495 | __metrics 20:03:49 INFO - PROCESS | 15495 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:03:49 INFO - PROCESS | 15495 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:03:51 INFO - TEST-INFO | 15495: exit 0 20:03:51 INFO - Browser initialized. 20:03:51 INFO - Running cycle 1/1 for dromaeo_css test... 20:03:51 INFO - TEST-INFO | started process 15594 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIwlAH4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:04:02 INFO - PROCESS | 15594 | RSS: Main: 148344832 20:04:02 INFO - PROCESS | 15594 | 20:04:54 INFO - PROCESS | 15594 | 1452657894416 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] 20:07:02 INFO - PROCESS | 15594 | Cycle 1(1): loaded http://localhost:51740/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51740/tests/dromaeo/cssquery-ext.html) 20:07:03 INFO - PROCESS | 15594 | RSS: Main: 228184064 20:07:03 INFO - PROCESS | 15594 | 20:10:05 INFO - PROCESS | 15594 | Cycle 1(1): loaded http://localhost:51740/tests/dromaeo/cssquery-ext.html (next: http://localhost:51740/tests/dromaeo/cssquery-jquery.html) 20:10:06 INFO - PROCESS | 15594 | RSS: Main: 228286464 20:10:06 INFO - PROCESS | 15594 | 20:13:08 INFO - PROCESS | 15594 | Cycle 1(1): loaded http://localhost:51740/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51740/tests/dromaeo/cssquery-mootools.html) 20:13:08 INFO - PROCESS | 15594 | RSS: Main: 224055296 20:13:08 INFO - PROCESS | 15594 | 20:16:10 INFO - PROCESS | 15594 | Cycle 1(1): loaded http://localhost:51740/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51740/tests/dromaeo/cssquery-prototype.html) 20:16:11 INFO - PROCESS | 15594 | RSS: Main: 207257600 20:16:11 INFO - PROCESS | 15594 | 20:19:13 INFO - PROCESS | 15594 | Cycle 1(1): loaded http://localhost:51740/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51740/tests/dromaeo/cssquery-yui.html) 20:19:14 INFO - PROCESS | 15594 | RSS: Main: 212070400 20:19:14 INFO - PROCESS | 15594 | 20:22:16 INFO - PROCESS | 15594 | Cycle 1(1): loaded http://localhost:51740/tests/dromaeo/cssquery-yui.html (next: http://localhost:51740/tests/dromaeo/cssquery-dojo.html) 20:22:17 INFO - PROCESS | 15594 | RSS: Main: 259428352 20:22:17 INFO - PROCESS | 15594 | 20:22:17 INFO - PROCESS | 15594 | __start_tp_report 20:22:17 INFO - PROCESS | 15594 | _x_x_mozilla_page_load 20:22:17 INFO - PROCESS | 15594 | _x_x_mozilla_page_load_details 20:22:17 INFO - PROCESS | 15594 | |i|pagename|runs| 20:22:17 INFO - PROCESS | 15594 | |0;dojo.html;3078.4766589679753;3112.424201522717;3149.7007784260486;3154.2429816843965;3171.4925611902086;4896.951030489694;4952.851414457563;4968.751562421878;4987.850364489067;5057.595392368611;4948.208286674133;4998.10034193845;5004.7747851346685;5082.949170508294;5091.79632814687;4574.153781550423;4575.839845605413;4597.586217240448;4606.0327331260305;4678.695884767496;4650.395448591678;4681.414823147106;4694.248920172773;4706.176419126657;4708.4820669726305;4468.75421851798;4540.500544940054;4560.9771951140365;4621.514740952202;4670.439547254317;4560.703554268962;4562.817487300537;4563.589276965089;4596.172688915994;4609.976950115228;4529.932051019237;4539.251023581105;4555.316702494652;4560.065186636732;4569.1547063793305;4744.5967092797155;4824.734639594821;4867.318575399447;4873.951260487421;4891.192953162724;5439.238506609078;5442.265294185274;5449.291592093042;5449.83650490482;5453.481919217668;5438.7280635968045;5469.425710300441;5474.945250547523;5489.862753431156;5500.80747173847;4929.162042452792;5006.349174607278;5034.16936205522;5104.821331253463;5109.339873288359;5503.669779813224;5504.752286147133;5505.091659876156;5505.504504594605;5506.03644362235;5271.130263506555;5293.417724050351;5294.814681486129;5305.124654432053;5356.517913387814;5350.357957045102;5373.2208829719475;5387.676739395649;5436.864078397993;5462.453754624506;5354.384245811703;5366.865828354323;5369.5972802040005;5376.650517716336;5377.435369286247;5259.132243179909;5375.865603359947;5386.299781028441;5393.43368946255;5435.619506634498;4144.647704945053;4159.417681524589;4168.083021735213;4191.874243772691;4196.51740049892;3792.146766977408;3801.258754542838;3809.29528037314;3818.9236215276096;3829.291581057513;4959.355283813081;4994.675346102492;5046.7476626168545;5052.418971818288;5096.05722941257;5438.564914806806;5445.428230035868;5459.372172200247;5460.836174914759;5518.33779946409;4995.275685025651;5026.798928042837;5027.522385373383;5039.3952725672425;5075.847724568269;4484.282514797616;4532.637389008872;4559.977200113978;4565.292379681155;4575.611073058827;5649.4633009864;5660;5665.688387138664;5666.291713535808;5667.716614169275;5395.838124856261;5411.756470958895;5438.537724293321;5441.646292990943;5454.4545545445135;5472;5513.972430137824;5526.640768350045;5630.690312032878;5681.9431805681415;5227.137522308776;5230.686158830483;5231.712255825966;5232.110541207928;5236.188390799432;5292.338457692788;5292.655977361459;5295.338082739658;5317.096093664164;5335.09303418412;5181.430042695225;5250.842474725764;5256.316678831728;5256.395514515727;5306.416294207711;5268.2624432578705;5284.524392804666;5288.127458969381;5290.523852853262;5290.841274761763;5121.513456221653;5218.634695571273;5220.634555581073;5225.6603320784025;5262.710550919736;5183.481651834786;5228.790848366023;5256.9211461827335;5322.281491998686;5330.493603107699;5168.612354073384;5169.043726910533;5184.818531351385;5188.169892817131;5193.272941788228 20:22:17 INFO - PROCESS | 15594 | |1;ext.html;498.9501049895011;524.77696978784;529.69542513055;532.7629205003773;544.5099410530521;27687.584686229722;28302.433951320985;35031.2993740125;35378.11554711127;35427.64572354276;37942.482300708005;38361.42457863134;38443.80778096113;38597.61402385975;38663.42004869929;8281.544515051684;8565.828683426327;8566.443181193203;8576.313894888393;8581.613827377752;8061.435699501038;8139.430239883211;8198.42611017229;8199.549024803633;8204.343652507814;8218.63016164271;8278.089410164877;8463.06906240313;8471.237588617023;8479.788005299886;8316.83366332676;8344.332453403713;8364.916350836475;8375.748727538183;8396.286315663176;8409.159084091603;8557.10150434208;8561.22948934599;8568.271696905771;8570;38051.61948380536;38495.61504384948;38513.61486385128;38538.80730596357;38539.807300963315;3237.4172648923186;3271.313024264907;3383.813890236036;3385.96614033859;3555.964440355589;27764.30589235285;27852.442951141067;28019.159425217276;28372.574411383845;29336.119916402542;3499.7025252853537;3500.789952602852;3503.3518799022263;3580.3197392495345;3643.4352675335367;198369;198846;199883;200070;200109;48418.5158148421;50870.74564627227;55191;57734;57804.421955780745;52754.472455275725;53074.469255307726;53139.734301329016;53295;53377.46622533725;14271.286435678174;14398.704116629553;14418.495352662607;14569;14575;11017.338959662446;11066.502007409686;11067.778644427066;11160.883911608775;11173.888261117447;18375.356862509747;18386.908065459585;18390;18490.44528664142;18529;7023.68393422287;7303;7331.450141239428;7344.779656610311;7426.368758655467;905.3210092430677;1014.4623349624711;1070.5129166229347;1072.6674730833467;1121.5681962444355;23097.88451057734;23353.299401017997;23818.92814823337;24014;24114.87942560276;1010.1514727628827;1034.3070143004206;1044.5821671331375;1054.2725519391595;1133.9319640821577;12557.56048538315;12578.245305281529;12660.683482912817;12685.873141268654;14890.627734306512;249797;250732;250777.47667570002;252346;252644;46761.29858052132;47008;47109.5289047112;47120;47187.29219061717;1158.4902642837126;1232.063631639942;1283.736833949038;1301.7006088599676;1312.9146605470614;26823.731762682903;28016.29959251035;28424.289392765346;28522;28543.14370568886;41951.53169639048;42231.577684222764;42235.94410139771;42289.57710422856;42333.788331058146;201012;268814;272750;288450;293385;27808.44383112367;27978.580321295605;27997.580036299063;28025.859870700515;28440;38809.417858732704;39625.40561891632;40195.3970690434;40224.1955160901;40720.59279407168;32674;35038.47442288419;35696.28607427785;36225.818870905474;36661.81669091638;35673.46489802707;35939.28121437504;36404.27191456209;36420.27159456849;36538.451923221706;34404.31191376209;34498.31003379868;34517.30965380628;34548.65451345555;35418.812306892505;26838.731612683623;28982;29263.85368073146;29507.55738663879;29512.11463656094;22566.435839104153;22961.54076918419;30677.386452270384;30958.53562196524;31188 20:22:17 INFO - PROCESS | 15594 | |2;jquery.html;350.0915125249977;354.36568542309266;356.7877113117695;362.0857335228547;363.2897685025775;13374.197548147118;13928.582142535715;15937.521874343774;16288.592785180377;17363.47909562715;15269.38922443101;15377.461788837392;15734.134622595753;15805.051696898194;15811.920940395283;4988.20188769796;5381.381141168777;5381.838544843641;5382.327209098863;5388.488093631099;3894.922101557967;4015.5783642717533;5301.946980530203;5638.379778224392;5934.673592952386;5671.461211184951;5864.530837532987;5914.260717410324;5916.822495325126;5984.790532331369;5918.615290006136;5937.821865344046;5941.079132734433;5954.642721436728;5975.193348897887;5125.2312153176945;5247.973760131213;5256.500632439912;5260.184671375943;5263.289455923439;14697;14698.33857476416;16851.662966740598;17098.230579623945;19137;2148.9355319340443;2177.379446857654;2197.824174066071;2270.5572413379396;2272.6022945984387;13000.609981700469;13058.542950996669;13104.80342794859;13105;13774.484806671358;1883.5102873252915;1895.924163033477;1927.2869038455722;1940.2045161483866;1940.8835469871854;48238.75880620575;57511;57747.13379299314;59287;59896.70051649714;13944.930275348559;13964.092333998258;13997.5100871469;14003.929980350033;14113.647158821112;21308.573828523342;21478.677819832716;21577.460563486038;21578.56842863134;21612.351629451143;8370.707025254087;8387;8542.060373358925;8606.5696715164;8617.267532259702;7299.23358047408;7318.597477138808;7349.081364829396;7374.373178279799;7504.699812007568;6732.192136943598;7421.0723659542555;7428.10862696469;7435.367993720486;7457.291557302047;2639.986800066026;2889.321009562751;2937.3097322129283;2969.5248760198265;2991.5811786349927;422.2821203953292;427.77755567105555;911.9863202051974;918.4626993208914;1053.6206965492418;9518.476483793458;9620.422774633544;9887.604495820231;10154.39073655583;10465.110465610509;450.6417398168464;480.4426864836842;490.5070404243712;490.5633985752683;857.562643052048;8608.870866937;8845.911540884637;8852.557372131496;8864.20222180007;8957.955210223907;344649;346817;374353;379546;520581;62989;68055.65972170206;68234.31765682378;68555.65722171357;69771.3022869775;1122.1752012270974;1135.7614900870744;1141.4863311509853;1142.440204299887;1150.3213104268523;14840.40638374453;15061.472848450252;15255.9906049325;15297.31162097686;15303.540893773205;31478.84260578774;31865.840670796497;32137;32205.51691724579;32975.50536741999;40842.591574083875;41028.79485602553;42018;42207;43031;7131.964340178266;7337.3029562191505;7375.262473752582;7407.703691852481;7413.888791668237;9046.864297035681;10901.563937442414;10910.454477276264;11204.551817927191;11474.94262528682;9656.275779316438;9664.371815831948;9863.704088877344;9924.15644670211;9998.650047248311;9704.417734935927;10008.09927106564;10140.340877842917;10211.132053775214;10243.282970192313;9765.560549775135;9867;10039.247056470647;10057.346272492265;10065.698029058847;7479.513831600929;7491.1385190701585;7500.13748418917;7506.536225435988;7509.66206520697;9241.537923103684;9452.10205030521;10029.69910902674;10125.64560240388;10149.898501014895 20:22:17 INFO - PROCESS | 15594 | |3;mootools.html;1323.8477575078869;1430.277709756573;1442.935067921943;1583.5170273066717;1743.250402326999;6564.638944858031;6733.7306507739695;6986.615736134504;7116.395106415948;7121.074260346148;7187.89218161728;7223.747168849091;7271.9819225308365;7282.126144862611;7298.817529561764;2210.3921421609107;2248.955020899581;2253.5605556916407;2257.4356410897276;2258.3450799268276;2219.6892435059103;2222.100049479955;2285.4400671835424;2287.7254729432493;2289.473421113145;2272.545490901818;2273.9658905116435;2279.293419040103;2283.1666441748725;2289.175896677195;2277.794998450131;2297.1959814065112;2305.3545007397956;2305.9077636894503;2306.4925716342377;2202.2402271216406;2203.46015226269;2204.570108828779;2227.265002549155;2230.342049095521;7372.815679607999;7421.5176013559485;7428.554286742758;7433.665485053131;7435.553866768011;4413.426254586883;4508.1659892919915;4535.229011068126;4539.818407263739;4542;2740.657417822772;2790.0234917778816;2793.69269380368;2821.774258059371;2821.887124515017;903.737916004358;908.1826356279336;939.567798812547;951.4291425144927;952.3571589177278;9554.61781528738;9568.425894446356;9574.90425095747;9610.327277090537;9617.51912404384;4178.937315940263;4212.389203565466;4248.63886569645;4287.228298906164;4289.6139347458875;8230.670773169126;8260.215279548433;8261.339092872557;8266.090730019692;8288.419810613319;4591.47198072226;4614.077184563101;4620.5148459411275;4629.768511574408;4631.351610774427;3688.7971161585833;3718.1262403335195;4097.836086556564;4190.161967606491;4196.286631272691;3586.8923932282073;3613.7289703271836;3620.3483372992587;3639.253952939641;3649.9635003650155;1177.3524561491145;1238.6717519857245;1242.3974372429363;1246.2211118051218;1264.4183675509184;1280.961571152867;1286.9420876060599;1294.1717300927414;1295.585412667956;1317.6574090736478;6864.897026544606;6908.585484870924;7031.437485001187;7034.753783617652;7049.048378468944;464.6050856771717;471.5567366675314;471.99528004719514;473.9336492890929;520.9609279304067;5358.5981051421295;5511.118221084607;5517.862053448615;5521.585881058856;5522.861928451821;8489.702860399857;8574.485530868167;8974.596143173572;8981.685641002534;9000.59497322622;8752.168543988311;8874.778130546789;8910.331725120512;8927.151920567536;8933.062028486915;6925.026367485242;7051.259617740166;7063.82340441493;7126.857462850818;7148.892766608505;6790.93209067903;6832.453403727789;6842.486813488908;6857.794266172023;6858.0398744176855;7823.217678232131;7952.125266220827;8053.275205231557;8076.596170191585;8087.150849160988;8029.237222463857;8137.389695772722;8173.877391839246;8329.416940814084;8330;5641.9435805641415;5654.85862853432;6561.639109849004;6639.203295604559;6666.100076489612;6871.278515755774;6931.44548436134;6944.583325000516;6995.055667484824;7004.439644828503;6396.264429590657;6544.411003009752;6573.769918052845;6635.8009259722285;6679.56582822115;6385.808425747235;6484.092227088306;6486.805395838132;6534.901976470262;6566.540342176002;6705.530612857053;6732.091167692494;6758;6763.93236067633;6770.627615480998;6128.172696686069;6137.539684523589;6156.722947467285;6161.045038019114;6175.660338681416;6095.1466794647895;6138.723757430837;6145.877082458415;6152.323244443018;6158.32258451561 20:22:17 INFO - PROCESS | 15594 | |4;prototype.html;315.28902325256547;323.5211886408116;345.87029863801075;350.6108219875939;359.1506088101639;5799.2750906136735;5815.651060936341;5867.295924489067;5872.0898260769545;5908.970455147718;5791.160281759153;5793.188953546496;5794.6523208607405;5796.333421656511;5815.941840581603;4526.207913615121;4526.434195725543;4533;4533.637309015287;4536.705114167568;4446.71096378736;4501.122281155176;4503.166914120881;4504.099180163964;4514.232580461313;4451.755153466558;4457.420535330402;4458.710183838057;4459.241928872099;4469.620082293009;4263.893402664927;4375.190589740908;4443.755593442375;4446.488653804805;4451.421315229016;3861.262431905626;3878;3887.1642596841816;3898.571157172709;3956.2680904032845;5523.944760552424;5533.391326954072;5550.4449555044575;5556.833295001156;5573.442655734435;5202.531772140525;5217.739113044333;5225.790968361261;5238.580913526908;5238.711870847102;5761.366249712528;5804.100364443518;5884.261547139448;6037.939620603782;6179.196704428396;4343.022819865537;4355.564443555619;4356.934645980313;4356.956430435686;4363.607275345203;6404.679766011681;6404.743810247584;6408.967955160194;6410;6420.165378500812;4455.844045458393;4458.4426946631675;4459.241928872099;4467.374567560544;4468.419105516262;4432.180046691308;4510.774461276988;4513.458384993822;4515.616172625364;4536.637069034469;5143.382794064736;5147.40804807452;5152.9742351288005;5153.871153221125;5155.5617772489;6165.907511387333;6171.722272497748;6171.7531298748445;6177.62934223948;6180.81457556274;1601.2874270949549;1622.991885040591;1625.0249850090088;1626.967460650804;1630.1604673592872;1048.8374301983206;1070.1224995503767;1079.83262594298;1093.327603523827;1121.3103941076179;5745.827625171251;5775.104858746901;5776.653400795882;5781.942180578225;5793.8551536211935;6257.374262573706;6262.749490020439;6263.530235232284;6264.749410023639;6273.62358258506;5674.489295963301;5709.714514274269;5775.826725198251;5778.306603207558;5787.913181302284;3310.7682462227895;3322.7840190387546;3395.7453191010277;3400.982995085009;3404.1829960809227;6513.1532900722605;6541.182352205974;6681.76613818514;6702.463802895854;6709.329067093349;6556.409923106848;6557.540972131905;6564;6568.96715516429;6586.73653053882;6574.704138313788;6615.371539703817;6666.100076489709;6673.9666301668185;6681.398674119353;6409.038644203407;6409.102725618324;6413.454856337077;6424.293327734039;6428.6785660717715;6340.334264902303;6353.237611486651;6360.109584658059;6361.459275961595;6363.395477429637;6463.192100987377;6603.669816509251;6648.468122550088;6685.0306705526455;6696.129503164558;4392.758398288125;4417.624501917373;4431.7562534060935;4431.977840110779;4480.663950203682;6402.743890244338;6430.935690643034;6442.516811239269;6445.355464453517;6445.709943052668;6268.373162683877;6272.278687950944;6273.65494897785;6277.089821975696;6280;6044.214252147192;6140.692965351804;6181.81454556346;6211.751529938751;6262.09199666055;6107.572469927062;6130.938690613037;6134.509239260759;6140.9078863816185;6142;6187.692338336226;6271;6274.14912600793;6274.372562743689;6280.937190628035;6016.518678505797;6106.603070800384;6111.602745821508;6114.205153330038;6117.449429551361 20:22:17 INFO - PROCESS | 15594 | |5;yui.html;770.2720928722359;821.3265122599468;829.4567058576631;829.5561874397199;847.766864112369;13063.542776002841;13193.80209296859;13201;13225.933870330658;13244;12600.117991740583;12828;12838.93580532096;12853.22880627163;12938.676533086678;791.8376732769783;811.290121143999;814.0963530481162;815.0382548592659;815.7675062607158;669.6082791566915;675.9053732477457;785.1912530094012;796.3072127249301;798.4650284309527;847.2036285891273;850.0309647002422;853.0786750309682;853.5604163855619;854.6666799948025;840.6931470013432;842.3850589069982;842.6123982967842;843.3379796859497;843.5866425451546;516.0891027336754;519.9844004679828;599.5862854630291;624.070135498109;626.3923993726079;12814;12815.487380504768;12844.871551284461;12845.871541284561;12864.742705145938;12794.168379055332;12929.288889111094;13001.720040962813;13109.541166059238;13371.732565348639;10709.303895246783;10814.188935829845;10852.782944341068;11084.113270938306;11210.775784484345;3690.4464330350393;3765.642263984917;3777.9055523611855;3846.7114966377353;3848.037990502374;43344.56655433437;43434;43557.34663980043;43770.56229437697;43808.342874856906;9719.17387022097;10164.695059148238;10224.488775561193;10236.283460157867;10640.361578305172;18055;18145.7278140828;18164.90917545404;18169.45491635253;18208.817911820977;7542.358899493604;7642.197569255148;7715.151333353327;7793.610319484003;7800.45396822217;4244.745315281093;4260.616544510947;4264.104538046983;4266.957330426656;4275.230458517434;2830.8584570771377;2863.226928729273;2865.412590419001;2867.7705783537267;2872.152714949095;520.0872468817278;539.0162952611499;545.0679338331497;549.1268882476801;553.0597983428108;521.8982298451841;525.0994544356447;555.3363730342202;572.9914051289234;636.2524034259726;7493.437992150611;7570.280823321776;7639.923600764032;7799.688012479551;7820.608969551499;569.4931510955253;595.7229888102054;631.9905201421982;633.4425705379236;651.4950913042335;3167.1448708848484;3389.5593572835373;3495.3940127123224;3510.315488479773;3535.1515636247113;50502.49497505051;51152.74423627858;51284.74357628263;51304.48695513072;52427.21359179616;45241;45389.09221815545;45921.77039114783;46973.76513117413;47239;42323;42332.57667423348;42976;43178.35232471515;43874.12251754947;7011.368976792113;7042.95258043052;7081.858362832818;7233.1681856587165;7378.815529611588;32021;32122;32267.838660806545;33161;33296;37213;37273.81363093167;39040.41439378468;41090.1781964365;41510.1697966045;10096.69709908704;10215.23385746087;10246.282760206714;10256;10457.320274182153;10798.56805727762;10861.34831910088;10997.61508347204;11291.266067705574;11362.375069371265;9928.801423971625;10166.135878450414;10203.846942295722;10636.680899573024;10694.14446844235;9931.304808663324;10023.599056037678;10347.27569070188;10363.94818025905;10560.788784224118;9946.254030947563;9960.252981026308;10017.348872323275;10086.596536138471;10503.107235885036;8412.116727743743;8529.402941794264;8706;8756.343274254585;9083.909160908306;8267.503949763033;8368.958155209186;8465.195806398382;8498.830023399621;8643.524606146722 20:22:17 INFO - PROCESS | 15594 | __end_tp_report 20:22:17 INFO - PROCESS | 15594 | __start_cc_report 20:22:17 INFO - PROCESS | 15594 | _x_x_mozilla_cycle_collect,677 20:22:17 INFO - PROCESS | 15594 | __end_cc_report 20:22:17 INFO - PROCESS | 15594 | __startTimestamp1452658937178__endTimestamp 20:22:17 INFO - PROCESS | 15594 | 20:22:17 INFO - PROCESS | 15594 | ------- Summary: start ------- 20:22:17 INFO - PROCESS | 15594 | Number of tests: 6 20:22:17 INFO - PROCESS | 15594 | 20:22:17 INFO - PROCESS | 15594 | [#0] dojo.html Cycles:165 Average:5009.49 Median:5193.27 stddev:537.74 (10.4%) stddev-sans-first:517.62 20:22:17 INFO - PROCESS | 15594 | Values: 3078.5 3112.4 3149.7 3154.2 3171.5 4897.0 4952.9 4968.8 4987.9 5057.6 4948.2 4998.1 5004.8 5082.9 5091.8 4574.2 4575.8 4597.6 4606.0 4678.7 4650.4 4681.4 4694.2 4706.2 4708.5 4468.8 4540.5 4561.0 4621.5 4670.4 4560.7 4562.8 4563.6 4596.2 4610.0 4529.9 4539.3 4555.3 4560.1 4569.2 4744.6 4824.7 4867.3 4874.0 4891.2 5439.2 5442.3 5449.3 5449.8 5453.5 5438.7 5469.4 5474.9 5489.9 5500.8 4929.2 5006.3 5034.2 5104.8 5109.3 5503.7 5504.8 5505.1 5505.5 5506.0 5271.1 5293.4 5294.8 5305.1 5356.5 5350.4 5373.2 5387.7 5436.9 5462.5 5354.4 5366.9 5369.6 5376.7 5377.4 5259.1 5375.9 5386.3 5393.4 5435.6 4144.6 4159.4 4168.1 4191.9 4196.5 3792.1 3801.3 3809.3 3818.9 3829.3 4959.4 4994.7 5046.7 5052.4 5096.1 5438.6 5445.4 5459.4 5460.8 5518.3 4995.3 5026.8 5027.5 5039.4 5075.8 4484.3 4532.6 4560.0 4565.3 4575.6 5649.5 5660.0 5665.7 5666.3 5667.7 5395.8 5411.8 5438.5 5441.6 5454.5 5472.0 5514.0 5526.6 5630.7 5681.9 5227.1 5230.7 5231.7 5232.1 5236.2 5292.3 5292.7 5295.3 5317.1 5335.1 5181.4 5250.8 5256.3 5256.4 5306.4 5268.3 5284.5 5288.1 5290.5 5290.8 5121.5 5218.6 5220.6 5225.7 5262.7 5183.5 5228.8 5256.9 5322.3 5330.5 5168.6 5169.0 5184.8 5188.2 5193.3 20:22:17 INFO - PROCESS | 15594 | 20:22:17 INFO - PROCESS | 15594 | [#1] ext.html Cycles:180 Average:40245.82 Median:3500.25 stddev:62715.29 (1791.7%) stddev-sans-first:62820.22 20:22:17 INFO - PROCESS | 15594 | Values: 499.0 524.8 529.7 532.8 544.5 27687.6 28302.4 35031.3 35378.1 35427.6 37942.5 38361.4 38443.8 38597.6 38663.4 8281.5 8565.8 8566.4 8576.3 8581.6 8061.4 8139.4 8198.4 8199.5 8204.3 8218.6 8278.1 8463.1 8471.2 8479.8 8316.8 8344.3 8364.9 8375.7 8396.3 8409.2 8557.1 8561.2 8568.3 8570.0 38051.6 38495.6 38513.6 38538.8 38539.8 3237.4 3271.3 3383.8 3386.0 3556.0 27764.3 27852.4 28019.2 28372.6 29336.1 3499.7 3500.8 3503.4 3580.3 3643.4 198369.0 198846.0 199883.0 200070.0 200109.0 48418.5 50870.7 55191.0 57734.0 57804.4 52754.5 53074.5 53139.7 53295.0 53377.5 14271.3 14398.7 14418.5 14569.0 14575.0 11017.3 11066.5 11067.8 11160.9 11173.9 18375.4 18386.9 18390.0 18490.4 18529.0 7023.7 7303.0 7331.5 7344.8 7426.4 905.3 1014.5 1070.5 1072.7 1121.6 23097.9 23353.3 23818.9 24014.0 24114.9 1010.2 1034.3 1044.6 1054.3 1133.9 12557.6 12578.2 12660.7 12685.9 14890.6 249797.0 250732.0 250777.5 252346.0 252644.0 46761.3 47008.0 47109.5 47120.0 47187.3 1158.5 1232.1 1283.7 1301.7 1312.9 26823.7 28016.3 28424.3 28522.0 28543.1 41951.5 42231.6 42235.9 42289.6 42333.8 201012.0 268814.0 272750.0 288450.0 293385.0 27808.4 27978.6 27997.6 28025.9 28440.0 38809.4 39625.4 40195.4 40224.2 40720.6 32674.0 35038.5 35696.3 36225.8 36661.8 35673.5 35939.3 36404.3 36420.3 36538.5 34404.3 34498.3 34517.3 34548.7 35418.8 26838.7 28982.0 29263.9 29507.6 29512.1 22566.4 22961.5 30677.4 30958.5 31188.0 20:22:17 INFO - PROCESS | 15594 | 20:22:17 INFO - PROCESS | 15594 | [#2] jquery.html Cycles:180 Average:23521.67 Median:21220.14 stddev:65258.86 (307.5%) stddev-sans-first:65418.73 20:22:17 INFO - PROCESS | 15594 | Values: 350.1 354.4 356.8 362.1 363.3 13374.2 13928.6 15937.5 16288.6 17363.5 15269.4 15377.5 15734.1 15805.1 15811.9 4988.2 5381.4 5381.8 5382.3 5388.5 3894.9 4015.6 5301.9 5638.4 5934.7 5671.5 5864.5 5914.3 5916.8 5984.8 5918.6 5937.8 5941.1 5954.6 5975.2 5125.2 5248.0 5256.5 5260.2 5263.3 14697.0 14698.3 16851.7 17098.2 19137.0 2148.9 2177.4 2197.8 2270.6 2272.6 13000.6 13058.5 13104.8 13105.0 13774.5 1883.5 1895.9 1927.3 1940.2 1940.9 48238.8 57511.0 57747.1 59287.0 59896.7 13944.9 13964.1 13997.5 14003.9 14113.6 21308.6 21478.7 21577.5 21578.6 21612.4 8370.7 8387.0 8542.1 8606.6 8617.3 7299.2 7318.6 7349.1 7374.4 7504.7 6732.2 7421.1 7428.1 7435.4 7457.3 2640.0 2889.3 2937.3 2969.5 2991.6 422.3 427.8 912.0 918.5 1053.6 9518.5 9620.4 9887.6 10154.4 10465.1 450.6 480.4 490.5 490.6 857.6 8608.9 8845.9 8852.6 8864.2 8958.0 344649.0 346817.0 374353.0 379546.0 520581.0 62989.0 68055.7 68234.3 68555.7 69771.3 1122.2 1135.8 1141.5 1142.4 1150.3 14840.4 15061.5 15256.0 15297.3 15303.5 31478.8 31865.8 32137.0 32205.5 32975.5 40842.6 41028.8 42018.0 42207.0 43031.0 7132.0 7337.3 7375.3 7407.7 7413.9 9046.9 10901.6 10910.5 11204.6 11474.9 9656.3 9664.4 9863.7 9924.2 9998.7 9704.4 10008.1 10140.3 10211.1 10243.3 9765.6 9867.0 10039.2 10057.3 10065.7 7479.5 7491.1 7500.1 7506.5 7509.7 9241.5 9452.1 10029.7 10125.6 10149.9 20:22:17 INFO - PROCESS | 15594 | 20:22:17 INFO - PROCESS | 15594 | [#3] mootools.html Cycles:180 Average:5151.39 Median:6168.35 stddev:2618.64 (42.5%) stddev-sans-first:2610.18 20:22:17 INFO - PROCESS | 15594 | Values: 1323.8 1430.3 1442.9 1583.5 1743.3 6564.6 6733.7 6986.6 7116.4 7121.1 7187.9 7223.7 7272.0 7282.1 7298.8 2210.4 2249.0 2253.6 2257.4 2258.3 2219.7 2222.1 2285.4 2287.7 2289.5 2272.5 2274.0 2279.3 2283.2 2289.2 2277.8 2297.2 2305.4 2305.9 2306.5 2202.2 2203.5 2204.6 2227.3 2230.3 7372.8 7421.5 7428.6 7433.7 7435.6 4413.4 4508.2 4535.2 4539.8 4542.0 2740.7 2790.0 2793.7 2821.8 2821.9 903.7 908.2 939.6 951.4 952.4 9554.6 9568.4 9574.9 9610.3 9617.5 4178.9 4212.4 4248.6 4287.2 4289.6 8230.7 8260.2 8261.3 8266.1 8288.4 4591.5 4614.1 4620.5 4629.8 4631.4 3688.8 3718.1 4097.8 4190.2 4196.3 3586.9 3613.7 3620.3 3639.3 3650.0 1177.4 1238.7 1242.4 1246.2 1264.4 1281.0 1286.9 1294.2 1295.6 1317.7 6864.9 6908.6 7031.4 7034.8 7049.0 464.6 471.6 472.0 473.9 521.0 5358.6 5511.1 5517.9 5521.6 5522.9 8489.7 8574.5 8974.6 8981.7 9000.6 8752.2 8874.8 8910.3 8927.2 8933.1 6925.0 7051.3 7063.8 7126.9 7148.9 6790.9 6832.5 6842.5 6857.8 6858.0 7823.2 7952.1 8053.3 8076.6 8087.2 8029.2 8137.4 8173.9 8329.4 8330.0 5641.9 5654.9 6561.6 6639.2 6666.1 6871.3 6931.4 6944.6 6995.1 7004.4 6396.3 6544.4 6573.8 6635.8 6679.6 6385.8 6484.1 6486.8 6534.9 6566.5 6705.5 6732.1 6758.0 6763.9 6770.6 6128.2 6137.5 6156.7 6161.0 6175.7 6095.1 6138.7 6145.9 6152.3 6158.3 20:22:17 INFO - PROCESS | 15594 | 20:22:17 INFO - PROCESS | 15594 | [#4] prototype.html Cycles:180 Average:5177.77 Median:5792.17 stddev:1548.22 (26.7%) stddev-sans-first:1508.93 20:22:17 INFO - PROCESS | 15594 | Values: 315.3 323.5 345.9 350.6 359.2 5799.3 5815.7 5867.3 5872.1 5909.0 5791.2 5793.2 5794.7 5796.3 5815.9 4526.2 4526.4 4533.0 4533.6 4536.7 4446.7 4501.1 4503.2 4504.1 4514.2 4451.8 4457.4 4458.7 4459.2 4469.6 4263.9 4375.2 4443.8 4446.5 4451.4 3861.3 3878.0 3887.2 3898.6 3956.3 5523.9 5533.4 5550.4 5556.8 5573.4 5202.5 5217.7 5225.8 5238.6 5238.7 5761.4 5804.1 5884.3 6037.9 6179.2 4343.0 4355.6 4356.9 4357.0 4363.6 6404.7 6404.7 6409.0 6410.0 6420.2 4455.8 4458.4 4459.2 4467.4 4468.4 4432.2 4510.8 4513.5 4515.6 4536.6 5143.4 5147.4 5153.0 5153.9 5155.6 6165.9 6171.7 6171.8 6177.6 6180.8 1601.3 1623.0 1625.0 1627.0 1630.2 1048.8 1070.1 1079.8 1093.3 1121.3 5745.8 5775.1 5776.7 5781.9 5793.9 6257.4 6262.7 6263.5 6264.7 6273.6 5674.5 5709.7 5775.8 5778.3 5787.9 3310.8 3322.8 3395.7 3401.0 3404.2 6513.2 6541.2 6681.8 6702.5 6709.3 6556.4 6557.5 6564.0 6569.0 6586.7 6574.7 6615.4 6666.1 6674.0 6681.4 6409.0 6409.1 6413.5 6424.3 6428.7 6340.3 6353.2 6360.1 6361.5 6363.4 6463.2 6603.7 6648.5 6685.0 6696.1 4392.8 4417.6 4431.8 4432.0 4480.7 6402.7 6430.9 6442.5 6445.4 6445.7 6268.4 6272.3 6273.7 6277.1 6280.0 6044.2 6140.7 6181.8 6211.8 6262.1 6107.6 6130.9 6134.5 6140.9 6142.0 6187.7 6271.0 6274.1 6274.4 6280.9 6016.5 6106.6 6111.6 6114.2 6117.4 20:22:17 INFO - PROCESS | 15594 | 20:22:17 INFO - PROCESS | 15594 | [#5] yui.html Cycles:180 Average:12758.48 Median:43495.67 stddev:14371.11 (33.0%) stddev-sans-first:14383.23 20:22:17 INFO - PROCESS | 15594 | Values: 770.3 821.3 829.5 829.6 847.8 13063.5 13193.8 13201.0 13225.9 13244.0 12600.1 12828.0 12838.9 12853.2 12938.7 791.8 811.3 814.1 815.0 815.8 669.6 675.9 785.2 796.3 798.5 847.2 850.0 853.1 853.6 854.7 840.7 842.4 842.6 843.3 843.6 516.1 520.0 599.6 624.1 626.4 12814.0 12815.5 12844.9 12845.9 12864.7 12794.2 12929.3 13001.7 13109.5 13371.7 10709.3 10814.2 10852.8 11084.1 11210.8 3690.4 3765.6 3777.9 3846.7 3848.0 43344.6 43434.0 43557.3 43770.6 43808.3 9719.2 10164.7 10224.5 10236.3 10640.4 18055.0 18145.7 18164.9 18169.5 18208.8 7542.4 7642.2 7715.2 7793.6 7800.5 4244.7 4260.6 4264.1 4267.0 4275.2 2830.9 2863.2 2865.4 2867.8 2872.2 520.1 539.0 545.1 549.1 553.1 521.9 525.1 555.3 573.0 636.3 7493.4 7570.3 7639.9 7799.7 7820.6 569.5 595.7 632.0 633.4 651.5 3167.1 3389.6 3495.4 3510.3 3535.2 50502.5 51152.7 51284.7 51304.5 52427.2 45241.0 45389.1 45921.8 46973.8 47239.0 42323.0 42332.6 42976.0 43178.4 43874.1 7011.4 7043.0 7081.9 7233.2 7378.8 32021.0 32122.0 32267.8 33161.0 33296.0 37213.0 37273.8 39040.4 41090.2 41510.2 10096.7 10215.2 10246.3 10256.0 10457.3 10798.6 10861.3 10997.6 11291.3 11362.4 9928.8 10166.1 10203.8 10636.7 10694.1 9931.3 10023.6 10347.3 10363.9 10560.8 9946.3 9960.3 10017.3 10086.6 10503.1 8412.1 8529.4 8706.0 8756.3 9083.9 8267.5 8369.0 8465.2 8498.8 8643.5 20:22:17 INFO - PROCESS | 15594 | -------- Summary: end -------- 20:22:17 INFO - PROCESS | 15594 | 20:22:17 INFO - TEST-INFO | 15594: exit 0 20:22:17 INFO - TEST-OK | dromaeo_css | took 1112264ms 20:22:17 INFO - TEST-START | kraken 20:22:17 INFO - operating with platform_type : linux_ 20:22:17 INFO - Initialising browser for kraken test... 20:22:17 INFO - TEST-INFO | started process 15790 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9zm2IT/profile http://localhost:51740/getInfo.html) 20:22:21 INFO - PROCESS | 15790 | __metrics Screen width/height:1600/1200 20:22:21 INFO - PROCESS | 15790 | colorDepth:24 20:22:21 INFO - PROCESS | 15790 | Browser inner width/height: 1024/697 20:22:21 INFO - PROCESS | 15790 | __metrics 20:22:21 INFO - PROCESS | 15790 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:22:22 INFO - PROCESS | 15790 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:22:23 INFO - TEST-INFO | 15790: exit 0 20:22:23 INFO - Browser initialized. 20:22:23 INFO - Running cycle 1/1 for kraken test... 20:22:23 INFO - TEST-INFO | started process 15875 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9zm2IT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:22:34 INFO - PROCESS | 15875 | RSS: Main: 148484096 20:22:34 INFO - PROCESS | 15875 | 20:22:37 INFO - PROCESS | 15875 | Cycle 1(1): loaded http://localhost:51740/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51740/tests/kraken/driver.html?testName=audio-beat-detection) 20:22:38 INFO - PROCESS | 15875 | RSS: Main: 184430592 20:22:38 INFO - PROCESS | 15875 | 20:22:40 INFO - PROCESS | 15875 | Cycle 1(1): loaded http://localhost:51740/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51740/tests/kraken/driver.html?testName=audio-dft) 20:22:41 INFO - PROCESS | 15875 | RSS: Main: 174284800 20:22:41 INFO - PROCESS | 15875 | 20:22:44 INFO - PROCESS | 15875 | Cycle 1(1): loaded http://localhost:51740/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51740/tests/kraken/driver.html?testName=audio-fft) 20:22:44 INFO - PROCESS | 15875 | RSS: Main: 160460800 20:22:44 INFO - PROCESS | 15875 | 20:22:46 INFO - PROCESS | 15875 | Cycle 1(1): loaded http://localhost:51740/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51740/tests/kraken/driver.html?testName=audio-oscillator) 20:22:47 INFO - PROCESS | 15875 | RSS: Main: 161853440 20:22:47 INFO - PROCESS | 15875 | 20:22:49 INFO - PROCESS | 15875 | Cycle 1(1): loaded http://localhost:51740/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51740/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:22:50 INFO - PROCESS | 15875 | RSS: Main: 164024320 20:22:50 INFO - PROCESS | 15875 | 20:22:53 INFO - PROCESS | 15875 | Cycle 1(1): loaded http://localhost:51740/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51740/tests/kraken/driver.html?testName=imaging-darkroom) 20:22:53 INFO - PROCESS | 15875 | RSS: Main: 164372480 20:22:53 INFO - PROCESS | 15875 | 20:22:56 INFO - PROCESS | 15875 | Cycle 1(1): loaded http://localhost:51740/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51740/tests/kraken/driver.html?testName=imaging-desaturate) 20:22:57 INFO - PROCESS | 15875 | RSS: Main: 166563840 20:22:57 INFO - PROCESS | 15875 | 20:23:00 INFO - PROCESS | 15875 | Cycle 1(1): loaded http://localhost:51740/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51740/tests/kraken/driver.html?testName=json-parse-financial) 20:23:00 INFO - PROCESS | 15875 | RSS: Main: 164831232 20:23:00 INFO - PROCESS | 15875 | 20:23:02 INFO - PROCESS | 15875 | Cycle 1(1): loaded http://localhost:51740/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51740/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:23:02 INFO - PROCESS | 15875 | RSS: Main: 172998656 20:23:02 INFO - PROCESS | 15875 | 20:23:04 INFO - PROCESS | 15875 | Cycle 1(1): loaded http://localhost:51740/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51740/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:23:05 INFO - PROCESS | 15875 | RSS: Main: 169943040 20:23:05 INFO - PROCESS | 15875 | 20:23:07 INFO - PROCESS | 15875 | Cycle 1(1): loaded http://localhost:51740/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51740/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:23:08 INFO - PROCESS | 15875 | RSS: Main: 179535872 20:23:08 INFO - PROCESS | 15875 | 20:23:10 INFO - PROCESS | 15875 | Cycle 1(1): loaded http://localhost:51740/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51740/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:23:11 INFO - PROCESS | 15875 | RSS: Main: 187138048 20:23:11 INFO - PROCESS | 15875 | 20:23:13 INFO - PROCESS | 15875 | Cycle 1(1): loaded http://localhost:51740/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51740/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:23:14 INFO - PROCESS | 15875 | RSS: Main: 186548224 20:23:14 INFO - PROCESS | 15875 | 20:23:15 INFO - PROCESS | 15875 | Cycle 1(1): loaded http://localhost:51740/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51740/tests/kraken/driver.html?testName=ai-astar) 20:23:16 INFO - PROCESS | 15875 | RSS: Main: 243445760 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - PROCESS | 15875 | __start_tp_report 20:23:16 INFO - PROCESS | 15875 | _x_x_mozilla_page_load 20:23:16 INFO - PROCESS | 15875 | _x_x_mozilla_page_load_details 20:23:16 INFO - PROCESS | 15875 | |i|pagename|runs| 20:23:16 INFO - PROCESS | 15875 | |0;ai-astar;111;114;107;111;112;113;101;112;112;112 20:23:16 INFO - PROCESS | 15875 | |1;audio-beat-detection;160;128;152;168;126;153;158;135;174;130 20:23:16 INFO - PROCESS | 15875 | |2;audio-dft;161;162;161;159;161;162;160;164;166;161 20:23:16 INFO - PROCESS | 15875 | |3;audio-fft;72;71;83;98;74;71;71;122;94;72 20:23:16 INFO - PROCESS | 15875 | |4;audio-oscillator;110;96;145;96;96;96;137;97;97;135 20:23:16 INFO - PROCESS | 15875 | |5;imaging-gaussian-blur;108;110;109;109;109;109;109;109;109;109 20:23:16 INFO - PROCESS | 15875 | |6;imaging-darkroom;145;146;146;145;145;145;145;146;145;145 20:23:16 INFO - PROCESS | 15875 | |7;imaging-desaturate;95;95;95;96;96;96;96;104;96;96 20:23:16 INFO - PROCESS | 15875 | |8;json-parse-financial;57;57;58;55;55;56;56;64;54;53 20:23:16 INFO - PROCESS | 15875 | |9;json-stringify-tinderbox;66;67;67;69;65;66;66;66;66;67 20:23:16 INFO - PROCESS | 15875 | |10;stanford-crypto-aes;85;85;87;85;86;86;86;92;87;86 20:23:16 INFO - PROCESS | 15875 | |11;stanford-crypto-ccm;117;129;119;116;131;118;117;119;126;124 20:23:16 INFO - PROCESS | 15875 | |12;stanford-crypto-pbkdf2;147;142;142;152;154;144;159;151;155;143 20:23:16 INFO - PROCESS | 15875 | |13;stanford-crypto-sha256-iterative;68;68;71;69;73;69;67;67;70;68 20:23:16 INFO - PROCESS | 15875 | __end_tp_report 20:23:16 INFO - PROCESS | 15875 | __start_cc_report 20:23:16 INFO - PROCESS | 15875 | _x_x_mozilla_cycle_collect,963 20:23:16 INFO - PROCESS | 15875 | __end_cc_report 20:23:16 INFO - PROCESS | 15875 | __startTimestamp1452658996171__endTimestamp 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - PROCESS | 15875 | ------- Summary: start ------- 20:23:16 INFO - PROCESS | 15875 | Number of tests: 14 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - PROCESS | 15875 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.81 (3.4%) stddev-sans-first:4.03 20:23:16 INFO - PROCESS | 15875 | Values: 111.0 114.0 107.0 111.0 112.0 113.0 101.0 112.0 112.0 112.0 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - PROCESS | 15875 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:155.50 stddev:17.44 (11.2%) stddev-sans-first:17.98 20:23:16 INFO - PROCESS | 15875 | Values: 160.0 128.0 152.0 168.0 126.0 153.0 158.0 135.0 174.0 130.0 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - PROCESS | 15875 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:2.00 (1.2%) stddev-sans-first:2.11 20:23:16 INFO - PROCESS | 15875 | Values: 161.0 162.0 161.0 159.0 161.0 162.0 160.0 164.0 166.0 161.0 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - PROCESS | 15875 | [#3] audio-fft Cycles:10 Average:82.80 Median:73.00 stddev:17.07 (23.4%) stddev-sans-first:17.65 20:23:16 INFO - PROCESS | 15875 | Values: 72.0 71.0 83.0 98.0 74.0 71.0 71.0 122.0 94.0 72.0 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - PROCESS | 15875 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:96.00 stddev:20.27 (21.1%) stddev-sans-first:21.50 20:23:16 INFO - PROCESS | 15875 | Values: 110.0 96.0 145.0 96.0 96.0 96.0 137.0 97.0 97.0 135.0 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - PROCESS | 15875 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 20:23:16 INFO - PROCESS | 15875 | Values: 108.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - PROCESS | 15875 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 20:23:16 INFO - PROCESS | 15875 | Values: 145.0 146.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - PROCESS | 15875 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:2.68 (2.8%) stddev-sans-first:2.78 20:23:16 INFO - PROCESS | 15875 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 104.0 96.0 96.0 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - PROCESS | 15875 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.50 stddev:3.03 (5.4%) stddev-sans-first:3.21 20:23:16 INFO - PROCESS | 15875 | Values: 57.0 57.0 58.0 55.0 55.0 56.0 56.0 64.0 54.0 53.0 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - PROCESS | 15875 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.50 stddev:1.08 (1.6%) stddev-sans-first:1.13 20:23:16 INFO - PROCESS | 15875 | Values: 66.0 67.0 67.0 69.0 65.0 66.0 66.0 66.0 66.0 67.0 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - PROCESS | 15875 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.00 stddev:2.07 (2.4%) stddev-sans-first:2.12 20:23:16 INFO - PROCESS | 15875 | Values: 85.0 85.0 87.0 85.0 86.0 86.0 86.0 92.0 87.0 86.0 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - PROCESS | 15875 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:121.50 stddev:5.46 (4.5%) stddev-sans-first:5.53 20:23:16 INFO - PROCESS | 15875 | Values: 117.0 129.0 119.0 116.0 131.0 118.0 117.0 119.0 126.0 124.0 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - PROCESS | 15875 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:151.50 stddev:6.12 (4.0%) stddev-sans-first:6.45 20:23:16 INFO - PROCESS | 15875 | Values: 147.0 142.0 142.0 152.0 154.0 144.0 159.0 151.0 155.0 143.0 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - PROCESS | 15875 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.89 (2.7%) stddev-sans-first:1.96 20:23:16 INFO - PROCESS | 15875 | Values: 68.0 68.0 71.0 69.0 73.0 69.0 67.0 67.0 70.0 68.0 20:23:16 INFO - PROCESS | 15875 | -------- Summary: end -------- 20:23:16 INFO - PROCESS | 15875 | 20:23:16 INFO - TEST-INFO | 15875: exit 0 20:23:17 INFO - TEST-OK | kraken | took 59222ms 20:23:17 INFO - TEST-START | v8_7 20:23:17 INFO - operating with platform_type : linux_ 20:23:17 INFO - Initialising browser for v8_7 test... 20:23:17 INFO - TEST-INFO | started process 16127 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVGxmk1/profile http://localhost:51740/getInfo.html) 20:23:21 INFO - PROCESS | 16127 | __metrics Screen width/height:1600/1200 20:23:21 INFO - PROCESS | 16127 | colorDepth:24 20:23:21 INFO - PROCESS | 16127 | Browser inner width/height: 1024/697 20:23:21 INFO - PROCESS | 16127 | __metrics 20:23:21 INFO - PROCESS | 16127 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:23:21 INFO - PROCESS | 16127 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:23:22 INFO - TEST-INFO | 16127: exit 0 20:23:22 INFO - Browser initialized. 20:23:22 INFO - Running cycle 1/1 for v8_7 test... 20:23:22 INFO - TEST-INFO | started process 16208 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVGxmk1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:34 INFO - PROCESS | 16208 | RSS: Main: 147832832 20:23:34 INFO - PROCESS | 16208 | 20:23:56 INFO - PROCESS | 16208 | Cycle 1(1): loaded http://localhost:51740/tests/v8_7/run.html (next: http://localhost:51740/tests/v8_7/run.html) 20:23:56 INFO - PROCESS | 16208 | RSS: Main: 556453888 20:23:56 INFO - PROCESS | 16208 | 20:23:56 INFO - PROCESS | 16208 | __start_tp_report 20:23:56 INFO - PROCESS | 16208 | _x_x_mozilla_page_load 20:23:56 INFO - PROCESS | 16208 | _x_x_mozilla_page_load_details 20:23:56 INFO - PROCESS | 16208 | |i|pagename|runs| 20:23:56 INFO - PROCESS | 16208 | |0;Richards;167.897918065816 20:23:56 INFO - PROCESS | 16208 | |1;DeltaBlue;192.64110961279138 20:23:56 INFO - PROCESS | 16208 | |2;Encrypt;285.8776443682104 20:23:56 INFO - PROCESS | 16208 | |3;Decrypt;5268.421052631579 20:23:56 INFO - PROCESS | 16208 | |4;RayTrace;2020.20202020202 20:23:56 INFO - PROCESS | 16208 | |5;Earley;803.2128514056225 20:23:56 INFO - PROCESS | 16208 | |6;Boyer;11988.095238095239 20:23:56 INFO - PROCESS | 16208 | |7;RegExp;43063.82978723404 20:23:56 INFO - PROCESS | 16208 | |8;Splay;588.2352941176471 20:23:56 INFO - PROCESS | 16208 | |9;NavierStokes;4859.223300970873 20:23:56 INFO - PROCESS | 16208 | __end_tp_report 20:23:56 INFO - PROCESS | 16208 | __startTimestamp1452659036781__endTimestamp 20:23:56 INFO - PROCESS | 16208 | 20:23:56 INFO - PROCESS | 16208 | ------- Summary: start ------- 20:23:56 INFO - PROCESS | 16208 | Number of tests: 10 20:23:56 INFO - PROCESS | 16208 | 20:23:56 INFO - PROCESS | 16208 | [#0] Richards Cycles:1 Average:167.90 Median:167.90 stddev:0.00 (0.0%) 20:23:56 INFO - PROCESS | 16208 | Values: 167.9 20:23:56 INFO - PROCESS | 16208 | 20:23:56 INFO - PROCESS | 16208 | [#1] DeltaBlue Cycles:1 Average:192.64 Median:192.64 stddev:0.00 (0.0%) 20:23:56 INFO - PROCESS | 16208 | Values: 192.6 20:23:56 INFO - PROCESS | 16208 | 20:23:56 INFO - PROCESS | 16208 | [#2] Encrypt Cycles:1 Average:285.88 Median:285.88 stddev:0.00 (0.0%) 20:23:56 INFO - PROCESS | 16208 | Values: 285.9 20:23:56 INFO - PROCESS | 16208 | 20:23:56 INFO - PROCESS | 16208 | [#3] Decrypt Cycles:1 Average:5268.42 Median:5268.42 stddev:0.00 (0.0%) 20:23:56 INFO - PROCESS | 16208 | Values: 5268.4 20:23:56 INFO - PROCESS | 16208 | 20:23:56 INFO - PROCESS | 16208 | [#4] RayTrace Cycles:1 Average:2020.20 Median:2020.20 stddev:0.00 (0.0%) 20:23:56 INFO - PROCESS | 16208 | Values: 2020.2 20:23:56 INFO - PROCESS | 16208 | 20:23:56 INFO - PROCESS | 16208 | [#5] Earley Cycles:1 Average:803.21 Median:803.21 stddev:0.00 (0.0%) 20:23:56 INFO - PROCESS | 16208 | Values: 803.2 20:23:56 INFO - PROCESS | 16208 | 20:23:56 INFO - PROCESS | 16208 | [#6] Boyer Cycles:1 Average:11988.10 Median:11988.10 stddev:0.00 (0.0%) 20:23:56 INFO - PROCESS | 16208 | Values: 11988.1 20:23:56 INFO - PROCESS | 16208 | 20:23:56 INFO - PROCESS | 16208 | [#7] RegExp Cycles:1 Average:43063.83 Median:43063.83 stddev:0.00 (0.0%) 20:23:56 INFO - PROCESS | 16208 | Values: 43063.8 20:23:56 INFO - PROCESS | 16208 | 20:23:56 INFO - PROCESS | 16208 | [#8] Splay Cycles:1 Average:588.24 Median:588.24 stddev:0.00 (0.0%) 20:23:56 INFO - PROCESS | 16208 | Values: 588.2 20:23:56 INFO - PROCESS | 16208 | 20:23:56 INFO - PROCESS | 16208 | [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 20:23:56 INFO - PROCESS | 16208 | Values: 4859.2 20:23:56 INFO - PROCESS | 16208 | -------- Summary: end -------- 20:23:56 INFO - PROCESS | 16208 | 20:23:57 INFO - TEST-INFO | 16208: exit 0 20:23:57 INFO - TEST-OK | v8_7 | took 40630ms 20:23:57 INFO - SUITE-END | took 1212s 20:23:57 INFO - Completed test suite (00:20:12) 20:23:57 INFO - Working with test: dromaeo_css 20:23:57 INFO - Generating results file: dromaeo_css 20:23:57 INFO - Working with test: kraken 20:23:57 INFO - Generating results file: kraken 20:23:57 INFO - javascript benchmark 20:23:57 INFO - Working with test: v8_7 20:23:57 INFO - Generating results file: v8_7 20:23:57 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:23:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:23:57 INFO - process_Request line: dromaeo_css 6601.43 graph.html#tests=[[72,64,35]] 20:23:57 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:23:57 INFO - process_Request line: kraken 1513.70 graph.html#tests=[[232,64,35]] 20:23:57 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:23:58 INFO - process_Request line: v8_7 18766.00 graph.html#tests=[[230,64,35]] 20:23:58 INFO - RETURN: dromaeo_css: 6601.43 20:23:58 INFO - RETURN: kraken: 1513.70 20:23:58 INFO - RETURN: v8_7: 18766.00 20:23:58 INFO - javascript benchmark 20:23:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3078.4766589679753, 3112.424201522717, 3149.7007784260486, 3154.2429816843965, 3171.4925611902086, 4896.951030489694, 4952.851414457563, 4968.751562421878, 4987.850364489067, 5057.595392368611, 4948.208286674133, 4998.10034193845, 5004.7747851346685, 5082.949170508294, 5091.79632814687, 4574.153781550423, 4575.839845605413, 4597.586217240448, 4606.0327331260305, 4678.695884767496, 4650.395448591678, 4681.414823147106, 4694.248920172773, 4706.176419126657, 4708.4820669726305, 4468.75421851798, 4540.500544940054, 4560.9771951140365, 4621.514740952202, 4670.439547254317, 4560.703554268962, 4562.817487300537, 4563.589276965089, 4596.172688915994, 4609.976950115228, 4529.932051019237, 4539.251023581105, 4555.316702494652, 4560.065186636732, 4569.1547063793305, 4744.5967092797155, 4824.734639594821, 4867.318575399447, 4873.951260487421, 4891.192953162724, 5439.238506609078, 5442.265294185274, 5449.291592093042, 5449.83650490482, 5453.481919217668, 5438.7280635968045, 5469.425710300441, 5474.945250547523, 5489.862753431156, 5500.80747173847, 4929.162042452792, 5006.349174607278, 5034.16936205522, 5104.821331253463, 5109.339873288359, 5503.669779813224, 5504.752286147133, 5505.091659876156, 5505.504504594605, 5506.03644362235, 5271.130263506555, 5293.417724050351, 5294.814681486129, 5305.124654432053, 5356.517913387814, 5350.357957045102, 5373.2208829719475, 5387.676739395649, 5436.864078397993, 5462.453754624506, 5354.384245811703, 5366.865828354323, 5369.5972802040005, 5376.650517716336, 5377.435369286247, 5259.132243179909, 5375.865603359947, 5386.299781028441, 5393.43368946255, 5435.619506634498, 4144.647704945053, 4159.417681524589, 4168.083021735213, 4191.874243772691, 4196.51740049892, 3792.146766977408, 3801.258754542838, 3809.29528037314, 3818.9236215276096, 3829.291581057513, 4959.355283813081, 4994.675346102492, 5046.7476626168545, 5052.418971818288, 5096.05722941257, 5438.564914806806, 5445.428230035868, 5459.372172200247, 5460.836174914759, 5518.33779946409, 4995.275685025651, 5026.798928042837, 5027.522385373383, 5039.3952725672425, 5075.847724568269, 4484.282514797616, 4532.637389008872, 4559.977200113978, 4565.292379681155, 4575.611073058827, 5649.4633009864, 5660.0, 5665.688387138664, 5666.291713535808, 5667.716614169275, 5395.838124856261, 5411.756470958895, 5438.537724293321, 5441.646292990943, 5454.4545545445135, 5472.0, 5513.972430137824, 5526.640768350045, 5630.690312032878, 5681.9431805681415, 5227.137522308776, 5230.686158830483, 5231.712255825966, 5232.110541207928, 5236.188390799432, 5292.338457692788, 5292.655977361459, 5295.338082739658, 5317.096093664164, 5335.09303418412, 5181.430042695225, 5250.842474725764, 5256.316678831728, 5256.395514515727, 5306.416294207711, 5268.2624432578705, 5284.524392804666, 5288.127458969381, 5290.523852853262, 5290.841274761763, 5121.513456221653, 5218.634695571273, 5220.634555581073, 5225.6603320784025, 5262.710550919736, 5183.481651834786, 5228.790848366023, 5256.9211461827335, 5322.281491998686, 5330.493603107699, 5168.612354073384, 5169.043726910533, 5184.818531351385, 5188.169892817131, 5193.272941788228], "unit": "score", "name": "dojo.html", "value": 4976.46074664138}, {"lowerIsBetter": false, "replicates": [498.9501049895011, 524.77696978784, 529.69542513055, 532.7629205003773, 544.5099410530521, 27687.584686229722, 28302.433951320985, 35031.2993740125, 35378.11554711127, 35427.64572354276, 37942.482300708005, 38361.42457863134, 38443.80778096113, 38597.61402385975, 38663.42004869929, 8281.544515051684, 8565.828683426327, 8566.443181193203, 8576.313894888393, 8581.613827377752, 8061.435699501038, 8139.430239883211, 8198.42611017229, 8199.549024803633, 8204.343652507814, 8218.63016164271, 8278.089410164877, 8463.06906240313, 8471.237588617023, 8479.788005299886, 8316.83366332676, 8344.332453403713, 8364.916350836475, 8375.748727538183, 8396.286315663176, 8409.159084091603, 8557.10150434208, 8561.22948934599, 8568.271696905771, 8570.0, 38051.61948380536, 38495.61504384948, 38513.61486385128, 38538.80730596357, 38539.807300963315, 3237.4172648923186, 3271.313024264907, 3383.813890236036, 3385.96614033859, 3555.964440355589, 27764.30589235285, 27852.442951141067, 28019.159425217276, 28372.574411383845, 29336.119916402542, 3499.7025252853537, 3500.789952602852, 3503.3518799022263, 3580.3197392495345, 3643.4352675335367, 198369.0, 198846.0, 199883.0, 200070.0, 200109.0, 48418.5158148421, 50870.74564627227, 55191.0, 57734.0, 57804.421955780745, 52754.472455275725, 53074.469255307726, 53139.734301329016, 53295.0, 53377.46622533725, 14271.286435678174, 14398.704116629553, 14418.495352662607, 14569.0, 14575.0, 11017.338959662446, 11066.502007409686, 11067.778644427066, 11160.883911608775, 11173.888261117447, 18375.356862509747, 18386.908065459585, 18390.0, 18490.44528664142, 18529.0, 7023.68393422287, 7303.0, 7331.450141239428, 7344.779656610311, 7426.368758655467, 905.3210092430677, 1014.4623349624711, 1070.5129166229347, 1072.6674730833467, 1121.5681962444355, 23097.88451057734, 23353.299401017997, 23818.92814823337, 24014.0, 24114.87942560276, 1010.1514727628827, 1034.3070143004206, 1044.5821671331375, 1054.2725519391595, 1133.9319640821577, 12557.56048538315, 12578.245305281529, 12660.683482912817, 12685.873141268654, 14890.627734306512, 249797.0, 250732.0, 250777.47667570002, 252346.0, 252644.0, 46761.29858052132, 47008.0, 47109.5289047112, 47120.0, 47187.29219061717, 1158.4902642837126, 1232.063631639942, 1283.736833949038, 1301.7006088599676, 1312.9146605470614, 26823.731762682903, 28016.29959251035, 28424.289392765346, 28522.0, 28543.14370568886, 41951.53169639048, 42231.577684222764, 42235.94410139771, 42289.57710422856, 42333.788331058146, 201012.0, 268814.0, 272750.0, 288450.0, 293385.0, 27808.44383112367, 27978.580321295605, 27997.580036299063, 28025.859870700515, 28440.0, 38809.417858732704, 39625.40561891632, 40195.3970690434, 40224.1955160901, 40720.59279407168, 32674.0, 35038.47442288419, 35696.28607427785, 36225.818870905474, 36661.81669091638, 35673.46489802707, 35939.28121437504, 36404.27191456209, 36420.27159456849, 36538.451923221706, 34404.31191376209, 34498.31003379868, 34517.30965380628, 34548.65451345555, 35418.812306892505, 26838.731612683623, 28982.0, 29263.85368073146, 29507.55738663879, 29512.11463656094, 22566.435839104153, 22961.54076918419, 30677.386452270384, 30958.53562196524, 31188.0], "unit": "score", "name": "ext.html", "value": 17151.811474633287}, {"lowerIsBetter": false, "replicates": [350.0915125249977, 354.36568542309266, 356.7877113117695, 362.0857335228547, 363.2897685025775, 13374.197548147118, 13928.582142535715, 15937.521874343774, 16288.592785180377, 17363.47909562715, 15269.38922443101, 15377.461788837392, 15734.134622595753, 15805.051696898194, 15811.920940395283, 4988.20188769796, 5381.381141168777, 5381.838544843641, 5382.327209098863, 5388.488093631099, 3894.922101557967, 4015.5783642717533, 5301.946980530203, 5638.379778224392, 5934.673592952386, 5671.461211184951, 5864.530837532987, 5914.260717410324, 5916.822495325126, 5984.790532331369, 5918.615290006136, 5937.821865344046, 5941.079132734433, 5954.642721436728, 5975.193348897887, 5125.2312153176945, 5247.973760131213, 5256.500632439912, 5260.184671375943, 5263.289455923439, 14697.0, 14698.33857476416, 16851.662966740598, 17098.230579623945, 19137.0, 2148.9355319340443, 2177.379446857654, 2197.824174066071, 2270.5572413379396, 2272.6022945984387, 13000.609981700469, 13058.542950996669, 13104.80342794859, 13105.0, 13774.484806671358, 1883.5102873252915, 1895.924163033477, 1927.2869038455722, 1940.2045161483866, 1940.8835469871854, 48238.75880620575, 57511.0, 57747.13379299314, 59287.0, 59896.70051649714, 13944.930275348559, 13964.092333998258, 13997.5100871469, 14003.929980350033, 14113.647158821112, 21308.573828523342, 21478.677819832716, 21577.460563486038, 21578.56842863134, 21612.351629451143, 8370.707025254087, 8387.0, 8542.060373358925, 8606.5696715164, 8617.267532259702, 7299.23358047408, 7318.597477138808, 7349.081364829396, 7374.373178279799, 7504.699812007568, 6732.192136943598, 7421.0723659542555, 7428.10862696469, 7435.367993720486, 7457.291557302047, 2639.986800066026, 2889.321009562751, 2937.3097322129283, 2969.5248760198265, 2991.5811786349927, 422.2821203953292, 427.77755567105555, 911.9863202051974, 918.4626993208914, 1053.6206965492418, 9518.476483793458, 9620.422774633544, 9887.604495820231, 10154.39073655583, 10465.110465610509, 450.6417398168464, 480.4426864836842, 490.5070404243712, 490.5633985752683, 857.562643052048, 8608.870866937, 8845.911540884637, 8852.557372131496, 8864.20222180007, 8957.955210223907, 344649.0, 346817.0, 374353.0, 379546.0, 520581.0, 62989.0, 68055.65972170206, 68234.31765682378, 68555.65722171357, 69771.3022869775, 1122.1752012270974, 1135.7614900870744, 1141.4863311509853, 1142.440204299887, 1150.3213104268523, 14840.40638374453, 15061.472848450252, 15255.9906049325, 15297.31162097686, 15303.540893773205, 31478.84260578774, 31865.840670796497, 32137.0, 32205.51691724579, 32975.50536741999, 40842.591574083875, 41028.79485602553, 42018.0, 42207.0, 43031.0, 7131.964340178266, 7337.3029562191505, 7375.262473752582, 7407.703691852481, 7413.888791668237, 9046.864297035681, 10901.563937442414, 10910.454477276264, 11204.551817927191, 11474.94262528682, 9656.275779316438, 9664.371815831948, 9863.704088877344, 9924.15644670211, 9998.650047248311, 9704.417734935927, 10008.09927106564, 10140.340877842917, 10211.132053775214, 10243.282970192313, 9765.560549775135, 9867.0, 10039.247056470647, 10057.346272492265, 10065.698029058847, 7479.513831600929, 7491.1385190701585, 7500.13748418917, 7506.536225435988, 7509.66206520697, 9241.537923103684, 9452.10205030521, 10029.69910902674, 10125.64560240388, 10149.898501014895], "unit": "score", "name": "jquery.html", "value": 8273.926230616042}, {"lowerIsBetter": false, "replicates": [1323.8477575078869, 1430.277709756573, 1442.935067921943, 1583.5170273066717, 1743.250402326999, 6564.638944858031, 6733.7306507739695, 6986.615736134504, 7116.395106415948, 7121.074260346148, 7187.89218161728, 7223.747168849091, 7271.9819225308365, 7282.126144862611, 7298.817529561764, 2210.3921421609107, 2248.955020899581, 2253.5605556916407, 2257.4356410897276, 2258.3450799268276, 2219.6892435059103, 2222.100049479955, 2285.4400671835424, 2287.7254729432493, 2289.473421113145, 2272.545490901818, 2273.9658905116435, 2279.293419040103, 2283.1666441748725, 2289.175896677195, 2277.794998450131, 2297.1959814065112, 2305.3545007397956, 2305.9077636894503, 2306.4925716342377, 2202.2402271216406, 2203.46015226269, 2204.570108828779, 2227.265002549155, 2230.342049095521, 7372.815679607999, 7421.5176013559485, 7428.554286742758, 7433.665485053131, 7435.553866768011, 4413.426254586883, 4508.1659892919915, 4535.229011068126, 4539.818407263739, 4542.0, 2740.657417822772, 2790.0234917778816, 2793.69269380368, 2821.774258059371, 2821.887124515017, 903.737916004358, 908.1826356279336, 939.567798812547, 951.4291425144927, 952.3571589177278, 9554.61781528738, 9568.425894446356, 9574.90425095747, 9610.327277090537, 9617.51912404384, 4178.937315940263, 4212.389203565466, 4248.63886569645, 4287.228298906164, 4289.6139347458875, 8230.670773169126, 8260.215279548433, 8261.339092872557, 8266.090730019692, 8288.419810613319, 4591.47198072226, 4614.077184563101, 4620.5148459411275, 4629.768511574408, 4631.351610774427, 3688.7971161585833, 3718.1262403335195, 4097.836086556564, 4190.161967606491, 4196.286631272691, 3586.8923932282073, 3613.7289703271836, 3620.3483372992587, 3639.253952939641, 3649.9635003650155, 1177.3524561491145, 1238.6717519857245, 1242.3974372429363, 1246.2211118051218, 1264.4183675509184, 1280.961571152867, 1286.9420876060599, 1294.1717300927414, 1295.585412667956, 1317.6574090736478, 6864.897026544606, 6908.585484870924, 7031.437485001187, 7034.753783617652, 7049.048378468944, 464.6050856771717, 471.5567366675314, 471.99528004719514, 473.9336492890929, 520.9609279304067, 5358.5981051421295, 5511.118221084607, 5517.862053448615, 5521.585881058856, 5522.861928451821, 8489.702860399857, 8574.485530868167, 8974.596143173572, 8981.685641002534, 9000.59497322622, 8752.168543988311, 8874.778130546789, 8910.331725120512, 8927.151920567536, 8933.062028486915, 6925.026367485242, 7051.259617740166, 7063.82340441493, 7126.857462850818, 7148.892766608505, 6790.93209067903, 6832.453403727789, 6842.486813488908, 6857.794266172023, 6858.0398744176855, 7823.217678232131, 7952.125266220827, 8053.275205231557, 8076.596170191585, 8087.150849160988, 8029.237222463857, 8137.389695772722, 8173.877391839246, 8329.416940814084, 8330.0, 5641.9435805641415, 5654.85862853432, 6561.639109849004, 6639.203295604559, 6666.100076489612, 6871.278515755774, 6931.44548436134, 6944.583325000516, 6995.055667484824, 7004.439644828503, 6396.264429590657, 6544.411003009752, 6573.769918052845, 6635.8009259722285, 6679.56582822115, 6385.808425747235, 6484.092227088306, 6486.805395838132, 6534.901976470262, 6566.540342176002, 6705.530612857053, 6732.091167692494, 6758.0, 6763.93236067633, 6770.627615480998, 6128.172696686069, 6137.539684523589, 6156.722947467285, 6161.045038019114, 6175.660338681416, 6095.1466794647895, 6138.723757430837, 6145.877082458415, 6152.323244443018, 6158.32258451561], "unit": "score", "name": "mootools.html", "value": 4209.389911954}, {"lowerIsBetter": false, "replicates": [315.28902325256547, 323.5211886408116, 345.87029863801075, 350.6108219875939, 359.1506088101639, 5799.2750906136735, 5815.651060936341, 5867.295924489067, 5872.0898260769545, 5908.970455147718, 5791.160281759153, 5793.188953546496, 5794.6523208607405, 5796.333421656511, 5815.941840581603, 4526.207913615121, 4526.434195725543, 4533.0, 4533.637309015287, 4536.705114167568, 4446.71096378736, 4501.122281155176, 4503.166914120881, 4504.099180163964, 4514.232580461313, 4451.755153466558, 4457.420535330402, 4458.710183838057, 4459.241928872099, 4469.620082293009, 4263.893402664927, 4375.190589740908, 4443.755593442375, 4446.488653804805, 4451.421315229016, 3861.262431905626, 3878.0, 3887.1642596841816, 3898.571157172709, 3956.2680904032845, 5523.944760552424, 5533.391326954072, 5550.4449555044575, 5556.833295001156, 5573.442655734435, 5202.531772140525, 5217.739113044333, 5225.790968361261, 5238.580913526908, 5238.711870847102, 5761.366249712528, 5804.100364443518, 5884.261547139448, 6037.939620603782, 6179.196704428396, 4343.022819865537, 4355.564443555619, 4356.934645980313, 4356.956430435686, 4363.607275345203, 6404.679766011681, 6404.743810247584, 6408.967955160194, 6410.0, 6420.165378500812, 4455.844045458393, 4458.4426946631675, 4459.241928872099, 4467.374567560544, 4468.419105516262, 4432.180046691308, 4510.774461276988, 4513.458384993822, 4515.616172625364, 4536.637069034469, 5143.382794064736, 5147.40804807452, 5152.9742351288005, 5153.871153221125, 5155.5617772489, 6165.907511387333, 6171.722272497748, 6171.7531298748445, 6177.62934223948, 6180.81457556274, 1601.2874270949549, 1622.991885040591, 1625.0249850090088, 1626.967460650804, 1630.1604673592872, 1048.8374301983206, 1070.1224995503767, 1079.83262594298, 1093.327603523827, 1121.3103941076179, 5745.827625171251, 5775.104858746901, 5776.653400795882, 5781.942180578225, 5793.8551536211935, 6257.374262573706, 6262.749490020439, 6263.530235232284, 6264.749410023639, 6273.62358258506, 5674.489295963301, 5709.714514274269, 5775.826725198251, 5778.306603207558, 5787.913181302284, 3310.7682462227895, 3322.7840190387546, 3395.7453191010277, 3400.982995085009, 3404.1829960809227, 6513.1532900722605, 6541.182352205974, 6681.76613818514, 6702.463802895854, 6709.329067093349, 6556.409923106848, 6557.540972131905, 6564.0, 6568.96715516429, 6586.73653053882, 6574.704138313788, 6615.371539703817, 6666.100076489709, 6673.9666301668185, 6681.398674119353, 6409.038644203407, 6409.102725618324, 6413.454856337077, 6424.293327734039, 6428.6785660717715, 6340.334264902303, 6353.237611486651, 6360.109584658059, 6361.459275961595, 6363.395477429637, 6463.192100987377, 6603.669816509251, 6648.468122550088, 6685.0306705526455, 6696.129503164558, 4392.758398288125, 4417.624501917373, 4431.7562534060935, 4431.977840110779, 4480.663950203682, 6402.743890244338, 6430.935690643034, 6442.516811239269, 6445.355464453517, 6445.709943052668, 6268.373162683877, 6272.278687950944, 6273.65494897785, 6277.089821975696, 6280.0, 6044.214252147192, 6140.692965351804, 6181.81454556346, 6211.751529938751, 6262.09199666055, 6107.572469927062, 6130.938690613037, 6134.509239260759, 6140.9078863816185, 6142.0, 6187.692338336226, 6271.0, 6274.14912600793, 6274.372562743689, 6280.937190628035, 6016.518678505797, 6106.603070800384, 6111.602745821508, 6114.205153330038, 6117.449429551361], "unit": "score", "name": "prototype.html", "value": 4681.433747899503}, {"lowerIsBetter": false, "replicates": [770.2720928722359, 821.3265122599468, 829.4567058576631, 829.5561874397199, 847.766864112369, 13063.542776002841, 13193.80209296859, 13201.0, 13225.933870330658, 13244.0, 12600.117991740583, 12828.0, 12838.93580532096, 12853.22880627163, 12938.676533086678, 791.8376732769783, 811.290121143999, 814.0963530481162, 815.0382548592659, 815.7675062607158, 669.6082791566915, 675.9053732477457, 785.1912530094012, 796.3072127249301, 798.4650284309527, 847.2036285891273, 850.0309647002422, 853.0786750309682, 853.5604163855619, 854.6666799948025, 840.6931470013432, 842.3850589069982, 842.6123982967842, 843.3379796859497, 843.5866425451546, 516.0891027336754, 519.9844004679828, 599.5862854630291, 624.070135498109, 626.3923993726079, 12814.0, 12815.487380504768, 12844.871551284461, 12845.871541284561, 12864.742705145938, 12794.168379055332, 12929.288889111094, 13001.720040962813, 13109.541166059238, 13371.732565348639, 10709.303895246783, 10814.188935829845, 10852.782944341068, 11084.113270938306, 11210.775784484345, 3690.4464330350393, 3765.642263984917, 3777.9055523611855, 3846.7114966377353, 3848.037990502374, 43344.56655433437, 43434.0, 43557.34663980043, 43770.56229437697, 43808.342874856906, 9719.17387022097, 10164.695059148238, 10224.488775561193, 10236.283460157867, 10640.361578305172, 18055.0, 18145.7278140828, 18164.90917545404, 18169.45491635253, 18208.817911820977, 7542.358899493604, 7642.197569255148, 7715.151333353327, 7793.610319484003, 7800.45396822217, 4244.745315281093, 4260.616544510947, 4264.104538046983, 4266.957330426656, 4275.230458517434, 2830.8584570771377, 2863.226928729273, 2865.412590419001, 2867.7705783537267, 2872.152714949095, 520.0872468817278, 539.0162952611499, 545.0679338331497, 549.1268882476801, 553.0597983428108, 521.8982298451841, 525.0994544356447, 555.3363730342202, 572.9914051289234, 636.2524034259726, 7493.437992150611, 7570.280823321776, 7639.923600764032, 7799.688012479551, 7820.608969551499, 569.4931510955253, 595.7229888102054, 631.9905201421982, 633.4425705379236, 651.4950913042335, 3167.1448708848484, 3389.5593572835373, 3495.3940127123224, 3510.315488479773, 3535.1515636247113, 50502.49497505051, 51152.74423627858, 51284.74357628263, 51304.48695513072, 52427.21359179616, 45241.0, 45389.09221815545, 45921.77039114783, 46973.76513117413, 47239.0, 42323.0, 42332.57667423348, 42976.0, 43178.35232471515, 43874.12251754947, 7011.368976792113, 7042.95258043052, 7081.858362832818, 7233.1681856587165, 7378.815529611588, 32021.0, 32122.0, 32267.838660806545, 33161.0, 33296.0, 37213.0, 37273.81363093167, 39040.41439378468, 41090.1781964365, 41510.1697966045, 10096.69709908704, 10215.23385746087, 10246.282760206714, 10256.0, 10457.320274182153, 10798.56805727762, 10861.34831910088, 10997.61508347204, 11291.266067705574, 11362.375069371265, 9928.801423971625, 10166.135878450414, 10203.846942295722, 10636.680899573024, 10694.14446844235, 9931.304808663324, 10023.599056037678, 10347.27569070188, 10363.94818025905, 10560.788784224118, 9946.254030947563, 9960.252981026308, 10017.348872323275, 10086.596536138471, 10503.107235885036, 8412.116727743743, 8529.402941794264, 8706.0, 8756.343274254585, 9083.909160908306, 8267.503949763033, 8368.958155209186, 8465.195806398382, 8498.830023399621, 8643.524606146722], "unit": "score", "name": "yui.html", "value": 5946.3139816828425}], "name": "dromaeo_css", "value": 6601.42817850344}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 107.0, 111.0, 112.0, 113.0, 101.0, 112.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [160.0, 128.0, 152.0, 168.0, 126.0, 153.0, 158.0, 135.0, 174.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 159.0, 161.0, 162.0, 160.0, 164.0, 166.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 83.0, 98.0, 74.0, 71.0, 71.0, 122.0, 94.0, 72.0], "unit": "score", "name": "audio-fft", "value": 82.8}, {"lowerIsBetter": true, "replicates": [110.0, 96.0, 145.0, 96.0, 96.0, 96.0, 137.0, 97.0, 97.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [108.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 104.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 58.0, 55.0, 55.0, 56.0, 56.0, 64.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 69.0, 65.0, 66.0, 66.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 87.0, 85.0, 86.0, 86.0, 86.0, 92.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [117.0, 129.0, 119.0, 116.0, 131.0, 118.0, 117.0, 119.0, 126.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [147.0, 142.0, 142.0, 152.0, 154.0, 144.0, 159.0, 151.0, 155.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 71.0, 69.0, 73.0, 69.0, 67.0, 67.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1513.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.897918065816], "unit": "score", "name": "Richards", "value": 210.25871200000006}, {"lowerIsBetter": false, "replicates": [192.64110961279138], "unit": "score", "name": "DeltaBlue", "value": 343.2185379999999}, {"lowerIsBetter": false, "replicates": [285.8776443682104], "unit": "score", "name": "Encrypt", "value": 931.1011380000001}, {"lowerIsBetter": false, "replicates": [5268.421052631579], "unit": "score", "name": "Decrypt", "value": 50.52386613386611}, {"lowerIsBetter": false, "replicates": [2020.20202020202], "unit": "score", "name": "RayTrace", "value": 366.2945550000002}, {"lowerIsBetter": false, "replicates": [803.2128514056225], "unit": "score", "name": "Earley", "value": 829.7464350000001}, {"lowerIsBetter": false, "replicates": [11988.095238095239], "unit": "score", "name": "Boyer", "value": 55.59373584905661}, {"lowerIsBetter": false, "replicates": [43063.82978723404], "unit": "score", "name": "RegExp", "value": 21.154295948616586}, {"lowerIsBetter": false, "replicates": [588.2352941176471], "unit": "score", "name": "Splay", "value": 138.53470000000002}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 18766.00155528828}]} 20:23:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18766.00"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1513.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6601.43"}}} 20:23:58 INFO - Return code: 0 20:23:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:23:58 INFO - # TBPL SUCCESS # 20:23:58 INFO - Running post-action listener: _resource_record_post_action 20:23:58 INFO - Running post-run listener: _resource_record_post_run 20:23:59 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 12288; Write bytes: 328896512; Read time: 136; Write time: 174124 20:23:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20611072; Read time: 0; Write time: 5392 20:23:59 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 12288; Write bytes: 308285440; Read time: 136; Write time: 168732 20:23:59 INFO - Running post-run listener: _upload_blobber_files 20:23:59 INFO - Blob upload gear active. 20:23:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:23:59 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:23:59 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:23:59 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:23:59 INFO - (blobuploader) - INFO - Open directory for files ... 20:23:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:23:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:24:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:00 INFO - (blobuploader) - INFO - Done attempting. 20:24:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:24:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:24:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:01 INFO - (blobuploader) - INFO - Done attempting. 20:24:01 INFO - (blobuploader) - INFO - Iteration through files over. 20:24:01 INFO - Return code: 0 20:24:01 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:24:01 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:24:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f9cbb9b4cdb9f673029974ac1e60fc2a8437834fbfd9e1f8451f88759b6ce83dc60c1dd378457d2c41e1e61e60aea5b3c0e817d497628846a0443bd32bc5d6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e50519ba032f410fd6a7d29c5e8b95be4332d493baab3e72c5c739488c6e8469f239e28c9a1cbdddddda71138ee14c50ce622f01221545752c32ceb6bc95c6f5"} 20:24:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:24:01 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:24:01 INFO - Contents: 20:24:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f9cbb9b4cdb9f673029974ac1e60fc2a8437834fbfd9e1f8451f88759b6ce83dc60c1dd378457d2c41e1e61e60aea5b3c0e817d497628846a0443bd32bc5d6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e50519ba032f410fd6a7d29c5e8b95be4332d493baab3e72c5c739488c6e8469f239e28c9a1cbdddddda71138ee14c50ce622f01221545752c32ceb6bc95c6f5"} 20:24:01 INFO - Copying logs to upload dir... 20:24:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1288.016547 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-12 20:24:00.921119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 20:24:00.925027) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f9cbb9b4cdb9f673029974ac1e60fc2a8437834fbfd9e1f8451f88759b6ce83dc60c1dd378457d2c41e1e61e60aea5b3c0e817d497628846a0443bd32bc5d6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e50519ba032f410fd6a7d29c5e8b95be4332d493baab3e72c5c739488c6e8469f239e28c9a1cbdddddda71138ee14c50ce622f01221545752c32ceb6bc95c6f5"} build_url:https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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/Fx-Team/sha512/8f9cbb9b4cdb9f673029974ac1e60fc2a8437834fbfd9e1f8451f88759b6ce83dc60c1dd378457d2c41e1e61e60aea5b3c0e817d497628846a0443bd32bc5d6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e50519ba032f410fd6a7d29c5e8b95be4332d493baab3e72c5c739488c6e8469f239e28c9a1cbdddddda71138ee14c50ce622f01221545752c32ceb6bc95c6f5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 20:24:00.949542) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:24:00.949879) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452654494.740393-1405989032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:24:01.032902) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 20:24:01.033307) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 20:24:01.033638) ========= ========= Total master_lag: 0.23 =========