builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1452307229.0 results: success (0) buildid: 20160108163004 builduid: 857424765f2d49a6997dbaf219a3addf revision: 0f363ae95dc90d593394ef464aa500804c824962 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:28.996146) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:28.996843) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:28.997264) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006322 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.025726) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.026323) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.123217) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.123513) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.178732) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.179068) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.179485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.179815) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 18:40:30-- 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% 222M=0s 2016-01-08 18:40:30 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092942 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.285797) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.286164) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020659 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.335901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.336275) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0f363ae95dc90d593394ef464aa500804c824962 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0f363ae95dc90d593394ef464aa500804c824962 --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=3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 18:40:30,528 truncating revision to first 12 chars 2016-01-08 18:40:30,528 Setting DEBUG logging. 2016-01-08 18:40:30,528 attempt 1/10 2016-01-08 18:40:30,528 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0f363ae95dc9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 18:40:30,769 unpacking tar archive at: mozilla-central-0f363ae95dc9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528036 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.887343) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.887653) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.896815) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.897127) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 18:40:29.897840) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-08 18:40:29.898204) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:40:31 INFO - MultiFileLogger online at 20160108 18:40:31 in /builds/slave/test-pgo 18:40:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:40:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:40:31 INFO - {'append_to_log': False, 18:40:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:40:31 INFO - 'blob_upload_branch': 'Firefox', 18:40:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:40:31 INFO - 'branch': 'Firefox', 18:40:31 INFO - 'buildbot_json_path': 'buildprops.json', 18:40:31 INFO - 'config_files': ('talos/linux_config.py',), 18:40:31 INFO - 'default_actions': ('clobber', 18:40:31 INFO - 'read-buildbot-config', 18:40:31 INFO - 'download-and-extract', 18:40:31 INFO - 'populate-webroot', 18:40:31 INFO - 'create-virtualenv', 18:40:31 INFO - 'install', 18:40:31 INFO - 'run-tests'), 18:40:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:40:31 INFO - 'download_minidump_stackwalk': True, 18:40:31 INFO - 'download_symbols': 'ondemand', 18:40:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:40:31 INFO - 'tooltool.py': '/tools/tooltool.py', 18:40:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:40:31 INFO - '/tools/misc-python/virtualenv.py')}, 18:40:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:40:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:40:31 INFO - 'installer_path': 'installer.exe', 18:40:31 INFO - 'log_level': 'info', 18:40:31 INFO - 'log_name': 'talos', 18:40:31 INFO - 'log_to_console': True, 18:40:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:40:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:40:31 INFO - 'opt_config_files': (), 18:40:31 INFO - 'pip_index': False, 18:40:31 INFO - 'sps_profile': False, 18:40:31 INFO - 'sps_profile_interval': 0, 18:40:31 INFO - 'suite': 'dromaeojs-e10s', 18:40:31 INFO - 'system_bits': '32', 18:40:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:40:31 INFO - 'title': 'talos-linux64-ix-059', 18:40:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:40:31 INFO - 'use_talos_json': True, 18:40:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:40:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:40:31 INFO - 'work_dir': 'build'} 18:40:31 INFO - ##### 18:40:31 INFO - ##### Running clobber step. 18:40:31 INFO - ##### 18:40:31 INFO - Running pre-action listener: _resource_record_pre_action 18:40:31 INFO - Running main action method: clobber 18:40:31 INFO - rmtree: /builds/slave/test-pgo/build 18:40:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:40:31 INFO - Running post-action listener: _resource_record_post_action 18:40:31 INFO - ##### 18:40:31 INFO - ##### Running read-buildbot-config step. 18:40:31 INFO - ##### 18:40:31 INFO - Running pre-action listener: _resource_record_pre_action 18:40:31 INFO - Running main action method: read_buildbot_config 18:40:31 INFO - Using buildbot properties: 18:40:31 INFO - { 18:40:31 INFO - "project": "", 18:40:31 INFO - "product": "firefox", 18:40:31 INFO - "script_repo_revision": "production", 18:40:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:40:31 INFO - "repository": "", 18:40:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 18:40:31 INFO - "buildid": "20160108163004", 18:40:31 INFO - "pgo_build": "True", 18:40:31 INFO - "basedir": "/builds/slave/test-pgo", 18:40:31 INFO - "buildnumber": 295, 18:40:31 INFO - "slavename": "talos-linux64-ix-059", 18:40:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:40:31 INFO - "platform": "ubuntu64_hw", 18:40:31 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:40:31 INFO - "branch": "mozilla-central", 18:40:31 INFO - "repo_path": "mozilla-central", 18:40:31 INFO - "revision": "0f363ae95dc90d593394ef464aa500804c824962", 18:40:31 INFO - "stage_platform": "linux64-pgo", 18:40:31 INFO - "builduid": "857424765f2d49a6997dbaf219a3addf", 18:40:31 INFO - "slavebuilddir": "test" 18:40:31 INFO - } 18:40:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:40:31 INFO - Running post-action listener: _resource_record_post_action 18:40:31 INFO - ##### 18:40:31 INFO - ##### Running download-and-extract step. 18:40:31 INFO - ##### 18:40:31 INFO - Running pre-action listener: _resource_record_pre_action 18:40:31 INFO - Running main action method: download_and_extract 18:40:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:31 INFO - https://queue.taskcluster.net/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:40:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/test_packages.json 18:40:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/test_packages.json 18:40:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:40:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:40:35 INFO - Downloaded 1302 bytes. 18:40:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:40:35 INFO - Using the following test package requirements: 18:40:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:40:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:40:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:35 INFO - u'jsshell-linux-x86_64.zip'], 18:40:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:40:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:40:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:40:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:40:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:40:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:40:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:40:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:35 INFO - https://queue.taskcluster.net/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:40:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:40:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:40:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/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 18:40:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/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 18:40:38 INFO - Downloaded 24028222 bytes. 18:40:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:40:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:40:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:40:39 INFO - Return code: 0 18:40:39 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 18:40:39 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')]} 18:40:39 INFO - https://queue.taskcluster.net/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:40:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:40:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:40:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/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 18:40:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/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 18:40:49 INFO - Downloaded 24028222 bytes. 18:40:49 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 18:40:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:40:49 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 18:40:50 INFO - Return code: 0 18:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:50 INFO - https://queue.taskcluster.net/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:40:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:40:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:40:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/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 18:40:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/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 18:40:52 INFO - Downloaded 11132285 bytes. 18:40:52 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 18:40:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:40:52 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 18:40:52 INFO - Return code: 0 18:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:52 INFO - https://queue.taskcluster.net/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:40:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:40:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:40:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/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 18:40:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/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 18:40:53 INFO - Downloaded 55896222 bytes. 18:40:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:40:53 INFO - mkdir: /builds/slave/test-pgo/properties 18:40:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:40:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:40:53 INFO - Contents: 18:40:53 INFO - build_url:https://queue.taskcluster.net/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:40:53 INFO - Running post-action listener: _resource_record_post_action 18:40:53 INFO - Running post-action listener: set_extra_try_arguments 18:40:53 INFO - ##### 18:40:53 INFO - ##### Running populate-webroot step. 18:40:53 INFO - ##### 18:40:53 INFO - Running pre-action listener: _resource_record_pre_action 18:40:53 INFO - Running main action method: populate_webroot 18:40:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:40:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:40:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:40:53 INFO - '--tppagecycles', 18:40:53 INFO - '7'], 18:40:53 INFO - 'tests': ['tsvgm']}}, 18:40:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:40:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:40:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:40:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:40:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:40:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:40:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:40:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:53 INFO - 'talos_options': ['--e10s'], 18:40:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:40:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:53 INFO - 'tests': ['damp', 'tps']}, 18:40:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:53 INFO - 'talos_options': ['--e10s'], 18:40:53 INFO - 'tests': ['damp', 'tps']}, 18:40:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:40:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:40:53 INFO - 'other': {'tests': ['a11yr', 18:40:53 INFO - 'ts_paint', 18:40:53 INFO - 'tpaint', 18:40:53 INFO - 'sessionrestore', 18:40:53 INFO - 'sessionrestore_no_auto_restore']}, 18:40:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:40:53 INFO - 'tests': ['a11yr', 18:40:53 INFO - 'ts_paint', 18:40:53 INFO - 'tpaint', 18:40:53 INFO - 'sessionrestore', 18:40:53 INFO - 'sessionrestore_no_auto_restore']}, 18:40:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:40:53 INFO - 'tests': ['a11yr', 18:40:53 INFO - 'ts_paint', 18:40:53 INFO - 'tpaint', 18:40:53 INFO - 'sessionrestore', 18:40:53 INFO - 'sessionrestore_no_auto_restore']}, 18:40:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:40:53 INFO - 'tests': ['a11yr', 18:40:53 INFO - 'ts_paint', 18:40:53 INFO - 'tpaint', 18:40:53 INFO - 'sessionrestore', 18:40:53 INFO - 'sessionrestore_no_auto_restore']}, 18:40:53 INFO - 'other_l64': {'tests': ['a11yr', 18:40:53 INFO - 'ts_paint', 18:40:53 INFO - 'tpaint', 18:40:53 INFO - 'sessionrestore', 18:40:53 INFO - 'sessionrestore_no_auto_restore']}, 18:40:53 INFO - 'other_nol64': {'tests': ['a11yr', 18:40:53 INFO - 'ts_paint', 18:40:53 INFO - 'tpaint', 18:40:53 INFO - 'sessionrestore', 18:40:53 INFO - 'sessionrestore_no_auto_restore']}, 18:40:53 INFO - 'svgr': {'tests': ['tsvgx', 18:40:53 INFO - 'tsvgr_opacity', 18:40:53 INFO - 'tart', 18:40:53 INFO - 'tscrollx', 18:40:53 INFO - 'cart']}, 18:40:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:40:53 INFO - 'tests': ['tsvgx', 18:40:53 INFO - 'tsvgr_opacity', 18:40:53 INFO - 'tart', 18:40:53 INFO - 'tscrollx', 18:40:53 INFO - 'cart']}, 18:40:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:53 INFO - 'tests': ['tp5o']}, 18:40:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:53 INFO - 'talos_options': ['--e10s'], 18:40:53 INFO - 'tests': ['tp5o']}, 18:40:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:53 INFO - 'talos_options': ['--xperf_path', 18:40:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:40:53 INFO - 'tests': ['tp5n']}, 18:40:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:53 INFO - 'talos_options': ['--e10s', 18:40:53 INFO - '--xperf_path', 18:40:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:40:53 INFO - 'tests': ['tp5n']}}, 18:40:53 INFO - 'talos.zip': {'path': '', 18:40:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:40:53 INFO - Running post-action listener: _resource_record_post_action 18:40:53 INFO - ##### 18:40:53 INFO - ##### Running create-virtualenv step. 18:40:53 INFO - ##### 18:40:53 INFO - Running pre-action listener: _resource_record_pre_action 18:40:53 INFO - Running main action method: create_virtualenv 18:40:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:40:53 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 18:40:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:40:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:40:54 INFO - Using real prefix '/usr' 18:40:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:40:54 INFO - Installing distribute.............................................................................................................................................................................................done. 18:40:56 INFO - Installing pip.................done. 18:40:56 INFO - Return code: 0 18:40:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:40:56 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')]} 18:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:56 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')]} 18:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:56 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 0x7f80e399ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2379840>, '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 0x22e66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', '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 18:40:56 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 18:40:56 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 18:40:56 INFO - Using env: {'DISPLAY': ':0', 18:40:56 INFO - 'HOME': '/home/cltbld', 18:40:56 INFO - 'LANG': 'en_US.UTF-8', 18:40:56 INFO - 'LANGUAGE': 'en_US:en', 18:40:56 INFO - 'LOGNAME': 'cltbld', 18:40:56 INFO - 'MAIL': '/var/mail/cltbld', 18:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:56 INFO - 'MOZ_NO_REMOTE': '1', 18:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:56 INFO - 'NO_EM_RESTART': '1', 18:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:40:56 INFO - 'PWD': '/builds/slave/test-pgo', 18:40:56 INFO - 'SHELL': '/bin/bash', 18:40:56 INFO - 'SHLVL': '1', 18:40:56 INFO - 'TERM': 'linux', 18:40:56 INFO - 'TMOUT': '86400', 18:40:56 INFO - 'USER': 'cltbld', 18:40:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', 18:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:56 INFO - '_': '/tools/buildbot/bin/python'} 18:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:56 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 18:40:56 INFO - Cleaning up... 18:40:56 INFO - Return code: 0 18:40:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:40:56 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')]} 18:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:56 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')]} 18:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:56 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 0x7f80e399ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2379840>, '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 0x22e66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', '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 18:40:56 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 18:40:56 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 18:40:56 INFO - Using env: {'DISPLAY': ':0', 18:40:56 INFO - 'HOME': '/home/cltbld', 18:40:56 INFO - 'LANG': 'en_US.UTF-8', 18:40:56 INFO - 'LANGUAGE': 'en_US:en', 18:40:56 INFO - 'LOGNAME': 'cltbld', 18:40:56 INFO - 'MAIL': '/var/mail/cltbld', 18:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:56 INFO - 'MOZ_NO_REMOTE': '1', 18:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:56 INFO - 'NO_EM_RESTART': '1', 18:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:40:56 INFO - 'PWD': '/builds/slave/test-pgo', 18:40:56 INFO - 'SHELL': '/bin/bash', 18:40:56 INFO - 'SHLVL': '1', 18:40:56 INFO - 'TERM': 'linux', 18:40:56 INFO - 'TMOUT': '86400', 18:40:56 INFO - 'USER': 'cltbld', 18:40:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', 18:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:56 INFO - '_': '/tools/buildbot/bin/python'} 18:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:57 INFO - Downloading/unpacking psutil>=0.7.1 18:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:40:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:58 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:40:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:40:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:40:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:40:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:40:58 INFO - Installing collected packages: psutil 18:40:58 INFO - Running setup.py install for psutil 18:40:58 INFO - building 'psutil._psutil_linux' extension 18:40:58 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 18:40:59 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 18:40:59 INFO - building 'psutil._psutil_posix' extension 18:40:59 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 18:40:59 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 18:40:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:40:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:40:59 INFO - Successfully installed psutil 18:40:59 INFO - Cleaning up... 18:40:59 INFO - Return code: 0 18:40:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f80e399ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2379840>, '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 0x22e66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', '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 18:40:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:40:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:40:59 INFO - Using env: {'DISPLAY': ':0', 18:40:59 INFO - 'HOME': '/home/cltbld', 18:40:59 INFO - 'LANG': 'en_US.UTF-8', 18:40:59 INFO - 'LANGUAGE': 'en_US:en', 18:40:59 INFO - 'LOGNAME': 'cltbld', 18:40:59 INFO - 'MAIL': '/var/mail/cltbld', 18:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:59 INFO - 'MOZ_NO_REMOTE': '1', 18:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:59 INFO - 'NO_EM_RESTART': '1', 18:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:40:59 INFO - 'PWD': '/builds/slave/test-pgo', 18:40:59 INFO - 'SHELL': '/bin/bash', 18:40:59 INFO - 'SHLVL': '1', 18:40:59 INFO - 'TERM': 'linux', 18:40:59 INFO - 'TMOUT': '86400', 18:40:59 INFO - 'USER': 'cltbld', 18:40:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', 18:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:59 INFO - '_': '/tools/buildbot/bin/python'} 18:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:40:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:41:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:41:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:41:01 INFO - Installing collected packages: mozsystemmonitor 18:41:01 INFO - Running setup.py install for mozsystemmonitor 18:41:01 INFO - Successfully installed mozsystemmonitor 18:41:01 INFO - Cleaning up... 18:41:01 INFO - Return code: 0 18:41:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f80e399ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2379840>, '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 0x22e66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', '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 18:41:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 18:41:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:41:01 INFO - Using env: {'DISPLAY': ':0', 18:41:01 INFO - 'HOME': '/home/cltbld', 18:41:01 INFO - 'LANG': 'en_US.UTF-8', 18:41:01 INFO - 'LANGUAGE': 'en_US:en', 18:41:01 INFO - 'LOGNAME': 'cltbld', 18:41:01 INFO - 'MAIL': '/var/mail/cltbld', 18:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:01 INFO - 'MOZ_NO_REMOTE': '1', 18:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:01 INFO - 'NO_EM_RESTART': '1', 18:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:01 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:01 INFO - 'SHELL': '/bin/bash', 18:41:01 INFO - 'SHLVL': '1', 18:41:01 INFO - 'TERM': 'linux', 18:41:01 INFO - 'TMOUT': '86400', 18:41:01 INFO - 'USER': 'cltbld', 18:41:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', 18:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:01 INFO - '_': '/tools/buildbot/bin/python'} 18:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:01 INFO - Downloading/unpacking blobuploader==1.2.4 18:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:03 INFO - Downloading blobuploader-1.2.4.tar.gz 18:41:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:41:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:41:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:41:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:41:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:04 INFO - Downloading docopt-0.6.1.tar.gz 18:41:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:41:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:41:04 INFO - Installing collected packages: blobuploader, requests, docopt 18:41:04 INFO - Running setup.py install for blobuploader 18:41:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:41:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:41:04 INFO - Running setup.py install for requests 18:41:04 INFO - Running setup.py install for docopt 18:41:04 INFO - Successfully installed blobuploader requests docopt 18:41:04 INFO - Cleaning up... 18:41:04 INFO - Return code: 0 18:41:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:04 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 0x7f80e399ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2379840>, '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 0x22e66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', '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 18:41:04 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 18:41:04 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 18:41:04 INFO - Using env: {'DISPLAY': ':0', 18:41:04 INFO - 'HOME': '/home/cltbld', 18:41:04 INFO - 'LANG': 'en_US.UTF-8', 18:41:04 INFO - 'LANGUAGE': 'en_US:en', 18:41:04 INFO - 'LOGNAME': 'cltbld', 18:41:04 INFO - 'MAIL': '/var/mail/cltbld', 18:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:04 INFO - 'MOZ_NO_REMOTE': '1', 18:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:04 INFO - 'NO_EM_RESTART': '1', 18:41:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:04 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:04 INFO - 'SHELL': '/bin/bash', 18:41:04 INFO - 'SHLVL': '1', 18:41:04 INFO - 'TERM': 'linux', 18:41:04 INFO - 'TMOUT': '86400', 18:41:04 INFO - 'USER': 'cltbld', 18:41:04 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', 18:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:04 INFO - '_': '/tools/buildbot/bin/python'} 18:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:41:05 INFO - Running setup.py (path:/tmp/pip-m3O0e2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:41:05 INFO - Running setup.py (path:/tmp/pip-MrSxEA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:41:05 INFO - Running setup.py (path:/tmp/pip-WiCplu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:41:05 INFO - Running setup.py (path:/tmp/pip-_W7zM9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:41:05 INFO - Running setup.py (path:/tmp/pip-wQ3ECd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:41:05 INFO - Running setup.py (path:/tmp/pip-84hU2h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:41:05 INFO - Running setup.py (path:/tmp/pip-_V0bBr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:41:05 INFO - Running setup.py (path:/tmp/pip-l0HKmQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:41:05 INFO - Running setup.py (path:/tmp/pip-iHiw0k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:41:05 INFO - Running setup.py (path:/tmp/pip-66UX44-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:41:05 INFO - Running setup.py (path:/tmp/pip-KkBc4m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:41:05 INFO - Running setup.py (path:/tmp/pip-RfANzA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:41:05 INFO - Running setup.py (path:/tmp/pip-bWdPOg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:41:05 INFO - Running setup.py (path:/tmp/pip-L93MII-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:41:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:41:06 INFO - Running setup.py (path:/tmp/pip-bKcccE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:41:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:41:06 INFO - Running setup.py (path:/tmp/pip-UF1O6P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:41:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:41:06 INFO - Running setup.py (path:/tmp/pip-A5keO_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:41:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:41:06 INFO - Running setup.py install for manifestparser 18:41:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:41:06 INFO - Running setup.py install for mozcrash 18:41:06 INFO - Running setup.py install for mozdebug 18:41:06 INFO - Running setup.py install for mozdevice 18:41:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:41:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:41:06 INFO - Running setup.py install for mozfile 18:41:06 INFO - Running setup.py install for mozhttpd 18:41:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:41:06 INFO - Running setup.py install for mozinfo 18:41:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:41:06 INFO - Running setup.py install for mozInstall 18:41:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:41:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:41:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:41:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:41:07 INFO - Running setup.py install for mozleak 18:41:07 INFO - Running setup.py install for mozlog 18:41:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:41:07 INFO - Running setup.py install for moznetwork 18:41:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:41:07 INFO - Running setup.py install for mozprocess 18:41:07 INFO - Running setup.py install for mozprofile 18:41:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:41:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:41:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:41:07 INFO - Running setup.py install for mozrunner 18:41:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:41:07 INFO - Running setup.py install for mozscreenshot 18:41:07 INFO - Running setup.py install for moztest 18:41:07 INFO - Running setup.py install for mozversion 18:41:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:41:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:41:08 INFO - Cleaning up... 18:41:08 INFO - Return code: 0 18:41:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:41:08 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')]} 18:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:08 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')]} 18:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:08 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 0x7f80e399ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2379840>, '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 0x22e66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', '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 18:41:08 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 18:41:08 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 18:41:08 INFO - Using env: {'DISPLAY': ':0', 18:41:08 INFO - 'HOME': '/home/cltbld', 18:41:08 INFO - 'LANG': 'en_US.UTF-8', 18:41:08 INFO - 'LANGUAGE': 'en_US:en', 18:41:08 INFO - 'LOGNAME': 'cltbld', 18:41:08 INFO - 'MAIL': '/var/mail/cltbld', 18:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:08 INFO - 'MOZ_NO_REMOTE': '1', 18:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:08 INFO - 'NO_EM_RESTART': '1', 18:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:08 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:08 INFO - 'SHELL': '/bin/bash', 18:41:08 INFO - 'SHLVL': '1', 18:41:08 INFO - 'TERM': 'linux', 18:41:08 INFO - 'TMOUT': '86400', 18:41:08 INFO - 'USER': 'cltbld', 18:41:08 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', 18:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:08 INFO - '_': '/tools/buildbot/bin/python'} 18:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:41:08 INFO - Running setup.py (path:/tmp/pip-IKpXKD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:41:08 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)) 18:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:41:08 INFO - Running setup.py (path:/tmp/pip-FEUz6W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:41:08 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)) 18:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:41:08 INFO - Running setup.py (path:/tmp/pip-JYL7tW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:41:08 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)) 18:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:41:08 INFO - Running setup.py (path:/tmp/pip-k5GiFq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:41:08 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)) 18:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:41:08 INFO - Running setup.py (path:/tmp/pip-Dm1H9l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:41:08 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)) 18:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:41:08 INFO - Running setup.py (path:/tmp/pip-NR_2Pi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:41:08 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)) 18:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:41:08 INFO - Running setup.py (path:/tmp/pip-oxV7K6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:41:08 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)) 18:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:41:08 INFO - Running setup.py (path:/tmp/pip-rHPppY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:41:08 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)) 18:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:41:08 INFO - Running setup.py (path:/tmp/pip-usrtS_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:41:08 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)) 18:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:41:08 INFO - Running setup.py (path:/tmp/pip-e3vBpE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:41:08 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)) 18:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:41:08 INFO - Running setup.py (path:/tmp/pip-q3xtSc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:41:09 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)) 18:41:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:41:09 INFO - Running setup.py (path:/tmp/pip-R_xDsi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:41:09 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)) 18:41:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:41:09 INFO - Running setup.py (path:/tmp/pip-3qvgAd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:41:09 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)) 18:41:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:41:09 INFO - Running setup.py (path:/tmp/pip-SAnjw3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:41:09 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)) 18:41:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:41:09 INFO - Running setup.py (path:/tmp/pip-gnOTxT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:41:09 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)) 18:41:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:41:09 INFO - Running setup.py (path:/tmp/pip-N4zRky-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:41:09 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)) 18:41:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:41:09 INFO - Running setup.py (path:/tmp/pip-8i2JrK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:41:09 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)) 18:41:09 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)) 18:41:09 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)) 18:41:09 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)) 18:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:41:09 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)) 18:41:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:41: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 18:41: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 18:41: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 18:41: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 18:41: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 18:41: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 18:41:11 INFO - Downloading blessings-1.5.1.tar.gz 18:41:11 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 18:41:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:41:11 INFO - Installing collected packages: blessings 18:41:11 INFO - Running setup.py install for blessings 18:41:11 INFO - Successfully installed blessings 18:41:11 INFO - Cleaning up... 18:41:11 INFO - Return code: 0 18:41:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:41:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:41:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:41:11 INFO - Reading from file tmpfile_stdout 18:41:11 INFO - Current package versions: 18:41:11 INFO - argparse == 1.2.1 18:41:11 INFO - blessings == 1.5.1 18:41:11 INFO - blobuploader == 1.2.4 18:41:11 INFO - docopt == 0.6.1 18:41:11 INFO - manifestparser == 1.1 18:41:11 INFO - mozInstall == 1.12 18:41:11 INFO - mozcrash == 0.16 18:41:11 INFO - mozdebug == 0.1 18:41:11 INFO - mozdevice == 0.47 18:41:11 INFO - mozfile == 1.2 18:41:11 INFO - mozhttpd == 0.7 18:41:11 INFO - mozinfo == 0.9 18:41:11 INFO - mozleak == 0.1 18:41:11 INFO - mozlog == 3.1 18:41:11 INFO - moznetwork == 0.27 18:41:11 INFO - mozprocess == 0.22 18:41:11 INFO - mozprofile == 0.28 18:41:11 INFO - mozrunner == 6.11 18:41:11 INFO - mozscreenshot == 0.1 18:41:11 INFO - mozsystemmonitor == 0.0 18:41:11 INFO - moztest == 0.7 18:41:11 INFO - mozversion == 1.4 18:41:11 INFO - psutil == 3.1.1 18:41:11 INFO - requests == 1.2.3 18:41:11 INFO - wsgiref == 0.1.2 18:41:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:41: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')]} 18:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41: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')]} 18:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41: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', '-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 0x7f80e399ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2379840>, '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 0x22e66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', '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 18:41:11 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 18:41:11 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 18:41:11 INFO - Using env: {'DISPLAY': ':0', 18:41:11 INFO - 'HOME': '/home/cltbld', 18:41:11 INFO - 'LANG': 'en_US.UTF-8', 18:41:11 INFO - 'LANGUAGE': 'en_US:en', 18:41:11 INFO - 'LOGNAME': 'cltbld', 18:41:11 INFO - 'MAIL': '/var/mail/cltbld', 18:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:11 INFO - 'MOZ_NO_REMOTE': '1', 18:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:11 INFO - 'NO_EM_RESTART': '1', 18:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:11 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:11 INFO - 'SHELL': '/bin/bash', 18:41:11 INFO - 'SHLVL': '1', 18:41:11 INFO - 'TERM': 'linux', 18:41:11 INFO - 'TMOUT': '86400', 18:41:11 INFO - 'USER': 'cltbld', 18:41:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', 18:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:11 INFO - '_': '/tools/buildbot/bin/python'} 18:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:11 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)) 18:41:11 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)) 18:41:11 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)) 18:41:11 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)) 18:41:11 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)) 18:41:11 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)) 18:41:11 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)) 18:41:11 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)) 18:41:11 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)) 18:41:11 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)) 18:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:41:11 INFO - Cleaning up... 18:41:11 INFO - Return code: 0 18:41:11 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:41: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')]} 18:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41: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')]} 18:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80e399ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2379840>, '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 0x22e66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', '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 18:41: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', 'jsonschema'] in /builds/slave/test-pgo/build 18:41: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 jsonschema 18:41:11 INFO - Using env: {'DISPLAY': ':0', 18:41:11 INFO - 'HOME': '/home/cltbld', 18:41:11 INFO - 'LANG': 'en_US.UTF-8', 18:41:11 INFO - 'LANGUAGE': 'en_US:en', 18:41:11 INFO - 'LOGNAME': 'cltbld', 18:41:11 INFO - 'MAIL': '/var/mail/cltbld', 18:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:11 INFO - 'MOZ_NO_REMOTE': '1', 18:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:11 INFO - 'NO_EM_RESTART': '1', 18:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:11 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:11 INFO - 'SHELL': '/bin/bash', 18:41:11 INFO - 'SHLVL': '1', 18:41:11 INFO - 'TERM': 'linux', 18:41:11 INFO - 'TMOUT': '86400', 18:41:11 INFO - 'USER': 'cltbld', 18:41:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', 18:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:11 INFO - '_': '/tools/buildbot/bin/python'} 18:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:12 INFO - Downloading/unpacking jsonschema 18:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:41:13 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 18:41:13 INFO - Downloading/unpacking functools32 (from jsonschema) 18:41: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 18:41: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 18:41: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 18:41: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 18:41: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 18:41: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 18:41:13 INFO - Downloading functools32-3.2.3-2.tar.gz 18:41:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:41:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:41:14 INFO - warning: no files found matching '*.txt' 18:41:14 INFO - no previously-included directories found matching 'build' 18:41:14 INFO - no previously-included directories found matching 'dist' 18:41:14 INFO - no previously-included directories found matching '.git*' 18:41:14 INFO - Installing collected packages: jsonschema, functools32 18:41:14 INFO - Running setup.py install for functools32 18:41:14 INFO - warning: no files found matching '*.txt' 18:41:14 INFO - no previously-included directories found matching 'build' 18:41:14 INFO - no previously-included directories found matching 'dist' 18:41:14 INFO - no previously-included directories found matching '.git*' 18:41:14 INFO - Successfully installed jsonschema functools32 18:41:14 INFO - Cleaning up... 18:41:14 INFO - Return code: 0 18:41:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:41: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')]} 18:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41: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')]} 18:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:14 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 0x7f80e399ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2379840>, '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 0x22e66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', '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 18:41:14 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 18:41:14 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 18:41:14 INFO - Using env: {'DISPLAY': ':0', 18:41:14 INFO - 'HOME': '/home/cltbld', 18:41:14 INFO - 'LANG': 'en_US.UTF-8', 18:41:14 INFO - 'LANGUAGE': 'en_US:en', 18:41:14 INFO - 'LOGNAME': 'cltbld', 18:41:14 INFO - 'MAIL': '/var/mail/cltbld', 18:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:14 INFO - 'MOZ_NO_REMOTE': '1', 18:41:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:14 INFO - 'NO_EM_RESTART': '1', 18:41:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:14 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:14 INFO - 'SHELL': '/bin/bash', 18:41:14 INFO - 'SHLVL': '1', 18:41:14 INFO - 'TERM': 'linux', 18:41:14 INFO - 'TMOUT': '86400', 18:41:14 INFO - 'USER': 'cltbld', 18:41:14 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', 18:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:14 INFO - '_': '/tools/buildbot/bin/python'} 18:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:14 INFO - Downloading/unpacking flake8 18:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:41:16 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 18:41:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:41:16 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 18:41:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:16 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 18:41:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:41:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:41:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:41:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:41:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:41:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:41:16 INFO - no previously-included directories found matching 'docs/_build' 18:41:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:41:16 INFO - Running setup.py install for pep8 18:41:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:41:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:41:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:41:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:41:16 INFO - no previously-included directories found matching 'docs/_build' 18:41:16 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:41:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:41:17 INFO - Cleaning up... 18:41:17 INFO - Return code: 0 18:41:17 INFO - Running post-action listener: _resource_record_post_action 18:41:17 INFO - Running post-action listener: _start_resource_monitoring 18:41:17 INFO - Starting resource monitoring. 18:41:17 INFO - ##### 18:41:17 INFO - ##### Running install step. 18:41:17 INFO - ##### 18:41:17 INFO - Running pre-action listener: _resource_record_pre_action 18:41:17 INFO - Running main action method: install 18:41:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:41:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:41:17 INFO - Reading from file tmpfile_stdout 18:41:17 INFO - Detecting whether we're running mozinstall >=1.0... 18:41:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:41:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:41:17 INFO - Reading from file tmpfile_stdout 18:41:17 INFO - Output received: 18:41:17 INFO - Usage: mozinstall [options] installer 18:41:17 INFO - Options: 18:41:17 INFO - -h, --help show this help message and exit 18:41:17 INFO - -d DEST, --destination=DEST 18:41:17 INFO - Directory to install application into. [default: 18:41:17 INFO - "/builds/slave/test-pgo"] 18:41:17 INFO - --app=APP Application being installed. [default: firefox] 18:41:17 INFO - mkdir: /builds/slave/test-pgo/build/application 18:41:17 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'] 18:41:17 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 18:41:33 INFO - Reading from file tmpfile_stdout 18:41:33 INFO - Output received: 18:41:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:41:33 INFO - Running post-action listener: _resource_record_post_action 18:41:33 INFO - ##### 18:41:33 INFO - ##### Running run-tests step. 18:41:33 INFO - ##### 18:41:33 INFO - Running pre-action listener: _resource_record_pre_action 18:41:33 INFO - Running main action method: run_tests 18:41:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:41:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:41:33 INFO - Python 2.7.3 18:41:33 INFO - Return code: 0 18:41:33 INFO - grabbing minidump binary from tooltool 18:41:33 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')]} 18:41:33 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 0x2379840>, '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 0x22e66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:41:33 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 18:41:33 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 18:41:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:41:33 INFO - Return code: 0 18:41:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:41:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:41:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:41:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:41:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:41:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:41:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:41:34 INFO - Return code: 0 18:41:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 18:41:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:41:34 INFO - Using env: {'DISPLAY': ':0', 18:41:34 INFO - 'HOME': '/home/cltbld', 18:41:34 INFO - 'LANG': 'en_US.UTF-8', 18:41:34 INFO - 'LANGUAGE': 'en_US:en', 18:41:34 INFO - 'LOGNAME': 'cltbld', 18:41:34 INFO - 'MAIL': '/var/mail/cltbld', 18:41:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:41:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:34 INFO - 'MOZ_NO_REMOTE': '1', 18:41:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:34 INFO - 'NO_EM_RESTART': '1', 18:41:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:34 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:41:34 INFO - 'SHELL': '/bin/bash', 18:41:34 INFO - 'SHLVL': '1', 18:41:34 INFO - 'TERM': 'linux', 18:41:34 INFO - 'TMOUT': '86400', 18:41:34 INFO - 'USER': 'cltbld', 18:41:34 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329', 18:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:34 INFO - '_': '/tools/buildbot/bin/python'} 18:41:34 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:41:34 INFO - mozversion application_buildid: 20160108163004 18:41:34 INFO - mozversion application_changeset: 0f363ae95dc90d593394ef464aa500804c824962 18:41:34 INFO - mozversion application_display_name: Nightly 18:41:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:41:34 INFO - mozversion application_name: Firefox 18:41:34 INFO - mozversion application_remotingname: firefox 18:41:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:41:34 INFO - mozversion application_vendor: Mozilla 18:41:34 INFO - mozversion application_version: 46.0a1 18:41:34 INFO - mozversion platform_buildid: 20160108163004 18:41:34 INFO - mozversion platform_changeset: 0f363ae95dc90d593394ef464aa500804c824962 18:41:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:41:34 INFO - mozversion platform_version: 46.0a1 18:41:34 INFO - using testdate: 1452307294 18:41:34 INFO - actual date: 1452307294 18:41:34 INFO - starting webserver on 'localhost:60171' 18:41:34 INFO - SUITE-START | Running 3 tests 18:41:34 INFO - TEST-START | dromaeo_css 18:41:34 INFO - operating with platform_type : linux_ 18:41:34 INFO - Initialising browser for dromaeo_css test... 18:41:34 INFO - TEST-INFO | started process 6763 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph1M1w9/profile http://localhost:60171/getInfo.html) 18:41:38 INFO - PROCESS | 6763 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 18:41:38 INFO - PROCESS | 6763 | __metrics Screen width/height:1600/1200 18:41:38 INFO - PROCESS | 6763 | colorDepth:24 18:41:38 INFO - PROCESS | 6763 | Browser inner width/height: 1024/697 18:41:38 INFO - PROCESS | 6763 | __metrics 18:41:38 INFO - PROCESS | 6763 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:41:39 INFO - TEST-INFO | 6763: exit 0 18:41:39 INFO - Browser initialized. 18:41:39 INFO - Running cycle 1/1 for dromaeo_css test... 18:41:39 INFO - TEST-INFO | started process 6897 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph1M1w9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:41:51 INFO - PROCESS | 6897 | RSS: Main: 151040000 18:41:51 INFO - PROCESS | 6897 | 18:42:41 INFO - PROCESS | 6897 | 1452307361192 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] 18:44:50 INFO - PROCESS | 6897 | Cycle 1(1): loaded http://localhost:60171/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60171/tests/dromaeo/cssquery-ext.html) 18:44:51 INFO - PROCESS | 6897 | RSS: Main: 158896128 18:44:51 INFO - PROCESS | 6897 | 18:47:53 INFO - PROCESS | 6897 | Cycle 1(1): loaded http://localhost:60171/tests/dromaeo/cssquery-ext.html (next: http://localhost:60171/tests/dromaeo/cssquery-jquery.html) 18:47:53 INFO - PROCESS | 6897 | RSS: Main: 153120768 18:47:53 INFO - PROCESS | 6897 | 18:50:55 INFO - PROCESS | 6897 | Cycle 1(1): loaded http://localhost:60171/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60171/tests/dromaeo/cssquery-mootools.html) 18:50:56 INFO - PROCESS | 6897 | RSS: Main: 153759744 18:50:56 INFO - PROCESS | 6897 | 18:53:57 INFO - PROCESS | 6897 | Cycle 1(1): loaded http://localhost:60171/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60171/tests/dromaeo/cssquery-prototype.html) 18:53:58 INFO - PROCESS | 6897 | RSS: Main: 153264128 18:53:58 INFO - PROCESS | 6897 | 18:57:00 INFO - PROCESS | 6897 | Cycle 1(1): loaded http://localhost:60171/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60171/tests/dromaeo/cssquery-yui.html) 18:57:01 INFO - PROCESS | 6897 | RSS: Main: 153759744 18:57:01 INFO - PROCESS | 6897 | 19:00:03 INFO - PROCESS | 6897 | Cycle 1(1): loaded http://localhost:60171/tests/dromaeo/cssquery-yui.html (next: http://localhost:60171/tests/dromaeo/cssquery-dojo.html) 19:00:04 INFO - PROCESS | 6897 | RSS: Main: 155570176 19:00:04 INFO - PROCESS | 6897 | 19:00:04 INFO - PROCESS | 6897 | __start_tp_report 19:00:04 INFO - PROCESS | 6897 | _x_x_mozilla_page_load 19:00:04 INFO - PROCESS | 6897 | _x_x_mozilla_page_load_details 19:00:04 INFO - PROCESS | 6897 | |i|pagename|runs| 19:00:04 INFO - PROCESS | 6897 | |0;dojo.html;3122.6252849658035;3139.670334614865;3174.333389988102;3188.2188863728384;3198.360327934414;5221.817236396727;5276.894462110756;5296.417394086652;5300.546992537387;5311.62818602698;5227.294315267438;5244.029854476925;5267;5401.513863752271;5496.560275177986;4815.903681926359;4908.754562271881;4926.359573255471;4939.876503087434;4953.678010929296;4831.637627177958;4893.388326459192;4900.730459824708;4913.606911447094;4918.385201849769;4855.465898751135;4918.5819205367225;4951.925721114186;4958.231474121517;4968.180250258703;4848.10310092634;4852.733099679516;4861.2222044473065;4876.902461950776;4899.975500122512;4781.42622885256;4835.5889749371345;4837.975810120927;4872.123017856784;4903.387076615423;5111.821086262;5120.769565369567;5139.331886854722;5182.222666600002;5185.299984502081;5650.830475085754;5710.971445142789;5732.656040637575;5746.827595172152;5754.3094828620415;5568.693721845297;5685.4883060524335;5794.956907756644;5806.709664516758;5825.359210486843;5433.157860531624;5494.230807686927;5498.780048798043;5499.230107784913;5542.251796007527;5847.44449277318;5887.35239123696;5894.469497745224;5897.085951677497;5901.380355062743;5548.500634942875;5641.153826925994;5649;5664.0937450007805;5676.602637815313;5784.537237021028;5792.247007889032;5794.50746686528;5806.2451881255165;5827.59206855516;5741.45456181662;5755.85610359736;5773.04744717117;5778.046622307273;5824.475797178275;5674.914876276859;5777.537796976232;5781.8554536136935;5809.82570522885;5877.52979761618;4433.46798384196;4440.045390241114;4447.221736196153;4453.643708503312;4470.597646211857;3927.410888366711;3946.723729338919;3955.7033222508426;3984.6015398460504;4021.095253567982;5182.196759502283;5216.347956505437;5247.317848679647;5257.474252574789;5301.469853014668;5730.914036289459;5734.541236701138;5748.080307150836;5751.568632352507;5758.3665796762325;5154.355705536808;5217.452167522356;5224.216367544898;5235.764390602432;5263.947360526346;4854.927176092361;4866.245731911559;4902.0441014002645;4918.631102667314;4958.355413796184;5915;5951.5238780897425;5953.404659534012;5967.761289548456;5968.46283834457;5668.603197776116;5770.6249093808765;5780.075187969905;5809;5810.680412577349;5822.534197264124;5870.17817505541;5891.204687367322;5899.67551784656;5903;5725.770969161187;5790.536757059341;5793.507551858139;5793.594448388741;5810.4189581041555;5715.428457154251;5819.127130930395;5819.156222347651;5830.329512106162;5898.64608123514;5590.776368945197;5591.8881622368135;5592.328920529562;5599.0761524349655;5622.072358060874;5558.194061861089;5578.219049333015;5583.553315734813;5586.190002449541;5590.105583106683;5430.185472179205;5522.420145884625;5536.806211782568;5583.218349431164;5613.46672066153;5569.860753481195;5572.804951826666;5617.32592088952;5629.408912064175;5635.605507614591;5478.096114141122;5485.259489968963;5487.231787549826;5496.450354964471;5500.50495455411 19:00:04 INFO - PROCESS | 6897 | |1;ext.html;538.1416640458467;555.1478480532381;558.5113026102161;562.8002059268962;565.1071307334412;36091.63908360916;36867.26265474689;36892.81553592235;37035.814820925894;37068.44397334042;42367.57632423675;42624.57375426253;42671.57328426722;42769.78615106928;42966.78516607413;8526;8743.12568743127;8779.517126558037;8785.165409286108;8787.25308348791;8464.746057618251;8611.440256383346;8651.783705407352;8654.264387527068;8659;8615.052344242129;8690.522021288827;8713.60788764504;8715.95642021789;8716.825663486727;8404.865343178653;8567.82864342716;8584.8712269316;8615.138486151398;8635.870461943075;8415.705450309271;8575.142485751438;8590.098039705803;8592.699255526026;8597.312215022783;40355.19289614191;40420.595794041976;40437.59562404397;40857.38713919264;40950;3246.724028457584;3426.7258619310396;3435.4846772984;3488.5639295088113;3884.8057597120032;30239.395212095857;30405.543916841267;30580.847095764602;30639.846800765852;30655.540166897514;3402.2515046689687;3411.8805841795665;3438.2263990602164;3459.567554055743;3524.9118772030647;271262;271350;272066;273272.6336368325;273428;42956.57043429526;43533.12933741308;43604.56395436068;56514.71742641343;57051.14423283654;41345.37981930273;41754;41824;41968.370474442905;42045.579544204775;13215.537456188988;13254.138480998705;13281.335933203494;13304.534341298202;13371.197728136343;11618.186726929034;11634.883651163549;11740.647780566596;11768.764624707457;11791.410429478663;14337.35481903317;14418.206998615176;14432.711345773236;14582.270886455635;14632.853671463363;5829.300483941955;5955.838611470722;5972.13404056418;6000.609960352563;6059.909101363483;908.7319240823973;941.1717688434134;979.3438396274513;1121.7532142928542;1159.7616599962155;29378.85310573476;29421.55867661987;29455.558166627517;29871.701282987327;29947;1046.1526163807341;1051.5268129341673;1059.8569193158978;1071.50175168547;1176.5235079792697;13727.665799254672;14490.85509144916;14496.710065798625;14645.901557383238;14653.12081275127;394495;398290;399200;399695;400415;53694.7315263429;53745;53957.1906421404;53960.46039539633;53973.730131349876;1385.8267716535433;1391;1400.649837540615;1401.2503310728914;1405.7469655462319;26779.33051673724;27792.16623501298;27938.16185514438;28217.294567635974;28226.85886570554;42758.358624620036;43548.78225608852;43567.56432435635;43677;43690;294510;294731;296681;297404;298392;32269.51595726113;41876;42940.35589466098;43690.78154609207;43923.78038109789;40285.39571906365;41409.37885931653;41721;41844.37233441562;42393;34895.476567850994;34919.82540087283;35142;35301.82349088238;35351.823240883634;34630.480542791374;35209.47185792164;35433.82283088568;35550.64449355473;35906.8204658975;35874.820625896704;36533;37937.4309385365;38901.805490972365;39030.21939561136;29773.851130744206;32050.519242211853;34042;34069.659303406646;34403.82798085993;25825.225243242734;25996.8700156498;26091.869540652177;26172.476550468502;26421 19:00:04 INFO - PROCESS | 6897 | |2;jquery.html;343.510497541004;347.5724858424138;354.87047227761866;359.955005624297;360.1482493901922;16212.675746485063;16610.58473538159;16688.41590544331;17419.73870391945;18002.549936251584;14398.568042958728;14437.061590996578;14616.12303261805;14624.195669238188;15444.613884652861;4637.675362724603;4996.425411077718;5008.924866127011;5015.899682006376;5026.321446604698;4542.364069030338;4932.210846264598;4940.34284360844;5005.374328208974;5007.32401125847;5387.703676297802;5393.083175860113;6182.289036760762;6486.805395838132;6517.478601711851;6421.8073457796345;6430.228372595295;6498.545101842873;6743.055972163901;6770.119884415044;6229.37706229378;6442.710078046499;6452.870942581169;6469.935300647027;6615.5369124161325;21265.787342126536;21646.891765541073;21769.673454898188;21958.451038724;22739.431514212112;2102.2642075273684;2204.7244094488187;2237.161064600775;2256.4922892349255;2405.915792947256;13689.247091409969;13711.657208569766;13720.519781807689;14335;14704.33830477631;1865.309835360925;1964.489232799468;1988.8607797454183;2033.755949286095;2047.2220556188702;61182;63656.36343636597;65148;66052.3394766051;66226.33773662298;14518;15073.397064117531;15100.320485578175;15114.244287785787;15170.393184272727;23320.883395582914;23353;23404.7659523406;23653.645195322082;23688.64467032996;6916.100906882073;7271.600061996641;7514.774556763306;7540.886886696704;7585.241475852371;7289.963550182321;7348.669309881068;7352.926470735331;7375.11498620169;7392.4086073115095;3958.9010274743364;3976.0855003349393;4026.9597304026584;4117.155983023473;4122.793860307032;1752.1852338662584;1754.850837678786;1788.418763901737;1798.7751531058618;1809.5837957269903;841.2050612171439;907.4011152639226;1003.0471052500009;1037.7042542875245;1038.408107378802;14383.424663013571;15256.160911149993;15373.1544765039;15797.763033554505;16517.091559964076;902.4269588811152;936.6066252174103;940.191435365585;970.3110791338229;1012.4431562640666;9374.296927730311;9521.23830093591;9612.423254604746;9627;9685.951570242103;448793;451412;455536;462923;497725;68327.65836170886;70749.29250707426;71193.28806711867;71330;71512.28487715057;1058.439027315524;1071.614218881202;1073.3881687438086;1084.4957094950728;1092.639428988448;14212.502562410265;14650.926745366205;14853.925730371711;14902.701945960804;14949.85050149528;30468.542971855884;30690.84654576713;30859.537106942964;31186.844065779525;31449.685503144676;35732;36508.087297817765;36605;36700.26599468049;37428.81285593664;3027.107003433948;3044.6346438426644;5636.971815140898;6934.479914006369;7230.45771567124;9578.568964396758;10213.642522511676;10262.384256944608;11076.113910886948;11257.549698011988;8901.73294801157;9425.38734982224;9586.520673966414;9953.253505986935;10068.89931100709;9529.475878826453;9767;9885.752856178653;9947;10257.435841028517;8769.429987050822;9207.76980575491;9927.305088643725;10110.545025474019;10197.286189966631;7146.142462904485;7346.77959661211;7421.517601355895;7511.286427789351;7592.544447333178;9012.32407569448;9889.208863291064;10035.046670566284;10149.594016239267;10325 19:00:04 INFO - PROCESS | 6897 | |3;mootools.html;1406.528812847696;1466.3987765016343;1642.252774987381;1783.1619139004663;1804.2061492943103;7352.779416617496;7550.5847178405165;7554.697812087524;7592.9240707592835;7721.459497835153;7777.533347999124;7798.8440231195345;7846.293833554979;7850.940123083396;7868.92131078689;2286.668433077207;2303.9193628223015;2314.0396735354807;2314.5833749925005;2325.9651105233434;2226.3432287475152;2239.1267405711787;2247.4269061389323;2259.2431535435567;2270.750217476076;2166.2418153646254;2201.7688142745023;2220.622494175994;2278.088764494199;2295.2655150351893;2164.3182397544724;2187.639039558471;2192.3203806819856;2202.1411649456722;2203.493196564791;2252.14418520961;2263.9434014149615;2276.920307789236;2278.874661893595;2286.554121946221;7256.96371518139;7265.963670181668;7282.635868206568;7290.81772955675;7303.160136584254;4541.591256786872;4634.420697412824;4636.35091087248;4642.628589712815;4649.535046495357;2814.746672799458;2944.219781757836;2948.8083274587084;2954.1432984434487;2958.45268625305;910.6676063236937;919.2140719684706;934.7476181430976;948.2840455456155;958.520739630185;10391.480425978747;10519.84220236697;10532.42071686057;10551.73620659482;10598.576056957712;3976.542697589814;3982.1438390745548;4048.817803198863;4064.573219811877;4068.572799856032;8678.78303042429;8683.044865064838;8697.043325234219;8702.564871756513;8713.085126061798;4575.7483338416705;4595.563421474954;4597.632189424838;4607.976960115245;4626.1441633297945;4243.405923170759;4244.808983595745;4261.041265715251;4266.296061149876;4269.31690929456;3410.710089642408;3428.074419906611;3435.4503279475166;3456.8271586421083;3478.373892699288;1010.2625083688802;1014.1633152649094;1018.4907546226887;1023.3910823060268;1029.8352263637782;1059.8569193158826;1082.5182793656747;1085.2999815119204;1219.4207751318231;1328.110166188656;6942.861142777117;6982.93017069833;6984.301569842975;6987.510874238755;7227.457940654472;1117.8602674665667;1123.550579768083;1156.4680247086435;1162.035510526261;1166.8133098704166;5431.565474762009;5573.303337082864;5580.693061881636;5600;5619.662820230799;8723.084076172037;8792.736217913473;8896.510691911877;9271;9342.859857102148;9192.080791920755;9207.539623018822;9247.676331328372;9271.536423178813;9336.253099752004;6985.755498557526;7036.648167591702;7244.601546914971;7371.6682749276415;7383.483156179123;7217.963910180415;7241.203467618452;7246.239144889711;7246.384057355184;7309.4152467803515;7986.680532778624;8062.677492900453;8159.3880458967005;8185.099639039582;8198.795030124294;8105.959470202612;8418.957905210435;8427.494350338999;8510.31917446615;8510.82978340442;6564.146660934048;6596.5052621052655;6649.567778094409;6675.365840245169;6925.653717314013;7222.74720384784;7253.093363329584;7259.455540834564;7263.6005019724425;7286.380657644159;6103.84740381494;6732.192136943598;6930.792076237721;6995.685194166376;7119.466040047121;6818.727250909908;6820.795376138723;6831.9658401707675;6875.278095799869;6936.098307220231;6720.563163394364;7038.577685338896;7066.823329416806;7075.257098004636;7099.467539934629;6503.25212600557;6507.577007494498;6526;6527.379898909596;6540.803775886731;6360.840978975562;6361.077643741724;6396.296407395276;6480.189976252968;6487.253965793994 19:00:04 INFO - PROCESS | 6897 | |4;prototype.html;328.6729703944575;330.039584808208;334.48322341981634;338.95939465839865;346.61352591860066;6234.594751341159;6246.750649870027;6274.529410294234;6282.623042617446;6396.424321811036;6239.438450539451;6241.750329986807;6258.812235632939;6258.874822503547;6279.277883043452;4716.434027916637;4728.66899317048;4733.431988161426;4733.952660473386;4734.242521196609;4732.408448943882;4738.620910327183;4742.193827049393;4742.217534106868;4748.453927798313;4549.613282870943;4600.700954437968;4608.4700259470255;4618.1687296286655;4663.044075964419;4578.221702310615;4605.677602567822;4609.815607375701;4614.630829533646;4638.930416043762;3999.5800440953863;4018.45750823638;4030.496187976503;4032.778197199153;4033.69747268956;5864.44287792659;5906.291245050621;5913.2608423947;5921.555883308726;5926.762929482816;5294.100002999499;5437.619366644337;5467.726613669301;5475.616706830523;5481.698506582136;6613.3056029117215;6616.536842421033;6620.86758264832;6624.138861947964;6632.8673426531195;4450.977745111286;4471.7987690554;4475.753833539154;4493.505714371417;4510.458744950594;6756.459483241329;6832.248452670202;6868.141482314711;6901.792946211572;6926.688299026556;4609.585137337655;4611.561901619408;4611.677182597186;4617.492075871652;4633.328167415773;4667.929981050287;4674.626029917598;4680.08738296029;4682.765861706969;4684.297355396649;5409.594280428983;5412.052890744183;5434.076207044733;5436.157395603688;5447.019536483471;6504.252011018699;6621.668916554153;6649.567778094409;6660.8667826643195;6661.866762664719;1631.0947424179458;1635.8527732503894;1638.2382192280647;1638.336473728142;1641.9261133249033;1077.8383242513685;1079.6383211624036;1094.731790711265;1097.8572785537829;1121.8485504456958;6127.448529632355;6129.785457508966;6135.0797380392405;6139.539534534839;6166.537509686791;6748.932510674928;6766.25571187169;6787.5588086774205;6799.864002719918;6828.6927088281145;5946.613470124515;6032.6983650818165;6057.727402266909;6071.483923866433;6083.817485475354;3676.062604036007;3692.040069581928;3714.9071273217846;3722.925541489155;3746.83139258734;7021.122359705037;7023.122109736283;7033.120859892513;7044;7047.753328633473;6834.521583489208;7047.189573199045;7047.718091276394;7113.7154513819905;7133.89299160513;7089.61007144612;7104.715811367488;7114.501984861114;7119.359257666835;7143.321384468467;6874.484413668894;6881.862362752817;6888.448924085961;6897;6903.965480172567;6646.90029649546;6823.829404264735;6858.382745552724;6861.588304701534;6862.3137686230975;7090.539114957717;7108.573485590881;7113.82215444618;7131.893021604784;7132.322429369202;4579.290210017452;4620.792064357179;4627.097715945359;4631.490536040966;4635.049814788028;6720.294369091371;6881.483888708267;6922.307769223239;6924.930750692429;6931.202911665021;6651.102101216274;6690.665466726547;6699.698513566998;6699.732010719712;6732.3267673232285;6624.90062649051;6677.7295719455615;6686.431653309523;6694.062831203538;6698.5980841149685;6371.649559274284;6594.505412094016;6595.868082638224;6599.4390476808085;6619.635920024445;6666.2333831609985;6671.999200120021;6680.131582894192;6730;6735.6295403753265;6394.840128996626;6516.51126165549;6521.869562608626;6525.836854078686;6543.70553325092 19:00:04 INFO - PROCESS | 6897 | |5;yui.html;793.3454899707742;818.1020033522227;831.5301854452234;865.1002956924794;893.8927328720555;13452.865471345296;13472.865271347307;13601.863981360184;13634.454621815128;13642.181469111836;11527.596534121287;11914.761704765899;12016.45925933333;12017.579384721537;12022.639320820368;637.8309747916794;777.7550071727416;802.5224991130298;804.9436539442241;806.7942674617964;788.7751990682657;800.4276941986478;800.951942883426;804.0311424733212;805.2832978649008;834.2408408348405;841.8442588121187;846.7713717296326;849.8682704180862;851.1531026628513;832.6919039955195;843.3127001493763;843.5571325054365;843.9915600844035;846.2341580869323;618.1839971237968;618.3229363846581;618.5577312221783;619.1053927075378;619.6994457688018;13052.412641431158;13142.277174755385;13248.40382182804;13282;13290.601281961557;12314.5074197032;12538.370011898394;12776.552820651232;12911.67720806978;12991.415386307639;9668.371555848918;9925.652602158962;9986.800263994679;10203.132733717643;10209.642662506776;3437.1063523483826;3439.914002149941;3478.095695119262;3478.147853775841;3595.26297109092;45346.546534534566;45484.54515454803;45561;46091.07817843624;46150.53849461496;9634.855477167848;9948.253880958957;10000.849987250198;10152.746181345525;10195.949020255;17141.657166856592;17171.31314747396;17206;17212.569685757706;17218.655626887394;7458.179600243969;7534.886976695354;7536.171021187665;7670.654820533089;7694.499857509244;4258.595433433881;4304.182205380967;4329.15581461612;4367.192069467159;4392.626626736763;2960.348723280918;3000.969990300113;3009.2176034231256;3014.954775678367;3016.834074125944;566.1253363553237;566.8922904648103;568.5508448325859;572.2103497173956;583.4398976982145;546.7321012703826;548.0491347512063;616.3282022595392;665.8335416145964;694.7116946467261;8281.254687078192;8287.461315014505;8342.374321925758;8346.624401901929;8443.197896199852;551.0631925726282;559.7732918168149;572.6392372805107;603.8279090459198;643.6273924634879;3897.1036661567996;3984.203159368138;4063.89840253996;4217.40956266123;4238.131183107455;53509.464905351226;54607;54719.726401368534;54835.45164548304;54852.17721734177;49140.75429622829;50146;50160.247596286084;50603;50708.492915070376;43160;43344.566554334684;43476.565234347254;44623.776881116035;45123.32315015278;8421.747347579583;8718.91281087181;8912.108789121035;8947.347419245312;9063.365564410427;34243.4863477053;34545.48181777225;34972.12569685778;34999.30001400009;35136.47295290521;40139;40208.396874047496;41050.58949410468;43890.341644874716;44028.55971440244;10867.184961128105;11160.776784464428;11174.106071514421;11186.776264474502;11304.830427543759;11826.34955077479;11909;11936.164468487123;12006.879931200576;12227.144099913277;11172.49723762449;11672.066234701373;11691;11773.941130294294;11983.460744266704;11009.229353945148;11199.160062995144;11216.55133794639;11264.718382040515;11643.941780291045;10896.564137434414;11043.116550676088;11108.722281943015;11188.552457901593;11472.369019703663;9425.104615061558;9602.32783705134;9755.512224388895;9937.254705896941;9994.300398972002;8958.552072396224;9212.401193922373;9261.86107208379;9353.298502612195;9572.76068098303 19:00:04 INFO - PROCESS | 6897 | __end_tp_report 19:00:04 INFO - PROCESS | 6897 | __start_cc_report 19:00:04 INFO - PROCESS | 6897 | _x_x_mozilla_cycle_collect,315 19:00:04 INFO - PROCESS | 6897 | __end_cc_report 19:00:04 INFO - PROCESS | 6897 | __startTimestamp1452308404007__endTimestamp 19:00:04 INFO - PROCESS | 6897 | 19:00:04 INFO - PROCESS | 6897 | ------- Summary: start ------- 19:00:04 INFO - PROCESS | 6897 | Number of tests: 6 19:00:04 INFO - PROCESS | 6897 | 19:00:04 INFO - PROCESS | 6897 | [#0] dojo.html Cycles:165 Average:5324.94 Median:5542.25 stddev:598.25 (10.8%) stddev-sans-first:574.60 19:00:04 INFO - PROCESS | 6897 | Values: 3122.6 3139.7 3174.3 3188.2 3198.4 5221.8 5276.9 5296.4 5300.5 5311.6 5227.3 5244.0 5267.0 5401.5 5496.6 4815.9 4908.8 4926.4 4939.9 4953.7 4831.6 4893.4 4900.7 4913.6 4918.4 4855.5 4918.6 4951.9 4958.2 4968.2 4848.1 4852.7 4861.2 4876.9 4900.0 4781.4 4835.6 4838.0 4872.1 4903.4 5111.8 5120.8 5139.3 5182.2 5185.3 5650.8 5711.0 5732.7 5746.8 5754.3 5568.7 5685.5 5795.0 5806.7 5825.4 5433.2 5494.2 5498.8 5499.2 5542.3 5847.4 5887.4 5894.5 5897.1 5901.4 5548.5 5641.2 5649.0 5664.1 5676.6 5784.5 5792.2 5794.5 5806.2 5827.6 5741.5 5755.9 5773.0 5778.0 5824.5 5674.9 5777.5 5781.9 5809.8 5877.5 4433.5 4440.0 4447.2 4453.6 4470.6 3927.4 3946.7 3955.7 3984.6 4021.1 5182.2 5216.3 5247.3 5257.5 5301.5 5730.9 5734.5 5748.1 5751.6 5758.4 5154.4 5217.5 5224.2 5235.8 5263.9 4854.9 4866.2 4902.0 4918.6 4958.4 5915.0 5951.5 5953.4 5967.8 5968.5 5668.6 5770.6 5780.1 5809.0 5810.7 5822.5 5870.2 5891.2 5899.7 5903.0 5725.8 5790.5 5793.5 5793.6 5810.4 5715.4 5819.1 5819.2 5830.3 5898.6 5590.8 5591.9 5592.3 5599.1 5622.1 5558.2 5578.2 5583.6 5586.2 5590.1 5430.2 5522.4 5536.8 5583.2 5613.5 5569.9 5572.8 5617.3 5629.4 5635.6 5478.1 5485.3 5487.2 5496.5 5500.5 19:00:04 INFO - PROCESS | 6897 | 19:00:04 INFO - PROCESS | 6897 | [#1] ext.html Cycles:180 Average:47955.66 Median:36880.04 stddev:85958.53 (233.1%) stddev-sans-first:86125.94 19:00:04 INFO - PROCESS | 6897 | Values: 538.1 555.1 558.5 562.8 565.1 36091.6 36867.3 36892.8 37035.8 37068.4 42367.6 42624.6 42671.6 42769.8 42966.8 8526.0 8743.1 8779.5 8785.2 8787.3 8464.7 8611.4 8651.8 8654.3 8659.0 8615.1 8690.5 8713.6 8716.0 8716.8 8404.9 8567.8 8584.9 8615.1 8635.9 8415.7 8575.1 8590.1 8592.7 8597.3 40355.2 40420.6 40437.6 40857.4 40950.0 3246.7 3426.7 3435.5 3488.6 3884.8 30239.4 30405.5 30580.8 30639.8 30655.5 3402.3 3411.9 3438.2 3459.6 3524.9 271262.0 271350.0 272066.0 273272.6 273428.0 42956.6 43533.1 43604.6 56514.7 57051.1 41345.4 41754.0 41824.0 41968.4 42045.6 13215.5 13254.1 13281.3 13304.5 13371.2 11618.2 11634.9 11740.6 11768.8 11791.4 14337.4 14418.2 14432.7 14582.3 14632.9 5829.3 5955.8 5972.1 6000.6 6059.9 908.7 941.2 979.3 1121.8 1159.8 29378.9 29421.6 29455.6 29871.7 29947.0 1046.2 1051.5 1059.9 1071.5 1176.5 13727.7 14490.9 14496.7 14645.9 14653.1 394495.0 398290.0 399200.0 399695.0 400415.0 53694.7 53745.0 53957.2 53960.5 53973.7 1385.8 1391.0 1400.6 1401.3 1405.7 26779.3 27792.2 27938.2 28217.3 28226.9 42758.4 43548.8 43567.6 43677.0 43690.0 294510.0 294731.0 296681.0 297404.0 298392.0 32269.5 41876.0 42940.4 43690.8 43923.8 40285.4 41409.4 41721.0 41844.4 42393.0 34895.5 34919.8 35142.0 35301.8 35351.8 34630.5 35209.5 35433.8 35550.6 35906.8 35874.8 36533.0 37937.4 38901.8 39030.2 29773.9 32050.5 34042.0 34069.7 34403.8 25825.2 25996.9 26091.9 26172.5 26421.0 19:00:04 INFO - PROCESS | 6897 | 19:00:04 INFO - PROCESS | 6897 | [#2] jquery.html Cycles:180 Average:25852.36 Median:37064.54 stddev:75804.59 (204.5%) stddev-sans-first:75993.04 19:00:04 INFO - PROCESS | 6897 | Values: 343.5 347.6 354.9 360.0 360.1 16212.7 16610.6 16688.4 17419.7 18002.5 14398.6 14437.1 14616.1 14624.2 15444.6 4637.7 4996.4 5008.9 5015.9 5026.3 4542.4 4932.2 4940.3 5005.4 5007.3 5387.7 5393.1 6182.3 6486.8 6517.5 6421.8 6430.2 6498.5 6743.1 6770.1 6229.4 6442.7 6452.9 6469.9 6615.5 21265.8 21646.9 21769.7 21958.5 22739.4 2102.3 2204.7 2237.2 2256.5 2405.9 13689.2 13711.7 13720.5 14335.0 14704.3 1865.3 1964.5 1988.9 2033.8 2047.2 61182.0 63656.4 65148.0 66052.3 66226.3 14518.0 15073.4 15100.3 15114.2 15170.4 23320.9 23353.0 23404.8 23653.6 23688.6 6916.1 7271.6 7514.8 7540.9 7585.2 7290.0 7348.7 7352.9 7375.1 7392.4 3958.9 3976.1 4027.0 4117.2 4122.8 1752.2 1754.9 1788.4 1798.8 1809.6 841.2 907.4 1003.0 1037.7 1038.4 14383.4 15256.2 15373.2 15797.8 16517.1 902.4 936.6 940.2 970.3 1012.4 9374.3 9521.2 9612.4 9627.0 9686.0 448793.0 451412.0 455536.0 462923.0 497725.0 68327.7 70749.3 71193.3 71330.0 71512.3 1058.4 1071.6 1073.4 1084.5 1092.6 14212.5 14650.9 14853.9 14902.7 14949.9 30468.5 30690.8 30859.5 31186.8 31449.7 35732.0 36508.1 36605.0 36700.3 37428.8 3027.1 3044.6 5637.0 6934.5 7230.5 9578.6 10213.6 10262.4 11076.1 11257.5 8901.7 9425.4 9586.5 9953.3 10068.9 9529.5 9767.0 9885.8 9947.0 10257.4 8769.4 9207.8 9927.3 10110.5 10197.3 7146.1 7346.8 7421.5 7511.3 7592.5 9012.3 9889.2 10035.0 10149.6 10325.0 19:00:04 INFO - PROCESS | 6897 | 19:00:04 INFO - PROCESS | 6897 | [#3] mootools.html Cycles:180 Average:5338.84 Median:6495.25 stddev:2758.56 (42.5%) stddev-sans-first:2750.46 19:00:04 INFO - PROCESS | 6897 | Values: 1406.5 1466.4 1642.3 1783.2 1804.2 7352.8 7550.6 7554.7 7592.9 7721.5 7777.5 7798.8 7846.3 7850.9 7868.9 2286.7 2303.9 2314.0 2314.6 2326.0 2226.3 2239.1 2247.4 2259.2 2270.8 2166.2 2201.8 2220.6 2278.1 2295.3 2164.3 2187.6 2192.3 2202.1 2203.5 2252.1 2263.9 2276.9 2278.9 2286.6 7257.0 7266.0 7282.6 7290.8 7303.2 4541.6 4634.4 4636.4 4642.6 4649.5 2814.7 2944.2 2948.8 2954.1 2958.5 910.7 919.2 934.7 948.3 958.5 10391.5 10519.8 10532.4 10551.7 10598.6 3976.5 3982.1 4048.8 4064.6 4068.6 8678.8 8683.0 8697.0 8702.6 8713.1 4575.7 4595.6 4597.6 4608.0 4626.1 4243.4 4244.8 4261.0 4266.3 4269.3 3410.7 3428.1 3435.5 3456.8 3478.4 1010.3 1014.2 1018.5 1023.4 1029.8 1059.9 1082.5 1085.3 1219.4 1328.1 6942.9 6982.9 6984.3 6987.5 7227.5 1117.9 1123.6 1156.5 1162.0 1166.8 5431.6 5573.3 5580.7 5600.0 5619.7 8723.1 8792.7 8896.5 9271.0 9342.9 9192.1 9207.5 9247.7 9271.5 9336.3 6985.8 7036.6 7244.6 7371.7 7383.5 7218.0 7241.2 7246.2 7246.4 7309.4 7986.7 8062.7 8159.4 8185.1 8198.8 8106.0 8419.0 8427.5 8510.3 8510.8 6564.1 6596.5 6649.6 6675.4 6925.7 7222.7 7253.1 7259.5 7263.6 7286.4 6103.8 6732.2 6930.8 6995.7 7119.5 6818.7 6820.8 6832.0 6875.3 6936.1 6720.6 7038.6 7066.8 7075.3 7099.5 6503.3 6507.6 6526.0 6527.4 6540.8 6360.8 6361.1 6396.3 6480.2 6487.3 19:00:04 INFO - PROCESS | 6897 | 19:00:04 INFO - PROCESS | 6897 | [#4] prototype.html Cycles:180 Average:5507.01 Median:6237.02 stddev:1691.05 (27.1%) stddev-sans-first:1650.52 19:00:04 INFO - PROCESS | 6897 | Values: 328.7 330.0 334.5 339.0 346.6 6234.6 6246.8 6274.5 6282.6 6396.4 6239.4 6241.8 6258.8 6258.9 6279.3 4716.4 4728.7 4733.4 4734.0 4734.2 4732.4 4738.6 4742.2 4742.2 4748.5 4549.6 4600.7 4608.5 4618.2 4663.0 4578.2 4605.7 4609.8 4614.6 4638.9 3999.6 4018.5 4030.5 4032.8 4033.7 5864.4 5906.3 5913.3 5921.6 5926.8 5294.1 5437.6 5467.7 5475.6 5481.7 6613.3 6616.5 6620.9 6624.1 6632.9 4451.0 4471.8 4475.8 4493.5 4510.5 6756.5 6832.2 6868.1 6901.8 6926.7 4609.6 4611.6 4611.7 4617.5 4633.3 4667.9 4674.6 4680.1 4682.8 4684.3 5409.6 5412.1 5434.1 5436.2 5447.0 6504.3 6621.7 6649.6 6660.9 6661.9 1631.1 1635.9 1638.2 1638.3 1641.9 1077.8 1079.6 1094.7 1097.9 1121.8 6127.4 6129.8 6135.1 6139.5 6166.5 6748.9 6766.3 6787.6 6799.9 6828.7 5946.6 6032.7 6057.7 6071.5 6083.8 3676.1 3692.0 3714.9 3722.9 3746.8 7021.1 7023.1 7033.1 7044.0 7047.8 6834.5 7047.2 7047.7 7113.7 7133.9 7089.6 7104.7 7114.5 7119.4 7143.3 6874.5 6881.9 6888.4 6897.0 6904.0 6646.9 6823.8 6858.4 6861.6 6862.3 7090.5 7108.6 7113.8 7131.9 7132.3 4579.3 4620.8 4627.1 4631.5 4635.0 6720.3 6881.5 6922.3 6924.9 6931.2 6651.1 6690.7 6699.7 6699.7 6732.3 6624.9 6677.7 6686.4 6694.1 6698.6 6371.6 6594.5 6595.9 6599.4 6619.6 6666.2 6672.0 6680.1 6730.0 6735.6 6394.8 6516.5 6521.9 6525.8 6543.7 19:00:04 INFO - PROCESS | 6897 | 19:00:04 INFO - PROCESS | 6897 | [#5] yui.html Cycles:180 Average:13384.20 Median:45415.55 stddev:15212.03 (33.5%) stddev-sans-first:15225.31 19:00:04 INFO - PROCESS | 6897 | Values: 793.3 818.1 831.5 865.1 893.9 13452.9 13472.9 13601.9 13634.5 13642.2 11527.6 11914.8 12016.5 12017.6 12022.6 637.8 777.8 802.5 804.9 806.8 788.8 800.4 801.0 804.0 805.3 834.2 841.8 846.8 849.9 851.2 832.7 843.3 843.6 844.0 846.2 618.2 618.3 618.6 619.1 619.7 13052.4 13142.3 13248.4 13282.0 13290.6 12314.5 12538.4 12776.6 12911.7 12991.4 9668.4 9925.7 9986.8 10203.1 10209.6 3437.1 3439.9 3478.1 3478.1 3595.3 45346.5 45484.5 45561.0 46091.1 46150.5 9634.9 9948.3 10000.8 10152.7 10195.9 17141.7 17171.3 17206.0 17212.6 17218.7 7458.2 7534.9 7536.2 7670.7 7694.5 4258.6 4304.2 4329.2 4367.2 4392.6 2960.3 3001.0 3009.2 3015.0 3016.8 566.1 566.9 568.6 572.2 583.4 546.7 548.0 616.3 665.8 694.7 8281.3 8287.5 8342.4 8346.6 8443.2 551.1 559.8 572.6 603.8 643.6 3897.1 3984.2 4063.9 4217.4 4238.1 53509.5 54607.0 54719.7 54835.5 54852.2 49140.8 50146.0 50160.2 50603.0 50708.5 43160.0 43344.6 43476.6 44623.8 45123.3 8421.7 8718.9 8912.1 8947.3 9063.4 34243.5 34545.5 34972.1 34999.3 35136.5 40139.0 40208.4 41050.6 43890.3 44028.6 10867.2 11160.8 11174.1 11186.8 11304.8 11826.3 11909.0 11936.2 12006.9 12227.1 11172.5 11672.1 11691.0 11773.9 11983.5 11009.2 11199.2 11216.6 11264.7 11643.9 10896.6 11043.1 11108.7 11188.6 11472.4 9425.1 9602.3 9755.5 9937.3 9994.3 8958.6 9212.4 9261.9 9353.3 9572.8 19:00:04 INFO - PROCESS | 6897 | -------- Summary: end -------- 19:00:04 INFO - PROCESS | 6897 | 19:00:04 INFO - TEST-INFO | 6897: exit 0 19:00:04 INFO - TEST-OK | dromaeo_css | took 1109984ms 19:00:04 INFO - TEST-START | kraken 19:00:04 INFO - operating with platform_type : linux_ 19:00:04 INFO - Initialising browser for kraken test... 19:00:04 INFO - TEST-INFO | started process 7139 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0GdLD2/profile http://localhost:60171/getInfo.html) 19:00:08 INFO - PROCESS | 7139 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 19:00:08 INFO - PROCESS | 7139 | __metrics Screen width/height:1600/1200 19:00:08 INFO - PROCESS | 7139 | colorDepth:24 19:00:08 INFO - PROCESS | 7139 | Browser inner width/height: 1024/697 19:00:08 INFO - PROCESS | 7139 | __metrics 19:00:08 INFO - PROCESS | 7139 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:00:09 INFO - TEST-INFO | 7139: exit 0 19:00:09 INFO - Browser initialized. 19:00:09 INFO - Running cycle 1/1 for kraken test... 19:00:09 INFO - TEST-INFO | started process 7262 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0GdLD2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:21 INFO - PROCESS | 7262 | RSS: Main: 150347776 19:00:21 INFO - PROCESS | 7262 | 19:00:24 INFO - PROCESS | 7262 | Cycle 1(1): loaded http://localhost:60171/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60171/tests/kraken/driver.html?testName=audio-beat-detection) 19:00:24 INFO - PROCESS | 7262 | RSS: Main: 151318528 19:00:24 INFO - PROCESS | 7262 | 19:00:27 INFO - PROCESS | 7262 | Cycle 1(1): loaded http://localhost:60171/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60171/tests/kraken/driver.html?testName=audio-dft) 19:00:27 INFO - PROCESS | 7262 | RSS: Main: 151687168 19:00:27 INFO - PROCESS | 7262 | 19:00:30 INFO - PROCESS | 7262 | Cycle 1(1): loaded http://localhost:60171/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60171/tests/kraken/driver.html?testName=audio-fft) 19:00:31 INFO - PROCESS | 7262 | RSS: Main: 147103744 19:00:31 INFO - PROCESS | 7262 | 19:00:33 INFO - PROCESS | 7262 | Cycle 1(1): loaded http://localhost:60171/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60171/tests/kraken/driver.html?testName=audio-oscillator) 19:00:34 INFO - PROCESS | 7262 | RSS: Main: 146698240 19:00:34 INFO - PROCESS | 7262 | 19:00:36 INFO - PROCESS | 7262 | Cycle 1(1): loaded http://localhost:60171/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60171/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:00:37 INFO - PROCESS | 7262 | RSS: Main: 147083264 19:00:37 INFO - PROCESS | 7262 | 19:00:40 INFO - PROCESS | 7262 | Cycle 1(1): loaded http://localhost:60171/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60171/tests/kraken/driver.html?testName=imaging-darkroom) 19:00:40 INFO - PROCESS | 7262 | RSS: Main: 147664896 19:00:40 INFO - PROCESS | 7262 | 19:00:43 INFO - PROCESS | 7262 | Cycle 1(1): loaded http://localhost:60171/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60171/tests/kraken/driver.html?testName=imaging-desaturate) 19:00:44 INFO - PROCESS | 7262 | RSS: Main: 148901888 19:00:44 INFO - PROCESS | 7262 | 19:00:47 INFO - PROCESS | 7262 | Cycle 1(1): loaded http://localhost:60171/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60171/tests/kraken/driver.html?testName=json-parse-financial) 19:00:47 INFO - PROCESS | 7262 | RSS: Main: 148918272 19:00:47 INFO - PROCESS | 7262 | 19:00:49 INFO - PROCESS | 7262 | Cycle 1(1): loaded http://localhost:60171/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60171/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:00:50 INFO - PROCESS | 7262 | RSS: Main: 149454848 19:00:50 INFO - PROCESS | 7262 | 19:00:51 INFO - PROCESS | 7262 | Cycle 1(1): loaded http://localhost:60171/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60171/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:00:52 INFO - PROCESS | 7262 | RSS: Main: 149151744 19:00:52 INFO - PROCESS | 7262 | 19:00:54 INFO - PROCESS | 7262 | Cycle 1(1): loaded http://localhost:60171/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60171/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:00:55 INFO - PROCESS | 7262 | RSS: Main: 149479424 19:00:55 INFO - PROCESS | 7262 | 19:00:57 INFO - PROCESS | 7262 | Cycle 1(1): loaded http://localhost:60171/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:00:58 INFO - PROCESS | 7262 | RSS: Main: 149278720 19:00:58 INFO - PROCESS | 7262 | 19:01:00 INFO - PROCESS | 7262 | Cycle 1(1): loaded http://localhost:60171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:01:01 INFO - PROCESS | 7262 | RSS: Main: 149995520 19:01:01 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | Cycle 1(1): loaded http://localhost:60171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60171/tests/kraken/driver.html?testName=ai-astar) 19:01:03 INFO - PROCESS | 7262 | RSS: Main: 148443136 19:01:03 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | __start_tp_report 19:01:03 INFO - PROCESS | 7262 | _x_x_mozilla_page_load 19:01:03 INFO - PROCESS | 7262 | _x_x_mozilla_page_load_details 19:01:03 INFO - PROCESS | 7262 | |i|pagename|runs| 19:01:03 INFO - PROCESS | 7262 | |0;ai-astar;115;106;112;114;112;125;111;112;111;112 19:01:03 INFO - PROCESS | 7262 | |1;audio-beat-detection;158;134;153;165;125;160;155;129;162;125 19:01:03 INFO - PROCESS | 7262 | |2;audio-dft;161;164;162;164;163;161;161;163;172;166 19:01:03 INFO - PROCESS | 7262 | |3;audio-fft;71;74;72;73;73;72;129;71;75;74 19:01:03 INFO - PROCESS | 7262 | |4;audio-oscillator;97;96;146;95;95;96;137;98;97;141 19:01:03 INFO - PROCESS | 7262 | |5;imaging-gaussian-blur;109;110;111;110;110;111;109;110;110;110 19:01:03 INFO - PROCESS | 7262 | |6;imaging-darkroom;147;147;148;146;146;148;147;146;146;148 19:01:03 INFO - PROCESS | 7262 | |7;imaging-desaturate;96;97;96;97;97;96;96;96;96;96 19:01:03 INFO - PROCESS | 7262 | |8;json-parse-financial;57;61;57;57;59;56;60;60;55;54 19:01:03 INFO - PROCESS | 7262 | |9;json-stringify-tinderbox;66;67;67;67;68;67;67;67;67;67 19:01:03 INFO - PROCESS | 7262 | |10;stanford-crypto-aes;84;93;94;85;87;88;87;88;91;85 19:01:03 INFO - PROCESS | 7262 | |11;stanford-crypto-ccm;121;121;131;133;116;121;125;118;126;126 19:01:03 INFO - PROCESS | 7262 | |12;stanford-crypto-pbkdf2;141;152;158;154;150;154;156;150;154;153 19:01:03 INFO - PROCESS | 7262 | |13;stanford-crypto-sha256-iterative;68;70;68;69;71;68;68;70;68;70 19:01:03 INFO - PROCESS | 7262 | __end_tp_report 19:01:03 INFO - PROCESS | 7262 | __start_cc_report 19:01:03 INFO - PROCESS | 7262 | _x_x_mozilla_cycle_collect,733 19:01:03 INFO - PROCESS | 7262 | __end_cc_report 19:01:03 INFO - PROCESS | 7262 | __startTimestamp1452308463400__endTimestamp 19:01:03 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | ------- Summary: start ------- 19:01:03 INFO - PROCESS | 7262 | Number of tests: 14 19:01:03 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | [#0] ai-astar Cycles:10 Average:113.00 Median:112.00 stddev:4.83 (4.3%) stddev-sans-first:5.07 19:01:03 INFO - PROCESS | 7262 | Values: 115.0 106.0 112.0 114.0 112.0 125.0 111.0 112.0 111.0 112.0 19:01:03 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:156.50 stddev:16.32 (10.4%) stddev-sans-first:16.79 19:01:03 INFO - PROCESS | 7262 | Values: 158.0 134.0 153.0 165.0 125.0 160.0 155.0 129.0 162.0 125.0 19:01:03 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:3.33 (2.0%) stddev-sans-first:3.39 19:01:03 INFO - PROCESS | 7262 | Values: 161.0 164.0 162.0 164.0 163.0 161.0 161.0 163.0 172.0 166.0 19:01:03 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | [#3] audio-fft Cycles:10 Average:78.40 Median:73.00 stddev:17.83 (24.4%) stddev-sans-first:18.71 19:01:03 INFO - PROCESS | 7262 | Values: 71.0 74.0 72.0 73.0 73.0 72.0 129.0 71.0 75.0 74.0 19:01:03 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:96.00 stddev:21.88 (22.8%) stddev-sans-first:22.71 19:01:03 INFO - PROCESS | 7262 | Values: 97.0 96.0 146.0 95.0 95.0 96.0 137.0 98.0 97.0 141.0 19:01:03 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 19:01:03 INFO - PROCESS | 7262 | Values: 109.0 110.0 111.0 110.0 110.0 111.0 109.0 110.0 110.0 110.0 19:01:03 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 19:01:03 INFO - PROCESS | 7262 | Values: 147.0 147.0 148.0 146.0 146.0 148.0 147.0 146.0 146.0 148.0 19:01:03 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:01:03 INFO - PROCESS | 7262 | Values: 96.0 97.0 96.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 19:01:03 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:2.32 (4.0%) stddev-sans-first:2.45 19:01:03 INFO - PROCESS | 7262 | Values: 57.0 61.0 57.0 57.0 59.0 56.0 60.0 60.0 55.0 54.0 19:01:03 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 19:01:03 INFO - PROCESS | 7262 | Values: 66.0 67.0 67.0 67.0 68.0 67.0 67.0 67.0 67.0 67.0 19:01:03 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:88.00 stddev:3.43 (3.9%) stddev-sans-first:3.28 19:01:03 INFO - PROCESS | 7262 | Values: 84.0 93.0 94.0 85.0 87.0 88.0 87.0 88.0 91.0 85.0 19:01:03 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:125.50 stddev:5.43 (4.3%) stddev-sans-first:5.67 19:01:03 INFO - PROCESS | 7262 | Values: 121.0 121.0 131.0 133.0 116.0 121.0 125.0 118.0 126.0 126.0 19:01:03 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.20 Median:154.00 stddev:4.64 (3.0%) stddev-sans-first:2.60 19:01:03 INFO - PROCESS | 7262 | Values: 141.0 152.0 158.0 154.0 150.0 154.0 156.0 150.0 154.0 153.0 19:01:03 INFO - PROCESS | 7262 | 19:01:03 INFO - PROCESS | 7262 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.15 (1.7%) stddev-sans-first:1.17 19:01:03 INFO - PROCESS | 7262 | Values: 68.0 70.0 68.0 69.0 71.0 68.0 68.0 70.0 68.0 70.0 19:01:03 INFO - PROCESS | 7262 | -------- Summary: end -------- 19:01:03 INFO - PROCESS | 7262 | 19:01:04 INFO - TEST-INFO | 7262: exit 0 19:01:04 INFO - TEST-OK | kraken | took 59643ms 19:01:04 INFO - TEST-START | v8_7 19:01:04 INFO - operating with platform_type : linux_ 19:01:04 INFO - Initialising browser for v8_7 test... 19:01:04 INFO - TEST-INFO | started process 7550 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJufCgT/profile http://localhost:60171/getInfo.html) 19:01:07 INFO - PROCESS | 7550 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 19:01:08 INFO - PROCESS | 7550 | __metrics Screen width/height:1600/1200 19:01:08 INFO - PROCESS | 7550 | colorDepth:24 19:01:08 INFO - PROCESS | 7550 | Browser inner width/height: 1024/697 19:01:08 INFO - PROCESS | 7550 | __metrics 19:01:08 INFO - PROCESS | 7550 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:01:09 INFO - TEST-INFO | 7550: exit 0 19:01:09 INFO - Browser initialized. 19:01:09 INFO - Running cycle 1/1 for v8_7 test... 19:01:09 INFO - TEST-INFO | started process 7671 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJufCgT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:21 INFO - PROCESS | 7671 | RSS: Main: 150147072 19:01:21 INFO - PROCESS | 7671 | 19:01:43 INFO - PROCESS | 7671 | Cycle 1(1): loaded http://localhost:60171/tests/v8_7/run.html (next: http://localhost:60171/tests/v8_7/run.html) 19:01:43 INFO - PROCESS | 7671 | RSS: Main: 146391040 19:01:43 INFO - PROCESS | 7671 | 19:01:43 INFO - PROCESS | 7671 | __start_tp_report 19:01:43 INFO - PROCESS | 7671 | _x_x_mozilla_page_load 19:01:43 INFO - PROCESS | 7671 | _x_x_mozilla_page_load_details 19:01:43 INFO - PROCESS | 7671 | |i|pagename|runs| 19:01:43 INFO - PROCESS | 7671 | |0;Richards;165.371258475277 19:01:43 INFO - PROCESS | 7671 | |1;DeltaBlue;187.93459875963165 19:01:43 INFO - PROCESS | 7671 | |2;Encrypt;279.79854504756577 19:01:43 INFO - PROCESS | 7671 | |3;Decrypt;5218.75 19:01:43 INFO - PROCESS | 7671 | |4;RayTrace;1072.961373390558 19:01:43 INFO - PROCESS | 7671 | |5;Earley;724.6376811594203 19:01:43 INFO - PROCESS | 7671 | |6;Boyer;12120.481927710844 19:01:43 INFO - PROCESS | 7671 | |7;RegExp;40431.37254901961 19:01:43 INFO - PROCESS | 7671 | |8;Splay;621.1180124223603 19:01:43 INFO - PROCESS | 7671 | |9;NavierStokes;4822.115384615385 19:01:43 INFO - PROCESS | 7671 | __end_tp_report 19:01:43 INFO - PROCESS | 7671 | __startTimestamp1452308503785__endTimestamp 19:01:43 INFO - PROCESS | 7671 | 19:01:43 INFO - PROCESS | 7671 | ------- Summary: start ------- 19:01:43 INFO - PROCESS | 7671 | Number of tests: 10 19:01:43 INFO - PROCESS | 7671 | 19:01:43 INFO - PROCESS | 7671 | [#0] Richards Cycles:1 Average:165.37 Median:165.37 stddev:0.00 (0.0%) 19:01:43 INFO - PROCESS | 7671 | Values: 165.4 19:01:43 INFO - PROCESS | 7671 | 19:01:43 INFO - PROCESS | 7671 | [#1] DeltaBlue Cycles:1 Average:187.93 Median:187.93 stddev:0.00 (0.0%) 19:01:43 INFO - PROCESS | 7671 | Values: 187.9 19:01:43 INFO - PROCESS | 7671 | 19:01:43 INFO - PROCESS | 7671 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 19:01:43 INFO - PROCESS | 7671 | Values: 279.8 19:01:43 INFO - PROCESS | 7671 | 19:01:43 INFO - PROCESS | 7671 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 19:01:43 INFO - PROCESS | 7671 | Values: 5218.8 19:01:43 INFO - PROCESS | 7671 | 19:01:43 INFO - PROCESS | 7671 | [#4] RayTrace Cycles:1 Average:1072.96 Median:1072.96 stddev:0.00 (0.0%) 19:01:43 INFO - PROCESS | 7671 | Values: 1073.0 19:01:43 INFO - PROCESS | 7671 | 19:01:43 INFO - PROCESS | 7671 | [#5] Earley Cycles:1 Average:724.64 Median:724.64 stddev:0.00 (0.0%) 19:01:43 INFO - PROCESS | 7671 | Values: 724.6 19:01:43 INFO - PROCESS | 7671 | 19:01:43 INFO - PROCESS | 7671 | [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 19:01:43 INFO - PROCESS | 7671 | Values: 12120.5 19:01:43 INFO - PROCESS | 7671 | 19:01:43 INFO - PROCESS | 7671 | [#7] RegExp Cycles:1 Average:40431.37 Median:40431.37 stddev:0.00 (0.0%) 19:01:43 INFO - PROCESS | 7671 | Values: 40431.4 19:01:43 INFO - PROCESS | 7671 | 19:01:43 INFO - PROCESS | 7671 | [#8] Splay Cycles:1 Average:621.12 Median:621.12 stddev:0.00 (0.0%) 19:01:43 INFO - PROCESS | 7671 | Values: 621.1 19:01:43 INFO - PROCESS | 7671 | 19:01:43 INFO - PROCESS | 7671 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 19:01:43 INFO - PROCESS | 7671 | Values: 4822.1 19:01:43 INFO - PROCESS | 7671 | -------- Summary: end -------- 19:01:43 INFO - PROCESS | 7671 | 19:01:44 INFO - TEST-INFO | 7671: exit 0 19:01:44 INFO - TEST-OK | v8_7 | took 40323ms 19:01:44 INFO - SUITE-END | took 1209s 19:01:44 INFO - Completed test suite (00:20:10) 19:01:44 INFO - Working with test: dromaeo_css 19:01:44 INFO - Generating results file: dromaeo_css 19:01:44 INFO - Working with test: kraken 19:01:44 INFO - Generating results file: kraken 19:01:44 INFO - javascript benchmark 19:01:44 INFO - Working with test: v8_7 19:01:44 INFO - Generating results file: v8_7 19:01:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:01:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 19:01:44 INFO - process_Request line: dromaeo_css 6896.44 graph.html#tests=[[72,1,43]] 19:01:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:01:44 INFO - process_Request line: kraken 1522.50 graph.html#tests=[[232,1,43]] 19:01:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:01:44 INFO - process_Request line: v8_7 20353.69 graph.html#tests=[[230,1,43]] 19:01:44 INFO - RETURN: dromaeo_css: 6896.44 19:01:44 INFO - RETURN: kraken: 1522.50 19:01:44 INFO - RETURN: v8_7: 20353.69 19:01:44 INFO - javascript benchmark 19:01:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3122.6252849658035, 3139.670334614865, 3174.333389988102, 3188.2188863728384, 3198.360327934414, 5221.817236396727, 5276.894462110756, 5296.417394086652, 5300.546992537387, 5311.62818602698, 5227.294315267438, 5244.029854476925, 5267.0, 5401.513863752271, 5496.560275177986, 4815.903681926359, 4908.754562271881, 4926.359573255471, 4939.876503087434, 4953.678010929296, 4831.637627177958, 4893.388326459192, 4900.730459824708, 4913.606911447094, 4918.385201849769, 4855.465898751135, 4918.5819205367225, 4951.925721114186, 4958.231474121517, 4968.180250258703, 4848.10310092634, 4852.733099679516, 4861.2222044473065, 4876.902461950776, 4899.975500122512, 4781.42622885256, 4835.5889749371345, 4837.975810120927, 4872.123017856784, 4903.387076615423, 5111.821086262, 5120.769565369567, 5139.331886854722, 5182.222666600002, 5185.299984502081, 5650.830475085754, 5710.971445142789, 5732.656040637575, 5746.827595172152, 5754.3094828620415, 5568.693721845297, 5685.4883060524335, 5794.956907756644, 5806.709664516758, 5825.359210486843, 5433.157860531624, 5494.230807686927, 5498.780048798043, 5499.230107784913, 5542.251796007527, 5847.44449277318, 5887.35239123696, 5894.469497745224, 5897.085951677497, 5901.380355062743, 5548.500634942875, 5641.153826925994, 5649.0, 5664.0937450007805, 5676.602637815313, 5784.537237021028, 5792.247007889032, 5794.50746686528, 5806.2451881255165, 5827.59206855516, 5741.45456181662, 5755.85610359736, 5773.04744717117, 5778.046622307273, 5824.475797178275, 5674.914876276859, 5777.537796976232, 5781.8554536136935, 5809.82570522885, 5877.52979761618, 4433.46798384196, 4440.045390241114, 4447.221736196153, 4453.643708503312, 4470.597646211857, 3927.410888366711, 3946.723729338919, 3955.7033222508426, 3984.6015398460504, 4021.095253567982, 5182.196759502283, 5216.347956505437, 5247.317848679647, 5257.474252574789, 5301.469853014668, 5730.914036289459, 5734.541236701138, 5748.080307150836, 5751.568632352507, 5758.3665796762325, 5154.355705536808, 5217.452167522356, 5224.216367544898, 5235.764390602432, 5263.947360526346, 4854.927176092361, 4866.245731911559, 4902.0441014002645, 4918.631102667314, 4958.355413796184, 5915.0, 5951.5238780897425, 5953.404659534012, 5967.761289548456, 5968.46283834457, 5668.603197776116, 5770.6249093808765, 5780.075187969905, 5809.0, 5810.680412577349, 5822.534197264124, 5870.17817505541, 5891.204687367322, 5899.67551784656, 5903.0, 5725.770969161187, 5790.536757059341, 5793.507551858139, 5793.594448388741, 5810.4189581041555, 5715.428457154251, 5819.127130930395, 5819.156222347651, 5830.329512106162, 5898.64608123514, 5590.776368945197, 5591.8881622368135, 5592.328920529562, 5599.0761524349655, 5622.072358060874, 5558.194061861089, 5578.219049333015, 5583.553315734813, 5586.190002449541, 5590.105583106683, 5430.185472179205, 5522.420145884625, 5536.806211782568, 5583.218349431164, 5613.46672066153, 5569.860753481195, 5572.804951826666, 5617.32592088952, 5629.408912064175, 5635.605507614591, 5478.096114141122, 5485.259489968963, 5487.231787549826, 5496.450354964471, 5500.50495455411], "unit": "score", "name": "dojo.html", "value": 5285.570165441146}, {"lowerIsBetter": false, "replicates": [538.1416640458467, 555.1478480532381, 558.5113026102161, 562.8002059268962, 565.1071307334412, 36091.63908360916, 36867.26265474689, 36892.81553592235, 37035.814820925894, 37068.44397334042, 42367.57632423675, 42624.57375426253, 42671.57328426722, 42769.78615106928, 42966.78516607413, 8526.0, 8743.12568743127, 8779.517126558037, 8785.165409286108, 8787.25308348791, 8464.746057618251, 8611.440256383346, 8651.783705407352, 8654.264387527068, 8659.0, 8615.052344242129, 8690.522021288827, 8713.60788764504, 8715.95642021789, 8716.825663486727, 8404.865343178653, 8567.82864342716, 8584.8712269316, 8615.138486151398, 8635.870461943075, 8415.705450309271, 8575.142485751438, 8590.098039705803, 8592.699255526026, 8597.312215022783, 40355.19289614191, 40420.595794041976, 40437.59562404397, 40857.38713919264, 40950.0, 3246.724028457584, 3426.7258619310396, 3435.4846772984, 3488.5639295088113, 3884.8057597120032, 30239.395212095857, 30405.543916841267, 30580.847095764602, 30639.846800765852, 30655.540166897514, 3402.2515046689687, 3411.8805841795665, 3438.2263990602164, 3459.567554055743, 3524.9118772030647, 271262.0, 271350.0, 272066.0, 273272.6336368325, 273428.0, 42956.57043429526, 43533.12933741308, 43604.56395436068, 56514.71742641343, 57051.14423283654, 41345.37981930273, 41754.0, 41824.0, 41968.370474442905, 42045.579544204775, 13215.537456188988, 13254.138480998705, 13281.335933203494, 13304.534341298202, 13371.197728136343, 11618.186726929034, 11634.883651163549, 11740.647780566596, 11768.764624707457, 11791.410429478663, 14337.35481903317, 14418.206998615176, 14432.711345773236, 14582.270886455635, 14632.853671463363, 5829.300483941955, 5955.838611470722, 5972.13404056418, 6000.609960352563, 6059.909101363483, 908.7319240823973, 941.1717688434134, 979.3438396274513, 1121.7532142928542, 1159.7616599962155, 29378.85310573476, 29421.55867661987, 29455.558166627517, 29871.701282987327, 29947.0, 1046.1526163807341, 1051.5268129341673, 1059.8569193158978, 1071.50175168547, 1176.5235079792697, 13727.665799254672, 14490.85509144916, 14496.710065798625, 14645.901557383238, 14653.12081275127, 394495.0, 398290.0, 399200.0, 399695.0, 400415.0, 53694.7315263429, 53745.0, 53957.1906421404, 53960.46039539633, 53973.730131349876, 1385.8267716535433, 1391.0, 1400.649837540615, 1401.2503310728914, 1405.7469655462319, 26779.33051673724, 27792.16623501298, 27938.16185514438, 28217.294567635974, 28226.85886570554, 42758.358624620036, 43548.78225608852, 43567.56432435635, 43677.0, 43690.0, 294510.0, 294731.0, 296681.0, 297404.0, 298392.0, 32269.51595726113, 41876.0, 42940.35589466098, 43690.78154609207, 43923.78038109789, 40285.39571906365, 41409.37885931653, 41721.0, 41844.37233441562, 42393.0, 34895.476567850994, 34919.82540087283, 35142.0, 35301.82349088238, 35351.823240883634, 34630.480542791374, 35209.47185792164, 35433.82283088568, 35550.64449355473, 35906.8204658975, 35874.820625896704, 36533.0, 37937.4309385365, 38901.805490972365, 39030.21939561136, 29773.851130744206, 32050.519242211853, 34042.0, 34069.659303406646, 34403.82798085993, 25825.225243242734, 25996.8700156498, 26091.869540652177, 26172.476550468502, 26421.0], "unit": "score", "name": "ext.html", "value": 18018.75406625273}, {"lowerIsBetter": false, "replicates": [343.510497541004, 347.5724858424138, 354.87047227761866, 359.955005624297, 360.1482493901922, 16212.675746485063, 16610.58473538159, 16688.41590544331, 17419.73870391945, 18002.549936251584, 14398.568042958728, 14437.061590996578, 14616.12303261805, 14624.195669238188, 15444.613884652861, 4637.675362724603, 4996.425411077718, 5008.924866127011, 5015.899682006376, 5026.321446604698, 4542.364069030338, 4932.210846264598, 4940.34284360844, 5005.374328208974, 5007.32401125847, 5387.703676297802, 5393.083175860113, 6182.289036760762, 6486.805395838132, 6517.478601711851, 6421.8073457796345, 6430.228372595295, 6498.545101842873, 6743.055972163901, 6770.119884415044, 6229.37706229378, 6442.710078046499, 6452.870942581169, 6469.935300647027, 6615.5369124161325, 21265.787342126536, 21646.891765541073, 21769.673454898188, 21958.451038724, 22739.431514212112, 2102.2642075273684, 2204.7244094488187, 2237.161064600775, 2256.4922892349255, 2405.915792947256, 13689.247091409969, 13711.657208569766, 13720.519781807689, 14335.0, 14704.33830477631, 1865.309835360925, 1964.489232799468, 1988.8607797454183, 2033.755949286095, 2047.2220556188702, 61182.0, 63656.36343636597, 65148.0, 66052.3394766051, 66226.33773662298, 14518.0, 15073.397064117531, 15100.320485578175, 15114.244287785787, 15170.393184272727, 23320.883395582914, 23353.0, 23404.7659523406, 23653.645195322082, 23688.64467032996, 6916.100906882073, 7271.600061996641, 7514.774556763306, 7540.886886696704, 7585.241475852371, 7289.963550182321, 7348.669309881068, 7352.926470735331, 7375.11498620169, 7392.4086073115095, 3958.9010274743364, 3976.0855003349393, 4026.9597304026584, 4117.155983023473, 4122.793860307032, 1752.1852338662584, 1754.850837678786, 1788.418763901737, 1798.7751531058618, 1809.5837957269903, 841.2050612171439, 907.4011152639226, 1003.0471052500009, 1037.7042542875245, 1038.408107378802, 14383.424663013571, 15256.160911149993, 15373.1544765039, 15797.763033554505, 16517.091559964076, 902.4269588811152, 936.6066252174103, 940.191435365585, 970.3110791338229, 1012.4431562640666, 9374.296927730311, 9521.23830093591, 9612.423254604746, 9627.0, 9685.951570242103, 448793.0, 451412.0, 455536.0, 462923.0, 497725.0, 68327.65836170886, 70749.29250707426, 71193.28806711867, 71330.0, 71512.28487715057, 1058.439027315524, 1071.614218881202, 1073.3881687438086, 1084.4957094950728, 1092.639428988448, 14212.502562410265, 14650.926745366205, 14853.925730371711, 14902.701945960804, 14949.85050149528, 30468.542971855884, 30690.84654576713, 30859.537106942964, 31186.844065779525, 31449.685503144676, 35732.0, 36508.087297817765, 36605.0, 36700.26599468049, 37428.81285593664, 3027.107003433948, 3044.6346438426644, 5636.971815140898, 6934.479914006369, 7230.45771567124, 9578.568964396758, 10213.642522511676, 10262.384256944608, 11076.113910886948, 11257.549698011988, 8901.73294801157, 9425.38734982224, 9586.520673966414, 9953.253505986935, 10068.89931100709, 9529.475878826453, 9767.0, 9885.752856178653, 9947.0, 10257.435841028517, 8769.429987050822, 9207.76980575491, 9927.305088643725, 10110.545025474019, 10197.286189966631, 7146.142462904485, 7346.77959661211, 7421.517601355895, 7511.286427789351, 7592.544447333178, 9012.32407569448, 9889.208863291064, 10035.046670566284, 10149.594016239267, 10325.0], "unit": "score", "name": "jquery.html", "value": 8401.387173843515}, {"lowerIsBetter": false, "replicates": [1406.528812847696, 1466.3987765016343, 1642.252774987381, 1783.1619139004663, 1804.2061492943103, 7352.779416617496, 7550.5847178405165, 7554.697812087524, 7592.9240707592835, 7721.459497835153, 7777.533347999124, 7798.8440231195345, 7846.293833554979, 7850.940123083396, 7868.92131078689, 2286.668433077207, 2303.9193628223015, 2314.0396735354807, 2314.5833749925005, 2325.9651105233434, 2226.3432287475152, 2239.1267405711787, 2247.4269061389323, 2259.2431535435567, 2270.750217476076, 2166.2418153646254, 2201.7688142745023, 2220.622494175994, 2278.088764494199, 2295.2655150351893, 2164.3182397544724, 2187.639039558471, 2192.3203806819856, 2202.1411649456722, 2203.493196564791, 2252.14418520961, 2263.9434014149615, 2276.920307789236, 2278.874661893595, 2286.554121946221, 7256.96371518139, 7265.963670181668, 7282.635868206568, 7290.81772955675, 7303.160136584254, 4541.591256786872, 4634.420697412824, 4636.35091087248, 4642.628589712815, 4649.535046495357, 2814.746672799458, 2944.219781757836, 2948.8083274587084, 2954.1432984434487, 2958.45268625305, 910.6676063236937, 919.2140719684706, 934.7476181430976, 948.2840455456155, 958.520739630185, 10391.480425978747, 10519.84220236697, 10532.42071686057, 10551.73620659482, 10598.576056957712, 3976.542697589814, 3982.1438390745548, 4048.817803198863, 4064.573219811877, 4068.572799856032, 8678.78303042429, 8683.044865064838, 8697.043325234219, 8702.564871756513, 8713.085126061798, 4575.7483338416705, 4595.563421474954, 4597.632189424838, 4607.976960115245, 4626.1441633297945, 4243.405923170759, 4244.808983595745, 4261.041265715251, 4266.296061149876, 4269.31690929456, 3410.710089642408, 3428.074419906611, 3435.4503279475166, 3456.8271586421083, 3478.373892699288, 1010.2625083688802, 1014.1633152649094, 1018.4907546226887, 1023.3910823060268, 1029.8352263637782, 1059.8569193158826, 1082.5182793656747, 1085.2999815119204, 1219.4207751318231, 1328.110166188656, 6942.861142777117, 6982.93017069833, 6984.301569842975, 6987.510874238755, 7227.457940654472, 1117.8602674665667, 1123.550579768083, 1156.4680247086435, 1162.035510526261, 1166.8133098704166, 5431.565474762009, 5573.303337082864, 5580.693061881636, 5600.0, 5619.662820230799, 8723.084076172037, 8792.736217913473, 8896.510691911877, 9271.0, 9342.859857102148, 9192.080791920755, 9207.539623018822, 9247.676331328372, 9271.536423178813, 9336.253099752004, 6985.755498557526, 7036.648167591702, 7244.601546914971, 7371.6682749276415, 7383.483156179123, 7217.963910180415, 7241.203467618452, 7246.239144889711, 7246.384057355184, 7309.4152467803515, 7986.680532778624, 8062.677492900453, 8159.3880458967005, 8185.099639039582, 8198.795030124294, 8105.959470202612, 8418.957905210435, 8427.494350338999, 8510.31917446615, 8510.82978340442, 6564.146660934048, 6596.5052621052655, 6649.567778094409, 6675.365840245169, 6925.653717314013, 7222.74720384784, 7253.093363329584, 7259.455540834564, 7263.6005019724425, 7286.380657644159, 6103.84740381494, 6732.192136943598, 6930.792076237721, 6995.685194166376, 7119.466040047121, 6818.727250909908, 6820.795376138723, 6831.9658401707675, 6875.278095799869, 6936.098307220231, 6720.563163394364, 7038.577685338896, 7066.823329416806, 7075.257098004636, 7099.467539934629, 6503.25212600557, 6507.577007494498, 6526.0, 6527.379898909596, 6540.803775886731, 6360.840978975562, 6361.077643741724, 6396.296407395276, 6480.189976252968, 6487.253965793994], "unit": "score", "name": "mootools.html", "value": 4386.2507312679945}, {"lowerIsBetter": false, "replicates": [328.6729703944575, 330.039584808208, 334.48322341981634, 338.95939465839865, 346.61352591860066, 6234.594751341159, 6246.750649870027, 6274.529410294234, 6282.623042617446, 6396.424321811036, 6239.438450539451, 6241.750329986807, 6258.812235632939, 6258.874822503547, 6279.277883043452, 4716.434027916637, 4728.66899317048, 4733.431988161426, 4733.952660473386, 4734.242521196609, 4732.408448943882, 4738.620910327183, 4742.193827049393, 4742.217534106868, 4748.453927798313, 4549.613282870943, 4600.700954437968, 4608.4700259470255, 4618.1687296286655, 4663.044075964419, 4578.221702310615, 4605.677602567822, 4609.815607375701, 4614.630829533646, 4638.930416043762, 3999.5800440953863, 4018.45750823638, 4030.496187976503, 4032.778197199153, 4033.69747268956, 5864.44287792659, 5906.291245050621, 5913.2608423947, 5921.555883308726, 5926.762929482816, 5294.100002999499, 5437.619366644337, 5467.726613669301, 5475.616706830523, 5481.698506582136, 6613.3056029117215, 6616.536842421033, 6620.86758264832, 6624.138861947964, 6632.8673426531195, 4450.977745111286, 4471.7987690554, 4475.753833539154, 4493.505714371417, 4510.458744950594, 6756.459483241329, 6832.248452670202, 6868.141482314711, 6901.792946211572, 6926.688299026556, 4609.585137337655, 4611.561901619408, 4611.677182597186, 4617.492075871652, 4633.328167415773, 4667.929981050287, 4674.626029917598, 4680.08738296029, 4682.765861706969, 4684.297355396649, 5409.594280428983, 5412.052890744183, 5434.076207044733, 5436.157395603688, 5447.019536483471, 6504.252011018699, 6621.668916554153, 6649.567778094409, 6660.8667826643195, 6661.866762664719, 1631.0947424179458, 1635.8527732503894, 1638.2382192280647, 1638.336473728142, 1641.9261133249033, 1077.8383242513685, 1079.6383211624036, 1094.731790711265, 1097.8572785537829, 1121.8485504456958, 6127.448529632355, 6129.785457508966, 6135.0797380392405, 6139.539534534839, 6166.537509686791, 6748.932510674928, 6766.25571187169, 6787.5588086774205, 6799.864002719918, 6828.6927088281145, 5946.613470124515, 6032.6983650818165, 6057.727402266909, 6071.483923866433, 6083.817485475354, 3676.062604036007, 3692.040069581928, 3714.9071273217846, 3722.925541489155, 3746.83139258734, 7021.122359705037, 7023.122109736283, 7033.120859892513, 7044.0, 7047.753328633473, 6834.521583489208, 7047.189573199045, 7047.718091276394, 7113.7154513819905, 7133.89299160513, 7089.61007144612, 7104.715811367488, 7114.501984861114, 7119.359257666835, 7143.321384468467, 6874.484413668894, 6881.862362752817, 6888.448924085961, 6897.0, 6903.965480172567, 6646.90029649546, 6823.829404264735, 6858.382745552724, 6861.588304701534, 6862.3137686230975, 7090.539114957717, 7108.573485590881, 7113.82215444618, 7131.893021604784, 7132.322429369202, 4579.290210017452, 4620.792064357179, 4627.097715945359, 4631.490536040966, 4635.049814788028, 6720.294369091371, 6881.483888708267, 6922.307769223239, 6924.930750692429, 6931.202911665021, 6651.102101216274, 6690.665466726547, 6699.698513566998, 6699.732010719712, 6732.3267673232285, 6624.90062649051, 6677.7295719455615, 6686.431653309523, 6694.062831203538, 6698.5980841149685, 6371.649559274284, 6594.505412094016, 6595.868082638224, 6599.4390476808085, 6619.635920024445, 6666.2333831609985, 6671.999200120021, 6680.131582894192, 6730.0, 6735.6295403753265, 6394.840128996626, 6516.51126165549, 6521.869562608626, 6525.836854078686, 6543.70553325092], "unit": "score", "name": "prototype.html", "value": 4951.353816975314}, {"lowerIsBetter": false, "replicates": [793.3454899707742, 818.1020033522227, 831.5301854452234, 865.1002956924794, 893.8927328720555, 13452.865471345296, 13472.865271347307, 13601.863981360184, 13634.454621815128, 13642.181469111836, 11527.596534121287, 11914.761704765899, 12016.45925933333, 12017.579384721537, 12022.639320820368, 637.8309747916794, 777.7550071727416, 802.5224991130298, 804.9436539442241, 806.7942674617964, 788.7751990682657, 800.4276941986478, 800.951942883426, 804.0311424733212, 805.2832978649008, 834.2408408348405, 841.8442588121187, 846.7713717296326, 849.8682704180862, 851.1531026628513, 832.6919039955195, 843.3127001493763, 843.5571325054365, 843.9915600844035, 846.2341580869323, 618.1839971237968, 618.3229363846581, 618.5577312221783, 619.1053927075378, 619.6994457688018, 13052.412641431158, 13142.277174755385, 13248.40382182804, 13282.0, 13290.601281961557, 12314.5074197032, 12538.370011898394, 12776.552820651232, 12911.67720806978, 12991.415386307639, 9668.371555848918, 9925.652602158962, 9986.800263994679, 10203.132733717643, 10209.642662506776, 3437.1063523483826, 3439.914002149941, 3478.095695119262, 3478.147853775841, 3595.26297109092, 45346.546534534566, 45484.54515454803, 45561.0, 46091.07817843624, 46150.53849461496, 9634.855477167848, 9948.253880958957, 10000.849987250198, 10152.746181345525, 10195.949020255, 17141.657166856592, 17171.31314747396, 17206.0, 17212.569685757706, 17218.655626887394, 7458.179600243969, 7534.886976695354, 7536.171021187665, 7670.654820533089, 7694.499857509244, 4258.595433433881, 4304.182205380967, 4329.15581461612, 4367.192069467159, 4392.626626736763, 2960.348723280918, 3000.969990300113, 3009.2176034231256, 3014.954775678367, 3016.834074125944, 566.1253363553237, 566.8922904648103, 568.5508448325859, 572.2103497173956, 583.4398976982145, 546.7321012703826, 548.0491347512063, 616.3282022595392, 665.8335416145964, 694.7116946467261, 8281.254687078192, 8287.461315014505, 8342.374321925758, 8346.624401901929, 8443.197896199852, 551.0631925726282, 559.7732918168149, 572.6392372805107, 603.8279090459198, 643.6273924634879, 3897.1036661567996, 3984.203159368138, 4063.89840253996, 4217.40956266123, 4238.131183107455, 53509.464905351226, 54607.0, 54719.726401368534, 54835.45164548304, 54852.17721734177, 49140.75429622829, 50146.0, 50160.247596286084, 50603.0, 50708.492915070376, 43160.0, 43344.566554334684, 43476.565234347254, 44623.776881116035, 45123.32315015278, 8421.747347579583, 8718.91281087181, 8912.108789121035, 8947.347419245312, 9063.365564410427, 34243.4863477053, 34545.48181777225, 34972.12569685778, 34999.30001400009, 35136.47295290521, 40139.0, 40208.396874047496, 41050.58949410468, 43890.341644874716, 44028.55971440244, 10867.184961128105, 11160.776784464428, 11174.106071514421, 11186.776264474502, 11304.830427543759, 11826.34955077479, 11909.0, 11936.164468487123, 12006.879931200576, 12227.144099913277, 11172.49723762449, 11672.066234701373, 11691.0, 11773.941130294294, 11983.460744266704, 11009.229353945148, 11199.160062995144, 11216.55133794639, 11264.718382040515, 11643.941780291045, 10896.564137434414, 11043.116550676088, 11108.722281943015, 11188.552457901593, 11472.369019703663, 9425.104615061558, 9602.32783705134, 9755.512224388895, 9937.254705896941, 9994.300398972002, 8958.552072396224, 9212.401193922373, 9261.86107208379, 9353.298502612195, 9572.76068098303], "unit": "score", "name": "yui.html", "value": 6190.546071319729}], "name": "dromaeo_css", "value": 6896.443151907021}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 106.0, 112.0, 114.0, 112.0, 125.0, 111.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [158.0, 134.0, 153.0, 165.0, 125.0, 160.0, 155.0, 129.0, 162.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 146.6}, {"lowerIsBetter": true, "replicates": [161.0, 164.0, 162.0, 164.0, 163.0, 161.0, 161.0, 163.0, 172.0, 166.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [71.0, 74.0, 72.0, 73.0, 73.0, 72.0, 129.0, 71.0, 75.0, 74.0], "unit": "score", "name": "audio-fft", "value": 78.4}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 146.0, 95.0, 95.0, 96.0, 137.0, 98.0, 97.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 111.0, 110.0, 110.0, 111.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 146.0, 146.0, 148.0, 147.0, 146.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [57.0, 61.0, 57.0, 57.0, 59.0, 56.0, 60.0, 60.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [84.0, 93.0, 94.0, 85.0, 87.0, 88.0, 87.0, 88.0, 91.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.2}, {"lowerIsBetter": true, "replicates": [121.0, 121.0, 131.0, 133.0, 116.0, 121.0, 125.0, 118.0, 126.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.8}, {"lowerIsBetter": true, "replicates": [141.0, 152.0, 158.0, 154.0, 150.0, 154.0, 156.0, 150.0, 154.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.2}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 69.0, 71.0, 68.0, 68.0, 70.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1522.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.371258475277], "unit": "score", "name": "Richards", "value": 213.47119400000008}, {"lowerIsBetter": false, "replicates": [187.93459875963165], "unit": "score", "name": "DeltaBlue", "value": 351.8138780000001}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1072.961373390558], "unit": "score", "name": "RayTrace", "value": 689.6697479999999}, {"lowerIsBetter": false, "replicates": [724.6376811594203], "unit": "score", "name": "Earley", "value": 919.7189400000003}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [40431.37254901961], "unit": "score", "name": "RegExp", "value": 22.531636760426764}, {"lowerIsBetter": false, "replicates": [621.1180124223603], "unit": "score", "name": "Splay", "value": 131.20050999999998}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20353.690683770074}]} 19:01:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20353.69"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1522.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6896.44"}}} 19:01:44 INFO - Return code: 0 19:01:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:01:45 INFO - # TBPL SUCCESS # 19:01:45 INFO - Running post-action listener: _resource_record_post_action 19:01:45 INFO - Running post-run listener: _resource_record_post_run 19:01:46 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 562765824; Read time: 24; Write time: 392044 19:01:46 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239259648; Read time: 0; Write time: 215036 19:01:46 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 323506176; Read time: 24; Write time: 177008 19:01:46 INFO - Running post-run listener: _upload_blobber_files 19:01:46 INFO - Blob upload gear active. 19:01:46 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:01:46 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 19:01:46 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:01:46 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:01:46 INFO - (blobuploader) - INFO - Open directory for files ... 19:01:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:01:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:01:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:47 INFO - (blobuploader) - INFO - Done attempting. 19:01:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:01:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:01:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:48 INFO - (blobuploader) - INFO - Done attempting. 19:01:48 INFO - (blobuploader) - INFO - Iteration through files over. 19:01:48 INFO - Return code: 0 19:01:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:01:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:01:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdbf6beda36f34c0323959148f168c33e92193b851ca32b6ae3b8255e517a7d49b370df5a555f1b7bef5c616fe883bcfb9cefd04e7e0988e3d6c617bbbb4c5e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b877ca676a5533666ae48882313471bfe2db03c1d3cbd0db867a382b5b7014ebe7feecdf6c39f2aa5bcd59135019f6bf91a9532b6977afd11cfb4dcc7524e624"} 19:01:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:01:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:01:48 INFO - Contents: 19:01:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdbf6beda36f34c0323959148f168c33e92193b851ca32b6ae3b8255e517a7d49b370df5a555f1b7bef5c616fe883bcfb9cefd04e7e0988e3d6c617bbbb4c5e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b877ca676a5533666ae48882313471bfe2db03c1d3cbd0db867a382b5b7014ebe7feecdf6c39f2aa5bcd59135019f6bf91a9532b6977afd11cfb4dcc7524e624"} 19:01:48 INFO - Copying logs to upload dir... 19:01:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.160098 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-08 19:01:47.052863) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 19:01:47.056423) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdbf6beda36f34c0323959148f168c33e92193b851ca32b6ae3b8255e517a7d49b370df5a555f1b7bef5c616fe883bcfb9cefd04e7e0988e3d6c617bbbb4c5e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b877ca676a5533666ae48882313471bfe2db03c1d3cbd0db867a382b5b7014ebe7feecdf6c39f2aa5bcd59135019f6bf91a9532b6977afd11cfb4dcc7524e624"} build_url:https://queue.taskcluster.net/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/LcoPNZDDSrm2Ju3_G4kvYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdbf6beda36f34c0323959148f168c33e92193b851ca32b6ae3b8255e517a7d49b370df5a555f1b7bef5c616fe883bcfb9cefd04e7e0988e3d6c617bbbb4c5e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b877ca676a5533666ae48882313471bfe2db03c1d3cbd0db867a382b5b7014ebe7feecdf6c39f2aa5bcd59135019f6bf91a9532b6977afd11cfb4dcc7524e624"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 19:01:47.080938) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 19:01:47.081287) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452293805.306397-921915329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 19:01:47.165948) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 19:01:47.166269) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 19:01:47.166545) ========= ========= Total master_lag: 0.23 =========