builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1453219699.78 results: success (0) buildid: 20160119053006 builduid: 1d9cc65bde6b4ca5aca8967644b9d0b5 revision: 491b1c69b3ed6e54de98f21b06d741e0981b0535 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.785384) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.785945) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.786239) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006462 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.818133) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.818473) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.870354) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.870640) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004629 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.919676) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.919989) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.920343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.920614) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 08:08:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 44.0M=0s 2016-01-19 08:08:20 (44.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100732 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:20.034961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:20.035354) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022280 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:20.088204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:20.088666) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 491b1c69b3ed6e54de98f21b06d741e0981b0535 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 491b1c69b3ed6e54de98f21b06d741e0981b0535 --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=edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 08:08:20,344 truncating revision to first 12 chars 2016-01-19 08:08:20,344 Setting DEBUG logging. 2016-01-19 08:08:20,344 attempt 1/10 2016-01-19 08:08:20,344 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/491b1c69b3ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 08:08:20,608 unpacking tar archive at: fx-team-491b1c69b3ed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571861 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:20.674407) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:20.674801) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004563 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:20.727451) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:20.727735) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:20.740207) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:20.740536) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:20.740963) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-01-19 08:08:20.741241) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:08:21 INFO - MultiFileLogger online at 20160119 08:08:21 in /builds/slave/test-pgo 08:08:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:08:21 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:08:21 INFO - {'append_to_log': False, 08:08:21 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:08:21 INFO - 'blob_upload_branch': 'Fx-Team', 08:08:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:08:21 INFO - 'branch': 'Fx-Team', 08:08:21 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:21 INFO - 'config_files': ('talos/linux_config.py',), 08:08:21 INFO - 'default_actions': ('clobber', 08:08:21 INFO - 'read-buildbot-config', 08:08:21 INFO - 'download-and-extract', 08:08:21 INFO - 'populate-webroot', 08:08:21 INFO - 'create-virtualenv', 08:08:21 INFO - 'install', 08:08:21 INFO - 'run-tests'), 08:08:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:21 INFO - 'download_minidump_stackwalk': True, 08:08:21 INFO - 'download_symbols': 'ondemand', 08:08:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:21 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:21 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:21 INFO - 'installer_path': 'installer.exe', 08:08:21 INFO - 'log_level': 'info', 08:08:21 INFO - 'log_name': 'talos', 08:08:21 INFO - 'log_to_console': True, 08:08:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:08:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:08:21 INFO - 'opt_config_files': (), 08:08:21 INFO - 'pip_index': False, 08:08:21 INFO - 'sps_profile': False, 08:08:21 INFO - 'sps_profile_interval': 0, 08:08:21 INFO - 'suite': 'dromaeojs', 08:08:21 INFO - 'system_bits': '32', 08:08:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:21 INFO - 'title': 'talos-linux64-ix-033', 08:08:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:21 INFO - 'use_talos_json': True, 08:08:21 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:08:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:21 INFO - 'work_dir': 'build'} 08:08:21 INFO - ##### 08:08:21 INFO - ##### Running clobber step. 08:08:21 INFO - ##### 08:08:21 INFO - Running pre-action listener: _resource_record_pre_action 08:08:21 INFO - Running main action method: clobber 08:08:21 INFO - rmtree: /builds/slave/test-pgo/build 08:08:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:08:21 INFO - Running post-action listener: _resource_record_post_action 08:08:21 INFO - ##### 08:08:21 INFO - ##### Running read-buildbot-config step. 08:08:21 INFO - ##### 08:08:21 INFO - Running pre-action listener: _resource_record_pre_action 08:08:21 INFO - Running main action method: read_buildbot_config 08:08:21 INFO - Using buildbot properties: 08:08:21 INFO - { 08:08:21 INFO - "project": "", 08:08:21 INFO - "product": "firefox", 08:08:21 INFO - "script_repo_revision": "production", 08:08:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:08:21 INFO - "repository": "", 08:08:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:08:21 INFO - "buildid": "20160119053006", 08:08:21 INFO - "pgo_build": "True", 08:08:21 INFO - "basedir": "/builds/slave/test-pgo", 08:08:21 INFO - "buildnumber": 427, 08:08:21 INFO - "slavename": "talos-linux64-ix-033", 08:08:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:08:21 INFO - "platform": "ubuntu64_hw", 08:08:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:08:21 INFO - "branch": "fx-team", 08:08:21 INFO - "repo_path": "integration/fx-team", 08:08:21 INFO - "revision": "491b1c69b3ed6e54de98f21b06d741e0981b0535", 08:08:21 INFO - "stage_platform": "linux64-pgo", 08:08:21 INFO - "builduid": "1d9cc65bde6b4ca5aca8967644b9d0b5", 08:08:21 INFO - "slavebuilddir": "test" 08:08:21 INFO - } 08:08:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:08:21 INFO - Running post-action listener: _resource_record_post_action 08:08:21 INFO - ##### 08:08:21 INFO - ##### Running download-and-extract step. 08:08:21 INFO - ##### 08:08:21 INFO - Running pre-action listener: _resource_record_pre_action 08:08:21 INFO - Running main action method: download_and_extract 08:08:21 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:21 INFO - https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:08:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/test_packages.json 08:08:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/test_packages.json 08:08:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:08:29 INFO - Downloaded 1448 bytes. 08:08:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:08:29 INFO - Using the following test package requirements: 08:08:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:08:29 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:08:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:29 INFO - u'jsshell-linux-x86_64.zip'], 08:08:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:08:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:08:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:08:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:08:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:08:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:08:29 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')]} 08:08:29 INFO - https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/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 08:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/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 08:08:42 INFO - Downloaded 22484778 bytes. 08:08:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:08:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:08:43 INFO - Return code: 0 08:08:43 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 08:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:43 INFO - https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/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 08:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/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 08:08:45 INFO - Downloaded 22484778 bytes. 08:08:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:08:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:08:46 INFO - Return code: 0 08:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:46 INFO - https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/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 08:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/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 08:08:47 INFO - Downloaded 11132144 bytes. 08:08:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:08:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 08:08:48 INFO - Return code: 0 08:08:48 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')]} 08:08:48 INFO - https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:08:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/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 08:08:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/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 08:08:49 INFO - Downloaded 55942533 bytes. 08:08:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:49 INFO - mkdir: /builds/slave/test-pgo/properties 08:08:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:08:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:08:49 INFO - Contents: 08:08:49 INFO - build_url:https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:49 INFO - Running post-action listener: _resource_record_post_action 08:08:49 INFO - Running post-action listener: set_extra_try_arguments 08:08:49 INFO - ##### 08:08:49 INFO - ##### Running populate-webroot step. 08:08:49 INFO - ##### 08:08:49 INFO - Running pre-action listener: _resource_record_pre_action 08:08:49 INFO - Running main action method: populate_webroot 08:08:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:08:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:08:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:08:49 INFO - '--tppagecycles', 08:08:49 INFO - '7'], 08:08:49 INFO - 'tests': ['tsvgm']}}, 08:08:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:08:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:08:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:08:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:08:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:08:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:08:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:49 INFO - 'talos_options': ['--e10s'], 08:08:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:49 INFO - 'tests': ['damp', 'tps']}, 08:08:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:49 INFO - 'talos_options': ['--e10s'], 08:08:49 INFO - 'tests': ['damp', 'tps']}, 08:08:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:08:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:08:49 INFO - 'other': {'tests': ['a11yr', 08:08:49 INFO - 'ts_paint', 08:08:49 INFO - 'tpaint', 08:08:49 INFO - 'sessionrestore', 08:08:49 INFO - 'sessionrestore_no_auto_restore']}, 08:08:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:08:49 INFO - 'tests': ['a11yr', 08:08:49 INFO - 'ts_paint', 08:08:49 INFO - 'tpaint', 08:08:49 INFO - 'sessionrestore', 08:08:49 INFO - 'sessionrestore_no_auto_restore']}, 08:08:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:08:49 INFO - 'tests': ['a11yr', 08:08:49 INFO - 'ts_paint', 08:08:49 INFO - 'tpaint', 08:08:49 INFO - 'sessionrestore', 08:08:49 INFO - 'sessionrestore_no_auto_restore']}, 08:08:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:08:49 INFO - 'tests': ['a11yr', 08:08:49 INFO - 'ts_paint', 08:08:49 INFO - 'tpaint', 08:08:49 INFO - 'sessionrestore', 08:08:49 INFO - 'sessionrestore_no_auto_restore']}, 08:08:49 INFO - 'other_l64': {'tests': ['a11yr', 08:08:49 INFO - 'ts_paint', 08:08:49 INFO - 'tpaint', 08:08:49 INFO - 'sessionrestore', 08:08:49 INFO - 'sessionrestore_no_auto_restore']}, 08:08:49 INFO - 'other_nol64': {'tests': ['a11yr', 08:08:49 INFO - 'ts_paint', 08:08:49 INFO - 'tpaint', 08:08:49 INFO - 'sessionrestore', 08:08:49 INFO - 'sessionrestore_no_auto_restore']}, 08:08:49 INFO - 'svgr': {'tests': ['tsvgx', 08:08:49 INFO - 'tsvgr_opacity', 08:08:49 INFO - 'tart', 08:08:49 INFO - 'tscrollx', 08:08:49 INFO - 'cart']}, 08:08:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:08:49 INFO - 'tests': ['tsvgx', 08:08:49 INFO - 'tsvgr_opacity', 08:08:49 INFO - 'tart', 08:08:49 INFO - 'tscrollx', 08:08:49 INFO - 'cart']}, 08:08:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:49 INFO - 'tests': ['tp5o']}, 08:08:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:49 INFO - 'talos_options': ['--e10s'], 08:08:49 INFO - 'tests': ['tp5o']}, 08:08:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:49 INFO - 'talos_options': ['--xperf_path', 08:08:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:49 INFO - 'tests': ['tp5n']}, 08:08:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:49 INFO - 'talos_options': ['--e10s', 08:08:49 INFO - '--xperf_path', 08:08:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:49 INFO - 'tests': ['tp5n']}}, 08:08:49 INFO - 'talos.zip': {'path': '', 08:08:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:08:49 INFO - Running post-action listener: _resource_record_post_action 08:08:49 INFO - ##### 08:08:49 INFO - ##### Running create-virtualenv step. 08:08:49 INFO - ##### 08:08:49 INFO - Running pre-action listener: _resource_record_pre_action 08:08:49 INFO - Running main action method: create_virtualenv 08:08:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:08:49 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 08:08:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:08:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:08:49 INFO - Using real prefix '/usr' 08:08:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:08:50 INFO - Installing distribute.............................................................................................................................................................................................done. 08:08:52 INFO - Installing pip.................done. 08:08:52 INFO - Return code: 0 08:08:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:08: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')]} 08:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8ec9d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c540>, '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 0x205d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205d8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', '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 08:08:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:08:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:08:52 INFO - Using env: {'DISPLAY': ':0', 08:08:52 INFO - 'HOME': '/home/cltbld', 08:08:52 INFO - 'LANG': 'en_US.UTF-8', 08:08:52 INFO - 'LANGUAGE': 'en_US:en', 08:08:52 INFO - 'LOGNAME': 'cltbld', 08:08:52 INFO - 'MAIL': '/var/mail/cltbld', 08:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:52 INFO - 'MOZ_NO_REMOTE': '1', 08:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:52 INFO - 'NO_EM_RESTART': '1', 08:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:52 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:52 INFO - 'SHELL': '/bin/bash', 08:08:52 INFO - 'SHLVL': '1', 08:08:52 INFO - 'TERM': 'linux', 08:08:52 INFO - 'TMOUT': '86400', 08:08:52 INFO - 'USER': 'cltbld', 08:08:52 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', 08:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:52 INFO - '_': '/tools/buildbot/bin/python'} 08:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:52 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 08:08:52 INFO - Cleaning up... 08:08:52 INFO - Return code: 0 08:08:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:08: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')]} 08:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc8ec9d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c540>, '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 0x205d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205d8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', '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 08:08:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:08:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:08:52 INFO - Using env: {'DISPLAY': ':0', 08:08:52 INFO - 'HOME': '/home/cltbld', 08:08:52 INFO - 'LANG': 'en_US.UTF-8', 08:08:52 INFO - 'LANGUAGE': 'en_US:en', 08:08:52 INFO - 'LOGNAME': 'cltbld', 08:08:52 INFO - 'MAIL': '/var/mail/cltbld', 08:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:52 INFO - 'MOZ_NO_REMOTE': '1', 08:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:52 INFO - 'NO_EM_RESTART': '1', 08:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:52 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:52 INFO - 'SHELL': '/bin/bash', 08:08:52 INFO - 'SHLVL': '1', 08:08:52 INFO - 'TERM': 'linux', 08:08:52 INFO - 'TMOUT': '86400', 08:08:52 INFO - 'USER': 'cltbld', 08:08:52 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', 08:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:52 INFO - '_': '/tools/buildbot/bin/python'} 08:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:52 INFO - Downloading/unpacking psutil>=0.7.1 08:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:08:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:08:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:08:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:54 INFO - Installing collected packages: psutil 08:08:54 INFO - Running setup.py install for psutil 08:08:54 INFO - building 'psutil._psutil_linux' extension 08:08:54 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 08:08:54 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 08:08:54 INFO - building 'psutil._psutil_posix' extension 08:08:54 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 08:08:54 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 08:08:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:54 INFO - Successfully installed psutil 08:08:54 INFO - Cleaning up... 08:08:54 INFO - Return code: 0 08:08:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc8ec9d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c540>, '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 0x205d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205d8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', '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 08:08:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:08:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:08:54 INFO - Using env: {'DISPLAY': ':0', 08:08:54 INFO - 'HOME': '/home/cltbld', 08:08:54 INFO - 'LANG': 'en_US.UTF-8', 08:08:54 INFO - 'LANGUAGE': 'en_US:en', 08:08:54 INFO - 'LOGNAME': 'cltbld', 08:08:54 INFO - 'MAIL': '/var/mail/cltbld', 08:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:54 INFO - 'MOZ_NO_REMOTE': '1', 08:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:54 INFO - 'NO_EM_RESTART': '1', 08:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:54 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:54 INFO - 'SHELL': '/bin/bash', 08:08:54 INFO - 'SHLVL': '1', 08:08:54 INFO - 'TERM': 'linux', 08:08:54 INFO - 'TMOUT': '86400', 08:08:54 INFO - 'USER': 'cltbld', 08:08:54 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', 08:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:54 INFO - '_': '/tools/buildbot/bin/python'} 08:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:08:55 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 08:08:55 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 08:08:55 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 08:08:55 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 08:08:55 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 08:08:55 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 08:08:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:08:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:08:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:08:56 INFO - Installing collected packages: mozsystemmonitor 08:08:56 INFO - Running setup.py install for mozsystemmonitor 08:08:56 INFO - Successfully installed mozsystemmonitor 08:08:56 INFO - Cleaning up... 08:08:56 INFO - Return code: 0 08:08:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:08: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')]} 08:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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', '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 0x7fc8ec9d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c540>, '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 0x205d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205d8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', '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 08:08: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:08: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 blobuploader==1.2.4 08:08:56 INFO - Using env: {'DISPLAY': ':0', 08:08:56 INFO - 'HOME': '/home/cltbld', 08:08:56 INFO - 'LANG': 'en_US.UTF-8', 08:08:56 INFO - 'LANGUAGE': 'en_US:en', 08:08:56 INFO - 'LOGNAME': 'cltbld', 08:08:56 INFO - 'MAIL': '/var/mail/cltbld', 08:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:56 INFO - 'MOZ_NO_REMOTE': '1', 08:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:57 INFO - 'NO_EM_RESTART': '1', 08:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:57 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:57 INFO - 'SHELL': '/bin/bash', 08:08:57 INFO - 'SHLVL': '1', 08:08:57 INFO - 'TERM': 'linux', 08:08:57 INFO - 'TMOUT': '86400', 08:08:57 INFO - 'USER': 'cltbld', 08:08:57 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', 08:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:57 INFO - '_': '/tools/buildbot/bin/python'} 08:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:57 INFO - Downloading/unpacking blobuploader==1.2.4 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:58 INFO - Downloading blobuploader-1.2.4.tar.gz 08:08:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:08:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:08:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:08:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:08:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:59 INFO - Downloading docopt-0.6.1.tar.gz 08:08:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:08:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:08:59 INFO - Installing collected packages: blobuploader, requests, docopt 08:08:59 INFO - Running setup.py install for blobuploader 08:08:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:08:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:08:59 INFO - Running setup.py install for requests 08:09:00 INFO - Running setup.py install for docopt 08:09:00 INFO - Successfully installed blobuploader requests docopt 08:09:00 INFO - Cleaning up... 08:09:00 INFO - Return code: 0 08:09:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:09:00 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')]} 08:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:00 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')]} 08:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:00 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 0x7fc8ec9d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c540>, '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 0x205d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205d8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', '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 08:09:00 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 08:09:00 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 08:09:00 INFO - Using env: {'DISPLAY': ':0', 08:09:00 INFO - 'HOME': '/home/cltbld', 08:09:00 INFO - 'LANG': 'en_US.UTF-8', 08:09:00 INFO - 'LANGUAGE': 'en_US:en', 08:09:00 INFO - 'LOGNAME': 'cltbld', 08:09:00 INFO - 'MAIL': '/var/mail/cltbld', 08:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:00 INFO - 'MOZ_NO_REMOTE': '1', 08:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:00 INFO - 'NO_EM_RESTART': '1', 08:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:00 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:00 INFO - 'SHELL': '/bin/bash', 08:09:00 INFO - 'SHLVL': '1', 08:09:00 INFO - 'TERM': 'linux', 08:09:00 INFO - 'TMOUT': '86400', 08:09:00 INFO - 'USER': 'cltbld', 08:09:00 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', 08:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:00 INFO - '_': '/tools/buildbot/bin/python'} 08:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:09:00 INFO - Running setup.py (path:/tmp/pip-sPgtAU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:09:00 INFO - Running setup.py (path:/tmp/pip-wvet6t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:09:00 INFO - Running setup.py (path:/tmp/pip-awJ7cg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:09:00 INFO - Running setup.py (path:/tmp/pip-cktsnS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:09:00 INFO - Running setup.py (path:/tmp/pip-xV5C1V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:09:00 INFO - Running setup.py (path:/tmp/pip-GYPvNW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:09:00 INFO - Running setup.py (path:/tmp/pip-UVMZR3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:09:01 INFO - Running setup.py (path:/tmp/pip-UjLJCb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:09:01 INFO - Running setup.py (path:/tmp/pip-h0X5OJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:09:01 INFO - Running setup.py (path:/tmp/pip-sXUnPr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:09:01 INFO - Running setup.py (path:/tmp/pip-BbqcIs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:09:01 INFO - Running setup.py (path:/tmp/pip-hsJBYF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:09:01 INFO - Running setup.py (path:/tmp/pip-wYD9GL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:09:01 INFO - Running setup.py (path:/tmp/pip-tLqZd1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:09:01 INFO - Running setup.py (path:/tmp/pip-UshVkX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:09:01 INFO - Running setup.py (path:/tmp/pip-Es8KDc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:09:01 INFO - Running setup.py (path:/tmp/pip-l0bXB3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:09:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:01 INFO - Running setup.py install for manifestparser 08:09:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:09:01 INFO - Running setup.py install for mozcrash 08:09:01 INFO - Running setup.py install for mozdebug 08:09:02 INFO - Running setup.py install for mozdevice 08:09:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:09:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:09:02 INFO - Running setup.py install for mozfile 08:09:02 INFO - Running setup.py install for mozhttpd 08:09:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:09:02 INFO - Running setup.py install for mozinfo 08:09:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:09:02 INFO - Running setup.py install for mozInstall 08:09:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:09:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:09:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:09:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:09:02 INFO - Running setup.py install for mozleak 08:09:02 INFO - Running setup.py install for mozlog 08:09:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:09:02 INFO - Running setup.py install for moznetwork 08:09:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:09:02 INFO - Running setup.py install for mozprocess 08:09:02 INFO - Running setup.py install for mozprofile 08:09:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:09:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:09:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:09:03 INFO - Running setup.py install for mozrunner 08:09:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:09:03 INFO - Running setup.py install for mozscreenshot 08:09:03 INFO - Running setup.py install for moztest 08:09:03 INFO - Running setup.py install for mozversion 08:09:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:09:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:03 INFO - Cleaning up... 08:09:03 INFO - Return code: 0 08:09:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fc8ec9d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c540>, '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 0x205d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205d8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', '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 08:09:03 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 08:09:03 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 08:09:03 INFO - Using env: {'DISPLAY': ':0', 08:09:03 INFO - 'HOME': '/home/cltbld', 08:09:03 INFO - 'LANG': 'en_US.UTF-8', 08:09:03 INFO - 'LANGUAGE': 'en_US:en', 08:09:03 INFO - 'LOGNAME': 'cltbld', 08:09:03 INFO - 'MAIL': '/var/mail/cltbld', 08:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:03 INFO - 'MOZ_NO_REMOTE': '1', 08:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:03 INFO - 'NO_EM_RESTART': '1', 08:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:03 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:03 INFO - 'SHELL': '/bin/bash', 08:09:03 INFO - 'SHLVL': '1', 08:09:03 INFO - 'TERM': 'linux', 08:09:03 INFO - 'TMOUT': '86400', 08:09:03 INFO - 'USER': 'cltbld', 08:09:03 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', 08:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:03 INFO - '_': '/tools/buildbot/bin/python'} 08:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:09:03 INFO - Running setup.py (path:/tmp/pip-NC6Kyf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:09:03 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)) 08:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:09:03 INFO - Running setup.py (path:/tmp/pip-IDk9Py-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:09:03 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)) 08:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:09:03 INFO - Running setup.py (path:/tmp/pip-qjXCQH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:09:03 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)) 08:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:09:03 INFO - Running setup.py (path:/tmp/pip-5SNg5S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:09:04 INFO - Running setup.py (path:/tmp/pip-yRrBHY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:09:04 INFO - Running setup.py (path:/tmp/pip-wphfgn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:09:04 INFO - Running setup.py (path:/tmp/pip-EXx0Gg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:09:04 INFO - Running setup.py (path:/tmp/pip-oZjbif-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:09:04 INFO - Running setup.py (path:/tmp/pip-BhhYdu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:09:04 INFO - Running setup.py (path:/tmp/pip-t3OJOd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:09:04 INFO - Running setup.py (path:/tmp/pip-akxtD1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:09:04 INFO - Running setup.py (path:/tmp/pip-79ABur-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:09:04 INFO - Running setup.py (path:/tmp/pip-YHk9hG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:09:04 INFO - Running setup.py (path:/tmp/pip-XeFL8s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:09:04 INFO - Running setup.py (path:/tmp/pip-T7cRyI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:09:04 INFO - Running setup.py (path:/tmp/pip-_ENpuu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:09:04 INFO - Running setup.py (path:/tmp/pip-pALGI_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:09:04 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)) 08:09:04 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)) 08:09:04 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)) 08:09:04 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)) 08:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:04 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 08:09:04 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 08:09:04 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 08:09:04 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 08:09:04 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 08:09:04 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 08:09:06 INFO - Downloading blessings-1.5.1.tar.gz 08:09:06 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 08:09:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:06 INFO - Installing collected packages: blessings 08:09:06 INFO - Running setup.py install for blessings 08:09:06 INFO - Successfully installed blessings 08:09:06 INFO - Cleaning up... 08:09:06 INFO - Return code: 0 08:09:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:09:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:09:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:09:07 INFO - Reading from file tmpfile_stdout 08:09:07 INFO - Current package versions: 08:09:07 INFO - argparse == 1.2.1 08:09:07 INFO - blessings == 1.5.1 08:09:07 INFO - blobuploader == 1.2.4 08:09:07 INFO - docopt == 0.6.1 08:09:07 INFO - manifestparser == 1.1 08:09:07 INFO - mozInstall == 1.12 08:09:07 INFO - mozcrash == 0.16 08:09:07 INFO - mozdebug == 0.1 08:09:07 INFO - mozdevice == 0.48 08:09:07 INFO - mozfile == 1.2 08:09:07 INFO - mozhttpd == 0.7 08:09:07 INFO - mozinfo == 0.9 08:09:07 INFO - mozleak == 0.1 08:09:07 INFO - mozlog == 3.1 08:09:07 INFO - moznetwork == 0.27 08:09:07 INFO - mozprocess == 0.22 08:09:07 INFO - mozprofile == 0.28 08:09:07 INFO - mozrunner == 6.11 08:09:07 INFO - mozscreenshot == 0.1 08:09:07 INFO - mozsystemmonitor == 0.0 08:09:07 INFO - moztest == 0.7 08:09:07 INFO - mozversion == 1.4 08:09:07 INFO - psutil == 3.1.1 08:09:07 INFO - requests == 1.2.3 08:09:07 INFO - wsgiref == 0.1.2 08:09:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fc8ec9d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c540>, '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 0x205d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205d8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', '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 08:09:07 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 08:09:07 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 08:09:07 INFO - Using env: {'DISPLAY': ':0', 08:09:07 INFO - 'HOME': '/home/cltbld', 08:09:07 INFO - 'LANG': 'en_US.UTF-8', 08:09:07 INFO - 'LANGUAGE': 'en_US:en', 08:09:07 INFO - 'LOGNAME': 'cltbld', 08:09:07 INFO - 'MAIL': '/var/mail/cltbld', 08:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:07 INFO - 'MOZ_NO_REMOTE': '1', 08:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:07 INFO - 'NO_EM_RESTART': '1', 08:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:07 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:07 INFO - 'SHELL': '/bin/bash', 08:09:07 INFO - 'SHLVL': '1', 08:09:07 INFO - 'TERM': 'linux', 08:09:07 INFO - 'TMOUT': '86400', 08:09:07 INFO - 'USER': 'cltbld', 08:09:07 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', 08:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:07 INFO - '_': '/tools/buildbot/bin/python'} 08:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:07 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)) 08:09:07 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)) 08:09:07 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)) 08:09:07 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)) 08:09:07 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)) 08:09:07 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)) 08:09:07 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)) 08:09:07 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)) 08:09:07 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)) 08:09:07 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)) 08:09:07 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)) 08:09:07 INFO - Cleaning up... 08:09:07 INFO - Return code: 0 08:09:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8ec9d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c540>, '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 0x205d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205d8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', '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 08:09:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 08:09:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:09:07 INFO - Using env: {'DISPLAY': ':0', 08:09:07 INFO - 'HOME': '/home/cltbld', 08:09:07 INFO - 'LANG': 'en_US.UTF-8', 08:09:07 INFO - 'LANGUAGE': 'en_US:en', 08:09:07 INFO - 'LOGNAME': 'cltbld', 08:09:07 INFO - 'MAIL': '/var/mail/cltbld', 08:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:07 INFO - 'MOZ_NO_REMOTE': '1', 08:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:07 INFO - 'NO_EM_RESTART': '1', 08:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:07 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:07 INFO - 'SHELL': '/bin/bash', 08:09:07 INFO - 'SHLVL': '1', 08:09:07 INFO - 'TERM': 'linux', 08:09:07 INFO - 'TMOUT': '86400', 08:09:07 INFO - 'USER': 'cltbld', 08:09:07 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', 08:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:07 INFO - '_': '/tools/buildbot/bin/python'} 08:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:07 INFO - Downloading/unpacking jsonschema 08:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:09:09 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 08:09:09 INFO - Downloading/unpacking functools32 (from jsonschema) 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09:09 INFO - Downloading functools32-3.2.3-2.tar.gz 08:09:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:09:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:09:09 INFO - warning: no files found matching '*.txt' 08:09:09 INFO - no previously-included directories found matching 'build' 08:09:09 INFO - no previously-included directories found matching 'dist' 08:09:09 INFO - no previously-included directories found matching '.git*' 08:09:09 INFO - Installing collected packages: jsonschema, functools32 08:09:09 INFO - Running setup.py install for functools32 08:09:09 INFO - warning: no files found matching '*.txt' 08:09:09 INFO - no previously-included directories found matching 'build' 08:09:09 INFO - no previously-included directories found matching 'dist' 08:09:09 INFO - no previously-included directories found matching '.git*' 08:09:09 INFO - Successfully installed jsonschema functools32 08:09:09 INFO - Cleaning up... 08:09:09 INFO - Return code: 0 08:09:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8ec9d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c540>, '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 0x205d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205d8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', '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 08:09:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:09:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:09:09 INFO - Using env: {'DISPLAY': ':0', 08:09:09 INFO - 'HOME': '/home/cltbld', 08:09:09 INFO - 'LANG': 'en_US.UTF-8', 08:09:09 INFO - 'LANGUAGE': 'en_US:en', 08:09:09 INFO - 'LOGNAME': 'cltbld', 08:09:09 INFO - 'MAIL': '/var/mail/cltbld', 08:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:09 INFO - 'MOZ_NO_REMOTE': '1', 08:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:09 INFO - 'NO_EM_RESTART': '1', 08:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:09 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:09 INFO - 'SHELL': '/bin/bash', 08:09:09 INFO - 'SHLVL': '1', 08:09:09 INFO - 'TERM': 'linux', 08:09:09 INFO - 'TMOUT': '86400', 08:09:09 INFO - 'USER': 'cltbld', 08:09:09 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', 08:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:09 INFO - '_': '/tools/buildbot/bin/python'} 08:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:09 INFO - Downloading/unpacking flake8 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:09:11 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 08:09:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:09:11 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 08:09:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:12 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 08:09:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:09:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:09:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:12 INFO - no previously-included directories found matching 'docs/_build' 08:09:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:09:12 INFO - Running setup.py install for pep8 08:09:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:12 INFO - no previously-included directories found matching 'docs/_build' 08:09:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:09:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:09:12 INFO - Cleaning up... 08:09:12 INFO - Return code: 0 08:09:12 INFO - Running post-action listener: _resource_record_post_action 08:09:12 INFO - Running post-action listener: _start_resource_monitoring 08:09:12 INFO - Starting resource monitoring. 08:09:12 INFO - ##### 08:09:12 INFO - ##### Running install step. 08:09:12 INFO - ##### 08:09:12 INFO - Running pre-action listener: _resource_record_pre_action 08:09:12 INFO - Running main action method: install 08:09:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:09:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:09:12 INFO - Reading from file tmpfile_stdout 08:09:12 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:09:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:09:12 INFO - Reading from file tmpfile_stdout 08:09:12 INFO - Output received: 08:09:12 INFO - Usage: mozinstall [options] installer 08:09:12 INFO - Options: 08:09:12 INFO - -h, --help show this help message and exit 08:09:12 INFO - -d DEST, --destination=DEST 08:09:12 INFO - Directory to install application into. [default: 08:09:12 INFO - "/builds/slave/test-pgo"] 08:09:12 INFO - --app=APP Application being installed. [default: firefox] 08:09:12 INFO - mkdir: /builds/slave/test-pgo/build/application 08:09:12 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'] 08:09:12 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 08:09:28 INFO - Reading from file tmpfile_stdout 08:09:28 INFO - Output received: 08:09:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:09:28 INFO - Running post-action listener: _resource_record_post_action 08:09:28 INFO - ##### 08:09:28 INFO - ##### Running run-tests step. 08:09:28 INFO - ##### 08:09:28 INFO - Running pre-action listener: _resource_record_pre_action 08:09:28 INFO - Running main action method: run_tests 08:09:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:09:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:09:28 INFO - Python 2.7.3 08:09:28 INFO - Return code: 0 08:09:28 INFO - grabbing minidump binary from tooltool 08:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:28 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 0x205c540>, '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 0x205d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205d8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:09:28 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 08:09:28 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 08:09:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:09:28 INFO - Return code: 0 08:09:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:09:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:09:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:09:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:09:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:09:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:09:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:09:29 INFO - Return code: 0 08:09:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 08:09:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 08:09:29 INFO - Using env: {'DISPLAY': ':0', 08:09:29 INFO - 'HOME': '/home/cltbld', 08:09:29 INFO - 'LANG': 'en_US.UTF-8', 08:09:29 INFO - 'LANGUAGE': 'en_US:en', 08:09:29 INFO - 'LOGNAME': 'cltbld', 08:09:29 INFO - 'MAIL': '/var/mail/cltbld', 08:09:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:09:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:29 INFO - 'MOZ_NO_REMOTE': '1', 08:09:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:29 INFO - 'NO_EM_RESTART': '1', 08:09:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:29 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:09:29 INFO - 'SHELL': '/bin/bash', 08:09:29 INFO - 'SHLVL': '1', 08:09:29 INFO - 'TERM': 'linux', 08:09:29 INFO - 'TMOUT': '86400', 08:09:29 INFO - 'USER': 'cltbld', 08:09:29 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761', 08:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:29 INFO - '_': '/tools/buildbot/bin/python'} 08:09:29 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:09:30 INFO - mozversion application_buildid: 20160119053006 08:09:30 INFO - mozversion application_changeset: 491b1c69b3ed6e54de98f21b06d741e0981b0535 08:09:30 INFO - mozversion application_display_name: Nightly 08:09:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:09:30 INFO - mozversion application_name: Firefox 08:09:30 INFO - mozversion application_remotingname: firefox 08:09:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:09:30 INFO - mozversion application_vendor: Mozilla 08:09:30 INFO - mozversion application_version: 46.0a1 08:09:30 INFO - mozversion platform_buildid: 20160119053006 08:09:30 INFO - mozversion platform_changeset: 491b1c69b3ed6e54de98f21b06d741e0981b0535 08:09:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:09:30 INFO - mozversion platform_version: 46.0a1 08:09:30 INFO - using testdate: 1453219770 08:09:30 INFO - actual date: 1453219770 08:09:30 INFO - starting webserver on 'localhost:56370' 08:09:30 INFO - SUITE-START | Running 3 tests 08:09:30 INFO - TEST-START | dromaeo_css 08:09:30 INFO - operating with platform_type : linux_ 08:09:30 INFO - Initialising browser for dromaeo_css test... 08:09:30 INFO - TEST-INFO | started process 18287 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp34ZECL/profile http://localhost:56370/getInfo.html) 08:09:35 INFO - PROCESS | 18287 | __metrics Screen width/height:1600/1200 08:09:35 INFO - PROCESS | 18287 | colorDepth:24 08:09:35 INFO - PROCESS | 18287 | Browser inner width/height: 1024/697 08:09:35 INFO - PROCESS | 18287 | __metrics 08:09:35 INFO - PROCESS | 18287 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:09:35 INFO - PROCESS | 18287 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:09:36 INFO - TEST-INFO | 18287: exit 0 08:09:36 INFO - Browser initialized. 08:09:36 INFO - Running cycle 1/1 for dromaeo_css test... 08:09:36 INFO - TEST-INFO | started process 18381 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp34ZECL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:09:48 INFO - PROCESS | 18381 | RSS: Main: 148594688 08:09:48 INFO - PROCESS | 18381 | 08:10:40 INFO - PROCESS | 18381 | 1453219840003 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] 08:12:48 INFO - PROCESS | 18381 | Cycle 1(1): loaded http://localhost:56370/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56370/tests/dromaeo/cssquery-ext.html) 08:12:49 INFO - PROCESS | 18381 | RSS: Main: 269586432 08:12:49 INFO - PROCESS | 18381 | 08:15:52 INFO - PROCESS | 18381 | Cycle 1(1): loaded http://localhost:56370/tests/dromaeo/cssquery-ext.html (next: http://localhost:56370/tests/dromaeo/cssquery-jquery.html) 08:15:52 INFO - PROCESS | 18381 | RSS: Main: 239505408 08:15:52 INFO - PROCESS | 18381 | 08:18:54 INFO - PROCESS | 18381 | Cycle 1(1): loaded http://localhost:56370/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56370/tests/dromaeo/cssquery-mootools.html) 08:18:55 INFO - PROCESS | 18381 | RSS: Main: 224276480 08:18:55 INFO - PROCESS | 18381 | 08:21:57 INFO - PROCESS | 18381 | Cycle 1(1): loaded http://localhost:56370/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56370/tests/dromaeo/cssquery-prototype.html) 08:21:57 INFO - PROCESS | 18381 | RSS: Main: 214183936 08:21:57 INFO - PROCESS | 18381 | 08:25:00 INFO - PROCESS | 18381 | Cycle 1(1): loaded http://localhost:56370/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56370/tests/dromaeo/cssquery-yui.html) 08:25:00 INFO - PROCESS | 18381 | RSS: Main: 217206784 08:25:00 INFO - PROCESS | 18381 | 08:28:03 INFO - PROCESS | 18381 | Cycle 1(1): loaded http://localhost:56370/tests/dromaeo/cssquery-yui.html (next: http://localhost:56370/tests/dromaeo/cssquery-dojo.html) 08:28:03 INFO - PROCESS | 18381 | RSS: Main: 260050944 08:28:03 INFO - PROCESS | 18381 | 08:28:03 INFO - PROCESS | 18381 | __start_tp_report 08:28:03 INFO - PROCESS | 18381 | _x_x_mozilla_page_load 08:28:03 INFO - PROCESS | 18381 | _x_x_mozilla_page_load_details 08:28:03 INFO - PROCESS | 18381 | |i|pagename|runs| 08:28:03 INFO - PROCESS | 18381 | |0;dojo.html;3120.1263646179077;3120.60992375953;3185.060407179883;3186.2512309607237;3214.710676039156;5058.215976523636;5152.639315247934;5185.196294574338;5219.9478005219935;5267.104592219327;5073.543381095701;5123.641345105844;5154.561862241704;5163.277141200235;5187.19598462238;4676.368690226827;4702.177119004177;4710.057988402316;4767.18957777177;4814.398200224972;4758.119747846659;4770.212914869043;4802.03959208158;4812.302216178652;4813.350197723315;4639.234526303156;4663.48701642819;4712.151812673735;4745.762711864393;4755.785989630441;4690.9530904690855;4701.764911754399;4714.6464015199;4719.10337035962;4742.359781429532;4622.306654001893;4691.554302341272;4699.318598803155;4710.411198600175;4735;5032.748362581856;5047.041062198171;5053.343065401475;5078.390593128848;5113.948860511422;5587.608867379285;5624.55003599711;5626.662400255997;5627.887442251132;5638.605297629168;5536.944630553683;5611.971940140314;5659.179418984266;5659.320881494205;5675.31896172462;5174.09453345663;5265.4997775211295;5329.387120481156;5349.384820745586;5359.624826262124;5682.261306030189;5694.544436445074;5705.771769129271;5710.314762228559;5753.482186603226;5501.5323697486165;5503.779848806083;5504.119340905516;5505.862353441196;5507.421720719347;5365.0342938270705;5449.536789372868;5533.142362933751;5589.916151257735;5640.069388550925;5570.498655121059;5575.275214222125;5576.944230557642;5577.330720313507;5597.020521408818;5359.196120581944;5527.39198688144;5580.351601868745;5582.7766889324785;5590.636608620508;4319.222539942841;4378.211921854033;4393.143337049245;4407.449068866392;4441.888952776207;3858.6913046956174;3860.845566177378;3864.072622570563;3888.202918401721;3913;5022.347094877642;5117.820876269313;5119.001794650082;5128.512791284822;5163.561097306696;5424.755885985141;5429.592780541475;5486.945130548724;5566.35986861508;5576.693281869536;5163.535281824654;5182.222666600041;5187.662801917863;5194.97402512985;5200.7919683213;4786.946871688223;4791.113643975876;4794.616430685537;4802.73584952831;4824.807007719652;5563.888722225533;5654.038813401649;5654.6324488908085;5728.283964504437;5819.76720931158;5575.498205161392;5579.9163012555655;5581;5592.524635406036;5626.324841019104;5733.541316694738;5748.971255143698;5750.338711048283;5772.624779389326;5775.7400916957995;5325.600579956596;5409.945900541102;5460.044492213926;5506.697131657797;5558.110702287615;5536.557075433875;5566.443355664564;5569.192467092168;5582.0231459495235;5592.944070559242;5361.51746342831;5446.618736688552;5448.073827449264;5448.945510545002;5491.258680078138;5344.946550534445;5364.785408583613;5398.703071331114;5400.378956420062;5440.483154100512;5303.098473259478;5342.7907789906085;5357.812476563302;5381.515663590296;5388.892222155457;5369.0872551665525;5399.136138217867;5464.808731694372;5486.149646804752;5488.670679759227;5318.601104917224;5362.436944120811;5373.167159090347;5375.1131063374105;5410.702411367255 08:28:03 INFO - PROCESS | 18381 | |1;ext.html;545.4845171313111;554.464941331615;569.2542768972644;574.5834270154139;585.8593937455009;28577.85711071444;28999.565006524866;29063.98276060341;29071;29113.272168195806;28978.1306560803;29129.708702912965;36904;37662.43506347407;37779.24441511168;8421.747347579567;8547.529885856275;8571.614277357503;8593.613287402082;8600.483970961732;8269.09040005599;8404.20160084791;8408.495490270603;8411.873821892677;8412.15878412157;8093.028836539624;8111.43219974602;8122.553259570721;8123.512589244635;8133.146019667938;8506.31949444046;8580.957095214484;8583.141685831368;8585.871211931826;8595;8408.411411201218;8568.143185681445;8570.571471426467;8572.971243450764;8573.52845593492;38397.808010959765;38710.419343709866;38842.22315553673;38875;38902.832915012594;3300.9174770630684;3315.287213249139;3334.333133373311;3344.6822551857535;3370.5449764281752;29445.852770736223;29593.55609665857;29888.954819021925;30091.398172036657;30685.539716904263;3846.7114966377353;3871.6515513603913;3892.630200130983;3934.5868683788362;3956.248312820555;262974.68512657506;263299;264038;264433;265256;50282.49717502851;50812.23781643278;54340;54604;54640.45359546433;61427;61605;61726.38273617206;62067.689661551405;62151.37848621456;13904.930475347559;14001.089929154572;14122.646933826736;14184.503542376173;14242.430302787772;9946.80106397868;10171.28800983924;10323.432211228455;10598.788024239626;10777.299475534222;17975.55061123456;18278.543036424195;18377.90811045936;18381.356652517366;18453.169607367432;7484.288992545699;7801.80495487606;7818.452708310478;7832.334251588679;7896.170902055202;980.9754756131153;982.6413359123868;986.8273052215834;1038.3199004651965;1086.5490821309068;27788.861055694593;28486.71513284882;28799.136025919255;28923;29390.26524336866;1020.5713600287897;1033.89661033896;1036.1141224253306;1098.3629494892944;1149.2127892393737;13731.656708582166;14044;14113.647158821112;14281.85718142826;14282.57152285433;307321;310515;311751;312431;312599;49505.50494495081;50278.24582631263;50332.49667503278;50368;50412.49587504152;1328.7873940169527;1352.2968056610507;1352.9797053044213;1353.1272329347516;1359.3135466589308;26394.34014149585;27167.86416067907;27221.1833644991;27336;27388.72611273862;44123;44600;44648.54433006086;44704;44771.77614111909;291959;293178;294444;295293;295790;27473.488958107497;28295.2926176839;28331.291717706397;30901;31930.6806931937;36230;36333.27333453369;36604.26791464209;36877;39007.609923900396;33492.49761253632;33556.49665255072;33749.83125084359;33819;34476.82761586176;30040.699593003792;33411.83294083514;33559.83220083884;35553;35802.10494737652;31366.372672546877;35024.29951401009;36052.4592131113;36130.8193459031;36137.63862361448;27000;28921.421571568873;29439.705602943697;29487.852560737058;29519.55720664235;22179.667304990115;22223.33330000038;22437.887810561497;22518.32445026652;22525.774742252368 08:28:03 INFO - PROCESS | 18381 | |2;jquery.html;353.81424752005205;358.7022771099987;361.5823723599241;361.913140846197;362.92378600493896;13147.539836105738;13481.39333729982;15701.450449234278;16476.42332518362;17702.645947081066;14655.853441465582;14702.632434189123;15979;15980.600484987881;15984.920075399636;5023.5981121510285;6633.701483433257;6912.170539535237;6916.827079323007;6918.827029324257;4320.5031421386475;4460.576245256695;6621.867562648744;6693.062971184038;6869.587824730532;6264.592801467913;6516.739330426777;6840.144981877265;6864.9656751716175;6871.518993670445;6356;6390.6485143317095;6393.136926514908;6535.869282614369;6796.626185559792;6329.778457753957;6522.804315870531;6528.249251336109;6529.738810447577;6529.902051469232;22106.22628208005;22167.44581385462;22223;22833.543329133325;23048.884755576284;2157.234181865431;2200.2739096098408;2209.3703294561133;2298.7816157465013;2314.409825494488;13582.660433489144;14051.227182504957;14176.858231417656;14368.856311436857;14447.711045779131;1918.9616207675767;2002.5942925563818;2028.3712049264627;2033.1867253098878;2119.5760847830343;63033.68483157601;64130.35869641337;66014;67095.66452167757;67268.32731672669;14758.40966361355;14953.177575233467;15161.924190378977;15177.089374637557;15189.924050379677;23614.29157125289;23756.16853410157;23968;24148.154814581758;24184.87907560451;6904.723811047602;7151.570905745568;7200.603966781878;7285.089363829521;8603.354748393895;6765.42493888025;6830.282820303796;6848.14398200225;6855.6572171391235;6873.518853680194;4216.578342165759;4344.6089851913475;4516.570925762047;4552.294394368878;4557.111363284194;1719.1576127697338;1852.5739080011672;1873.2226126157493;1886.5472286651104;1886.5849513107094;846.5555583318807;941.6711923350922;992.980140397188;999.7450650084182;1005.3465247589126;13623.386947587382;14877.628059298604;15189.924050379677;15868.603284917739;15912.681746365008;955.7419496735843;968.9273304502191;970.854371844229;977.3207620703542;1032.948352582368;8118.10700822909;9106.362554621246;9199;9269.72190834276;9455.243580513543;495593;502543;509348;513470;520097;53335.19997200045;69398.65300673465;72790.2720972794;73000.63499682468;73402;1112.9833052504218;1114.3870871020906;1135.3528488761492;1151.1078913841673;1155.445386214605;14731;14814.77777833355;14982.507505644568;15153.696926061197;15281;29876.253093671963;30110.247243819078;32013.839930800197;34280.31439371149;34456.13859653529;41009.794951025055;41093;41650;42382.36426453544;42567.5743242576;7060.152781666233;7106.538075025107;7330.853382932205;7412.295831895961;7444.106707195171;8699.478031318142;10647.89352106469;10814.080803131506;11009.2843965142;11471.655850324503;9250.676226332045;9343.672971445967;9559.283053771134;9608.855867161858;10082.89917100849;6900.7929762107215;8986.640534378552;9620.873216204622;9632.855507167538;9825.606975720892;9164.525578094012;9954.502274886081;10147.695569132939;10476.790464190826;10673.839892401775;7503.849923001619;7580.54516728998;7620.9618951907105;7670.7698769037015;7728.806779830325;9435.622575097193;9717;9866.210703143588;9968.40189588627;10356.17150627963 08:28:03 INFO - PROCESS | 18381 | |3;mootools.html;1324.6754545136444;1462.3784891421146;1502.992485037575;1659.4523807143637;1813.23843985526;7072.363487286143;7615.771526854196;7699.384049276058;7740.8838867417035;7749.573773442458;7585.317321441069;7746.302832745052;7777.105632852224;7804.063512378522;7830.491018083821;2084.218418093215;2146.377550510358;2323.2333330001143;2367.266147494274;2391.2826152154285;2314.7685231476885;2322.129201549419;2325.174563030117;2326.0346956013236;2327.615943369342;2281.7147856517936;2354.9529009419803;2358.6697862299293;2359.504504054142;2369.2892132360307;2260.4122928038664;2280.407094155515;2330.487292795582;2342.6251799712136;2345.870977096259;2302.631578947377;2310.4570425949887;2313.1788215183537;2319.373769082338;2330.1029103795163;7806.1413244543055;7822.843543129163;7865.567393793339;7878.172791856887;7882.527048377058;4864.927026094611;4943.777530011158;4988.226824842155;4992.101421744084;4996.550310472075;3197.9840100799347;3237.2877966847254;3268.346330733839;3332.483465062919;3353.8826141085187;1048.6224959014748;1065.9926369580749;1077.197487871533;1087.5758454202867;1100.350793032115;10570.048695617432;10837.566497340096;10847.837282440769;10853.24027318088;10857.294275872044;4429.911401772011;4451.1765323415275;4466.798994045275;4491.169133710274;4515.887102822456;9356.4386136832;9358.251339892793;9360.297977651568;9397.530123493798;9425.481598512148;4932;4945.703257804544;4948.208286674115;4949.307097006422;4950.6782059166035;4399.560043995575;4495.348174514677;4498.640108791289;4498.820047198075;4509.571590698878;3565.1978304881195;3664;3775.5469343678933;3827.942580861289;3870.0905287257474;1252.9686757831128;1253.0414233111676;1258.779713550125;1263.3493750718387;1271.1165739810742;1043.968680939573;1062.5324857062867;1064.7231719752765;1230.3171739684383;1387.8195834541648;7365.484416090822;7422.183559808417;7466.365358944442;7476.102867655807;7508.812279692942;1129.8022846001916;1134.5810436172455;1140.4240858366472;1141.6517962021662;1159.6694941941676;5859.824205273849;5952.0476723724;5954.07711804671;5954.493868021266;5954.672493012926;9112.316576256808;9150.954245228731;9321.627134914663;9381.718548443558;9417.670381536613;9136.223421009288;9152.405093668891;9164.450132992042;9182.219511341611;9265.583048762823;7134.429245660334;7154.856902862018;7292.854142917112;7356.080489938758;7374.041374621265;7332.81667958284;7419.258074192538;7422.072240969879;7424.146223184187;7428.70285188608;8029.598520073856;8190;8291.95854020726;8480.872786908325;8483.575821208791;8382.077971423018;8418.789530261793;8486.618102185294;8573.571321434029;8578.91421085781;6379.872402552016;6976.616286104313;7146.106736657918;7150.284971502808;7151.499395042505;6954.47841411886;7100.218975912749;7248.311410416002;7252.818679533054;7258.0927384076995;6843.589384636739;6983.441324694114;7034.155901291673;7051.5063945523325;7096.8935465967015;6863.656817159222;6915.066466027223;6943;7046.612436315847;7050.365467107985;6932.272111428228;6979.895301570379;6995.335443132894;7027.332403421667;7152.177499587614;6546.8363290918105;6574.934250657432;6599;6599.0761293418;6611.438027767501;6677.031830384664;6685.39831415175;6712.362325579063;6742.325767423218;6757.797266082025 08:28:03 INFO - PROCESS | 18381 | |4;prototype.html;345.6353547007907;347.09408443961274;350.3850741947881;352.0564886105237;356.3959089343562;5666.886662266763;5686.346070201928;5712.542996560275;5730.713464326788;5837.474627283544;5564.10974244121;5702.77188912443;5736.110902810071;5746.59773815832;5756.02147634902;4492.528284530126;4502.6172775314135;4506.864794056183;4511.233090374628;4511.977440112795;4279.251131052069;4377;4409.250427427345;4488.236999710057;4513.074819661978;4464.799084041226;4466.039801442689;4482.731036137842;4487.5736805003635;4493.393391892102;4484.1928452878465;4485.372047913294;4485.708428952108;4487.618552423048;4498.842540511099;3962.881113566598;3968.1666849961543;3973.7615743055508;3974.225026119908;3977.7414468059483;5389.110796718537;5503.6147469677135;5523.613347065707;5540.750666219989;5544.944550554484;5171.482851714798;5178.896422071537;5179.766910488999;5185.196294574309;5186.325777648882;5817.331006934214;6179;6196.845078873019;6222.844428889269;6223.222097237845;4217.915641687149;4224;4301.870943871689;4303.63419109373;4337.457817772778;6251.499880009634;6338.176037115146;6354.142190804275;6354.618722876642;6358.300586935434;4405.0969551241915;4406.008648054226;4407.382966384709;4408.448943882015;4408.448943882015;4253.170631726845;4447.510773814878;4452.287633978548;4456.46522417312;4459.286514157784;5102.132637451642;5119.923201151985;5144.331236939249;5147.202183661464;5152.175651895754;6058.575899687068;6066.605670631395;6069.0592958091565;6078.908816367758;6140.846478838065;1557.7040362331347;1583.2716950203035;1583.5566041508396;1583.9841601583837;1584.081232884924;1059.2691043180182;1062.1927335225284;1069.4919913041242;1070.272214893864;1092.4537731134433;5750.424957504216;5759.049756790083;5764.221830052973;5767.048437007847;5772.5670574707065;6262.718177682015;6273.905891411632;6277;6279.340669229757;6282.057691346335;5762.855928601734;5766.625169363978;5767.048437007847;5768.596198266165;5772.942270577324;3301.8018918864946;3365.7812242204177;3399.949000764941;3408.0627827347676;3411.761176717606;6477.060826180177;6481.740730370827;6484.773032943825;6491.058796474579;6500.577462464925;6413.807585772434;6428.164338635947;6433.035044743232;6442.710078046499;6443.5167362448;6296.937030629727;6477.449416799531;6484.383983521558;6486.416222539994;6488.31872653374;6121.112438696453;6196.566240363131;6277.121203031488;6277.654728989949;6281.057841323838;6143.600665956698;6242.625442473466;6250.718717657807;6274.309825919237;6285.371462853678;6513.967430163008;6524.021396790519;6524.380183882524;6526.477881769542;6531.836704082436;4355.063661312833;4443.178012067778;4446.133004064306;4448.421705178306;4449.599536041772;6335.271443784024;6337.302896681269;6337.746490140343;6339.524535659752;6342.143810585697;6172.4136207060255;6174.660393678211;6182.907256391068;6186.072089186658;6189.876202475835;6010.429009244115;6144.1398204250545;6144.293406258159;6152.876942461036;6156.969215153896;6048.84877878039;6061.1514387984835;6069.817905462844;6071.574989750675;6080.087986802015;6192.133101365723;6196.318404975539;6253.7185826637;6274.278457977209;6277.748890044347;5892.970535147469;5977.22296101504;6010.699465026643;6015.2781666200335;6017.06735456005 08:28:03 INFO - PROCESS | 18381 | |5;yui.html;826.8966379202601;843.1947490146911;847.8855354527137;857.4426622695247;872.2672954718038;13216.801747973788;13336.733265334688;13366.93316533416;13387.79918301225;13429.261390623511;12784.936075319634;13200.53798117066;13225.074244802867;13225.404856781444;13234.669133271673;683.6308393467547;693.6913073682214;805.3999770171231;820.1306614988102;836.1304243586693;826.2316046077145;827.2430725885807;832.8167803083312;833.0295206084904;833.0295206084934;881.0748713850463;881.9647214111428;882.5102068352062;882.9779255518631;884.1644645809712;717.6591119218356;728.6502478810174;851.5742128935564;870.9477431354076;872.8036191856845;644.7453255963868;646.0986923242051;646.2245305633259;646.4408286831904;647.7247169952751;13580.728385432334;13650.317484125853;13698.452061917511;13716.971227158003;13723.931380343134;12914.41885115172;12961.611151665371;13007.934960325232;13139.60581182566;13177.209367437888;10559.577616895393;10653;10673.199510036779;10703.036726694558;10947.124230061576;3520.2079532105327;3559.661832125944;3641.0715267606593;3655.9634403656155;3682.981585092084;44505.33242001373;45430.772846135886;45667.543324566665;45774.31338529925;46045.30932036055;10073.395596264247;10107.241956853119;10173.491325433699;10230.693079207636;10649;18180.545486362946;18256.908715456604;18281.908590457228;18294;18297.634047319247;7313.817154571072;7367.115946086504;7377.114746230487;7596.278353556403;7665.3101220890385;4355.259605867011;4386.6637455436585;4433.490148632884;4481.574250446202;4516.954830451654;3144.622645282581;3180.9522857157162;3194.5367921651696;3212.855421506038;3214.72674822638;574.5317566183547;583.2971269620098;588.8645611509377;591.704147926037;605.2041565341561;618.2364779497317;618.5762752514452;661.4576047640984;671.3890359772681;687.0998991321385;8267.379946504036;8386.203310685476;8387.790305242417;8401.453905496122;8516.06323304436;620.7082671144555;648.970796314167;661.6783745597075;680.5032326401655;681.4887140885753;3730.515033045687;3784.129650180474;3799.3351163546267;3872.9419058714143;4006.358982562776;52337.21494177591;52974.470255297725;53136.202956955676;53290.467095329324;53311.46688533143;46809.29786053212;46957.53042469532;47016;47497.52502475;47550;42099;43787.78106109449;44128.558714412444;44744;45006.549934500894;8032.437729359122;8236.217559331853;8367.707130250656;8449.704260350858;8626;32575;32578.51132232971;32830.34339313248;33541.496877547346;34295.971120866416;42208;42403.363949540166;42540.78729606456;42943.14113717771;43202;10938.575232624215;11071.280366776135;11317.377544235145;11414.885851141382;11918.106142039209;12411.937940310241;12471.688207794878;12633.115681902178;12814.359282036048;12856.228626282453;10620.787584248426;10658.946705266735;10660.733481663021;10762.515686793957;11032.779344413228;11384.943075284571;11712.238704484182;11849.822252666389;11924.284542927453;12094;7371.741989030358;9405.623775048922;10851.240413171317;11191.496382662963;11299.209055366046;9361.344705870524;9585.233181345615;9673.951630241803;9832.655857045254;9902.603895844086;8521.724431097762;8560.871586926325;8672.653093876426;8794.956025219833;9358.578863951274 08:28:03 INFO - PROCESS | 18381 | __end_tp_report 08:28:03 INFO - PROCESS | 18381 | __start_cc_report 08:28:03 INFO - PROCESS | 18381 | _x_x_mozilla_cycle_collect,977 08:28:03 INFO - PROCESS | 18381 | __end_cc_report 08:28:03 INFO - PROCESS | 18381 | __startTimestamp1453220883586__endTimestamp 08:28:03 INFO - PROCESS | 18381 | 08:28:03 INFO - PROCESS | 18381 | ------- Summary: start ------- 08:28:03 INFO - PROCESS | 18381 | Number of tests: 6 08:28:03 INFO - PROCESS | 18381 | 08:28:03 INFO - PROCESS | 18381 | [#0] dojo.html Cycles:165 Average:5165.70 Median:5361.52 stddev:556.58 (10.4%) stddev-sans-first:534.65 08:28:03 INFO - PROCESS | 18381 | Values: 3120.1 3120.6 3185.1 3186.3 3214.7 5058.2 5152.6 5185.2 5219.9 5267.1 5073.5 5123.6 5154.6 5163.3 5187.2 4676.4 4702.2 4710.1 4767.2 4814.4 4758.1 4770.2 4802.0 4812.3 4813.4 4639.2 4663.5 4712.2 4745.8 4755.8 4691.0 4701.8 4714.6 4719.1 4742.4 4622.3 4691.6 4699.3 4710.4 4735.0 5032.7 5047.0 5053.3 5078.4 5113.9 5587.6 5624.6 5626.7 5627.9 5638.6 5536.9 5612.0 5659.2 5659.3 5675.3 5174.1 5265.5 5329.4 5349.4 5359.6 5682.3 5694.5 5705.8 5710.3 5753.5 5501.5 5503.8 5504.1 5505.9 5507.4 5365.0 5449.5 5533.1 5589.9 5640.1 5570.5 5575.3 5576.9 5577.3 5597.0 5359.2 5527.4 5580.4 5582.8 5590.6 4319.2 4378.2 4393.1 4407.4 4441.9 3858.7 3860.8 3864.1 3888.2 3913.0 5022.3 5117.8 5119.0 5128.5 5163.6 5424.8 5429.6 5486.9 5566.4 5576.7 5163.5 5182.2 5187.7 5195.0 5200.8 4786.9 4791.1 4794.6 4802.7 4824.8 5563.9 5654.0 5654.6 5728.3 5819.8 5575.5 5579.9 5581.0 5592.5 5626.3 5733.5 5749.0 5750.3 5772.6 5775.7 5325.6 5409.9 5460.0 5506.7 5558.1 5536.6 5566.4 5569.2 5582.0 5592.9 5361.5 5446.6 5448.1 5448.9 5491.3 5344.9 5364.8 5398.7 5400.4 5440.5 5303.1 5342.8 5357.8 5381.5 5388.9 5369.1 5399.1 5464.8 5486.1 5488.7 5318.6 5362.4 5373.2 5375.1 5410.7 08:28:03 INFO - PROCESS | 18381 | 08:28:03 INFO - PROCESS | 18381 | [#1] ext.html Cycles:180 Average:44559.20 Median:33524.50 stddev:76018.02 (226.8%) stddev-sans-first:76159.44 08:28:03 INFO - PROCESS | 18381 | Values: 545.5 554.5 569.3 574.6 585.9 28577.9 28999.6 29064.0 29071.0 29113.3 28978.1 29129.7 36904.0 37662.4 37779.2 8421.7 8547.5 8571.6 8593.6 8600.5 8269.1 8404.2 8408.5 8411.9 8412.2 8093.0 8111.4 8122.6 8123.5 8133.1 8506.3 8581.0 8583.1 8585.9 8595.0 8408.4 8568.1 8570.6 8573.0 8573.5 38397.8 38710.4 38842.2 38875.0 38902.8 3300.9 3315.3 3334.3 3344.7 3370.5 29445.9 29593.6 29889.0 30091.4 30685.5 3846.7 3871.7 3892.6 3934.6 3956.2 262974.7 263299.0 264038.0 264433.0 265256.0 50282.5 50812.2 54340.0 54604.0 54640.5 61427.0 61605.0 61726.4 62067.7 62151.4 13904.9 14001.1 14122.6 14184.5 14242.4 9946.8 10171.3 10323.4 10598.8 10777.3 17975.6 18278.5 18377.9 18381.4 18453.2 7484.3 7801.8 7818.5 7832.3 7896.2 981.0 982.6 986.8 1038.3 1086.5 27788.9 28486.7 28799.1 28923.0 29390.3 1020.6 1033.9 1036.1 1098.4 1149.2 13731.7 14044.0 14113.6 14281.9 14282.6 307321.0 310515.0 311751.0 312431.0 312599.0 49505.5 50278.2 50332.5 50368.0 50412.5 1328.8 1352.3 1353.0 1353.1 1359.3 26394.3 27167.9 27221.2 27336.0 27388.7 44123.0 44600.0 44648.5 44704.0 44771.8 291959.0 293178.0 294444.0 295293.0 295790.0 27473.5 28295.3 28331.3 30901.0 31930.7 36230.0 36333.3 36604.3 36877.0 39007.6 33492.5 33556.5 33749.8 33819.0 34476.8 30040.7 33411.8 33559.8 35553.0 35802.1 31366.4 35024.3 36052.5 36130.8 36137.6 27000.0 28921.4 29439.7 29487.9 29519.6 22179.7 22223.3 22437.9 22518.3 22525.8 08:28:03 INFO - PROCESS | 18381 | 08:28:03 INFO - PROCESS | 18381 | [#2] jquery.html Cycles:180 Average:27376.42 Median:4534.43 stddev:83001.38 (1830.5%) stddev-sans-first:83209.42 08:28:03 INFO - PROCESS | 18381 | Values: 353.8 358.7 361.6 361.9 362.9 13147.5 13481.4 15701.5 16476.4 17702.6 14655.9 14702.6 15979.0 15980.6 15984.9 5023.6 6633.7 6912.2 6916.8 6918.8 4320.5 4460.6 6621.9 6693.1 6869.6 6264.6 6516.7 6840.1 6865.0 6871.5 6356.0 6390.6 6393.1 6535.9 6796.6 6329.8 6522.8 6528.2 6529.7 6529.9 22106.2 22167.4 22223.0 22833.5 23048.9 2157.2 2200.3 2209.4 2298.8 2314.4 13582.7 14051.2 14176.9 14368.9 14447.7 1919.0 2002.6 2028.4 2033.2 2119.6 63033.7 64130.4 66014.0 67095.7 67268.3 14758.4 14953.2 15161.9 15177.1 15189.9 23614.3 23756.2 23968.0 24148.2 24184.9 6904.7 7151.6 7200.6 7285.1 8603.4 6765.4 6830.3 6848.1 6855.7 6873.5 4216.6 4344.6 4516.6 4552.3 4557.1 1719.2 1852.6 1873.2 1886.5 1886.6 846.6 941.7 993.0 999.7 1005.3 13623.4 14877.6 15189.9 15868.6 15912.7 955.7 968.9 970.9 977.3 1032.9 8118.1 9106.4 9199.0 9269.7 9455.2 495593.0 502543.0 509348.0 513470.0 520097.0 53335.2 69398.7 72790.3 73000.6 73402.0 1113.0 1114.4 1135.4 1151.1 1155.4 14731.0 14814.8 14982.5 15153.7 15281.0 29876.3 30110.2 32013.8 34280.3 34456.1 41009.8 41093.0 41650.0 42382.4 42567.6 7060.2 7106.5 7330.9 7412.3 7444.1 8699.5 10647.9 10814.1 11009.3 11471.7 9250.7 9343.7 9559.3 9608.9 10082.9 6900.8 8986.6 9620.9 9632.9 9825.6 9164.5 9954.5 10147.7 10476.8 10673.8 7503.8 7580.5 7621.0 7670.8 7728.8 9435.6 9717.0 9866.2 9968.4 10356.2 08:28:03 INFO - PROCESS | 18381 | 08:28:03 INFO - PROCESS | 18381 | [#3] mootools.html Cycles:180 Average:5518.45 Median:6463.35 stddev:2798.62 (43.3%) stddev-sans-first:2788.71 08:28:03 INFO - PROCESS | 18381 | Values: 1324.7 1462.4 1503.0 1659.5 1813.2 7072.4 7615.8 7699.4 7740.9 7749.6 7585.3 7746.3 7777.1 7804.1 7830.5 2084.2 2146.4 2323.2 2367.3 2391.3 2314.8 2322.1 2325.2 2326.0 2327.6 2281.7 2355.0 2358.7 2359.5 2369.3 2260.4 2280.4 2330.5 2342.6 2345.9 2302.6 2310.5 2313.2 2319.4 2330.1 7806.1 7822.8 7865.6 7878.2 7882.5 4864.9 4943.8 4988.2 4992.1 4996.6 3198.0 3237.3 3268.3 3332.5 3353.9 1048.6 1066.0 1077.2 1087.6 1100.4 10570.0 10837.6 10847.8 10853.2 10857.3 4429.9 4451.2 4466.8 4491.2 4515.9 9356.4 9358.3 9360.3 9397.5 9425.5 4932.0 4945.7 4948.2 4949.3 4950.7 4399.6 4495.3 4498.6 4498.8 4509.6 3565.2 3664.0 3775.5 3827.9 3870.1 1253.0 1253.0 1258.8 1263.3 1271.1 1044.0 1062.5 1064.7 1230.3 1387.8 7365.5 7422.2 7466.4 7476.1 7508.8 1129.8 1134.6 1140.4 1141.7 1159.7 5859.8 5952.0 5954.1 5954.5 5954.7 9112.3 9151.0 9321.6 9381.7 9417.7 9136.2 9152.4 9164.5 9182.2 9265.6 7134.4 7154.9 7292.9 7356.1 7374.0 7332.8 7419.3 7422.1 7424.1 7428.7 8029.6 8190.0 8292.0 8480.9 8483.6 8382.1 8418.8 8486.6 8573.6 8578.9 6379.9 6976.6 7146.1 7150.3 7151.5 6954.5 7100.2 7248.3 7252.8 7258.1 6843.6 6983.4 7034.2 7051.5 7096.9 6863.7 6915.1 6943.0 7046.6 7050.4 6932.3 6979.9 6995.3 7027.3 7152.2 6546.8 6574.9 6599.0 6599.1 6611.4 6677.0 6685.4 6712.4 6742.3 6757.8 08:28:03 INFO - PROCESS | 18381 | 08:28:03 INFO - PROCESS | 18381 | [#4] prototype.html Cycles:180 Average:5128.85 Median:5760.95 stddev:1520.33 (26.4%) stddev-sans-first:1481.60 08:28:03 INFO - PROCESS | 18381 | Values: 345.6 347.1 350.4 352.1 356.4 5666.9 5686.3 5712.5 5730.7 5837.5 5564.1 5702.8 5736.1 5746.6 5756.0 4492.5 4502.6 4506.9 4511.2 4512.0 4279.3 4377.0 4409.3 4488.2 4513.1 4464.8 4466.0 4482.7 4487.6 4493.4 4484.2 4485.4 4485.7 4487.6 4498.8 3962.9 3968.2 3973.8 3974.2 3977.7 5389.1 5503.6 5523.6 5540.8 5544.9 5171.5 5178.9 5179.8 5185.2 5186.3 5817.3 6179.0 6196.8 6222.8 6223.2 4217.9 4224.0 4301.9 4303.6 4337.5 6251.5 6338.2 6354.1 6354.6 6358.3 4405.1 4406.0 4407.4 4408.4 4408.4 4253.2 4447.5 4452.3 4456.5 4459.3 5102.1 5119.9 5144.3 5147.2 5152.2 6058.6 6066.6 6069.1 6078.9 6140.8 1557.7 1583.3 1583.6 1584.0 1584.1 1059.3 1062.2 1069.5 1070.3 1092.5 5750.4 5759.0 5764.2 5767.0 5772.6 6262.7 6273.9 6277.0 6279.3 6282.1 5762.9 5766.6 5767.0 5768.6 5772.9 3301.8 3365.8 3399.9 3408.1 3411.8 6477.1 6481.7 6484.8 6491.1 6500.6 6413.8 6428.2 6433.0 6442.7 6443.5 6296.9 6477.4 6484.4 6486.4 6488.3 6121.1 6196.6 6277.1 6277.7 6281.1 6143.6 6242.6 6250.7 6274.3 6285.4 6514.0 6524.0 6524.4 6526.5 6531.8 4355.1 4443.2 4446.1 4448.4 4449.6 6335.3 6337.3 6337.7 6339.5 6342.1 6172.4 6174.7 6182.9 6186.1 6189.9 6010.4 6144.1 6144.3 6152.9 6157.0 6048.8 6061.2 6069.8 6071.6 6080.1 6192.1 6196.3 6253.7 6274.3 6277.7 5893.0 5977.2 6010.7 6015.3 6017.1 08:28:03 INFO - PROCESS | 18381 | 08:28:03 INFO - PROCESS | 18381 | [#5] yui.html Cycles:180 Average:13299.80 Median:24612.79 stddev:14878.69 (60.5%) stddev-sans-first:14890.95 08:28:03 INFO - PROCESS | 18381 | Values: 826.9 843.2 847.9 857.4 872.3 13216.8 13336.7 13366.9 13387.8 13429.3 12784.9 13200.5 13225.1 13225.4 13234.7 683.6 693.7 805.4 820.1 836.1 826.2 827.2 832.8 833.0 833.0 881.1 882.0 882.5 883.0 884.2 717.7 728.7 851.6 870.9 872.8 644.7 646.1 646.2 646.4 647.7 13580.7 13650.3 13698.5 13717.0 13723.9 12914.4 12961.6 13007.9 13139.6 13177.2 10559.6 10653.0 10673.2 10703.0 10947.1 3520.2 3559.7 3641.1 3656.0 3683.0 44505.3 45430.8 45667.5 45774.3 46045.3 10073.4 10107.2 10173.5 10230.7 10649.0 18180.5 18256.9 18281.9 18294.0 18297.6 7313.8 7367.1 7377.1 7596.3 7665.3 4355.3 4386.7 4433.5 4481.6 4517.0 3144.6 3181.0 3194.5 3212.9 3214.7 574.5 583.3 588.9 591.7 605.2 618.2 618.6 661.5 671.4 687.1 8267.4 8386.2 8387.8 8401.5 8516.1 620.7 649.0 661.7 680.5 681.5 3730.5 3784.1 3799.3 3872.9 4006.4 52337.2 52974.5 53136.2 53290.5 53311.5 46809.3 46957.5 47016.0 47497.5 47550.0 42099.0 43787.8 44128.6 44744.0 45006.5 8032.4 8236.2 8367.7 8449.7 8626.0 32575.0 32578.5 32830.3 33541.5 34296.0 42208.0 42403.4 42540.8 42943.1 43202.0 10938.6 11071.3 11317.4 11414.9 11918.1 12411.9 12471.7 12633.1 12814.4 12856.2 10620.8 10658.9 10660.7 10762.5 11032.8 11384.9 11712.2 11849.8 11924.3 12094.0 7371.7 9405.6 10851.2 11191.5 11299.2 9361.3 9585.2 9674.0 9832.7 9902.6 8521.7 8560.9 8672.7 8795.0 9358.6 08:28:03 INFO - PROCESS | 18381 | -------- Summary: end -------- 08:28:03 INFO - PROCESS | 18381 | 08:28:04 INFO - TEST-INFO | 18381: exit 0 08:28:04 INFO - TEST-OK | dromaeo_css | took 1114176ms 08:28:04 INFO - TEST-START | kraken 08:28:04 INFO - operating with platform_type : linux_ 08:28:04 INFO - Initialising browser for kraken test... 08:28:04 INFO - TEST-INFO | started process 18586 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLSUL8s/profile http://localhost:56370/getInfo.html) 08:28:08 INFO - PROCESS | 18586 | __metrics Screen width/height:1600/1200 08:28:08 INFO - PROCESS | 18586 | colorDepth:24 08:28:08 INFO - PROCESS | 18586 | Browser inner width/height: 1024/697 08:28:08 INFO - PROCESS | 18586 | __metrics 08:28:08 INFO - PROCESS | 18586 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:28:09 INFO - PROCESS | 18586 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:28:10 INFO - TEST-INFO | 18586: exit 0 08:28:10 INFO - Browser initialized. 08:28:10 INFO - Running cycle 1/1 for kraken test... 08:28:10 INFO - TEST-INFO | started process 18666 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLSUL8s/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:28:22 INFO - PROCESS | 18666 | RSS: Main: 149528576 08:28:22 INFO - PROCESS | 18666 | 08:28:24 INFO - PROCESS | 18666 | Cycle 1(1): loaded http://localhost:56370/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56370/tests/kraken/driver.html?testName=audio-beat-detection) 08:28:25 INFO - PROCESS | 18666 | RSS: Main: 186871808 08:28:25 INFO - PROCESS | 18666 | 08:28:28 INFO - PROCESS | 18666 | Cycle 1(1): loaded http://localhost:56370/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56370/tests/kraken/driver.html?testName=audio-dft) 08:28:28 INFO - PROCESS | 18666 | RSS: Main: 178171904 08:28:28 INFO - PROCESS | 18666 | 08:28:31 INFO - PROCESS | 18666 | Cycle 1(1): loaded http://localhost:56370/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56370/tests/kraken/driver.html?testName=audio-fft) 08:28:32 INFO - PROCESS | 18666 | RSS: Main: 162082816 08:28:32 INFO - PROCESS | 18666 | 08:28:34 INFO - PROCESS | 18666 | Cycle 1(1): loaded http://localhost:56370/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56370/tests/kraken/driver.html?testName=audio-oscillator) 08:28:34 INFO - PROCESS | 18666 | RSS: Main: 162926592 08:28:34 INFO - PROCESS | 18666 | 08:28:36 INFO - PROCESS | 18666 | Cycle 1(1): loaded http://localhost:56370/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56370/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:28:37 INFO - PROCESS | 18666 | RSS: Main: 166326272 08:28:37 INFO - PROCESS | 18666 | 08:28:40 INFO - PROCESS | 18666 | Cycle 1(1): loaded http://localhost:56370/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56370/tests/kraken/driver.html?testName=imaging-darkroom) 08:28:40 INFO - PROCESS | 18666 | RSS: Main: 165011456 08:28:40 INFO - PROCESS | 18666 | 08:28:44 INFO - PROCESS | 18666 | Cycle 1(1): loaded http://localhost:56370/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56370/tests/kraken/driver.html?testName=imaging-desaturate) 08:28:44 INFO - PROCESS | 18666 | RSS: Main: 166723584 08:28:44 INFO - PROCESS | 18666 | 08:28:47 INFO - PROCESS | 18666 | Cycle 1(1): loaded http://localhost:56370/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56370/tests/kraken/driver.html?testName=json-parse-financial) 08:28:48 INFO - PROCESS | 18666 | RSS: Main: 165715968 08:28:48 INFO - PROCESS | 18666 | 08:28:49 INFO - PROCESS | 18666 | Cycle 1(1): loaded http://localhost:56370/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56370/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:28:50 INFO - PROCESS | 18666 | RSS: Main: 180391936 08:28:50 INFO - PROCESS | 18666 | 08:28:52 INFO - PROCESS | 18666 | Cycle 1(1): loaded http://localhost:56370/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56370/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:28:52 INFO - PROCESS | 18666 | RSS: Main: 177422336 08:28:52 INFO - PROCESS | 18666 | 08:28:54 INFO - PROCESS | 18666 | Cycle 1(1): loaded http://localhost:56370/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56370/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:28:55 INFO - PROCESS | 18666 | RSS: Main: 189947904 08:28:55 INFO - PROCESS | 18666 | 08:28:57 INFO - PROCESS | 18666 | Cycle 1(1): loaded http://localhost:56370/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:28:58 INFO - PROCESS | 18666 | RSS: Main: 196440064 08:28:58 INFO - PROCESS | 18666 | 08:29:00 INFO - PROCESS | 18666 | Cycle 1(1): loaded http://localhost:56370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:29:01 INFO - PROCESS | 18666 | RSS: Main: 196411392 08:29:01 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | Cycle 1(1): loaded http://localhost:56370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56370/tests/kraken/driver.html?testName=ai-astar) 08:29:03 INFO - PROCESS | 18666 | RSS: Main: 253665280 08:29:03 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | __start_tp_report 08:29:03 INFO - PROCESS | 18666 | _x_x_mozilla_page_load 08:29:03 INFO - PROCESS | 18666 | _x_x_mozilla_page_load_details 08:29:03 INFO - PROCESS | 18666 | |i|pagename|runs| 08:29:03 INFO - PROCESS | 18666 | |0;ai-astar;112;110;107;112;109;110;112;113;106;110 08:29:03 INFO - PROCESS | 18666 | |1;audio-beat-detection;149;124;147;176;132;159;149;126;171;131 08:29:03 INFO - PROCESS | 18666 | |2;audio-dft;160;160;162;161;162;160;161;161;163;161 08:29:03 INFO - PROCESS | 18666 | |3;audio-fft;71;75;92;93;72;71;72;130;88;70 08:29:03 INFO - PROCESS | 18666 | |4;audio-oscillator;96;96;148;96;96;97;139;97;98;149 08:29:03 INFO - PROCESS | 18666 | |5;imaging-gaussian-blur;109;110;109;109;108;108;109;110;109;109 08:29:03 INFO - PROCESS | 18666 | |6;imaging-darkroom;146;146;146;146;146;145;146;145;146;146 08:29:03 INFO - PROCESS | 18666 | |7;imaging-desaturate;95;96;95;95;95;96;96;96;95;96 08:29:03 INFO - PROCESS | 18666 | |8;json-parse-financial;56;55;56;56;56;57;61;56;57;56 08:29:03 INFO - PROCESS | 18666 | |9;json-stringify-tinderbox;68;68;68;69;69;70;69;69;71;68 08:29:03 INFO - PROCESS | 18666 | |10;stanford-crypto-aes;82;81;82;83;82;81;84;83;83;85 08:29:03 INFO - PROCESS | 18666 | |11;stanford-crypto-ccm;122;120;121;128;114;122;113;116;120;116 08:29:03 INFO - PROCESS | 18666 | |12;stanford-crypto-pbkdf2;147;136;146;151;145;134;148;143;144;145 08:29:03 INFO - PROCESS | 18666 | |13;stanford-crypto-sha256-iterative;68;71;70;68;69;67;66;68;67;67 08:29:03 INFO - PROCESS | 18666 | __end_tp_report 08:29:03 INFO - PROCESS | 18666 | __start_cc_report 08:29:03 INFO - PROCESS | 18666 | _x_x_mozilla_cycle_collect,948 08:29:03 INFO - PROCESS | 18666 | __end_cc_report 08:29:03 INFO - PROCESS | 18666 | __startTimestamp1453220943403__endTimestamp 08:29:03 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | ------- Summary: start ------- 08:29:03 INFO - PROCESS | 18666 | Number of tests: 14 08:29:03 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.28 (2.1%) stddev-sans-first:2.32 08:29:03 INFO - PROCESS | 18666 | Values: 112.0 110.0 107.0 112.0 109.0 110.0 112.0 113.0 106.0 110.0 08:29:03 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:149.00 stddev:18.31 (12.3%) stddev-sans-first:19.39 08:29:03 INFO - PROCESS | 18666 | Values: 149.0 124.0 147.0 176.0 132.0 159.0 149.0 126.0 171.0 131.0 08:29:03 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 08:29:03 INFO - PROCESS | 18666 | Values: 160.0 160.0 162.0 161.0 162.0 160.0 161.0 161.0 163.0 161.0 08:29:03 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | [#3] audio-fft Cycles:10 Average:83.40 Median:73.50 stddev:18.79 (25.6%) stddev-sans-first:19.38 08:29:03 INFO - PROCESS | 18666 | Values: 71.0 75.0 92.0 93.0 72.0 71.0 72.0 130.0 88.0 70.0 08:29:03 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:96.00 stddev:23.71 (24.7%) stddev-sans-first:24.50 08:29:03 INFO - PROCESS | 18666 | Values: 96.0 96.0 148.0 96.0 96.0 97.0 139.0 97.0 98.0 149.0 08:29:03 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 08:29:03 INFO - PROCESS | 18666 | Values: 109.0 110.0 109.0 109.0 108.0 108.0 109.0 110.0 109.0 109.0 08:29:03 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 08:29:03 INFO - PROCESS | 18666 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 08:29:03 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:29:03 INFO - PROCESS | 18666 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 08:29:03 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:1.65 (2.9%) stddev-sans-first:1.73 08:29:03 INFO - PROCESS | 18666 | Values: 56.0 55.0 56.0 56.0 56.0 57.0 61.0 56.0 57.0 56.0 08:29:03 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.99 (1.4%) stddev-sans-first:1.00 08:29:03 INFO - PROCESS | 18666 | Values: 68.0 68.0 68.0 69.0 69.0 70.0 69.0 69.0 71.0 68.0 08:29:03 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:1.26 (1.5%) stddev-sans-first:1.32 08:29:03 INFO - PROCESS | 18666 | Values: 82.0 81.0 82.0 83.0 82.0 81.0 84.0 83.0 83.0 85.0 08:29:03 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:120.50 stddev:4.52 (3.7%) stddev-sans-first:4.68 08:29:03 INFO - PROCESS | 18666 | Values: 122.0 120.0 121.0 128.0 114.0 122.0 113.0 116.0 120.0 116.0 08:29:03 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:145.50 stddev:5.22 (3.6%) stddev-sans-first:5.41 08:29:03 INFO - PROCESS | 18666 | Values: 147.0 136.0 146.0 151.0 145.0 134.0 148.0 143.0 144.0 145.0 08:29:03 INFO - PROCESS | 18666 | 08:29:03 INFO - PROCESS | 18666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.52 (2.2%) stddev-sans-first:1.62 08:29:03 INFO - PROCESS | 18666 | Values: 68.0 71.0 70.0 68.0 69.0 67.0 66.0 68.0 67.0 67.0 08:29:03 INFO - PROCESS | 18666 | -------- Summary: end -------- 08:29:03 INFO - PROCESS | 18666 | 08:29:04 INFO - TEST-INFO | 18666: exit 0 08:29:04 INFO - TEST-OK | kraken | took 60096ms 08:29:04 INFO - TEST-START | v8_7 08:29:04 INFO - operating with platform_type : linux_ 08:29:04 INFO - Initialising browser for v8_7 test... 08:29:04 INFO - TEST-INFO | started process 18918 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNs2o08/profile http://localhost:56370/getInfo.html) 08:29:09 INFO - PROCESS | 18918 | __metrics Screen width/height:1600/1200 08:29:09 INFO - PROCESS | 18918 | colorDepth:24 08:29:09 INFO - PROCESS | 18918 | Browser inner width/height: 1024/697 08:29:09 INFO - PROCESS | 18918 | __metrics 08:29:09 INFO - PROCESS | 18918 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:29:09 INFO - PROCESS | 18918 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:29:10 INFO - TEST-INFO | 18918: exit 0 08:29:10 INFO - Browser initialized. 08:29:10 INFO - Running cycle 1/1 for v8_7 test... 08:29:10 INFO - TEST-INFO | started process 19002 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNs2o08/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:22 INFO - PROCESS | 19002 | RSS: Main: 148975616 08:29:22 INFO - PROCESS | 19002 | 08:29:45 INFO - PROCESS | 19002 | Cycle 1(1): loaded http://localhost:56370/tests/v8_7/run.html (next: http://localhost:56370/tests/v8_7/run.html) 08:29:45 INFO - PROCESS | 19002 | RSS: Main: 526618624 08:29:45 INFO - PROCESS | 19002 | 08:29:45 INFO - PROCESS | 19002 | __start_tp_report 08:29:45 INFO - PROCESS | 19002 | _x_x_mozilla_page_load 08:29:45 INFO - PROCESS | 19002 | _x_x_mozilla_page_load_details 08:29:45 INFO - PROCESS | 19002 | |i|pagename|runs| 08:29:45 INFO - PROCESS | 19002 | |0;Richards;167.84155756965424 08:29:45 INFO - PROCESS | 19002 | |1;DeltaBlue;188.6080724254998 08:29:45 INFO - PROCESS | 19002 | |2;Encrypt;279.01785714285717 08:29:45 INFO - PROCESS | 19002 | |3;Decrypt;5240.837696335078 08:29:45 INFO - PROCESS | 19002 | |4;RayTrace;1116.0714285714287 08:29:45 INFO - PROCESS | 19002 | |5;Earley;787.4015748031496 08:29:45 INFO - PROCESS | 19002 | |6;Boyer;12268.292682926829 08:29:45 INFO - PROCESS | 19002 | |7;RegExp;42645.833333333336 08:29:45 INFO - PROCESS | 19002 | |8;Splay;557.5858250276855 08:29:45 INFO - PROCESS | 19002 | |9;NavierStokes;4830.917874396136 08:29:45 INFO - PROCESS | 19002 | __end_tp_report 08:29:45 INFO - PROCESS | 19002 | __startTimestamp1453220985311__endTimestamp 08:29:45 INFO - PROCESS | 19002 | 08:29:45 INFO - PROCESS | 19002 | ------- Summary: start ------- 08:29:45 INFO - PROCESS | 19002 | Number of tests: 10 08:29:45 INFO - PROCESS | 19002 | 08:29:45 INFO - PROCESS | 19002 | [#0] Richards Cycles:1 Average:167.84 Median:167.84 stddev:0.00 (0.0%) 08:29:45 INFO - PROCESS | 19002 | Values: 167.8 08:29:45 INFO - PROCESS | 19002 | 08:29:45 INFO - PROCESS | 19002 | [#1] DeltaBlue Cycles:1 Average:188.61 Median:188.61 stddev:0.00 (0.0%) 08:29:45 INFO - PROCESS | 19002 | Values: 188.6 08:29:45 INFO - PROCESS | 19002 | 08:29:45 INFO - PROCESS | 19002 | [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 08:29:45 INFO - PROCESS | 19002 | Values: 279.0 08:29:45 INFO - PROCESS | 19002 | 08:29:45 INFO - PROCESS | 19002 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 08:29:45 INFO - PROCESS | 19002 | Values: 5240.8 08:29:45 INFO - PROCESS | 19002 | 08:29:45 INFO - PROCESS | 19002 | [#4] RayTrace Cycles:1 Average:1116.07 Median:1116.07 stddev:0.00 (0.0%) 08:29:45 INFO - PROCESS | 19002 | Values: 1116.1 08:29:45 INFO - PROCESS | 19002 | 08:29:45 INFO - PROCESS | 19002 | [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 08:29:45 INFO - PROCESS | 19002 | Values: 787.4 08:29:45 INFO - PROCESS | 19002 | 08:29:45 INFO - PROCESS | 19002 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 08:29:45 INFO - PROCESS | 19002 | Values: 12268.3 08:29:45 INFO - PROCESS | 19002 | 08:29:45 INFO - PROCESS | 19002 | [#7] RegExp Cycles:1 Average:42645.83 Median:42645.83 stddev:0.00 (0.0%) 08:29:45 INFO - PROCESS | 19002 | Values: 42645.8 08:29:45 INFO - PROCESS | 19002 | 08:29:45 INFO - PROCESS | 19002 | [#8] Splay Cycles:1 Average:557.59 Median:557.59 stddev:0.00 (0.0%) 08:29:45 INFO - PROCESS | 19002 | Values: 557.6 08:29:45 INFO - PROCESS | 19002 | 08:29:45 INFO - PROCESS | 19002 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 08:29:45 INFO - PROCESS | 19002 | Values: 4830.9 08:29:45 INFO - PROCESS | 19002 | -------- Summary: end -------- 08:29:45 INFO - PROCESS | 19002 | 08:29:46 INFO - TEST-INFO | 19002: exit 0 08:29:46 INFO - TEST-OK | v8_7 | took 41876ms 08:29:46 INFO - SUITE-END | took 1216s 08:29:46 INFO - Completed test suite (00:20:16) 08:29:46 INFO - Working with test: dromaeo_css 08:29:46 INFO - Generating results file: dromaeo_css 08:29:46 INFO - Working with test: kraken 08:29:46 INFO - Generating results file: kraken 08:29:46 INFO - javascript benchmark 08:29:46 INFO - Working with test: v8_7 08:29:46 INFO - Generating results file: v8_7 08:29:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:29:46 INFO - process_Request line: dromaeo_css 6853.19 graph.html#tests=[[72,64,35]] 08:29:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:46 INFO - process_Request line: kraken 1501.80 graph.html#tests=[[232,64,35]] 08:29:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:46 INFO - process_Request line: v8_7 20151.04 graph.html#tests=[[230,64,35]] 08:29:46 INFO - RETURN: dromaeo_css: 6853.19 08:29:46 INFO - RETURN: kraken: 1501.80 08:29:46 INFO - RETURN: v8_7: 20151.04 08:29:46 INFO - javascript benchmark 08:29:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3120.1263646179077, 3120.60992375953, 3185.060407179883, 3186.2512309607237, 3214.710676039156, 5058.215976523636, 5152.639315247934, 5185.196294574338, 5219.9478005219935, 5267.104592219327, 5073.543381095701, 5123.641345105844, 5154.561862241704, 5163.277141200235, 5187.19598462238, 4676.368690226827, 4702.177119004177, 4710.057988402316, 4767.18957777177, 4814.398200224972, 4758.119747846659, 4770.212914869043, 4802.03959208158, 4812.302216178652, 4813.350197723315, 4639.234526303156, 4663.48701642819, 4712.151812673735, 4745.762711864393, 4755.785989630441, 4690.9530904690855, 4701.764911754399, 4714.6464015199, 4719.10337035962, 4742.359781429532, 4622.306654001893, 4691.554302341272, 4699.318598803155, 4710.411198600175, 4735.0, 5032.748362581856, 5047.041062198171, 5053.343065401475, 5078.390593128848, 5113.948860511422, 5587.608867379285, 5624.55003599711, 5626.662400255997, 5627.887442251132, 5638.605297629168, 5536.944630553683, 5611.971940140314, 5659.179418984266, 5659.320881494205, 5675.31896172462, 5174.09453345663, 5265.4997775211295, 5329.387120481156, 5349.384820745586, 5359.624826262124, 5682.261306030189, 5694.544436445074, 5705.771769129271, 5710.314762228559, 5753.482186603226, 5501.5323697486165, 5503.779848806083, 5504.119340905516, 5505.862353441196, 5507.421720719347, 5365.0342938270705, 5449.536789372868, 5533.142362933751, 5589.916151257735, 5640.069388550925, 5570.498655121059, 5575.275214222125, 5576.944230557642, 5577.330720313507, 5597.020521408818, 5359.196120581944, 5527.39198688144, 5580.351601868745, 5582.7766889324785, 5590.636608620508, 4319.222539942841, 4378.211921854033, 4393.143337049245, 4407.449068866392, 4441.888952776207, 3858.6913046956174, 3860.845566177378, 3864.072622570563, 3888.202918401721, 3913.0, 5022.347094877642, 5117.820876269313, 5119.001794650082, 5128.512791284822, 5163.561097306696, 5424.755885985141, 5429.592780541475, 5486.945130548724, 5566.35986861508, 5576.693281869536, 5163.535281824654, 5182.222666600041, 5187.662801917863, 5194.97402512985, 5200.7919683213, 4786.946871688223, 4791.113643975876, 4794.616430685537, 4802.73584952831, 4824.807007719652, 5563.888722225533, 5654.038813401649, 5654.6324488908085, 5728.283964504437, 5819.76720931158, 5575.498205161392, 5579.9163012555655, 5581.0, 5592.524635406036, 5626.324841019104, 5733.541316694738, 5748.971255143698, 5750.338711048283, 5772.624779389326, 5775.7400916957995, 5325.600579956596, 5409.945900541102, 5460.044492213926, 5506.697131657797, 5558.110702287615, 5536.557075433875, 5566.443355664564, 5569.192467092168, 5582.0231459495235, 5592.944070559242, 5361.51746342831, 5446.618736688552, 5448.073827449264, 5448.945510545002, 5491.258680078138, 5344.946550534445, 5364.785408583613, 5398.703071331114, 5400.378956420062, 5440.483154100512, 5303.098473259478, 5342.7907789906085, 5357.812476563302, 5381.515663590296, 5388.892222155457, 5369.0872551665525, 5399.136138217867, 5464.808731694372, 5486.149646804752, 5488.670679759227, 5318.601104917224, 5362.436944120811, 5373.167159090347, 5375.1131063374105, 5410.702411367255], "unit": "score", "name": "dojo.html", "value": 5130.935956435172}, {"lowerIsBetter": false, "replicates": [545.4845171313111, 554.464941331615, 569.2542768972644, 574.5834270154139, 585.8593937455009, 28577.85711071444, 28999.565006524866, 29063.98276060341, 29071.0, 29113.272168195806, 28978.1306560803, 29129.708702912965, 36904.0, 37662.43506347407, 37779.24441511168, 8421.747347579567, 8547.529885856275, 8571.614277357503, 8593.613287402082, 8600.483970961732, 8269.09040005599, 8404.20160084791, 8408.495490270603, 8411.873821892677, 8412.15878412157, 8093.028836539624, 8111.43219974602, 8122.553259570721, 8123.512589244635, 8133.146019667938, 8506.31949444046, 8580.957095214484, 8583.141685831368, 8585.871211931826, 8595.0, 8408.411411201218, 8568.143185681445, 8570.571471426467, 8572.971243450764, 8573.52845593492, 38397.808010959765, 38710.419343709866, 38842.22315553673, 38875.0, 38902.832915012594, 3300.9174770630684, 3315.287213249139, 3334.333133373311, 3344.6822551857535, 3370.5449764281752, 29445.852770736223, 29593.55609665857, 29888.954819021925, 30091.398172036657, 30685.539716904263, 3846.7114966377353, 3871.6515513603913, 3892.630200130983, 3934.5868683788362, 3956.248312820555, 262974.68512657506, 263299.0, 264038.0, 264433.0, 265256.0, 50282.49717502851, 50812.23781643278, 54340.0, 54604.0, 54640.45359546433, 61427.0, 61605.0, 61726.38273617206, 62067.689661551405, 62151.37848621456, 13904.930475347559, 14001.089929154572, 14122.646933826736, 14184.503542376173, 14242.430302787772, 9946.80106397868, 10171.28800983924, 10323.432211228455, 10598.788024239626, 10777.299475534222, 17975.55061123456, 18278.543036424195, 18377.90811045936, 18381.356652517366, 18453.169607367432, 7484.288992545699, 7801.80495487606, 7818.452708310478, 7832.334251588679, 7896.170902055202, 980.9754756131153, 982.6413359123868, 986.8273052215834, 1038.3199004651965, 1086.5490821309068, 27788.861055694593, 28486.71513284882, 28799.136025919255, 28923.0, 29390.26524336866, 1020.5713600287897, 1033.89661033896, 1036.1141224253306, 1098.3629494892944, 1149.2127892393737, 13731.656708582166, 14044.0, 14113.647158821112, 14281.85718142826, 14282.57152285433, 307321.0, 310515.0, 311751.0, 312431.0, 312599.0, 49505.50494495081, 50278.24582631263, 50332.49667503278, 50368.0, 50412.49587504152, 1328.7873940169527, 1352.2968056610507, 1352.9797053044213, 1353.1272329347516, 1359.3135466589308, 26394.34014149585, 27167.86416067907, 27221.1833644991, 27336.0, 27388.72611273862, 44123.0, 44600.0, 44648.54433006086, 44704.0, 44771.77614111909, 291959.0, 293178.0, 294444.0, 295293.0, 295790.0, 27473.488958107497, 28295.2926176839, 28331.291717706397, 30901.0, 31930.6806931937, 36230.0, 36333.27333453369, 36604.26791464209, 36877.0, 39007.609923900396, 33492.49761253632, 33556.49665255072, 33749.83125084359, 33819.0, 34476.82761586176, 30040.699593003792, 33411.83294083514, 33559.83220083884, 35553.0, 35802.10494737652, 31366.372672546877, 35024.29951401009, 36052.4592131113, 36130.8193459031, 36137.63862361448, 27000.0, 28921.421571568873, 29439.705602943697, 29487.852560737058, 29519.55720664235, 22179.667304990115, 22223.33330000038, 22437.887810561497, 22518.32445026652, 22525.774742252368], "unit": "score", "name": "ext.html", "value": 17524.968970484195}, {"lowerIsBetter": false, "replicates": [353.81424752005205, 358.7022771099987, 361.5823723599241, 361.913140846197, 362.92378600493896, 13147.539836105738, 13481.39333729982, 15701.450449234278, 16476.42332518362, 17702.645947081066, 14655.853441465582, 14702.632434189123, 15979.0, 15980.600484987881, 15984.920075399636, 5023.5981121510285, 6633.701483433257, 6912.170539535237, 6916.827079323007, 6918.827029324257, 4320.5031421386475, 4460.576245256695, 6621.867562648744, 6693.062971184038, 6869.587824730532, 6264.592801467913, 6516.739330426777, 6840.144981877265, 6864.9656751716175, 6871.518993670445, 6356.0, 6390.6485143317095, 6393.136926514908, 6535.869282614369, 6796.626185559792, 6329.778457753957, 6522.804315870531, 6528.249251336109, 6529.738810447577, 6529.902051469232, 22106.22628208005, 22167.44581385462, 22223.0, 22833.543329133325, 23048.884755576284, 2157.234181865431, 2200.2739096098408, 2209.3703294561133, 2298.7816157465013, 2314.409825494488, 13582.660433489144, 14051.227182504957, 14176.858231417656, 14368.856311436857, 14447.711045779131, 1918.9616207675767, 2002.5942925563818, 2028.3712049264627, 2033.1867253098878, 2119.5760847830343, 63033.68483157601, 64130.35869641337, 66014.0, 67095.66452167757, 67268.32731672669, 14758.40966361355, 14953.177575233467, 15161.924190378977, 15177.089374637557, 15189.924050379677, 23614.29157125289, 23756.16853410157, 23968.0, 24148.154814581758, 24184.87907560451, 6904.723811047602, 7151.570905745568, 7200.603966781878, 7285.089363829521, 8603.354748393895, 6765.42493888025, 6830.282820303796, 6848.14398200225, 6855.6572171391235, 6873.518853680194, 4216.578342165759, 4344.6089851913475, 4516.570925762047, 4552.294394368878, 4557.111363284194, 1719.1576127697338, 1852.5739080011672, 1873.2226126157493, 1886.5472286651104, 1886.5849513107094, 846.5555583318807, 941.6711923350922, 992.980140397188, 999.7450650084182, 1005.3465247589126, 13623.386947587382, 14877.628059298604, 15189.924050379677, 15868.603284917739, 15912.681746365008, 955.7419496735843, 968.9273304502191, 970.854371844229, 977.3207620703542, 1032.948352582368, 8118.10700822909, 9106.362554621246, 9199.0, 9269.72190834276, 9455.243580513543, 495593.0, 502543.0, 509348.0, 513470.0, 520097.0, 53335.19997200045, 69398.65300673465, 72790.2720972794, 73000.63499682468, 73402.0, 1112.9833052504218, 1114.3870871020906, 1135.3528488761492, 1151.1078913841673, 1155.445386214605, 14731.0, 14814.77777833355, 14982.507505644568, 15153.696926061197, 15281.0, 29876.253093671963, 30110.247243819078, 32013.839930800197, 34280.31439371149, 34456.13859653529, 41009.794951025055, 41093.0, 41650.0, 42382.36426453544, 42567.5743242576, 7060.152781666233, 7106.538075025107, 7330.853382932205, 7412.295831895961, 7444.106707195171, 8699.478031318142, 10647.89352106469, 10814.080803131506, 11009.2843965142, 11471.655850324503, 9250.676226332045, 9343.672971445967, 9559.283053771134, 9608.855867161858, 10082.89917100849, 6900.7929762107215, 8986.640534378552, 9620.873216204622, 9632.855507167538, 9825.606975720892, 9164.525578094012, 9954.502274886081, 10147.695569132939, 10476.790464190826, 10673.839892401775, 7503.849923001619, 7580.54516728998, 7620.9618951907105, 7670.7698769037015, 7728.806779830325, 9435.622575097193, 9717.0, 9866.210703143588, 9968.40189588627, 10356.17150627963], "unit": "score", "name": "jquery.html", "value": 8692.34013666931}, {"lowerIsBetter": false, "replicates": [1324.6754545136444, 1462.3784891421146, 1502.992485037575, 1659.4523807143637, 1813.23843985526, 7072.363487286143, 7615.771526854196, 7699.384049276058, 7740.8838867417035, 7749.573773442458, 7585.317321441069, 7746.302832745052, 7777.105632852224, 7804.063512378522, 7830.491018083821, 2084.218418093215, 2146.377550510358, 2323.2333330001143, 2367.266147494274, 2391.2826152154285, 2314.7685231476885, 2322.129201549419, 2325.174563030117, 2326.0346956013236, 2327.615943369342, 2281.7147856517936, 2354.9529009419803, 2358.6697862299293, 2359.504504054142, 2369.2892132360307, 2260.4122928038664, 2280.407094155515, 2330.487292795582, 2342.6251799712136, 2345.870977096259, 2302.631578947377, 2310.4570425949887, 2313.1788215183537, 2319.373769082338, 2330.1029103795163, 7806.1413244543055, 7822.843543129163, 7865.567393793339, 7878.172791856887, 7882.527048377058, 4864.927026094611, 4943.777530011158, 4988.226824842155, 4992.101421744084, 4996.550310472075, 3197.9840100799347, 3237.2877966847254, 3268.346330733839, 3332.483465062919, 3353.8826141085187, 1048.6224959014748, 1065.9926369580749, 1077.197487871533, 1087.5758454202867, 1100.350793032115, 10570.048695617432, 10837.566497340096, 10847.837282440769, 10853.24027318088, 10857.294275872044, 4429.911401772011, 4451.1765323415275, 4466.798994045275, 4491.169133710274, 4515.887102822456, 9356.4386136832, 9358.251339892793, 9360.297977651568, 9397.530123493798, 9425.481598512148, 4932.0, 4945.703257804544, 4948.208286674115, 4949.307097006422, 4950.6782059166035, 4399.560043995575, 4495.348174514677, 4498.640108791289, 4498.820047198075, 4509.571590698878, 3565.1978304881195, 3664.0, 3775.5469343678933, 3827.942580861289, 3870.0905287257474, 1252.9686757831128, 1253.0414233111676, 1258.779713550125, 1263.3493750718387, 1271.1165739810742, 1043.968680939573, 1062.5324857062867, 1064.7231719752765, 1230.3171739684383, 1387.8195834541648, 7365.484416090822, 7422.183559808417, 7466.365358944442, 7476.102867655807, 7508.812279692942, 1129.8022846001916, 1134.5810436172455, 1140.4240858366472, 1141.6517962021662, 1159.6694941941676, 5859.824205273849, 5952.0476723724, 5954.07711804671, 5954.493868021266, 5954.672493012926, 9112.316576256808, 9150.954245228731, 9321.627134914663, 9381.718548443558, 9417.670381536613, 9136.223421009288, 9152.405093668891, 9164.450132992042, 9182.219511341611, 9265.583048762823, 7134.429245660334, 7154.856902862018, 7292.854142917112, 7356.080489938758, 7374.041374621265, 7332.81667958284, 7419.258074192538, 7422.072240969879, 7424.146223184187, 7428.70285188608, 8029.598520073856, 8190.0, 8291.95854020726, 8480.872786908325, 8483.575821208791, 8382.077971423018, 8418.789530261793, 8486.618102185294, 8573.571321434029, 8578.91421085781, 6379.872402552016, 6976.616286104313, 7146.106736657918, 7150.284971502808, 7151.499395042505, 6954.47841411886, 7100.218975912749, 7248.311410416002, 7252.818679533054, 7258.0927384076995, 6843.589384636739, 6983.441324694114, 7034.155901291673, 7051.5063945523325, 7096.8935465967015, 6863.656817159222, 6915.066466027223, 6943.0, 7046.612436315847, 7050.365467107985, 6932.272111428228, 6979.895301570379, 6995.335443132894, 7027.332403421667, 7152.177499587614, 6546.8363290918105, 6574.934250657432, 6599.0, 6599.0761293418, 6611.438027767501, 6677.031830384664, 6685.39831415175, 6712.362325579063, 6742.325767423218, 6757.797266082025], "unit": "score", "name": "mootools.html", "value": 4566.436836368409}, {"lowerIsBetter": false, "replicates": [345.6353547007907, 347.09408443961274, 350.3850741947881, 352.0564886105237, 356.3959089343562, 5666.886662266763, 5686.346070201928, 5712.542996560275, 5730.713464326788, 5837.474627283544, 5564.10974244121, 5702.77188912443, 5736.110902810071, 5746.59773815832, 5756.02147634902, 4492.528284530126, 4502.6172775314135, 4506.864794056183, 4511.233090374628, 4511.977440112795, 4279.251131052069, 4377.0, 4409.250427427345, 4488.236999710057, 4513.074819661978, 4464.799084041226, 4466.039801442689, 4482.731036137842, 4487.5736805003635, 4493.393391892102, 4484.1928452878465, 4485.372047913294, 4485.708428952108, 4487.618552423048, 4498.842540511099, 3962.881113566598, 3968.1666849961543, 3973.7615743055508, 3974.225026119908, 3977.7414468059483, 5389.110796718537, 5503.6147469677135, 5523.613347065707, 5540.750666219989, 5544.944550554484, 5171.482851714798, 5178.896422071537, 5179.766910488999, 5185.196294574309, 5186.325777648882, 5817.331006934214, 6179.0, 6196.845078873019, 6222.844428889269, 6223.222097237845, 4217.915641687149, 4224.0, 4301.870943871689, 4303.63419109373, 4337.457817772778, 6251.499880009634, 6338.176037115146, 6354.142190804275, 6354.618722876642, 6358.300586935434, 4405.0969551241915, 4406.008648054226, 4407.382966384709, 4408.448943882015, 4408.448943882015, 4253.170631726845, 4447.510773814878, 4452.287633978548, 4456.46522417312, 4459.286514157784, 5102.132637451642, 5119.923201151985, 5144.331236939249, 5147.202183661464, 5152.175651895754, 6058.575899687068, 6066.605670631395, 6069.0592958091565, 6078.908816367758, 6140.846478838065, 1557.7040362331347, 1583.2716950203035, 1583.5566041508396, 1583.9841601583837, 1584.081232884924, 1059.2691043180182, 1062.1927335225284, 1069.4919913041242, 1070.272214893864, 1092.4537731134433, 5750.424957504216, 5759.049756790083, 5764.221830052973, 5767.048437007847, 5772.5670574707065, 6262.718177682015, 6273.905891411632, 6277.0, 6279.340669229757, 6282.057691346335, 5762.855928601734, 5766.625169363978, 5767.048437007847, 5768.596198266165, 5772.942270577324, 3301.8018918864946, 3365.7812242204177, 3399.949000764941, 3408.0627827347676, 3411.761176717606, 6477.060826180177, 6481.740730370827, 6484.773032943825, 6491.058796474579, 6500.577462464925, 6413.807585772434, 6428.164338635947, 6433.035044743232, 6442.710078046499, 6443.5167362448, 6296.937030629727, 6477.449416799531, 6484.383983521558, 6486.416222539994, 6488.31872653374, 6121.112438696453, 6196.566240363131, 6277.121203031488, 6277.654728989949, 6281.057841323838, 6143.600665956698, 6242.625442473466, 6250.718717657807, 6274.309825919237, 6285.371462853678, 6513.967430163008, 6524.021396790519, 6524.380183882524, 6526.477881769542, 6531.836704082436, 4355.063661312833, 4443.178012067778, 4446.133004064306, 4448.421705178306, 4449.599536041772, 6335.271443784024, 6337.302896681269, 6337.746490140343, 6339.524535659752, 6342.143810585697, 6172.4136207060255, 6174.660393678211, 6182.907256391068, 6186.072089186658, 6189.876202475835, 6010.429009244115, 6144.1398204250545, 6144.293406258159, 6152.876942461036, 6156.969215153896, 6048.84877878039, 6061.1514387984835, 6069.817905462844, 6071.574989750675, 6080.087986802015, 6192.133101365723, 6196.318404975539, 6253.7185826637, 6274.278457977209, 6277.748890044347, 5892.970535147469, 5977.22296101504, 6010.699465026643, 6015.2781666200335, 6017.06735456005], "unit": "score", "name": "prototype.html", "value": 4644.313138519815}, {"lowerIsBetter": false, "replicates": [826.8966379202601, 843.1947490146911, 847.8855354527137, 857.4426622695247, 872.2672954718038, 13216.801747973788, 13336.733265334688, 13366.93316533416, 13387.79918301225, 13429.261390623511, 12784.936075319634, 13200.53798117066, 13225.074244802867, 13225.404856781444, 13234.669133271673, 683.6308393467547, 693.6913073682214, 805.3999770171231, 820.1306614988102, 836.1304243586693, 826.2316046077145, 827.2430725885807, 832.8167803083312, 833.0295206084904, 833.0295206084934, 881.0748713850463, 881.9647214111428, 882.5102068352062, 882.9779255518631, 884.1644645809712, 717.6591119218356, 728.6502478810174, 851.5742128935564, 870.9477431354076, 872.8036191856845, 644.7453255963868, 646.0986923242051, 646.2245305633259, 646.4408286831904, 647.7247169952751, 13580.728385432334, 13650.317484125853, 13698.452061917511, 13716.971227158003, 13723.931380343134, 12914.41885115172, 12961.611151665371, 13007.934960325232, 13139.60581182566, 13177.209367437888, 10559.577616895393, 10653.0, 10673.199510036779, 10703.036726694558, 10947.124230061576, 3520.2079532105327, 3559.661832125944, 3641.0715267606593, 3655.9634403656155, 3682.981585092084, 44505.33242001373, 45430.772846135886, 45667.543324566665, 45774.31338529925, 46045.30932036055, 10073.395596264247, 10107.241956853119, 10173.491325433699, 10230.693079207636, 10649.0, 18180.545486362946, 18256.908715456604, 18281.908590457228, 18294.0, 18297.634047319247, 7313.817154571072, 7367.115946086504, 7377.114746230487, 7596.278353556403, 7665.3101220890385, 4355.259605867011, 4386.6637455436585, 4433.490148632884, 4481.574250446202, 4516.954830451654, 3144.622645282581, 3180.9522857157162, 3194.5367921651696, 3212.855421506038, 3214.72674822638, 574.5317566183547, 583.2971269620098, 588.8645611509377, 591.704147926037, 605.2041565341561, 618.2364779497317, 618.5762752514452, 661.4576047640984, 671.3890359772681, 687.0998991321385, 8267.379946504036, 8386.203310685476, 8387.790305242417, 8401.453905496122, 8516.06323304436, 620.7082671144555, 648.970796314167, 661.6783745597075, 680.5032326401655, 681.4887140885753, 3730.515033045687, 3784.129650180474, 3799.3351163546267, 3872.9419058714143, 4006.358982562776, 52337.21494177591, 52974.470255297725, 53136.202956955676, 53290.467095329324, 53311.46688533143, 46809.29786053212, 46957.53042469532, 47016.0, 47497.52502475, 47550.0, 42099.0, 43787.78106109449, 44128.558714412444, 44744.0, 45006.549934500894, 8032.437729359122, 8236.217559331853, 8367.707130250656, 8449.704260350858, 8626.0, 32575.0, 32578.51132232971, 32830.34339313248, 33541.496877547346, 34295.971120866416, 42208.0, 42403.363949540166, 42540.78729606456, 42943.14113717771, 43202.0, 10938.575232624215, 11071.280366776135, 11317.377544235145, 11414.885851141382, 11918.106142039209, 12411.937940310241, 12471.688207794878, 12633.115681902178, 12814.359282036048, 12856.228626282453, 10620.787584248426, 10658.946705266735, 10660.733481663021, 10762.515686793957, 11032.779344413228, 11384.943075284571, 11712.238704484182, 11849.822252666389, 11924.284542927453, 12094.0, 7371.741989030358, 9405.623775048922, 10851.240413171317, 11191.496382662963, 11299.209055366046, 9361.344705870524, 9585.233181345615, 9673.951630241803, 9832.655857045254, 9902.603895844086, 8521.724431097762, 8560.871586926325, 8672.653093876426, 8794.956025219833, 9358.578863951274], "unit": "score", "name": "yui.html", "value": 6249.2822897794595}], "name": "dromaeo_css", "value": 6853.190741783934}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 107.0, 112.0, 109.0, 110.0, 112.0, 113.0, 106.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [149.0, 124.0, 147.0, 176.0, 132.0, 159.0, 149.0, 126.0, 171.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 162.0, 161.0, 162.0, 160.0, 161.0, 161.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [71.0, 75.0, 92.0, 93.0, 72.0, 71.0, 72.0, 130.0, 88.0, 70.0], "unit": "score", "name": "audio-fft", "value": 83.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 148.0, 96.0, 96.0, 97.0, 139.0, 97.0, 98.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 111.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 108.0, 108.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 56.0, 56.0, 57.0, 61.0, 56.0, 57.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 69.0, 70.0, 69.0, 69.0, 71.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 82.0, 83.0, 82.0, 81.0, 84.0, 83.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [122.0, 120.0, 121.0, 128.0, 114.0, 122.0, 113.0, 116.0, 120.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.2}, {"lowerIsBetter": true, "replicates": [147.0, 136.0, 146.0, 151.0, 145.0, 134.0, 148.0, 143.0, 144.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 70.0, 68.0, 69.0, 67.0, 66.0, 68.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1501.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.84155756965424], "unit": "score", "name": "Richards", "value": 210.32931599999992}, {"lowerIsBetter": false, "replicates": [188.6080724254998], "unit": "score", "name": "DeltaBlue", "value": 350.5576359999999}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1116.0714285714287], "unit": "score", "name": "RayTrace", "value": 663.0301440000001}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [42645.833333333336], "unit": "score", "name": "RegExp", "value": 21.361641426477778}, {"lowerIsBetter": false, "replicates": [557.5858250276855], "unit": "score", "name": "Splay", "value": 146.1496981132076}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20151.03991184678}]} 08:29:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20151.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1501.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6853.19"}}} 08:29:46 INFO - Return code: 0 08:29:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:29:47 INFO - # TBPL SUCCESS # 08:29:47 INFO - Running post-action listener: _resource_record_post_action 08:29:47 INFO - Running post-run listener: _resource_record_post_run 08:29:48 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 8192; Write bytes: 548458496; Read time: 20; Write time: 1116384 08:29:48 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 237625344; Read time: 0; Write time: 607944 08:29:48 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 8192; Write bytes: 310833152; Read time: 20; Write time: 508440 08:29:48 INFO - Running post-run listener: _upload_blobber_files 08:29:48 INFO - Blob upload gear active. 08:29:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:29:48 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:29:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:29:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:29:48 INFO - (blobuploader) - INFO - Open directory for files ... 08:29:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:29:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:29:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:49 INFO - (blobuploader) - INFO - Done attempting. 08:29:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:29:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:29:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:50 INFO - (blobuploader) - INFO - Done attempting. 08:29:50 INFO - (blobuploader) - INFO - Iteration through files over. 08:29:50 INFO - Return code: 0 08:29:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:29:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:29:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81db57d015f0fddf0b3733256d1bdc01fc4b4fa0734eed698452547fb988a2a2725a0119df3f49d9caae65a5a1caa2bf7931a262d8d689c871a6ea6d6bef0286", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05af92e1b589b50cc482ea420d2e9ad952dfb01af15f18edda8211e2bbc5f14daf988d5ad11a23951439fcd5b69453d454032a2d7c3ea5ecd1fbce265e90e72b"} 08:29:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:29:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:29:50 INFO - Contents: 08:29:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81db57d015f0fddf0b3733256d1bdc01fc4b4fa0734eed698452547fb988a2a2725a0119df3f49d9caae65a5a1caa2bf7931a262d8d689c871a6ea6d6bef0286", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05af92e1b589b50cc482ea420d2e9ad952dfb01af15f18edda8211e2bbc5f14daf988d5ad11a23951439fcd5b69453d454032a2d7c3ea5ecd1fbce265e90e72b"} 08:29:50 INFO - Running post-run listener: copy_logs_to_upload_dir 08:29:50 INFO - Copying logs to upload dir... 08:29:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:29:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.522718 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-01-19 08:29:50.285675) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 08:29:50.289336) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81db57d015f0fddf0b3733256d1bdc01fc4b4fa0734eed698452547fb988a2a2725a0119df3f49d9caae65a5a1caa2bf7931a262d8d689c871a6ea6d6bef0286", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05af92e1b589b50cc482ea420d2e9ad952dfb01af15f18edda8211e2bbc5f14daf988d5ad11a23951439fcd5b69453d454032a2d7c3ea5ecd1fbce265e90e72b"} build_url:https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/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/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81db57d015f0fddf0b3733256d1bdc01fc4b4fa0734eed698452547fb988a2a2725a0119df3f49d9caae65a5a1caa2bf7931a262d8d689c871a6ea6d6bef0286", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05af92e1b589b50cc482ea420d2e9ad952dfb01af15f18edda8211e2bbc5f14daf988d5ad11a23951439fcd5b69453d454032a2d7c3ea5ecd1fbce265e90e72b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 08:29:50.321492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:29:50.321925) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453219583.509479-28746761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:29:50.401296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 08:29:50.401709) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 08:29:50.402096) ========= ========= Total master_lag: 0.29 =========