builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1452785412.99 results: success (0) buildid: 20160114023008 builduid: acd6920a3b3a47b585f9921219bb1015 revision: a0875ba554c053d490f577ea727e2d1b0693b314 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:12.987910) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:12.988379) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:12.988670) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006224 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.24 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:13.235196) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:13.235502) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:13.248767) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:13.249274) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:13.298753) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:13.299052) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:13.299440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:13.299723) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 07:30:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.1M=0s 2016-01-14 07:30:13 (47.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097658 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:13.409821) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:13.410153) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022131 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:13.459996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:13.460371) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev a0875ba554c053d490f577ea727e2d1b0693b314 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev a0875ba554c053d490f577ea727e2d1b0693b314 --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=b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 07:30:13,579 truncating revision to first 12 chars 2016-01-14 07:30:13,579 Setting DEBUG logging. 2016-01-14 07:30:13,579 attempt 1/10 2016-01-14 07:30:13,579 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/a0875ba554c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 07:30:13,831 unpacking tar archive at: b2g-inbound-a0875ba554c0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.546719 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:14.019854) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:14.020211) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:14.030174) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:14.030485) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 07:30:14.030937) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-14 07:30:14.031265) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:30:14 INFO - MultiFileLogger online at 20160114 07:30:14 in /builds/slave/test-pgo 07:30:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 07:30:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:30:14 INFO - {'append_to_log': False, 07:30:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:30:14 INFO - 'blob_upload_branch': 'B2G-Inbound', 07:30:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:30:14 INFO - 'branch': 'B2G-Inbound', 07:30:14 INFO - 'buildbot_json_path': 'buildprops.json', 07:30:14 INFO - 'config_files': ('talos/linux_config.py',), 07:30:14 INFO - 'default_actions': ('clobber', 07:30:14 INFO - 'read-buildbot-config', 07:30:14 INFO - 'download-and-extract', 07:30:14 INFO - 'populate-webroot', 07:30:14 INFO - 'create-virtualenv', 07:30:14 INFO - 'install', 07:30:14 INFO - 'run-tests'), 07:30:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:30:14 INFO - 'download_minidump_stackwalk': True, 07:30:14 INFO - 'download_symbols': 'ondemand', 07:30:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:30:14 INFO - 'tooltool.py': '/tools/tooltool.py', 07:30:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:30:14 INFO - '/tools/misc-python/virtualenv.py')}, 07:30:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:30:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:30:14 INFO - 'installer_path': 'installer.exe', 07:30:14 INFO - 'log_level': 'info', 07:30:14 INFO - 'log_name': 'talos', 07:30:14 INFO - 'log_to_console': True, 07:30:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:30:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:30:14 INFO - 'opt_config_files': (), 07:30:14 INFO - 'pip_index': False, 07:30:14 INFO - 'sps_profile': False, 07:30:14 INFO - 'sps_profile_interval': 0, 07:30:14 INFO - 'suite': 'dromaeojs', 07:30:14 INFO - 'system_bits': '32', 07:30:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:30:14 INFO - 'title': 'talos-linux64-ix-007', 07:30:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:30:14 INFO - 'use_talos_json': True, 07:30:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:30:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:30:14 INFO - 'work_dir': 'build'} 07:30:14 INFO - ##### 07:30:14 INFO - ##### Running clobber step. 07:30:14 INFO - ##### 07:30:14 INFO - Running pre-action listener: _resource_record_pre_action 07:30:14 INFO - Running main action method: clobber 07:30:14 INFO - rmtree: /builds/slave/test-pgo/build 07:30:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:30:14 INFO - Running post-action listener: _resource_record_post_action 07:30:14 INFO - ##### 07:30:14 INFO - ##### Running read-buildbot-config step. 07:30:14 INFO - ##### 07:30:14 INFO - Running pre-action listener: _resource_record_pre_action 07:30:14 INFO - Running main action method: read_buildbot_config 07:30:14 INFO - Using buildbot properties: 07:30:14 INFO - { 07:30:14 INFO - "project": "", 07:30:14 INFO - "product": "firefox", 07:30:14 INFO - "script_repo_revision": "production", 07:30:14 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 07:30:14 INFO - "repository": "", 07:30:14 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 07:30:14 INFO - "buildid": "20160114023008", 07:30:14 INFO - "pgo_build": "True", 07:30:14 INFO - "basedir": "/builds/slave/test-pgo", 07:30:14 INFO - "buildnumber": 1109, 07:30:14 INFO - "slavename": "talos-linux64-ix-007", 07:30:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:30:14 INFO - "platform": "ubuntu64_hw", 07:30:14 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 07:30:14 INFO - "branch": "b2g-inbound", 07:30:14 INFO - "repo_path": "integration/b2g-inbound", 07:30:14 INFO - "revision": "a0875ba554c053d490f577ea727e2d1b0693b314", 07:30:14 INFO - "stage_platform": "linux64-pgo", 07:30:14 INFO - "builduid": "acd6920a3b3a47b585f9921219bb1015", 07:30:14 INFO - "slavebuilddir": "test" 07:30:14 INFO - } 07:30:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:30:14 INFO - Running post-action listener: _resource_record_post_action 07:30:14 INFO - ##### 07:30:14 INFO - ##### Running download-and-extract step. 07:30:14 INFO - ##### 07:30:14 INFO - Running pre-action listener: _resource_record_pre_action 07:30:14 INFO - Running main action method: download_and_extract 07:30:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:30:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:14 INFO - https://queue.taskcluster.net/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:30:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/test_packages.json 07:30:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/test_packages.json 07:30:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:30:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:30:15 INFO - Downloaded 1448 bytes. 07:30:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:30:15 INFO - Using the following test package requirements: 07:30:15 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:30:15 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:30:15 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:30:15 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:15 INFO - u'jsshell-linux-x86_64.zip'], 07:30:15 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:30:15 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:30:15 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:30:15 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:30:15 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:30:15 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:30:15 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:30:15 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:30:15 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')]} 07:30:15 INFO - https://queue.taskcluster.net/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:30:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:30:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:30:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/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 07:30:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/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 07:30:17 INFO - Downloaded 24030429 bytes. 07:30:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:30:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:30:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:30:18 INFO - Return code: 0 07:30:18 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 07:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:18 INFO - https://queue.taskcluster.net/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:30:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:30:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:30:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/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 07:30:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/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 07:30:21 INFO - Downloaded 24030429 bytes. 07:30:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:30:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:30:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:30:23 INFO - Return code: 0 07:30:23 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')]} 07:30:23 INFO - https://queue.taskcluster.net/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:30:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:30:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:30:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/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 07:30:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/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 07:30:26 INFO - Downloaded 11132279 bytes. 07:30:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 07:30:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:30:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:30:27 INFO - Return code: 0 07:30:27 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')]} 07:30:27 INFO - https://queue.taskcluster.net/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:30:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:30:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:30:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/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 07:30:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2hztez3Q3WNfYpXfeOI8w/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 07:30:30 INFO - Downloaded 55880797 bytes. 07:30:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:30:30 INFO - mkdir: /builds/slave/test-pgo/properties 07:30:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:30:30 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:30:30 INFO - Contents: 07:30:30 INFO - build_url:https://queue.taskcluster.net/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:30:30 INFO - Running post-action listener: _resource_record_post_action 07:30:30 INFO - Running post-action listener: set_extra_try_arguments 07:30:30 INFO - ##### 07:30:30 INFO - ##### Running populate-webroot step. 07:30:30 INFO - ##### 07:30:30 INFO - Running pre-action listener: _resource_record_pre_action 07:30:30 INFO - Running main action method: populate_webroot 07:30:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:30:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:30:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:30:30 INFO - '--tppagecycles', 07:30:30 INFO - '7'], 07:30:30 INFO - 'tests': ['tsvgm']}}, 07:30:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:30:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:30:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:30:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:30:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:30:30 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:30:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:30 INFO - 'talos_options': ['--e10s'], 07:30:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:30 INFO - 'tests': ['damp', 'tps']}, 07:30:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:30 INFO - 'talos_options': ['--e10s'], 07:30:30 INFO - 'tests': ['damp', 'tps']}, 07:30:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:30:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:30:30 INFO - 'other': {'tests': ['a11yr', 07:30:30 INFO - 'ts_paint', 07:30:30 INFO - 'tpaint', 07:30:30 INFO - 'sessionrestore', 07:30:30 INFO - 'sessionrestore_no_auto_restore']}, 07:30:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:30:30 INFO - 'tests': ['a11yr', 07:30:30 INFO - 'ts_paint', 07:30:30 INFO - 'tpaint', 07:30:30 INFO - 'sessionrestore', 07:30:30 INFO - 'sessionrestore_no_auto_restore']}, 07:30:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:30:30 INFO - 'tests': ['a11yr', 07:30:30 INFO - 'ts_paint', 07:30:30 INFO - 'tpaint', 07:30:30 INFO - 'sessionrestore', 07:30:30 INFO - 'sessionrestore_no_auto_restore']}, 07:30:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:30:30 INFO - 'tests': ['a11yr', 07:30:30 INFO - 'ts_paint', 07:30:30 INFO - 'tpaint', 07:30:30 INFO - 'sessionrestore', 07:30:30 INFO - 'sessionrestore_no_auto_restore']}, 07:30:30 INFO - 'other_l64': {'tests': ['a11yr', 07:30:30 INFO - 'ts_paint', 07:30:30 INFO - 'tpaint', 07:30:30 INFO - 'sessionrestore', 07:30:30 INFO - 'sessionrestore_no_auto_restore']}, 07:30:30 INFO - 'other_nol64': {'tests': ['a11yr', 07:30:30 INFO - 'ts_paint', 07:30:30 INFO - 'tpaint', 07:30:30 INFO - 'sessionrestore', 07:30:30 INFO - 'sessionrestore_no_auto_restore']}, 07:30:30 INFO - 'svgr': {'tests': ['tsvgx', 07:30:30 INFO - 'tsvgr_opacity', 07:30:30 INFO - 'tart', 07:30:30 INFO - 'tscrollx', 07:30:30 INFO - 'cart']}, 07:30:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:30:30 INFO - 'tests': ['tsvgx', 07:30:30 INFO - 'tsvgr_opacity', 07:30:30 INFO - 'tart', 07:30:30 INFO - 'tscrollx', 07:30:30 INFO - 'cart']}, 07:30:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:30 INFO - 'tests': ['tp5o']}, 07:30:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:30 INFO - 'talos_options': ['--e10s'], 07:30:30 INFO - 'tests': ['tp5o']}, 07:30:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:30 INFO - 'talos_options': ['--xperf_path', 07:30:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:30 INFO - 'tests': ['tp5n']}, 07:30:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:30 INFO - 'talos_options': ['--e10s', 07:30:30 INFO - '--xperf_path', 07:30:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:30 INFO - 'tests': ['tp5n']}}, 07:30:30 INFO - 'talos.zip': {'path': '', 07:30:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:30:30 INFO - Running post-action listener: _resource_record_post_action 07:30:30 INFO - ##### 07:30:30 INFO - ##### Running create-virtualenv step. 07:30:30 INFO - ##### 07:30:30 INFO - Running pre-action listener: _resource_record_pre_action 07:30:30 INFO - Running main action method: create_virtualenv 07:30:30 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:30:30 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 07:30:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:30:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:30:30 INFO - Using real prefix '/usr' 07:30:30 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:30:31 INFO - Installing distribute.............................................................................................................................................................................................done. 07:30:33 INFO - Installing pip.................done. 07:30:33 INFO - Return code: 0 07:30:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:33 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 0x7fb9bf915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769660>, '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 0x276a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276aa10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', '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 07:30:33 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 07:30:33 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 07:30:33 INFO - Using env: {'DISPLAY': ':0', 07:30:33 INFO - 'HOME': '/home/cltbld', 07:30:33 INFO - 'LANG': 'en_US.UTF-8', 07:30:33 INFO - 'LANGUAGE': 'en_US:en', 07:30:33 INFO - 'LOGNAME': 'cltbld', 07:30:33 INFO - 'MAIL': '/var/mail/cltbld', 07:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:33 INFO - 'MOZ_NO_REMOTE': '1', 07:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:33 INFO - 'NO_EM_RESTART': '1', 07:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:30:33 INFO - 'PWD': '/builds/slave/test-pgo', 07:30:33 INFO - 'SHELL': '/bin/bash', 07:30:33 INFO - 'SHLVL': '1', 07:30:33 INFO - 'TERM': 'linux', 07:30:33 INFO - 'TMOUT': '86400', 07:30:33 INFO - 'USER': 'cltbld', 07:30:33 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', 07:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:33 INFO - '_': '/tools/buildbot/bin/python'} 07:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:33 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 07:30:33 INFO - Cleaning up... 07:30:33 INFO - Return code: 0 07:30:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:33 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 0x7fb9bf915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769660>, '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 0x276a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276aa10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', '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 07:30:33 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 07:30:33 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 07:30:33 INFO - Using env: {'DISPLAY': ':0', 07:30:33 INFO - 'HOME': '/home/cltbld', 07:30:33 INFO - 'LANG': 'en_US.UTF-8', 07:30:33 INFO - 'LANGUAGE': 'en_US:en', 07:30:33 INFO - 'LOGNAME': 'cltbld', 07:30:33 INFO - 'MAIL': '/var/mail/cltbld', 07:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:33 INFO - 'MOZ_NO_REMOTE': '1', 07:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:33 INFO - 'NO_EM_RESTART': '1', 07:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:30:33 INFO - 'PWD': '/builds/slave/test-pgo', 07:30:33 INFO - 'SHELL': '/bin/bash', 07:30:33 INFO - 'SHLVL': '1', 07:30:33 INFO - 'TERM': 'linux', 07:30:33 INFO - 'TMOUT': '86400', 07:30:33 INFO - 'USER': 'cltbld', 07:30:33 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', 07:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:33 INFO - '_': '/tools/buildbot/bin/python'} 07:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:33 INFO - Downloading/unpacking psutil>=0.7.1 07:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:35 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:30:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:30:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:30:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:30:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:30:35 INFO - Installing collected packages: psutil 07:30:35 INFO - Running setup.py install for psutil 07:30:35 INFO - building 'psutil._psutil_linux' extension 07:30:35 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 07:30:35 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 07:30:35 INFO - building 'psutil._psutil_posix' extension 07:30:35 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 07:30:35 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 07:30:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:30:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:30:35 INFO - Successfully installed psutil 07:30:35 INFO - Cleaning up... 07:30:36 INFO - Return code: 0 07:30:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:36 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 0x7fb9bf915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769660>, '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 0x276a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276aa10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', '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 07:30:36 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 07:30:36 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 07:30:36 INFO - Using env: {'DISPLAY': ':0', 07:30:36 INFO - 'HOME': '/home/cltbld', 07:30:36 INFO - 'LANG': 'en_US.UTF-8', 07:30:36 INFO - 'LANGUAGE': 'en_US:en', 07:30:36 INFO - 'LOGNAME': 'cltbld', 07:30:36 INFO - 'MAIL': '/var/mail/cltbld', 07:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:36 INFO - 'MOZ_NO_REMOTE': '1', 07:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:36 INFO - 'NO_EM_RESTART': '1', 07:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:30:36 INFO - 'PWD': '/builds/slave/test-pgo', 07:30:36 INFO - 'SHELL': '/bin/bash', 07:30:36 INFO - 'SHLVL': '1', 07:30:36 INFO - 'TERM': 'linux', 07:30:36 INFO - 'TMOUT': '86400', 07:30:36 INFO - 'USER': 'cltbld', 07:30:36 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', 07:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:36 INFO - '_': '/tools/buildbot/bin/python'} 07:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:30:36 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 07:30:36 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 07:30:36 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 07:30:36 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 07:30:36 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 07:30:36 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 07:30:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:30:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:30:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:30:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:30:37 INFO - Installing collected packages: mozsystemmonitor 07:30:37 INFO - Running setup.py install for mozsystemmonitor 07:30:38 INFO - Successfully installed mozsystemmonitor 07:30:38 INFO - Cleaning up... 07:30:38 INFO - Return code: 0 07:30:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:30:38 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')]} 07:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:38 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')]} 07:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:38 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 0x7fb9bf915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769660>, '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 0x276a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276aa10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', '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 07:30:38 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 07:30:38 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 07:30:38 INFO - Using env: {'DISPLAY': ':0', 07:30:38 INFO - 'HOME': '/home/cltbld', 07:30:38 INFO - 'LANG': 'en_US.UTF-8', 07:30:38 INFO - 'LANGUAGE': 'en_US:en', 07:30:38 INFO - 'LOGNAME': 'cltbld', 07:30:38 INFO - 'MAIL': '/var/mail/cltbld', 07:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:38 INFO - 'MOZ_NO_REMOTE': '1', 07:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:38 INFO - 'NO_EM_RESTART': '1', 07:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:30:38 INFO - 'PWD': '/builds/slave/test-pgo', 07:30:38 INFO - 'SHELL': '/bin/bash', 07:30:38 INFO - 'SHLVL': '1', 07:30:38 INFO - 'TERM': 'linux', 07:30:38 INFO - 'TMOUT': '86400', 07:30:38 INFO - 'USER': 'cltbld', 07:30:38 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', 07:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:38 INFO - '_': '/tools/buildbot/bin/python'} 07:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:38 INFO - Downloading/unpacking blobuploader==1.2.4 07:30:38 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 07:30:38 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 07:30:38 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 07:30:38 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 07:30:38 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 07:30:38 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 07:30:40 INFO - Downloading blobuploader-1.2.4.tar.gz 07:30:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:30:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:30:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:30:40 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 07:30:40 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 07:30:40 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 07:30:40 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 07:30:40 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 07:30:40 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 07:30:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:30:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:30:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:30:40 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 07:30:40 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 07:30:40 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 07:30:40 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 07:30:40 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 07:30:40 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 07:30:40 INFO - Downloading docopt-0.6.1.tar.gz 07:30:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:30:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:30:40 INFO - Installing collected packages: blobuploader, requests, docopt 07:30:40 INFO - Running setup.py install for blobuploader 07:30:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:30:41 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:30:41 INFO - Running setup.py install for requests 07:30:41 INFO - Running setup.py install for docopt 07:30:41 INFO - Successfully installed blobuploader requests docopt 07:30:41 INFO - Cleaning up... 07:30:41 INFO - Return code: 0 07:30:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:30:41 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')]} 07:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:41 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')]} 07:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:41 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 0x7fb9bf915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769660>, '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 0x276a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276aa10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', '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 07:30:41 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 07:30:41 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 07:30:41 INFO - Using env: {'DISPLAY': ':0', 07:30:41 INFO - 'HOME': '/home/cltbld', 07:30:41 INFO - 'LANG': 'en_US.UTF-8', 07:30:41 INFO - 'LANGUAGE': 'en_US:en', 07:30:41 INFO - 'LOGNAME': 'cltbld', 07:30:41 INFO - 'MAIL': '/var/mail/cltbld', 07:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:41 INFO - 'MOZ_NO_REMOTE': '1', 07:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:41 INFO - 'NO_EM_RESTART': '1', 07:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:30:41 INFO - 'PWD': '/builds/slave/test-pgo', 07:30:41 INFO - 'SHELL': '/bin/bash', 07:30:41 INFO - 'SHLVL': '1', 07:30:41 INFO - 'TERM': 'linux', 07:30:41 INFO - 'TMOUT': '86400', 07:30:41 INFO - 'USER': 'cltbld', 07:30:41 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', 07:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:41 INFO - '_': '/tools/buildbot/bin/python'} 07:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:30:41 INFO - Running setup.py (path:/tmp/pip-EBcSfc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:30:41 INFO - Running setup.py (path:/tmp/pip-LOhXee-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:30:41 INFO - Running setup.py (path:/tmp/pip-Ph88Jz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:30:42 INFO - Running setup.py (path:/tmp/pip-3c6Q32-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:30:42 INFO - Running setup.py (path:/tmp/pip-Jp8tOS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:30:42 INFO - Running setup.py (path:/tmp/pip-i1zBE6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:30:42 INFO - Running setup.py (path:/tmp/pip-ia5Sj0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:30:42 INFO - Running setup.py (path:/tmp/pip-GrPvYD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:30:42 INFO - Running setup.py (path:/tmp/pip-a6ygni-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:30:42 INFO - Running setup.py (path:/tmp/pip-6AG4dR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:30:42 INFO - Running setup.py (path:/tmp/pip-I7OyEz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:30:42 INFO - Running setup.py (path:/tmp/pip-1m5scP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:30:42 INFO - Running setup.py (path:/tmp/pip-CKma1s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:30:42 INFO - Running setup.py (path:/tmp/pip-FjyLD8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:30:42 INFO - Running setup.py (path:/tmp/pip-PyjugY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:30:42 INFO - Running setup.py (path:/tmp/pip-7w8V0t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:30:42 INFO - Running setup.py (path:/tmp/pip-uxeDES-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:30:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:30:43 INFO - Running setup.py install for manifestparser 07:30:43 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:30:43 INFO - Running setup.py install for mozcrash 07:30:43 INFO - Running setup.py install for mozdebug 07:30:43 INFO - Running setup.py install for mozdevice 07:30:43 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:30:43 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:30:43 INFO - Running setup.py install for mozfile 07:30:43 INFO - Running setup.py install for mozhttpd 07:30:43 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:30:43 INFO - Running setup.py install for mozinfo 07:30:43 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:30:43 INFO - Running setup.py install for mozInstall 07:30:43 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:30:43 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:30:43 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:30:43 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:30:43 INFO - Running setup.py install for mozleak 07:30:43 INFO - Running setup.py install for mozlog 07:30:44 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:30:44 INFO - Running setup.py install for moznetwork 07:30:44 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:30:44 INFO - Running setup.py install for mozprocess 07:30:44 INFO - Running setup.py install for mozprofile 07:30:44 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:30:44 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:30:44 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:30:44 INFO - Running setup.py install for mozrunner 07:30:44 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:30:44 INFO - Running setup.py install for mozscreenshot 07:30:44 INFO - Running setup.py install for moztest 07:30:44 INFO - Running setup.py install for mozversion 07:30:44 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:30:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:30:44 INFO - Cleaning up... 07:30:44 INFO - Return code: 0 07:30:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:44 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 0x7fb9bf915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769660>, '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 0x276a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276aa10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', '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 07:30:44 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 07:30:44 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 07:30:44 INFO - Using env: {'DISPLAY': ':0', 07:30:44 INFO - 'HOME': '/home/cltbld', 07:30:44 INFO - 'LANG': 'en_US.UTF-8', 07:30:44 INFO - 'LANGUAGE': 'en_US:en', 07:30:44 INFO - 'LOGNAME': 'cltbld', 07:30:44 INFO - 'MAIL': '/var/mail/cltbld', 07:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:44 INFO - 'MOZ_NO_REMOTE': '1', 07:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:44 INFO - 'NO_EM_RESTART': '1', 07:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:30:44 INFO - 'PWD': '/builds/slave/test-pgo', 07:30:44 INFO - 'SHELL': '/bin/bash', 07:30:44 INFO - 'SHLVL': '1', 07:30:44 INFO - 'TERM': 'linux', 07:30:44 INFO - 'TMOUT': '86400', 07:30:44 INFO - 'USER': 'cltbld', 07:30:44 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', 07:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:44 INFO - '_': '/tools/buildbot/bin/python'} 07:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:30:45 INFO - Running setup.py (path:/tmp/pip-ptlC1B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:30:45 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)) 07:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:30:45 INFO - Running setup.py (path:/tmp/pip-w_cxt6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:30:45 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)) 07:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:30:45 INFO - Running setup.py (path:/tmp/pip-cMITL5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:30:45 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)) 07:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:30:45 INFO - Running setup.py (path:/tmp/pip-ZsVcks-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:30:45 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)) 07:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:30:45 INFO - Running setup.py (path:/tmp/pip-uN9JVL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:30:45 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)) 07:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:30:45 INFO - Running setup.py (path:/tmp/pip-GhqU5o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:30:45 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)) 07:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:30:45 INFO - Running setup.py (path:/tmp/pip-YEYnhW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:30:45 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)) 07:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:30:45 INFO - Running setup.py (path:/tmp/pip-G1grQ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:30:45 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)) 07:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:30:45 INFO - Running setup.py (path:/tmp/pip-wKEi0D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:30:45 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)) 07:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:30:45 INFO - Running setup.py (path:/tmp/pip-EPp08f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:30:45 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)) 07:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:30:45 INFO - Running setup.py (path:/tmp/pip-JN4kFg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:30:45 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)) 07:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:30:45 INFO - Running setup.py (path:/tmp/pip-NjEHCR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:30:45 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)) 07:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:30:45 INFO - Running setup.py (path:/tmp/pip-HFPg8P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:30:45 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)) 07:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:30:45 INFO - Running setup.py (path:/tmp/pip-pppApc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:30:46 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)) 07:30:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:30:46 INFO - Running setup.py (path:/tmp/pip-NU9tAJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:30:46 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)) 07:30:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:30:46 INFO - Running setup.py (path:/tmp/pip-bd96kX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:30:46 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)) 07:30:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:30:46 INFO - Running setup.py (path:/tmp/pip-hl94Lh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:30:46 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)) 07:30:46 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)) 07:30:46 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)) 07:30:46 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)) 07:30:46 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)) 07:30:46 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)) 07:30:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:30:46 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 07:30:46 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 07:30:46 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 07:30:46 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 07:30:46 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 07:30:46 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 07:30:47 INFO - Downloading blessings-1.5.1.tar.gz 07:30:47 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 07:30:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:30:48 INFO - Installing collected packages: blessings 07:30:48 INFO - Running setup.py install for blessings 07:30:48 INFO - Successfully installed blessings 07:30:48 INFO - Cleaning up... 07:30:48 INFO - Return code: 0 07:30:48 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:30:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:30:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:30:48 INFO - Reading from file tmpfile_stdout 07:30:48 INFO - Current package versions: 07:30:48 INFO - argparse == 1.2.1 07:30:48 INFO - blessings == 1.5.1 07:30:48 INFO - blobuploader == 1.2.4 07:30:48 INFO - docopt == 0.6.1 07:30:48 INFO - manifestparser == 1.1 07:30:48 INFO - mozInstall == 1.12 07:30:48 INFO - mozcrash == 0.16 07:30:48 INFO - mozdebug == 0.1 07:30:48 INFO - mozdevice == 0.48 07:30:48 INFO - mozfile == 1.2 07:30:48 INFO - mozhttpd == 0.7 07:30:48 INFO - mozinfo == 0.9 07:30:48 INFO - mozleak == 0.1 07:30:48 INFO - mozlog == 3.1 07:30:48 INFO - moznetwork == 0.27 07:30:48 INFO - mozprocess == 0.22 07:30:48 INFO - mozprofile == 0.28 07:30:48 INFO - mozrunner == 6.11 07:30:48 INFO - mozscreenshot == 0.1 07:30:48 INFO - mozsystemmonitor == 0.0 07:30:48 INFO - moztest == 0.7 07:30:48 INFO - mozversion == 1.4 07:30:48 INFO - psutil == 3.1.1 07:30:48 INFO - requests == 1.2.3 07:30:48 INFO - wsgiref == 0.1.2 07:30:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:30: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')]} 07:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30: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')]} 07:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:48 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 0x7fb9bf915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769660>, '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 0x276a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276aa10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', '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 07:30:48 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 07:30:48 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 07:30:48 INFO - Using env: {'DISPLAY': ':0', 07:30:48 INFO - 'HOME': '/home/cltbld', 07:30:48 INFO - 'LANG': 'en_US.UTF-8', 07:30:48 INFO - 'LANGUAGE': 'en_US:en', 07:30:48 INFO - 'LOGNAME': 'cltbld', 07:30:48 INFO - 'MAIL': '/var/mail/cltbld', 07:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:48 INFO - 'MOZ_NO_REMOTE': '1', 07:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:48 INFO - 'NO_EM_RESTART': '1', 07:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:30:48 INFO - 'PWD': '/builds/slave/test-pgo', 07:30:48 INFO - 'SHELL': '/bin/bash', 07:30:48 INFO - 'SHLVL': '1', 07:30:48 INFO - 'TERM': 'linux', 07:30:48 INFO - 'TMOUT': '86400', 07:30:48 INFO - 'USER': 'cltbld', 07:30:48 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', 07:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:48 INFO - '_': '/tools/buildbot/bin/python'} 07:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:48 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)) 07:30:48 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)) 07:30:48 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)) 07:30:48 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)) 07:30:48 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)) 07:30:48 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)) 07:30:48 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)) 07:30:48 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)) 07:30:48 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)) 07:30:48 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)) 07:30:48 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)) 07:30:48 INFO - Cleaning up... 07:30:48 INFO - Return code: 0 07:30:48 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:30: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')]} 07:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30: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')]} 07:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:48 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 0x7fb9bf915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769660>, '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 0x276a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276aa10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', '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 07:30:48 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 07:30:48 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 07:30:48 INFO - Using env: {'DISPLAY': ':0', 07:30:48 INFO - 'HOME': '/home/cltbld', 07:30:48 INFO - 'LANG': 'en_US.UTF-8', 07:30:48 INFO - 'LANGUAGE': 'en_US:en', 07:30:48 INFO - 'LOGNAME': 'cltbld', 07:30:48 INFO - 'MAIL': '/var/mail/cltbld', 07:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:48 INFO - 'MOZ_NO_REMOTE': '1', 07:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:48 INFO - 'NO_EM_RESTART': '1', 07:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:30:48 INFO - 'PWD': '/builds/slave/test-pgo', 07:30:48 INFO - 'SHELL': '/bin/bash', 07:30:48 INFO - 'SHLVL': '1', 07:30:48 INFO - 'TERM': 'linux', 07:30:48 INFO - 'TMOUT': '86400', 07:30:48 INFO - 'USER': 'cltbld', 07:30:48 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', 07:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:48 INFO - '_': '/tools/buildbot/bin/python'} 07:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:48 INFO - Downloading/unpacking jsonschema 07:30:48 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 07:30:48 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 07:30:48 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 07:30:48 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 07:30:48 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 07:30:48 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 07:30:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:30:50 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 07:30:50 INFO - Downloading/unpacking functools32 (from jsonschema) 07:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:50 INFO - Downloading functools32-3.2.3-2.tar.gz 07:30:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:30:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:30:50 INFO - warning: no files found matching '*.txt' 07:30:50 INFO - no previously-included directories found matching 'build' 07:30:50 INFO - no previously-included directories found matching 'dist' 07:30:50 INFO - no previously-included directories found matching '.git*' 07:30:50 INFO - Installing collected packages: jsonschema, functools32 07:30:50 INFO - Running setup.py install for functools32 07:30:50 INFO - warning: no files found matching '*.txt' 07:30:50 INFO - no previously-included directories found matching 'build' 07:30:50 INFO - no previously-included directories found matching 'dist' 07:30:50 INFO - no previously-included directories found matching '.git*' 07:30:51 INFO - Successfully installed jsonschema functools32 07:30:51 INFO - Cleaning up... 07:30:51 INFO - Return code: 0 07:30:51 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:30:51 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')]} 07:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:51 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')]} 07:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:51 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 0x7fb9bf915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769660>, '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 0x276a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276aa10>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', '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 07:30:51 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 07:30:51 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 07:30:51 INFO - Using env: {'DISPLAY': ':0', 07:30:51 INFO - 'HOME': '/home/cltbld', 07:30:51 INFO - 'LANG': 'en_US.UTF-8', 07:30:51 INFO - 'LANGUAGE': 'en_US:en', 07:30:51 INFO - 'LOGNAME': 'cltbld', 07:30:51 INFO - 'MAIL': '/var/mail/cltbld', 07:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:51 INFO - 'MOZ_NO_REMOTE': '1', 07:30:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:51 INFO - 'NO_EM_RESTART': '1', 07:30:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:30:51 INFO - 'PWD': '/builds/slave/test-pgo', 07:30:51 INFO - 'SHELL': '/bin/bash', 07:30:51 INFO - 'SHLVL': '1', 07:30:51 INFO - 'TERM': 'linux', 07:30:51 INFO - 'TMOUT': '86400', 07:30:51 INFO - 'USER': 'cltbld', 07:30:51 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', 07:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:51 INFO - '_': '/tools/buildbot/bin/python'} 07:30:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:51 INFO - Downloading/unpacking flake8 07:30:51 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 07:30:51 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 07:30:51 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 07:30:51 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 07:30:51 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 07:30:51 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 07:30:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:30:52 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 07:30:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:30: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 07:30:53 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 07:30:53 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 07:30:53 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 07:30:53 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 07:30:53 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 07:30:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:30:53 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 07:30:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:30:53 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 07:30:53 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 07:30:53 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 07:30:53 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 07:30:53 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 07:30:53 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 07:30:53 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 07:30:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:30:53 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 07:30:53 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 07:30:53 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 07:30:53 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 07:30:53 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 07:30:53 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 07:30:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:30:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:30:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:30:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:30:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:30:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:30:53 INFO - no previously-included directories found matching 'docs/_build' 07:30:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:30:53 INFO - Running setup.py install for pep8 07:30:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:30:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:30:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:30:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:30:53 INFO - no previously-included directories found matching 'docs/_build' 07:30:53 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:30:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:30:53 INFO - Cleaning up... 07:30:53 INFO - Return code: 0 07:30:53 INFO - Running post-action listener: _resource_record_post_action 07:30:53 INFO - Running post-action listener: _start_resource_monitoring 07:30:53 INFO - Starting resource monitoring. 07:30:53 INFO - ##### 07:30:53 INFO - ##### Running install step. 07:30:53 INFO - ##### 07:30:53 INFO - Running pre-action listener: _resource_record_pre_action 07:30:53 INFO - Running main action method: install 07:30:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:30:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:30:54 INFO - Reading from file tmpfile_stdout 07:30:54 INFO - Detecting whether we're running mozinstall >=1.0... 07:30:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:30:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:30:54 INFO - Reading from file tmpfile_stdout 07:30:54 INFO - Output received: 07:30:54 INFO - Usage: mozinstall [options] installer 07:30:54 INFO - Options: 07:30:54 INFO - -h, --help show this help message and exit 07:30:54 INFO - -d DEST, --destination=DEST 07:30:54 INFO - Directory to install application into. [default: 07:30:54 INFO - "/builds/slave/test-pgo"] 07:30:54 INFO - --app=APP Application being installed. [default: firefox] 07:30:54 INFO - mkdir: /builds/slave/test-pgo/build/application 07:30:54 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'] 07:30:54 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 07:31:10 INFO - Reading from file tmpfile_stdout 07:31:10 INFO - Output received: 07:31:10 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:31:10 INFO - Running post-action listener: _resource_record_post_action 07:31:10 INFO - ##### 07:31:10 INFO - ##### Running run-tests step. 07:31:10 INFO - ##### 07:31:10 INFO - Running pre-action listener: _resource_record_pre_action 07:31:10 INFO - Running main action method: run_tests 07:31:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:31:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:31:10 INFO - Python 2.7.3 07:31:10 INFO - Return code: 0 07:31:10 INFO - grabbing minidump binary from tooltool 07:31:10 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')]} 07:31:10 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 0x2769660>, '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 0x276a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276aa10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:31:10 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 07:31:10 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 07:31:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:31:10 INFO - Return code: 0 07:31:10 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:31:10 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:31:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:31:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:31:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:31:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:31:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:31:11 INFO - Return code: 0 07:31:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 07:31:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 07:31:11 INFO - Using env: {'DISPLAY': ':0', 07:31:11 INFO - 'HOME': '/home/cltbld', 07:31:11 INFO - 'LANG': 'en_US.UTF-8', 07:31:11 INFO - 'LANGUAGE': 'en_US:en', 07:31:11 INFO - 'LOGNAME': 'cltbld', 07:31:11 INFO - 'MAIL': '/var/mail/cltbld', 07:31:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:31:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:11 INFO - 'MOZ_NO_REMOTE': '1', 07:31:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:31:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:11 INFO - 'NO_EM_RESTART': '1', 07:31:11 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:31:11 INFO - 'PWD': '/builds/slave/test-pgo', 07:31:11 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:31:11 INFO - 'SHELL': '/bin/bash', 07:31:11 INFO - 'SHLVL': '1', 07:31:11 INFO - 'TERM': 'linux', 07:31:11 INFO - 'TMOUT': '86400', 07:31:11 INFO - 'USER': 'cltbld', 07:31:11 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366', 07:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:11 INFO - '_': '/tools/buildbot/bin/python'} 07:31:11 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 07:31:11 INFO - mozversion application_buildid: 20160114023008 07:31:11 INFO - mozversion application_changeset: a0875ba554c053d490f577ea727e2d1b0693b314 07:31:11 INFO - mozversion application_display_name: Nightly 07:31:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:31:11 INFO - mozversion application_name: Firefox 07:31:11 INFO - mozversion application_remotingname: firefox 07:31:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 07:31:11 INFO - mozversion application_vendor: Mozilla 07:31:11 INFO - mozversion application_version: 46.0a1 07:31:11 INFO - mozversion platform_buildid: 20160114023008 07:31:11 INFO - mozversion platform_changeset: a0875ba554c053d490f577ea727e2d1b0693b314 07:31:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 07:31:11 INFO - mozversion platform_version: 46.0a1 07:31:11 INFO - using testdate: 1452785471 07:31:11 INFO - actual date: 1452785471 07:31:11 INFO - starting webserver on 'localhost:44144' 07:31:11 INFO - SUITE-START | Running 3 tests 07:31:11 INFO - TEST-START | dromaeo_css 07:31:11 INFO - operating with platform_type : linux_ 07:31:11 INFO - Initialising browser for dromaeo_css test... 07:31:11 INFO - TEST-INFO | started process 14079 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRhchEw/profile http://localhost:44144/getInfo.html) 07:31:15 INFO - PROCESS | 14079 | __metrics Screen width/height:1600/1200 07:31:15 INFO - PROCESS | 14079 | colorDepth:24 07:31:15 INFO - PROCESS | 14079 | Browser inner width/height: 1024/697 07:31:15 INFO - PROCESS | 14079 | __metrics 07:31:15 INFO - PROCESS | 14079 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:31:15 INFO - PROCESS | 14079 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:31:16 INFO - TEST-INFO | 14079: exit 0 07:31:16 INFO - Browser initialized. 07:31:16 INFO - Running cycle 1/1 for dromaeo_css test... 07:31:16 INFO - TEST-INFO | started process 14174 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRhchEw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:28 INFO - PROCESS | 14174 | RSS: Main: 149004288 07:31:28 INFO - PROCESS | 14174 | 07:32:20 INFO - PROCESS | 14174 | 1452785540424 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] 07:34:28 INFO - PROCESS | 14174 | Cycle 1(1): loaded http://localhost:44144/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44144/tests/dromaeo/cssquery-ext.html) 07:34:29 INFO - PROCESS | 14174 | RSS: Main: 230236160 07:34:29 INFO - PROCESS | 14174 | 07:37:31 INFO - PROCESS | 14174 | Cycle 1(1): loaded http://localhost:44144/tests/dromaeo/cssquery-ext.html (next: http://localhost:44144/tests/dromaeo/cssquery-jquery.html) 07:37:32 INFO - PROCESS | 14174 | RSS: Main: 226476032 07:37:32 INFO - PROCESS | 14174 | 07:40:34 INFO - PROCESS | 14174 | Cycle 1(1): loaded http://localhost:44144/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44144/tests/dromaeo/cssquery-mootools.html) 07:40:34 INFO - PROCESS | 14174 | RSS: Main: 246321152 07:40:34 INFO - PROCESS | 14174 | 07:43:36 INFO - PROCESS | 14174 | Cycle 1(1): loaded http://localhost:44144/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44144/tests/dromaeo/cssquery-prototype.html) 07:43:37 INFO - PROCESS | 14174 | RSS: Main: 208035840 07:43:37 INFO - PROCESS | 14174 | 07:46:39 INFO - PROCESS | 14174 | Cycle 1(1): loaded http://localhost:44144/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44144/tests/dromaeo/cssquery-yui.html) 07:46:40 INFO - PROCESS | 14174 | RSS: Main: 212406272 07:46:40 INFO - PROCESS | 14174 | 07:49:43 INFO - PROCESS | 14174 | Cycle 1(1): loaded http://localhost:44144/tests/dromaeo/cssquery-yui.html (next: http://localhost:44144/tests/dromaeo/cssquery-dojo.html) 07:49:43 INFO - PROCESS | 14174 | RSS: Main: 263397376 07:49:43 INFO - PROCESS | 14174 | 07:49:43 INFO - PROCESS | 14174 | __start_tp_report 07:49:43 INFO - PROCESS | 14174 | _x_x_mozilla_page_load 07:49:43 INFO - PROCESS | 14174 | _x_x_mozilla_page_load_details 07:49:43 INFO - PROCESS | 14174 | |i|pagename|runs| 07:49:43 INFO - PROCESS | 14174 | |0;dojo.html;3140.7173354398105;3149.5118256670225;3199.4880819068953;3201.887933922313;3224.6775322467756;4934.950650493494;5021.3221215135945;5086.771095300715;5095.872603184922;5152;5058.84823455296;5088.669236499625;5118.820841270556;5180.740962951856;5245.580353571705;4627.930581041287;4661.58045775881;4683.391159149306;4733.100710864942;4733.952660473386;4816.903661926759;4835.347228124193;4845;4857.392825896763;4858.975705121469;4609.7695115244105;4672.15901137795;4678.251479763221;4736.218523943545;4781.880452988686;4662.487126416091;4672.15901137795;4687.390639216914;4690.530946905282;4694.037722266927;4635.652326075524;4640.280756482751;4641.698289611199;4645.0477652081245;4694.225452800284;4822.035592881438;4904.509549045067;4974.079795237856;4980.352554167971;5065.620078494091;5399;5410.458954104597;5411.83764487066;5414.187871819219;5416.91874621881;5434;5435.619506634537;5442.537384322337;5447.046766815792;5488.259085023511;5027.773750181251;5101.056304583664;5109.770060347293;5144.356955380577;5170.482951704837;5663.603547751618;5666.943330566724;5669.858253543694;5680.801171958961;5714.428557144335;5230.215467679803;5477.643953143033;5487.917681234785;5491.533219676292;5493.670379777226;5417.6478528895495;5468.37113731918;5487.670739755627;5511.0080185566985;5547.223388725582;5436.728163591804;5438.483344082306;5439.646422982493;5441.83674489766;5444.8366549003595;5264.184051472028;5339.038972984822;5420.349558053059;5441.863953401117;5475.342958844964;4219.346001369792;4295.72077814941;4339.522652508222;4348.478182618106;4351.760653164043;3837.2325534893134;3846.0577158596325;3862.2661694278;3871.7483363581277;3889.0666240102173;4887.975560122177;4971.279164521125;5042.647014708935;5052.797888084436;5105.897882042338;5490.752916118784;5490.752916118784;5511.200875872976;5512.834614961557;5561.193626924154;5008;5030.874228144253;5031.345925029723;5031.597472202215;5074.4671809460215;4569.611583015481;4636.350910872413;4682;4698.929516057262;4749.857504274877;5666.405027472056;5685.971570142123;5692.800751973744;5692.946804841201;5709.200711900337;5492.505674489315;5495.258140151188;5507.779688812403;5513.807016754395;5521.061419558604;5464.617476776588;5514.117741161395;5601.411851755507;5620.437956204347;5673.092305231308;5365.436629153883;5380.623356365017;5383.138697808332;5385.73071346439;5400.459954004568;5426.213199086189;5439.537639300704;5439.891202176013;5467.480589344006;5485.149801780731;5194.091034068947;5211.322528071327;5402.810901618424;5433.673979561239;5459.781608735606;5363.812266570651;5375.462453754593;5375.489328513785;5377.166539186433;5395.70323632204;5135.589152867837;5279.577633789211;5293.994141113176;5298.4171741107675;5339.7063161526485;5253.106971814725;5367.302250707539;5402.594805389533;5465.508104270476;5467.097928841697;5310.628256022042;5324.494173053554;5327.121025030981;5328.813491527778;5335.1730481775385 07:49:43 INFO - PROCESS | 14174 | |1;ext.html;498.80795893580984;531.9202119682047;541.4720647368816;545.5526468295994;558.3774091887545;28244.293892652695;28515;28582.428351432958;28627.570586441194;28808.42383152338;35095.649043509555;35528.2894342113;35806.104847378825;35816.82091589538;35832.46251306226;8428.831423371528;8603.612837422299;8605.698800541983;8607.870881936777;8615.784605384884;7420.295071968181;7613.467057305991;8318.66725330986;8451.619677114544;9828.459434731087;9864.852027219598;9905.059019393182;9929.156021738161;9946.204303655726;9948.900510994907;9706.66026689066;9756.463394513334;9757.804843903154;9759.170470510015;9764.121229089416;9677.080677335642;9811.166050885684;9823.36148150375;9823.656172033945;9827.852582211273;35844.46233306477;35851.103722406886;35962.460563091576;36185.81907090474;38706.41940370897;3322.4185767490835;3355.6308806031316;3396.252824378633;3421.0763093964492;3506.0358401439553;29243;29476;29766.70233297661;30113;30871.38257234865;3138.2938838761324;3187.7609179311644;3258.983705081483;3269.476883698597;3296.8846090386724;268371;268410;268841;269069;269167;50041.74979125081;50882.745586271834;55881.882362352524;56238.43761562414;56253.7187314069;60502.39497605056;61522.38477615256;61667.69166154141;61718.38281617216;61749.382506175265;14260.286985650677;14280.642983925485;14389.136651800925;14454.20501872386;14516.85483145155;12105.334206618545;12193.085518586142;12204.084693647834;12220.20568663052;12228.205166664138;18641.7203741944;18776.436706898814;18782.90608546976;18826.62346753057;18917.62164756697;7564.546127232384;7902.841943161105;7913.564753938589;7926.286634202949;7955.284024437713;988.1748739802202;1021.6832781837654;1056.9788604228027;1083.1930211992117;1104.6962085426412;26574.335641608726;27113.322166945985;28036;28310.43379132406;28310.71689283122;1075.9193060520493;1123.2361993844265;1126.5043380912373;1150.2006105756586;1179.6343133628432;14643.853561464462;14689.41242350294;14724.411023559152;14835.258237088317;14984;316655;319503.2198712072;324099;324385;326508;50775.746121269156;51044.74477627588;51066.48933510692;51086;51128.23307650388;1331.6670832291927;1347.0570600579438;1348.1169833758904;1360.3674291454324;1368.4115830192914;26684.466310673288;27210.1836944892;27471.862640686668;27653.58519622167;27827.582586261626;41626;42760.14479710326;45166.77416612896;45743.313850292936;46659.76670116628;234226;234365;235037;236935;237222;27291.181264562096;29332.706672932996;29577.26056848596;29611.851940740158;29642.11073667707;30885;33547.161320966195;36828.26343473169;39294.41058384069;40162.598374015884;33157.67452980566;35997.280054398245;36041;36586;36876.26247474982;36174.570194534645;36816.63183368132;36847;36856.63143368532;37031.62968370282;35459;35928;36031.27937441289;36066.8196659015;36228.63771362358;31177.68822311748;32899;32915.50626740553;33327;33518.66481335253;24340.75659243385;24490;24791.380215494755;24889.377765556004;25237.74762252354 07:49:43 INFO - PROCESS | 14174 | |2;jquery.html;358.4175714463996;363.8817384350087;366.59857456085587;367.46533793330696;369.2283128261932;13381.799273010913;13533.255670938095;15644.53066408008;16891.155442227886;17941.3720519782;15465.458708945189;15653.964984552022;15724.921375393136;15851.841481585181;16609.91695041523;5231.5814734821215;5388.299521062276;5391.487808658171;5392.352917649868;5392.73036348183;3933.1347103637154;4122.216778812031;5289.074411977907;5377.704226267554;5637.3517045539675;5701.868059570564;5774.769009239625;5817.331006934214;5832.533397328203;5837.211976383198;5753.395893431192;5875.38308477608;5906.527477801787;5909.556783241231;5911.379305172981;5042.722650254234;5201.037808005531;5201.193814958649;5225.294585231021;5228.294180285651;14821.555353339418;14964.551063468005;15630.531084067383;19361.709574356395;19745.605087898304;2084.5414008918165;2126.138913739938;2188.441947303443;2263.094762095159;2401.6037353836596;12507.812382814265;12591.937040314831;12845;13004.414801333962;13139.34303284832;1785.3394244129754;1855.4794316227026;1861.7207418887276;1865.3098353609116;1865.450285400935;50100.74949625265;51265;51592.48407515952;51766;51795.482045179444;9433.292503062297;9518.095780900803;9616.663416780379;9629.807403852024;9692.70921872345;12537.874621253854;12544.310062946442;12548.372581370895;12555.05837062224;12565.811512827315;7379.963100184465;7405.8889116663295;7445.813854653677;7499.437542184358;7511.474196806171;7203.711851525985;7227.313405226495;7257.0565826442225;7287.125544934642;7305.45209109319;5809.331926828469;5958.255218097738;5965.164876917235;5974.103884417285;6005.279366476051;1598.073117591794;1613.2175894691065;1654.3134599141463;1671.9164041797862;1686.3591835102582;921.5162039929091;981.0581841432305;984.2962281968427;1017.3895662602528;1057.1859668055554;15008.774868376982;16337.509874703777;16392.67214655724;16597.668046639;16743.413980510868;908.8318661047728;923.5290002098978;924.2605915267759;933.5472295936465;955.3264948211494;9593.760155996157;9682.612695492102;9719.514024298756;9794.804103917882;9836.409815411098;491962;495950;513893;530074;531010;48756;59368.70315648394;60570;61089;61499.38500615026;998.5257002923698;1023.9897601024044;1091.9781604367868;1095.808233559124;1136.6646839182295;13589.592312230649;14248.501302454779;14297;14722.852771472577;14858.479953201586;23208.4197895054;29105.12684619465;29535;29687.703122969357;29851.402971940875;33757.15607109842;33875.322493550484;34131.317373652884;34250.657493425744;34952;6843.349881761224;7094.574325540484;7165.677544510405;7242.529235599669;7744.070711514654;10439;11171;11193.104551635686;11301.886981130412;11558.826617600575;9027.277817774431;9199.034101419255;9203.309751768778;9512.95243523778;9554.426734395958;9728.367656102331;9757.21942244633;10044.54799534008;10094.495275236355;10378.325408848401;9374.765630859283;9552.188064014359;9781;9793.216542676426;9838.704838854846;7710.961445192738;7712.190220026816;7764.534127952341;7771.533707977539;7792.493487923267;9040.276777857624;9585.664501742405;9646.565904534453;9669.661561845302;9695.854562181432 07:49:43 INFO - PROCESS | 14174 | |3;mootools.html;1307.1634154141357;1443.7689969604862;1469.4122351059575;1605.8795590330728;1760.0407777761127;6726.596404215745;7537.811554711128;7656.3109320161175;7665.8850117248285;7687.538747675129;7527.5859827709455;7727.497712648674;7739.110002349731;7747.845043099149;7755.418343624223;1997.1312479071578;2032.4106009257298;2032.5121970727066;2312.456572705417;2341.94145146371;2015.556577552936;2297.7357603875516;2348.5420343033115;2352.494213744045;2357.5874222011166;2280.304507125326;2328.662343960125;2342.496363281894;2347.307544274443;2350.5063936573256;2265.2637892684943;2294.6328587426015;2300.3444018454743;2303.0557471436714;2306.757790432014;2314.525522267931;2324.4305145239355;2342.543204075206;2344.0858065354355;2344.800691941187;7938.325242354407;7998.160193179749;8002.119766825645;8002.239787220205;8014.799630009296;4828.686135401188;4952.8761780955765;4979.128652485801;4981.501849815026;4988.850334489971;2985.0746268656785;2994.2364697002126;3035.4536183487185;3044.071558174756;3124.718775310233;905.0994260710569;907.1246247371319;929.2983797233113;932.4917919733762;942.6559305853383;10255.641052563124;10369.79260414795;10382.688519344432;10385.84421233682;10411.11505522024;4192.3711443283755;4260.318349064135;4307.246231909403;4328.675349348749;4333.155034768253;8636.78408039804;8643.049264580892;8650.567471626393;8672.176143266379;8677.522736249566;4805.37530121082;4809.0862736080035;4838.69355274074;4843.200871856105;4845.41854977405;4403.625691816167;4460.174867649495;4465.732056076646;4468.195724769573;4471.128130014616;3291.4075466416275;3347.933041339208;3471.496632988253;3554.182538016271;3562.946555801665;1085.1535802074395;1130.8699499557492;1133.9716507087223;1135.5628083188033;1153.5731779241735;1261.1802328486374;1269.6571925580226;1280.9679758005939;1290.5031562848371;1290.7547565962436;7080.114985626797;7099.57402555838;7447.292507211806;7599.278068583586;7621.885671714928;1079.3577821196375;1081.9513121909376;1087.472575800736;1090.378484263962;1098.4068602954476;5437.918431223535;5445.945540544623;5454.127339625641;5498.477644623755;5505.284313039279;9299.256059515223;9311.813763724824;9548.952255238679;9660.468674222844;9670.661526846527;9533;9595.568199431042;9705.641210230573;9721.805563888682;9724.076212759777;7052.506324557232;7259.491835571459;7328.377087947584;7341.339279464767;7425.777226683208;7331.74338898136;7417.8145546361775;7443.81390465221;7448.664810083667;7449.515781474187;8285.751427457186;8570.057293697564;8637.395382323177;8755.737327880173;8865.423747456394;8883.156100170474;8960.238379737795;9022.14289642483;9146.63413463454;9152.17630413266;7029.29707029293;7177.210506844139;7182.96408517954;7192.784216473514;7194.2086370498155;6168.414000669929;6263.530235232284;7213.6032518212005;7372.410207183305;7628.237176282328;6962.895556566757;7176.7488137914925;7186.24544422849;7192.244814294424;7372.299631534996;6892.517523773287;7034.366906978396;7043.823904402431;7072.646367681493;7284.817879553054;6966.338197871194;7015;7017.614031228127;7023.613701246481;7026.613536255555;6062.211912451353;6142.938570614416;6148.631082134907;6157.199564056644;6221.9377806221355;6327;6329.620222786648;6330.430261276507;6330.746770129327;6332.873342533216 07:49:43 INFO - PROCESS | 14174 | |4;prototype.html;334.70044310342246;335.57549699629965;337.7365654789264;339.2113336492655;348.9598696149942;5752.367239603651;5883.85290367741;5888.5877988540815;5908.379620139877;5951.1965884605515;5660.915086273699;5807.1579620954935;5857.3849745776715;5876.412358764122;5893.351731309553;4577.793999270024;4585.587297143248;4586.3579098926175;4587.72473651582;4591;4385.583369579901;4477.216487114758;4495.1459222747735;4542.886427839314;4580.473245576752;4534.841280555182;4554.043650833329;4565.520620334867;4566.292224705176;4567.08658268346;4551.817927282905;4559.110973360196;4561.361409402686;4561.452625684906;4564.726116433025;4022.517297924268;4027.677785777131;4028.4762980812307;4029.5164580250266;4034.213328400963;5529.253550770634;5639.548836093103;5661.377248502703;5678.6024978251535;5717.142428635696;5234.973825130888;5245.318108645852;5250.894982100336;5251.133562962106;5252.579793616502;5921.911171332434;6262.561620686553;6268.87462250757;6270.372962703693;6270.749170033193;4227.534971153171;4234.830606775725;4288.399624052635;4308.38435586655;4379.824807007716;6416.518761092937;6474.643894585796;6475.222973243241;6487.664440801355;6503.642299673516;4413.7793110344355;4444.177827101997;4453.153900758845;4458.264386376211;4460.1525710114975;4373.75944323059;4483.30508771141;4501.459824821042;4501.77491125449;4558.703684260512;5221.895562088813;5234.659747116425;5243.187305967581;5246.344206974129;5251.343582052244;6282.371762823681;6292;6295.276043254993;6302.086197501337;6309.242890853127;1572.2374648295568;1598.3127255280108;1601.719699052661;1602.439146298786;1602.9519114426587;1064.4677661169414;1067.5249513966367;1073.350622873166;1075.2526993739432;1096.8025755363951;5872.677002764889;5875.148103524965;5878.559108066912;5878.882422351529;5879.412058794086;6423.389777971085;6445.291017988017;6447.161868957006;6452.806415807533;6458.257300410513;5863.67749773758;5864.296284445893;5869;5869.911951320648;5871.471567558855;3397.8980630581123;3469.705075068597;3493.5633045869267;3512.701420379245;3520.0495866116007;6746.628935408501;6758.628275444898;6763.898541521881;6777.085093512412;6780.423663988616;6711.362420570038;6722.361375669304;6722.394984451423;6723.193216813916;6724.260331363546;6563.606183628997;6748.628825414649;6748.83127921796;6759.256481787;6776.05135281061;6232.844178895564;6399.456046235936;6519.7392104315295;6520.771772987922;6524.804255872332;6276.435120839146;6413.615183089029;6419.2938776735455;6422.068800023877;6432.35676432353;6718.563293385914;6729.091572637827;6731.461483081243;6736.93263067363;6740.494462915399;4337.891552711208;4458.375827384234;4494.101179763995;4499.392582001519;4500;6419.614823110628;6443.871122577616;6449.6130232186215;6451.161349024596;6454.354564543508;6208.875822483616;6232.25212974446;6261.749530018748;6270.811875643738;6278.340774218824;6092.329843717099;6262.342454042442;6267.435930766253;6268.498520118471;6276.246850377984;6161.6919154041225;6207.596506227081;6207.844803879939;6211.0372892201785;6211.16149319836;6331.3352098029045;6343.936560634519;6345.809625711236;6348.587341822951;6352.237731472068;6101.542384321282;6191.628502289877;6207.534434917489;6209.161763161916;6210.285817131088 07:49:43 INFO - PROCESS | 14174 | |5;yui.html;733.4719002318332;757.6969212315073;829.8008477965286;835.5822088955522;840.7603832907619;12525.812112818303;12679.809802852964;12685.682857928556;12690.619281421548;12734.172278801894;12328.4452199651;12361;12377.814332785016;12413.503459861617;12445.875541244584;663.6018388966629;673.0678010954814;803.8834369016489;812.2405550810012;813.585071613477;809.0372456776447;811.4319976016783;812.0742353716768;815.4862436664893;816.0411516468156;709.8509313044267;863.4171933944593;863.87905693203;865.6191275838611;871.8299931513358;709.5529816215777;711.2709472790406;847.8177191903709;860.1742327365737;864.775158458799;639.0892977507034;639.0924886660906;639.3191251317332;639.9840003999891;640.3948268885858;13062;13081.28052957087;13135.146215495963;13155.07914445989;13198.868011319955;12464.750704985849;12964.611061668165;13187.802182967263;13254.40355184019;13279.800802987866;10511.21165912552;10568.260221784478;10664;10673.733156671067;10850.29473084247;3612.096975756061;3662.066173125836;3704;3732.141607430306;3774.5281839770028;46113.76943115263;48063.279050813915;48067;48133.51866481325;48236.517634823904;9966.103050725469;10133.746656333504;10135.64525241613;10457;10475.486622257355;17388.913055434896;18114.547136321697;18197.7270340945;18233.544161395806;18236.36172733948;7422.369098626569;7455.440841936768;7570.470067095251;7659.195784442553;7790.766277011699;4121.278776214151;4122.216778812016;4160.251154792167;4192.203481338536;4223.603718121845;3195.6005499312587;3202.343519578481;3226.467632840602;3230.9192270193435;3244.1078703356766;573.3734131617535;587.6797145555682;601.506764453153;602.036741214054;606.0606060606043;514.9588032957355;522.6002108387087;571.5256337240164;615.7136931326954;663.7842701122155;8207.917920820715;8298.377621678399;8344.290735287446;8362.749117526484;8468.364872634576;455.54218010898836;498.01890276155916;616.4636766013507;619.1424876546016;627.2285089340046;3859.4403811447182;3870.7871067091583;4013.337799263147;4053.7365071270274;4150.335946248586;55848.44151558514;57012;59079.70460147672;59083;59183.70408148018;50137.74931125321;50744;50917.236241456405;52025.219621705706;52027.73986130045;45390.319145212845;45420.54579454229;45500;45507.31739023917;45537.54462455399;7941.920580794118;7960.402969777174;8119.188081191834;8180.386471014579;8248.752537423887;33292.50061249132;33382.332353352314;34208.657913420546;34393;34421.139471513416;42498;44058.55941440545;44066.33900491431;44263;44313.11373772442;10439.686809395731;10576.153907687212;10576.259661823598;10806.783864322511;10928.125749940145;10999.725006874573;11038.44807759625;11077.501512432122;11534.826977595176;11878;10401.219908507044;10642.201834862262;10673.57305707763;10747.193960452842;10883.564657413615;11342.262752921033;11415.885841141815;11468;11733.237339572901;11780.882191177978;6850.486213533905;10538.485304523803;11069;11168.720781980515;11448.174076068542;8493;8661.220490155916;8709.390342675952;8754.51850148248;8936.50849203274;9682.806343873224;9809.607615695577;9892.15916647093;9904.554295056596;9905.554250058909 07:49:43 INFO - PROCESS | 14174 | __end_tp_report 07:49:43 INFO - PROCESS | 14174 | __start_cc_report 07:49:43 INFO - PROCESS | 14174 | _x_x_mozilla_cycle_collect,686 07:49:43 INFO - PROCESS | 14174 | __end_cc_report 07:49:43 INFO - PROCESS | 14174 | __startTimestamp1452786583286__endTimestamp 07:49:43 INFO - PROCESS | 14174 | 07:49:43 INFO - PROCESS | 14174 | ------- Summary: start ------- 07:49:43 INFO - PROCESS | 14174 | Number of tests: 6 07:49:43 INFO - PROCESS | 14174 | 07:49:43 INFO - PROCESS | 14174 | [#0] dojo.html Cycles:165 Average:5090.85 Median:5293.99 stddev:533.77 (10.1%) stddev-sans-first:513.02 07:49:43 INFO - PROCESS | 14174 | Values: 3140.7 3149.5 3199.5 3201.9 3224.7 4935.0 5021.3 5086.8 5095.9 5152.0 5058.8 5088.7 5118.8 5180.7 5245.6 4627.9 4661.6 4683.4 4733.1 4734.0 4816.9 4835.3 4845.0 4857.4 4859.0 4609.8 4672.2 4678.3 4736.2 4781.9 4662.5 4672.2 4687.4 4690.5 4694.0 4635.7 4640.3 4641.7 4645.0 4694.2 4822.0 4904.5 4974.1 4980.4 5065.6 5399.0 5410.5 5411.8 5414.2 5416.9 5434.0 5435.6 5442.5 5447.0 5488.3 5027.8 5101.1 5109.8 5144.4 5170.5 5663.6 5666.9 5669.9 5680.8 5714.4 5230.2 5477.6 5487.9 5491.5 5493.7 5417.6 5468.4 5487.7 5511.0 5547.2 5436.7 5438.5 5439.6 5441.8 5444.8 5264.2 5339.0 5420.3 5441.9 5475.3 4219.3 4295.7 4339.5 4348.5 4351.8 3837.2 3846.1 3862.3 3871.7 3889.1 4888.0 4971.3 5042.6 5052.8 5105.9 5490.8 5490.8 5511.2 5512.8 5561.2 5008.0 5030.9 5031.3 5031.6 5074.5 4569.6 4636.4 4682.0 4698.9 4749.9 5666.4 5686.0 5692.8 5692.9 5709.2 5492.5 5495.3 5507.8 5513.8 5521.1 5464.6 5514.1 5601.4 5620.4 5673.1 5365.4 5380.6 5383.1 5385.7 5400.5 5426.2 5439.5 5439.9 5467.5 5485.1 5194.1 5211.3 5402.8 5433.7 5459.8 5363.8 5375.5 5375.5 5377.2 5395.7 5135.6 5279.6 5294.0 5298.4 5339.7 5253.1 5367.3 5402.6 5465.5 5467.1 5310.6 5324.5 5327.1 5328.8 5335.2 07:49:43 INFO - PROCESS | 14174 | 07:49:43 INFO - PROCESS | 14174 | [#1] ext.html Cycles:180 Average:43863.69 Median:33422.83 stddev:72585.18 (217.2%) stddev-sans-first:72715.77 07:49:43 INFO - PROCESS | 14174 | Values: 498.8 531.9 541.5 545.6 558.4 28244.3 28515.0 28582.4 28627.6 28808.4 35095.6 35528.3 35806.1 35816.8 35832.5 8428.8 8603.6 8605.7 8607.9 8615.8 7420.3 7613.5 8318.7 8451.6 9828.5 9864.9 9905.1 9929.2 9946.2 9948.9 9706.7 9756.5 9757.8 9759.2 9764.1 9677.1 9811.2 9823.4 9823.7 9827.9 35844.5 35851.1 35962.5 36185.8 38706.4 3322.4 3355.6 3396.3 3421.1 3506.0 29243.0 29476.0 29766.7 30113.0 30871.4 3138.3 3187.8 3259.0 3269.5 3296.9 268371.0 268410.0 268841.0 269069.0 269167.0 50041.7 50882.7 55881.9 56238.4 56253.7 60502.4 61522.4 61667.7 61718.4 61749.4 14260.3 14280.6 14389.1 14454.2 14516.9 12105.3 12193.1 12204.1 12220.2 12228.2 18641.7 18776.4 18782.9 18826.6 18917.6 7564.5 7902.8 7913.6 7926.3 7955.3 988.2 1021.7 1057.0 1083.2 1104.7 26574.3 27113.3 28036.0 28310.4 28310.7 1075.9 1123.2 1126.5 1150.2 1179.6 14643.9 14689.4 14724.4 14835.3 14984.0 316655.0 319503.2 324099.0 324385.0 326508.0 50775.7 51044.7 51066.5 51086.0 51128.2 1331.7 1347.1 1348.1 1360.4 1368.4 26684.5 27210.2 27471.9 27653.6 27827.6 41626.0 42760.1 45166.8 45743.3 46659.8 234226.0 234365.0 235037.0 236935.0 237222.0 27291.2 29332.7 29577.3 29611.9 29642.1 30885.0 33547.2 36828.3 39294.4 40162.6 33157.7 35997.3 36041.0 36586.0 36876.3 36174.6 36816.6 36847.0 36856.6 37031.6 35459.0 35928.0 36031.3 36066.8 36228.6 31177.7 32899.0 32915.5 33327.0 33518.7 24340.8 24490.0 24791.4 24889.4 25237.7 07:49:43 INFO - PROCESS | 14174 | 07:49:43 INFO - PROCESS | 14174 | [#2] jquery.html Cycles:180 Average:25818.42 Median:28498.26 stddev:83517.08 (293.1%) stddev-sans-first:83729.49 07:49:43 INFO - PROCESS | 14174 | Values: 358.4 363.9 366.6 367.5 369.2 13381.8 13533.3 15644.5 16891.2 17941.4 15465.5 15654.0 15724.9 15851.8 16609.9 5231.6 5388.3 5391.5 5392.4 5392.7 3933.1 4122.2 5289.1 5377.7 5637.4 5701.9 5774.8 5817.3 5832.5 5837.2 5753.4 5875.4 5906.5 5909.6 5911.4 5042.7 5201.0 5201.2 5225.3 5228.3 14821.6 14964.6 15630.5 19361.7 19745.6 2084.5 2126.1 2188.4 2263.1 2401.6 12507.8 12591.9 12845.0 13004.4 13139.3 1785.3 1855.5 1861.7 1865.3 1865.5 50100.7 51265.0 51592.5 51766.0 51795.5 9433.3 9518.1 9616.7 9629.8 9692.7 12537.9 12544.3 12548.4 12555.1 12565.8 7380.0 7405.9 7445.8 7499.4 7511.5 7203.7 7227.3 7257.1 7287.1 7305.5 5809.3 5958.3 5965.2 5974.1 6005.3 1598.1 1613.2 1654.3 1671.9 1686.4 921.5 981.1 984.3 1017.4 1057.2 15008.8 16337.5 16392.7 16597.7 16743.4 908.8 923.5 924.3 933.5 955.3 9593.8 9682.6 9719.5 9794.8 9836.4 491962.0 495950.0 513893.0 530074.0 531010.0 48756.0 59368.7 60570.0 61089.0 61499.4 998.5 1024.0 1092.0 1095.8 1136.7 13589.6 14248.5 14297.0 14722.9 14858.5 23208.4 29105.1 29535.0 29687.7 29851.4 33757.2 33875.3 34131.3 34250.7 34952.0 6843.3 7094.6 7165.7 7242.5 7744.1 10439.0 11171.0 11193.1 11301.9 11558.8 9027.3 9199.0 9203.3 9513.0 9554.4 9728.4 9757.2 10044.5 10094.5 10378.3 9374.8 9552.2 9781.0 9793.2 9838.7 7711.0 7712.2 7764.5 7771.5 7792.5 9040.3 9585.7 9646.6 9669.7 9695.9 07:49:43 INFO - PROCESS | 14174 | 07:49:43 INFO - PROCESS | 14174 | [#3] mootools.html Cycles:180 Average:5461.95 Median:6242.73 stddev:2832.99 (45.4%) stddev-sans-first:2823.73 07:49:43 INFO - PROCESS | 14174 | Values: 1307.2 1443.8 1469.4 1605.9 1760.0 6726.6 7537.8 7656.3 7665.9 7687.5 7527.6 7727.5 7739.1 7747.8 7755.4 1997.1 2032.4 2032.5 2312.5 2341.9 2015.6 2297.7 2348.5 2352.5 2357.6 2280.3 2328.7 2342.5 2347.3 2350.5 2265.3 2294.6 2300.3 2303.1 2306.8 2314.5 2324.4 2342.5 2344.1 2344.8 7938.3 7998.2 8002.1 8002.2 8014.8 4828.7 4952.9 4979.1 4981.5 4988.9 2985.1 2994.2 3035.5 3044.1 3124.7 905.1 907.1 929.3 932.5 942.7 10255.6 10369.8 10382.7 10385.8 10411.1 4192.4 4260.3 4307.2 4328.7 4333.2 8636.8 8643.0 8650.6 8672.2 8677.5 4805.4 4809.1 4838.7 4843.2 4845.4 4403.6 4460.2 4465.7 4468.2 4471.1 3291.4 3347.9 3471.5 3554.2 3562.9 1085.2 1130.9 1134.0 1135.6 1153.6 1261.2 1269.7 1281.0 1290.5 1290.8 7080.1 7099.6 7447.3 7599.3 7621.9 1079.4 1082.0 1087.5 1090.4 1098.4 5437.9 5445.9 5454.1 5498.5 5505.3 9299.3 9311.8 9549.0 9660.5 9670.7 9533.0 9595.6 9705.6 9721.8 9724.1 7052.5 7259.5 7328.4 7341.3 7425.8 7331.7 7417.8 7443.8 7448.7 7449.5 8285.8 8570.1 8637.4 8755.7 8865.4 8883.2 8960.2 9022.1 9146.6 9152.2 7029.3 7177.2 7183.0 7192.8 7194.2 6168.4 6263.5 7213.6 7372.4 7628.2 6962.9 7176.7 7186.2 7192.2 7372.3 6892.5 7034.4 7043.8 7072.6 7284.8 6966.3 7015.0 7017.6 7023.6 7026.6 6062.2 6142.9 6148.6 6157.2 6221.9 6327.0 6329.6 6330.4 6330.7 6332.9 07:49:43 INFO - PROCESS | 14174 | 07:49:43 INFO - PROCESS | 14174 | [#4] prototype.html Cycles:180 Average:5244.47 Median:5875.78 stddev:1575.16 (26.8%) stddev-sans-first:1535.86 07:49:43 INFO - PROCESS | 14174 | Values: 334.7 335.6 337.7 339.2 349.0 5752.4 5883.9 5888.6 5908.4 5951.2 5660.9 5807.2 5857.4 5876.4 5893.4 4577.8 4585.6 4586.4 4587.7 4591.0 4385.6 4477.2 4495.1 4542.9 4580.5 4534.8 4554.0 4565.5 4566.3 4567.1 4551.8 4559.1 4561.4 4561.5 4564.7 4022.5 4027.7 4028.5 4029.5 4034.2 5529.3 5639.5 5661.4 5678.6 5717.1 5235.0 5245.3 5250.9 5251.1 5252.6 5921.9 6262.6 6268.9 6270.4 6270.7 4227.5 4234.8 4288.4 4308.4 4379.8 6416.5 6474.6 6475.2 6487.7 6503.6 4413.8 4444.2 4453.2 4458.3 4460.2 4373.8 4483.3 4501.5 4501.8 4558.7 5221.9 5234.7 5243.2 5246.3 5251.3 6282.4 6292.0 6295.3 6302.1 6309.2 1572.2 1598.3 1601.7 1602.4 1603.0 1064.5 1067.5 1073.4 1075.3 1096.8 5872.7 5875.1 5878.6 5878.9 5879.4 6423.4 6445.3 6447.2 6452.8 6458.3 5863.7 5864.3 5869.0 5869.9 5871.5 3397.9 3469.7 3493.6 3512.7 3520.0 6746.6 6758.6 6763.9 6777.1 6780.4 6711.4 6722.4 6722.4 6723.2 6724.3 6563.6 6748.6 6748.8 6759.3 6776.1 6232.8 6399.5 6519.7 6520.8 6524.8 6276.4 6413.6 6419.3 6422.1 6432.4 6718.6 6729.1 6731.5 6736.9 6740.5 4337.9 4458.4 4494.1 4499.4 4500.0 6419.6 6443.9 6449.6 6451.2 6454.4 6208.9 6232.3 6261.7 6270.8 6278.3 6092.3 6262.3 6267.4 6268.5 6276.2 6161.7 6207.6 6207.8 6211.0 6211.2 6331.3 6343.9 6345.8 6348.6 6352.2 6101.5 6191.6 6207.5 6209.2 6210.3 07:49:43 INFO - PROCESS | 14174 | 07:49:43 INFO - PROCESS | 14174 | [#5] yui.html Cycles:180 Average:13575.43 Median:22977.77 stddev:15853.98 (69.0%) stddev-sans-first:15869.12 07:49:43 INFO - PROCESS | 14174 | Values: 733.5 757.7 829.8 835.6 840.8 12525.8 12679.8 12685.7 12690.6 12734.2 12328.4 12361.0 12377.8 12413.5 12445.9 663.6 673.1 803.9 812.2 813.6 809.0 811.4 812.1 815.5 816.0 709.9 863.4 863.9 865.6 871.8 709.6 711.3 847.8 860.2 864.8 639.1 639.1 639.3 640.0 640.4 13062.0 13081.3 13135.1 13155.1 13198.9 12464.8 12964.6 13187.8 13254.4 13279.8 10511.2 10568.3 10664.0 10673.7 10850.3 3612.1 3662.1 3704.0 3732.1 3774.5 46113.8 48063.3 48067.0 48133.5 48236.5 9966.1 10133.7 10135.6 10457.0 10475.5 17388.9 18114.5 18197.7 18233.5 18236.4 7422.4 7455.4 7570.5 7659.2 7790.8 4121.3 4122.2 4160.3 4192.2 4223.6 3195.6 3202.3 3226.5 3230.9 3244.1 573.4 587.7 601.5 602.0 606.1 515.0 522.6 571.5 615.7 663.8 8207.9 8298.4 8344.3 8362.7 8468.4 455.5 498.0 616.5 619.1 627.2 3859.4 3870.8 4013.3 4053.7 4150.3 55848.4 57012.0 59079.7 59083.0 59183.7 50137.7 50744.0 50917.2 52025.2 52027.7 45390.3 45420.5 45500.0 45507.3 45537.5 7941.9 7960.4 8119.2 8180.4 8248.8 33292.5 33382.3 34208.7 34393.0 34421.1 42498.0 44058.6 44066.3 44263.0 44313.1 10439.7 10576.2 10576.3 10806.8 10928.1 10999.7 11038.4 11077.5 11534.8 11878.0 10401.2 10642.2 10673.6 10747.2 10883.6 11342.3 11415.9 11468.0 11733.2 11780.9 6850.5 10538.5 11069.0 11168.7 11448.2 8493.0 8661.2 8709.4 8754.5 8936.5 9682.8 9809.6 9892.2 9904.6 9905.6 07:49:43 INFO - PROCESS | 14174 | -------- Summary: end -------- 07:49:43 INFO - PROCESS | 14174 | 07:49:43 INFO - TEST-INFO | 14174: exit 0 07:49:44 INFO - TEST-OK | dromaeo_css | took 1112464ms 07:49:44 INFO - TEST-START | kraken 07:49:44 INFO - operating with platform_type : linux_ 07:49:44 INFO - Initialising browser for kraken test... 07:49:44 INFO - TEST-INFO | started process 14362 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpREJqsn/profile http://localhost:44144/getInfo.html) 07:49:48 INFO - PROCESS | 14362 | __metrics Screen width/height:1600/1200 07:49:48 INFO - PROCESS | 14362 | colorDepth:24 07:49:48 INFO - PROCESS | 14362 | Browser inner width/height: 1024/697 07:49:48 INFO - PROCESS | 14362 | __metrics 07:49:48 INFO - PROCESS | 14362 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:49:48 INFO - PROCESS | 14362 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:49:49 INFO - TEST-INFO | 14362: exit 0 07:49:49 INFO - Browser initialized. 07:49:49 INFO - Running cycle 1/1 for kraken test... 07:49:49 INFO - TEST-INFO | started process 14442 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpREJqsn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:50:01 INFO - PROCESS | 14442 | RSS: Main: 150417408 07:50:01 INFO - PROCESS | 14442 | 07:50:03 INFO - PROCESS | 14442 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44144/tests/kraken/driver.html?testName=audio-beat-detection) 07:50:04 INFO - PROCESS | 14442 | RSS: Main: 188571648 07:50:04 INFO - PROCESS | 14442 | 07:50:06 INFO - PROCESS | 14442 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44144/tests/kraken/driver.html?testName=audio-dft) 07:50:07 INFO - PROCESS | 14442 | RSS: Main: 177090560 07:50:07 INFO - PROCESS | 14442 | 07:50:10 INFO - PROCESS | 14442 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44144/tests/kraken/driver.html?testName=audio-fft) 07:50:10 INFO - PROCESS | 14442 | RSS: Main: 160686080 07:50:10 INFO - PROCESS | 14442 | 07:50:12 INFO - PROCESS | 14442 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44144/tests/kraken/driver.html?testName=audio-oscillator) 07:50:13 INFO - PROCESS | 14442 | RSS: Main: 164212736 07:50:13 INFO - PROCESS | 14442 | 07:50:15 INFO - PROCESS | 14442 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44144/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:50:16 INFO - PROCESS | 14442 | RSS: Main: 166363136 07:50:16 INFO - PROCESS | 14442 | 07:50:19 INFO - PROCESS | 14442 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44144/tests/kraken/driver.html?testName=imaging-darkroom) 07:50:19 INFO - PROCESS | 14442 | RSS: Main: 165658624 07:50:19 INFO - PROCESS | 14442 | 07:50:23 INFO - PROCESS | 14442 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44144/tests/kraken/driver.html?testName=imaging-desaturate) 07:50:23 INFO - PROCESS | 14442 | RSS: Main: 166793216 07:50:23 INFO - PROCESS | 14442 | 07:50:26 INFO - PROCESS | 14442 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44144/tests/kraken/driver.html?testName=json-parse-financial) 07:50:26 INFO - PROCESS | 14442 | RSS: Main: 167292928 07:50:26 INFO - PROCESS | 14442 | 07:50:28 INFO - PROCESS | 14442 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44144/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:50:29 INFO - PROCESS | 14442 | RSS: Main: 177315840 07:50:29 INFO - PROCESS | 14442 | 07:50:30 INFO - PROCESS | 14442 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44144/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:50:31 INFO - PROCESS | 14442 | RSS: Main: 176128000 07:50:31 INFO - PROCESS | 14442 | 07:50:33 INFO - PROCESS | 14442 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44144/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:50:34 INFO - PROCESS | 14442 | RSS: Main: 187056128 07:50:34 INFO - PROCESS | 14442 | 07:50:36 INFO - PROCESS | 14442 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:50:37 INFO - PROCESS | 14442 | RSS: Main: 192851968 07:50:37 INFO - PROCESS | 14442 | 07:50:39 INFO - PROCESS | 14442 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:50:40 INFO - PROCESS | 14442 | RSS: Main: 192282624 07:50:40 INFO - PROCESS | 14442 | 07:50:41 INFO - PROCESS | 14442 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44144/tests/kraken/driver.html?testName=ai-astar) 07:50:42 INFO - PROCESS | 14442 | RSS: Main: 251465728 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - PROCESS | 14442 | __start_tp_report 07:50:42 INFO - PROCESS | 14442 | _x_x_mozilla_page_load 07:50:42 INFO - PROCESS | 14442 | _x_x_mozilla_page_load_details 07:50:42 INFO - PROCESS | 14442 | |i|pagename|runs| 07:50:42 INFO - PROCESS | 14442 | |0;ai-astar;109;111;107;111;111;111;101;110;110;110 07:50:42 INFO - PROCESS | 14442 | |1;audio-beat-detection;164;123;153;161;127;151;149;124;159;126 07:50:42 INFO - PROCESS | 14442 | |2;audio-dft;160;160;161;161;160;161;159;163;161;162 07:50:42 INFO - PROCESS | 14442 | |3;audio-fft;73;71;96;101;74;75;75;119;89;70 07:50:42 INFO - PROCESS | 14442 | |4;audio-oscillator;96;96;144;96;95;97;139;95;95;137 07:50:42 INFO - PROCESS | 14442 | |5;imaging-gaussian-blur;110;109;109;109;109;109;110;109;109;110 07:50:42 INFO - PROCESS | 14442 | |6;imaging-darkroom;146;146;145;145;145;147;146;145;145;146 07:50:42 INFO - PROCESS | 14442 | |7;imaging-desaturate;95;95;96;96;96;96;97;96;96;95 07:50:42 INFO - PROCESS | 14442 | |8;json-parse-financial;56;55;58;56;55;55;56;63;53;54 07:50:42 INFO - PROCESS | 14442 | |9;json-stringify-tinderbox;68;68;67;68;73;68;67;67;68;67 07:50:42 INFO - PROCESS | 14442 | |10;stanford-crypto-aes;83;82;82;83;81;82;84;85;82;82 07:50:42 INFO - PROCESS | 14442 | |11;stanford-crypto-ccm;123;113;118;112;119;119;122;117;117;113 07:50:42 INFO - PROCESS | 14442 | |12;stanford-crypto-pbkdf2;145;144;142;143;142;135;143;142;154;135 07:50:42 INFO - PROCESS | 14442 | |13;stanford-crypto-sha256-iterative;67;67;68;66;68;66;68;69;67;71 07:50:42 INFO - PROCESS | 14442 | __end_tp_report 07:50:42 INFO - PROCESS | 14442 | __start_cc_report 07:50:42 INFO - PROCESS | 14442 | _x_x_mozilla_cycle_collect,942 07:50:42 INFO - PROCESS | 14442 | __end_cc_report 07:50:42 INFO - PROCESS | 14442 | __startTimestamp1452786642006__endTimestamp 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - PROCESS | 14442 | ------- Summary: start ------- 07:50:42 INFO - PROCESS | 14442 | Number of tests: 14 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - PROCESS | 14442 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:3.11 (2.8%) stddev-sans-first:3.30 07:50:42 INFO - PROCESS | 14442 | Values: 109.0 111.0 107.0 111.0 111.0 111.0 101.0 110.0 110.0 110.0 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - PROCESS | 14442 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:152.00 stddev:16.74 (11.0%) stddev-sans-first:16.06 07:50:42 INFO - PROCESS | 14442 | Values: 164.0 123.0 153.0 161.0 127.0 151.0 149.0 124.0 159.0 126.0 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - PROCESS | 14442 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.17 07:50:42 INFO - PROCESS | 14442 | Values: 160.0 160.0 161.0 161.0 160.0 161.0 159.0 163.0 161.0 162.0 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - PROCESS | 14442 | [#3] audio-fft Cycles:10 Average:84.30 Median:74.50 stddev:16.43 (22.1%) stddev-sans-first:16.91 07:50:42 INFO - PROCESS | 14442 | Values: 73.0 71.0 96.0 101.0 74.0 75.0 75.0 119.0 89.0 70.0 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - PROCESS | 14442 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:95.50 stddev:21.47 (22.5%) stddev-sans-first:22.25 07:50:42 INFO - PROCESS | 14442 | Values: 96.0 96.0 144.0 96.0 95.0 97.0 139.0 95.0 95.0 137.0 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - PROCESS | 14442 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 07:50:42 INFO - PROCESS | 14442 | Values: 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 110.0 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - PROCESS | 14442 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 07:50:42 INFO - PROCESS | 14442 | Values: 146.0 146.0 145.0 145.0 145.0 147.0 146.0 145.0 145.0 146.0 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - PROCESS | 14442 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 07:50:42 INFO - PROCESS | 14442 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 95.0 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - PROCESS | 14442 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:2.77 (4.9%) stddev-sans-first:2.93 07:50:42 INFO - PROCESS | 14442 | Values: 56.0 55.0 58.0 56.0 55.0 55.0 56.0 63.0 53.0 54.0 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - PROCESS | 14442 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:1.79 (2.6%) stddev-sans-first:1.90 07:50:42 INFO - PROCESS | 14442 | Values: 68.0 68.0 67.0 68.0 73.0 68.0 67.0 67.0 68.0 67.0 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - PROCESS | 14442 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.50 stddev:1.17 (1.4%) stddev-sans-first:1.24 07:50:42 INFO - PROCESS | 14442 | Values: 83.0 82.0 82.0 83.0 81.0 82.0 84.0 85.0 82.0 82.0 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - PROCESS | 14442 | [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:118.50 stddev:3.74 (3.2%) stddev-sans-first:3.35 07:50:42 INFO - PROCESS | 14442 | Values: 123.0 113.0 118.0 112.0 119.0 119.0 122.0 117.0 117.0 113.0 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - PROCESS | 14442 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.50 Median:143.00 stddev:5.32 (3.7%) stddev-sans-first:5.56 07:50:42 INFO - PROCESS | 14442 | Values: 145.0 144.0 142.0 143.0 142.0 135.0 143.0 142.0 154.0 135.0 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - PROCESS | 14442 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.49 (2.2%) stddev-sans-first:1.56 07:50:42 INFO - PROCESS | 14442 | Values: 67.0 67.0 68.0 66.0 68.0 66.0 68.0 69.0 67.0 71.0 07:50:42 INFO - PROCESS | 14442 | -------- Summary: end -------- 07:50:42 INFO - PROCESS | 14442 | 07:50:42 INFO - TEST-INFO | 14442: exit 0 07:50:42 INFO - TEST-OK | kraken | took 58922ms 07:50:42 INFO - TEST-START | v8_7 07:50:42 INFO - operating with platform_type : linux_ 07:50:42 INFO - Initialising browser for v8_7 test... 07:50:42 INFO - TEST-INFO | started process 14690 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpj1Ot3u/profile http://localhost:44144/getInfo.html) 07:50:47 INFO - PROCESS | 14690 | __metrics Screen width/height:1600/1200 07:50:47 INFO - PROCESS | 14690 | colorDepth:24 07:50:47 INFO - PROCESS | 14690 | Browser inner width/height: 1024/697 07:50:47 INFO - PROCESS | 14690 | __metrics 07:50:47 INFO - PROCESS | 14690 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:50:47 INFO - PROCESS | 14690 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:50:48 INFO - TEST-INFO | 14690: exit 0 07:50:48 INFO - Browser initialized. 07:50:48 INFO - Running cycle 1/1 for v8_7 test... 07:50:48 INFO - TEST-INFO | started process 14773 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpj1Ot3u/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:51:00 INFO - PROCESS | 14773 | RSS: Main: 150794240 07:51:00 INFO - PROCESS | 14773 | 07:51:22 INFO - PROCESS | 14773 | Cycle 1(1): loaded http://localhost:44144/tests/v8_7/run.html (next: http://localhost:44144/tests/v8_7/run.html) 07:51:22 INFO - PROCESS | 14773 | RSS: Main: 590852096 07:51:22 INFO - PROCESS | 14773 | 07:51:22 INFO - PROCESS | 14773 | __start_tp_report 07:51:22 INFO - PROCESS | 14773 | _x_x_mozilla_page_load 07:51:22 INFO - PROCESS | 14773 | _x_x_mozilla_page_load_details 07:51:22 INFO - PROCESS | 14773 | |i|pagename|runs| 07:51:22 INFO - PROCESS | 14773 | |0;Richards;167.98252981689905 07:51:22 INFO - PROCESS | 14773 | |1;DeltaBlue;190.11406844106463 07:51:22 INFO - PROCESS | 14773 | |2;Encrypt;279.6420581655481 07:51:22 INFO - PROCESS | 14773 | |3;Decrypt;5251.308900523561 07:51:22 INFO - PROCESS | 14773 | |4;RayTrace;1976.2845849802372 07:51:22 INFO - PROCESS | 14773 | |5;Earley;788.6435331230284 07:51:22 INFO - PROCESS | 14773 | |6;Boyer;12329.268292682927 07:51:22 INFO - PROCESS | 14773 | |7;RegExp;42854.166666666664 07:51:22 INFO - PROCESS | 14773 | |8;Splay;654.0222367560497 07:51:22 INFO - PROCESS | 14773 | |9;NavierStokes;4826.923076923077 07:51:22 INFO - PROCESS | 14773 | __end_tp_report 07:51:22 INFO - PROCESS | 14773 | __startTimestamp1452786682723__endTimestamp 07:51:22 INFO - PROCESS | 14773 | 07:51:22 INFO - PROCESS | 14773 | ------- Summary: start ------- 07:51:22 INFO - PROCESS | 14773 | Number of tests: 10 07:51:22 INFO - PROCESS | 14773 | 07:51:22 INFO - PROCESS | 14773 | [#0] Richards Cycles:1 Average:167.98 Median:167.98 stddev:0.00 (0.0%) 07:51:22 INFO - PROCESS | 14773 | Values: 168.0 07:51:22 INFO - PROCESS | 14773 | 07:51:22 INFO - PROCESS | 14773 | [#1] DeltaBlue Cycles:1 Average:190.11 Median:190.11 stddev:0.00 (0.0%) 07:51:22 INFO - PROCESS | 14773 | Values: 190.1 07:51:22 INFO - PROCESS | 14773 | 07:51:22 INFO - PROCESS | 14773 | [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 07:51:22 INFO - PROCESS | 14773 | Values: 279.6 07:51:22 INFO - PROCESS | 14773 | 07:51:22 INFO - PROCESS | 14773 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 07:51:22 INFO - PROCESS | 14773 | Values: 5251.3 07:51:22 INFO - PROCESS | 14773 | 07:51:22 INFO - PROCESS | 14773 | [#4] RayTrace Cycles:1 Average:1976.28 Median:1976.28 stddev:0.00 (0.0%) 07:51:22 INFO - PROCESS | 14773 | Values: 1976.3 07:51:22 INFO - PROCESS | 14773 | 07:51:22 INFO - PROCESS | 14773 | [#5] Earley Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 07:51:22 INFO - PROCESS | 14773 | Values: 788.6 07:51:22 INFO - PROCESS | 14773 | 07:51:22 INFO - PROCESS | 14773 | [#6] Boyer Cycles:1 Average:12329.27 Median:12329.27 stddev:0.00 (0.0%) 07:51:22 INFO - PROCESS | 14773 | Values: 12329.3 07:51:22 INFO - PROCESS | 14773 | 07:51:22 INFO - PROCESS | 14773 | [#7] RegExp Cycles:1 Average:42854.17 Median:42854.17 stddev:0.00 (0.0%) 07:51:22 INFO - PROCESS | 14773 | Values: 42854.2 07:51:22 INFO - PROCESS | 14773 | 07:51:22 INFO - PROCESS | 14773 | [#8] Splay Cycles:1 Average:654.02 Median:654.02 stddev:0.00 (0.0%) 07:51:22 INFO - PROCESS | 14773 | Values: 654.0 07:51:22 INFO - PROCESS | 14773 | 07:51:22 INFO - PROCESS | 14773 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 07:51:22 INFO - PROCESS | 14773 | Values: 4826.9 07:51:22 INFO - PROCESS | 14773 | -------- Summary: end -------- 07:51:22 INFO - PROCESS | 14773 | 07:51:23 INFO - TEST-INFO | 14773: exit 0 07:51:23 INFO - TEST-OK | v8_7 | took 40676ms 07:51:23 INFO - SUITE-END | took 1212s 07:51:23 INFO - Completed test suite (00:20:12) 07:51:23 INFO - Working with test: dromaeo_css 07:51:23 INFO - Generating results file: dromaeo_css 07:51:23 INFO - Working with test: kraken 07:51:23 INFO - Generating results file: kraken 07:51:23 INFO - javascript benchmark 07:51:23 INFO - Working with test: v8_7 07:51:23 INFO - Generating results file: v8_7 07:51:23 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:51:23 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 07:51:23 INFO - process_Request line: dromaeo_css 6759.21 graph.html#tests=[[72,201,35]] 07:51:23 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:51:23 INFO - process_Request line: kraken 1491.90 graph.html#tests=[[232,201,35]] 07:51:23 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:51:24 INFO - process_Request line: v8_7 18684.35 graph.html#tests=[[230,201,35]] 07:51:24 INFO - RETURN: dromaeo_css: 6759.21 07:51:24 INFO - RETURN: kraken: 1491.90 07:51:24 INFO - RETURN: v8_7: 18684.35 07:51:24 INFO - javascript benchmark 07:51:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3140.7173354398105, 3149.5118256670225, 3199.4880819068953, 3201.887933922313, 3224.6775322467756, 4934.950650493494, 5021.3221215135945, 5086.771095300715, 5095.872603184922, 5152.0, 5058.84823455296, 5088.669236499625, 5118.820841270556, 5180.740962951856, 5245.580353571705, 4627.930581041287, 4661.58045775881, 4683.391159149306, 4733.100710864942, 4733.952660473386, 4816.903661926759, 4835.347228124193, 4845.0, 4857.392825896763, 4858.975705121469, 4609.7695115244105, 4672.15901137795, 4678.251479763221, 4736.218523943545, 4781.880452988686, 4662.487126416091, 4672.15901137795, 4687.390639216914, 4690.530946905282, 4694.037722266927, 4635.652326075524, 4640.280756482751, 4641.698289611199, 4645.0477652081245, 4694.225452800284, 4822.035592881438, 4904.509549045067, 4974.079795237856, 4980.352554167971, 5065.620078494091, 5399.0, 5410.458954104597, 5411.83764487066, 5414.187871819219, 5416.91874621881, 5434.0, 5435.619506634537, 5442.537384322337, 5447.046766815792, 5488.259085023511, 5027.773750181251, 5101.056304583664, 5109.770060347293, 5144.356955380577, 5170.482951704837, 5663.603547751618, 5666.943330566724, 5669.858253543694, 5680.801171958961, 5714.428557144335, 5230.215467679803, 5477.643953143033, 5487.917681234785, 5491.533219676292, 5493.670379777226, 5417.6478528895495, 5468.37113731918, 5487.670739755627, 5511.0080185566985, 5547.223388725582, 5436.728163591804, 5438.483344082306, 5439.646422982493, 5441.83674489766, 5444.8366549003595, 5264.184051472028, 5339.038972984822, 5420.349558053059, 5441.863953401117, 5475.342958844964, 4219.346001369792, 4295.72077814941, 4339.522652508222, 4348.478182618106, 4351.760653164043, 3837.2325534893134, 3846.0577158596325, 3862.2661694278, 3871.7483363581277, 3889.0666240102173, 4887.975560122177, 4971.279164521125, 5042.647014708935, 5052.797888084436, 5105.897882042338, 5490.752916118784, 5490.752916118784, 5511.200875872976, 5512.834614961557, 5561.193626924154, 5008.0, 5030.874228144253, 5031.345925029723, 5031.597472202215, 5074.4671809460215, 4569.611583015481, 4636.350910872413, 4682.0, 4698.929516057262, 4749.857504274877, 5666.405027472056, 5685.971570142123, 5692.800751973744, 5692.946804841201, 5709.200711900337, 5492.505674489315, 5495.258140151188, 5507.779688812403, 5513.807016754395, 5521.061419558604, 5464.617476776588, 5514.117741161395, 5601.411851755507, 5620.437956204347, 5673.092305231308, 5365.436629153883, 5380.623356365017, 5383.138697808332, 5385.73071346439, 5400.459954004568, 5426.213199086189, 5439.537639300704, 5439.891202176013, 5467.480589344006, 5485.149801780731, 5194.091034068947, 5211.322528071327, 5402.810901618424, 5433.673979561239, 5459.781608735606, 5363.812266570651, 5375.462453754593, 5375.489328513785, 5377.166539186433, 5395.70323632204, 5135.589152867837, 5279.577633789211, 5293.994141113176, 5298.4171741107675, 5339.7063161526485, 5253.106971814725, 5367.302250707539, 5402.594805389533, 5465.508104270476, 5467.097928841697, 5310.628256022042, 5324.494173053554, 5327.121025030981, 5328.813491527778, 5335.1730481775385], "unit": "score", "name": "dojo.html", "value": 5058.761963822914}, {"lowerIsBetter": false, "replicates": [498.80795893580984, 531.9202119682047, 541.4720647368816, 545.5526468295994, 558.3774091887545, 28244.293892652695, 28515.0, 28582.428351432958, 28627.570586441194, 28808.42383152338, 35095.649043509555, 35528.2894342113, 35806.104847378825, 35816.82091589538, 35832.46251306226, 8428.831423371528, 8603.612837422299, 8605.698800541983, 8607.870881936777, 8615.784605384884, 7420.295071968181, 7613.467057305991, 8318.66725330986, 8451.619677114544, 9828.459434731087, 9864.852027219598, 9905.059019393182, 9929.156021738161, 9946.204303655726, 9948.900510994907, 9706.66026689066, 9756.463394513334, 9757.804843903154, 9759.170470510015, 9764.121229089416, 9677.080677335642, 9811.166050885684, 9823.36148150375, 9823.656172033945, 9827.852582211273, 35844.46233306477, 35851.103722406886, 35962.460563091576, 36185.81907090474, 38706.41940370897, 3322.4185767490835, 3355.6308806031316, 3396.252824378633, 3421.0763093964492, 3506.0358401439553, 29243.0, 29476.0, 29766.70233297661, 30113.0, 30871.38257234865, 3138.2938838761324, 3187.7609179311644, 3258.983705081483, 3269.476883698597, 3296.8846090386724, 268371.0, 268410.0, 268841.0, 269069.0, 269167.0, 50041.74979125081, 50882.745586271834, 55881.882362352524, 56238.43761562414, 56253.7187314069, 60502.39497605056, 61522.38477615256, 61667.69166154141, 61718.38281617216, 61749.382506175265, 14260.286985650677, 14280.642983925485, 14389.136651800925, 14454.20501872386, 14516.85483145155, 12105.334206618545, 12193.085518586142, 12204.084693647834, 12220.20568663052, 12228.205166664138, 18641.7203741944, 18776.436706898814, 18782.90608546976, 18826.62346753057, 18917.62164756697, 7564.546127232384, 7902.841943161105, 7913.564753938589, 7926.286634202949, 7955.284024437713, 988.1748739802202, 1021.6832781837654, 1056.9788604228027, 1083.1930211992117, 1104.6962085426412, 26574.335641608726, 27113.322166945985, 28036.0, 28310.43379132406, 28310.71689283122, 1075.9193060520493, 1123.2361993844265, 1126.5043380912373, 1150.2006105756586, 1179.6343133628432, 14643.853561464462, 14689.41242350294, 14724.411023559152, 14835.258237088317, 14984.0, 316655.0, 319503.2198712072, 324099.0, 324385.0, 326508.0, 50775.746121269156, 51044.74477627588, 51066.48933510692, 51086.0, 51128.23307650388, 1331.6670832291927, 1347.0570600579438, 1348.1169833758904, 1360.3674291454324, 1368.4115830192914, 26684.466310673288, 27210.1836944892, 27471.862640686668, 27653.58519622167, 27827.582586261626, 41626.0, 42760.14479710326, 45166.77416612896, 45743.313850292936, 46659.76670116628, 234226.0, 234365.0, 235037.0, 236935.0, 237222.0, 27291.181264562096, 29332.706672932996, 29577.26056848596, 29611.851940740158, 29642.11073667707, 30885.0, 33547.161320966195, 36828.26343473169, 39294.41058384069, 40162.598374015884, 33157.67452980566, 35997.280054398245, 36041.0, 36586.0, 36876.26247474982, 36174.570194534645, 36816.63183368132, 36847.0, 36856.63143368532, 37031.62968370282, 35459.0, 35928.0, 36031.27937441289, 36066.8196659015, 36228.63771362358, 31177.68822311748, 32899.0, 32915.50626740553, 33327.0, 33518.66481335253, 24340.75659243385, 24490.0, 24791.380215494755, 24889.377765556004, 25237.74762252354], "unit": "score", "name": "ext.html", "value": 17900.015835536877}, {"lowerIsBetter": false, "replicates": [358.4175714463996, 363.8817384350087, 366.59857456085587, 367.46533793330696, 369.2283128261932, 13381.799273010913, 13533.255670938095, 15644.53066408008, 16891.155442227886, 17941.3720519782, 15465.458708945189, 15653.964984552022, 15724.921375393136, 15851.841481585181, 16609.91695041523, 5231.5814734821215, 5388.299521062276, 5391.487808658171, 5392.352917649868, 5392.73036348183, 3933.1347103637154, 4122.216778812031, 5289.074411977907, 5377.704226267554, 5637.3517045539675, 5701.868059570564, 5774.769009239625, 5817.331006934214, 5832.533397328203, 5837.211976383198, 5753.395893431192, 5875.38308477608, 5906.527477801787, 5909.556783241231, 5911.379305172981, 5042.722650254234, 5201.037808005531, 5201.193814958649, 5225.294585231021, 5228.294180285651, 14821.555353339418, 14964.551063468005, 15630.531084067383, 19361.709574356395, 19745.605087898304, 2084.5414008918165, 2126.138913739938, 2188.441947303443, 2263.094762095159, 2401.6037353836596, 12507.812382814265, 12591.937040314831, 12845.0, 13004.414801333962, 13139.34303284832, 1785.3394244129754, 1855.4794316227026, 1861.7207418887276, 1865.3098353609116, 1865.450285400935, 50100.74949625265, 51265.0, 51592.48407515952, 51766.0, 51795.482045179444, 9433.292503062297, 9518.095780900803, 9616.663416780379, 9629.807403852024, 9692.70921872345, 12537.874621253854, 12544.310062946442, 12548.372581370895, 12555.05837062224, 12565.811512827315, 7379.963100184465, 7405.8889116663295, 7445.813854653677, 7499.437542184358, 7511.474196806171, 7203.711851525985, 7227.313405226495, 7257.0565826442225, 7287.125544934642, 7305.45209109319, 5809.331926828469, 5958.255218097738, 5965.164876917235, 5974.103884417285, 6005.279366476051, 1598.073117591794, 1613.2175894691065, 1654.3134599141463, 1671.9164041797862, 1686.3591835102582, 921.5162039929091, 981.0581841432305, 984.2962281968427, 1017.3895662602528, 1057.1859668055554, 15008.774868376982, 16337.509874703777, 16392.67214655724, 16597.668046639, 16743.413980510868, 908.8318661047728, 923.5290002098978, 924.2605915267759, 933.5472295936465, 955.3264948211494, 9593.760155996157, 9682.612695492102, 9719.514024298756, 9794.804103917882, 9836.409815411098, 491962.0, 495950.0, 513893.0, 530074.0, 531010.0, 48756.0, 59368.70315648394, 60570.0, 61089.0, 61499.38500615026, 998.5257002923698, 1023.9897601024044, 1091.9781604367868, 1095.808233559124, 1136.6646839182295, 13589.592312230649, 14248.501302454779, 14297.0, 14722.852771472577, 14858.479953201586, 23208.4197895054, 29105.12684619465, 29535.0, 29687.703122969357, 29851.402971940875, 33757.15607109842, 33875.322493550484, 34131.317373652884, 34250.657493425744, 34952.0, 6843.349881761224, 7094.574325540484, 7165.677544510405, 7242.529235599669, 7744.070711514654, 10439.0, 11171.0, 11193.104551635686, 11301.886981130412, 11558.826617600575, 9027.277817774431, 9199.034101419255, 9203.309751768778, 9512.95243523778, 9554.426734395958, 9728.367656102331, 9757.21942244633, 10044.54799534008, 10094.495275236355, 10378.325408848401, 9374.765630859283, 9552.188064014359, 9781.0, 9793.216542676426, 9838.704838854846, 7710.961445192738, 7712.190220026816, 7764.534127952341, 7771.533707977539, 7792.493487923267, 9040.276777857624, 9585.664501742405, 9646.565904534453, 9669.661561845302, 9695.854562181432], "unit": "score", "name": "jquery.html", "value": 8052.64454335495}, {"lowerIsBetter": false, "replicates": [1307.1634154141357, 1443.7689969604862, 1469.4122351059575, 1605.8795590330728, 1760.0407777761127, 6726.596404215745, 7537.811554711128, 7656.3109320161175, 7665.8850117248285, 7687.538747675129, 7527.5859827709455, 7727.497712648674, 7739.110002349731, 7747.845043099149, 7755.418343624223, 1997.1312479071578, 2032.4106009257298, 2032.5121970727066, 2312.456572705417, 2341.94145146371, 2015.556577552936, 2297.7357603875516, 2348.5420343033115, 2352.494213744045, 2357.5874222011166, 2280.304507125326, 2328.662343960125, 2342.496363281894, 2347.307544274443, 2350.5063936573256, 2265.2637892684943, 2294.6328587426015, 2300.3444018454743, 2303.0557471436714, 2306.757790432014, 2314.525522267931, 2324.4305145239355, 2342.543204075206, 2344.0858065354355, 2344.800691941187, 7938.325242354407, 7998.160193179749, 8002.119766825645, 8002.239787220205, 8014.799630009296, 4828.686135401188, 4952.8761780955765, 4979.128652485801, 4981.501849815026, 4988.850334489971, 2985.0746268656785, 2994.2364697002126, 3035.4536183487185, 3044.071558174756, 3124.718775310233, 905.0994260710569, 907.1246247371319, 929.2983797233113, 932.4917919733762, 942.6559305853383, 10255.641052563124, 10369.79260414795, 10382.688519344432, 10385.84421233682, 10411.11505522024, 4192.3711443283755, 4260.318349064135, 4307.246231909403, 4328.675349348749, 4333.155034768253, 8636.78408039804, 8643.049264580892, 8650.567471626393, 8672.176143266379, 8677.522736249566, 4805.37530121082, 4809.0862736080035, 4838.69355274074, 4843.200871856105, 4845.41854977405, 4403.625691816167, 4460.174867649495, 4465.732056076646, 4468.195724769573, 4471.128130014616, 3291.4075466416275, 3347.933041339208, 3471.496632988253, 3554.182538016271, 3562.946555801665, 1085.1535802074395, 1130.8699499557492, 1133.9716507087223, 1135.5628083188033, 1153.5731779241735, 1261.1802328486374, 1269.6571925580226, 1280.9679758005939, 1290.5031562848371, 1290.7547565962436, 7080.114985626797, 7099.57402555838, 7447.292507211806, 7599.278068583586, 7621.885671714928, 1079.3577821196375, 1081.9513121909376, 1087.472575800736, 1090.378484263962, 1098.4068602954476, 5437.918431223535, 5445.945540544623, 5454.127339625641, 5498.477644623755, 5505.284313039279, 9299.256059515223, 9311.813763724824, 9548.952255238679, 9660.468674222844, 9670.661526846527, 9533.0, 9595.568199431042, 9705.641210230573, 9721.805563888682, 9724.076212759777, 7052.506324557232, 7259.491835571459, 7328.377087947584, 7341.339279464767, 7425.777226683208, 7331.74338898136, 7417.8145546361775, 7443.81390465221, 7448.664810083667, 7449.515781474187, 8285.751427457186, 8570.057293697564, 8637.395382323177, 8755.737327880173, 8865.423747456394, 8883.156100170474, 8960.238379737795, 9022.14289642483, 9146.63413463454, 9152.17630413266, 7029.29707029293, 7177.210506844139, 7182.96408517954, 7192.784216473514, 7194.2086370498155, 6168.414000669929, 6263.530235232284, 7213.6032518212005, 7372.410207183305, 7628.237176282328, 6962.895556566757, 7176.7488137914925, 7186.24544422849, 7192.244814294424, 7372.299631534996, 6892.517523773287, 7034.366906978396, 7043.823904402431, 7072.646367681493, 7284.817879553054, 6966.338197871194, 7015.0, 7017.614031228127, 7023.613701246481, 7026.613536255555, 6062.211912451353, 6142.938570614416, 6148.631082134907, 6157.199564056644, 6221.9377806221355, 6327.0, 6329.620222786648, 6330.430261276507, 6330.746770129327, 6332.873342533216], "unit": "score", "name": "mootools.html", "value": 4480.432003386843}, {"lowerIsBetter": false, "replicates": [334.70044310342246, 335.57549699629965, 337.7365654789264, 339.2113336492655, 348.9598696149942, 5752.367239603651, 5883.85290367741, 5888.5877988540815, 5908.379620139877, 5951.1965884605515, 5660.915086273699, 5807.1579620954935, 5857.3849745776715, 5876.412358764122, 5893.351731309553, 4577.793999270024, 4585.587297143248, 4586.3579098926175, 4587.72473651582, 4591.0, 4385.583369579901, 4477.216487114758, 4495.1459222747735, 4542.886427839314, 4580.473245576752, 4534.841280555182, 4554.043650833329, 4565.520620334867, 4566.292224705176, 4567.08658268346, 4551.817927282905, 4559.110973360196, 4561.361409402686, 4561.452625684906, 4564.726116433025, 4022.517297924268, 4027.677785777131, 4028.4762980812307, 4029.5164580250266, 4034.213328400963, 5529.253550770634, 5639.548836093103, 5661.377248502703, 5678.6024978251535, 5717.142428635696, 5234.973825130888, 5245.318108645852, 5250.894982100336, 5251.133562962106, 5252.579793616502, 5921.911171332434, 6262.561620686553, 6268.87462250757, 6270.372962703693, 6270.749170033193, 4227.534971153171, 4234.830606775725, 4288.399624052635, 4308.38435586655, 4379.824807007716, 6416.518761092937, 6474.643894585796, 6475.222973243241, 6487.664440801355, 6503.642299673516, 4413.7793110344355, 4444.177827101997, 4453.153900758845, 4458.264386376211, 4460.1525710114975, 4373.75944323059, 4483.30508771141, 4501.459824821042, 4501.77491125449, 4558.703684260512, 5221.895562088813, 5234.659747116425, 5243.187305967581, 5246.344206974129, 5251.343582052244, 6282.371762823681, 6292.0, 6295.276043254993, 6302.086197501337, 6309.242890853127, 1572.2374648295568, 1598.3127255280108, 1601.719699052661, 1602.439146298786, 1602.9519114426587, 1064.4677661169414, 1067.5249513966367, 1073.350622873166, 1075.2526993739432, 1096.8025755363951, 5872.677002764889, 5875.148103524965, 5878.559108066912, 5878.882422351529, 5879.412058794086, 6423.389777971085, 6445.291017988017, 6447.161868957006, 6452.806415807533, 6458.257300410513, 5863.67749773758, 5864.296284445893, 5869.0, 5869.911951320648, 5871.471567558855, 3397.8980630581123, 3469.705075068597, 3493.5633045869267, 3512.701420379245, 3520.0495866116007, 6746.628935408501, 6758.628275444898, 6763.898541521881, 6777.085093512412, 6780.423663988616, 6711.362420570038, 6722.361375669304, 6722.394984451423, 6723.193216813916, 6724.260331363546, 6563.606183628997, 6748.628825414649, 6748.83127921796, 6759.256481787, 6776.05135281061, 6232.844178895564, 6399.456046235936, 6519.7392104315295, 6520.771772987922, 6524.804255872332, 6276.435120839146, 6413.615183089029, 6419.2938776735455, 6422.068800023877, 6432.35676432353, 6718.563293385914, 6729.091572637827, 6731.461483081243, 6736.93263067363, 6740.494462915399, 4337.891552711208, 4458.375827384234, 4494.101179763995, 4499.392582001519, 4500.0, 6419.614823110628, 6443.871122577616, 6449.6130232186215, 6451.161349024596, 6454.354564543508, 6208.875822483616, 6232.25212974446, 6261.749530018748, 6270.811875643738, 6278.340774218824, 6092.329843717099, 6262.342454042442, 6267.435930766253, 6268.498520118471, 6276.246850377984, 6161.6919154041225, 6207.596506227081, 6207.844803879939, 6211.0372892201785, 6211.16149319836, 6331.3352098029045, 6343.936560634519, 6345.809625711236, 6348.587341822951, 6352.237731472068, 6101.542384321282, 6191.628502289877, 6207.534434917489, 6209.161763161916, 6210.285817131088], "unit": "score", "name": "prototype.html", "value": 4735.563641436401}, {"lowerIsBetter": false, "replicates": [733.4719002318332, 757.6969212315073, 829.8008477965286, 835.5822088955522, 840.7603832907619, 12525.812112818303, 12679.809802852964, 12685.682857928556, 12690.619281421548, 12734.172278801894, 12328.4452199651, 12361.0, 12377.814332785016, 12413.503459861617, 12445.875541244584, 663.6018388966629, 673.0678010954814, 803.8834369016489, 812.2405550810012, 813.585071613477, 809.0372456776447, 811.4319976016783, 812.0742353716768, 815.4862436664893, 816.0411516468156, 709.8509313044267, 863.4171933944593, 863.87905693203, 865.6191275838611, 871.8299931513358, 709.5529816215777, 711.2709472790406, 847.8177191903709, 860.1742327365737, 864.775158458799, 639.0892977507034, 639.0924886660906, 639.3191251317332, 639.9840003999891, 640.3948268885858, 13062.0, 13081.28052957087, 13135.146215495963, 13155.07914445989, 13198.868011319955, 12464.750704985849, 12964.611061668165, 13187.802182967263, 13254.40355184019, 13279.800802987866, 10511.21165912552, 10568.260221784478, 10664.0, 10673.733156671067, 10850.29473084247, 3612.096975756061, 3662.066173125836, 3704.0, 3732.141607430306, 3774.5281839770028, 46113.76943115263, 48063.279050813915, 48067.0, 48133.51866481325, 48236.517634823904, 9966.103050725469, 10133.746656333504, 10135.64525241613, 10457.0, 10475.486622257355, 17388.913055434896, 18114.547136321697, 18197.7270340945, 18233.544161395806, 18236.36172733948, 7422.369098626569, 7455.440841936768, 7570.470067095251, 7659.195784442553, 7790.766277011699, 4121.278776214151, 4122.216778812016, 4160.251154792167, 4192.203481338536, 4223.603718121845, 3195.6005499312587, 3202.343519578481, 3226.467632840602, 3230.9192270193435, 3244.1078703356766, 573.3734131617535, 587.6797145555682, 601.506764453153, 602.036741214054, 606.0606060606043, 514.9588032957355, 522.6002108387087, 571.5256337240164, 615.7136931326954, 663.7842701122155, 8207.917920820715, 8298.377621678399, 8344.290735287446, 8362.749117526484, 8468.364872634576, 455.54218010898836, 498.01890276155916, 616.4636766013507, 619.1424876546016, 627.2285089340046, 3859.4403811447182, 3870.7871067091583, 4013.337799263147, 4053.7365071270274, 4150.335946248586, 55848.44151558514, 57012.0, 59079.70460147672, 59083.0, 59183.70408148018, 50137.74931125321, 50744.0, 50917.236241456405, 52025.219621705706, 52027.73986130045, 45390.319145212845, 45420.54579454229, 45500.0, 45507.31739023917, 45537.54462455399, 7941.920580794118, 7960.402969777174, 8119.188081191834, 8180.386471014579, 8248.752537423887, 33292.50061249132, 33382.332353352314, 34208.657913420546, 34393.0, 34421.139471513416, 42498.0, 44058.55941440545, 44066.33900491431, 44263.0, 44313.11373772442, 10439.686809395731, 10576.153907687212, 10576.259661823598, 10806.783864322511, 10928.125749940145, 10999.725006874573, 11038.44807759625, 11077.501512432122, 11534.826977595176, 11878.0, 10401.219908507044, 10642.201834862262, 10673.57305707763, 10747.193960452842, 10883.564657413615, 11342.262752921033, 11415.885841141815, 11468.0, 11733.237339572901, 11780.882191177978, 6850.486213533905, 10538.485304523803, 11069.0, 11168.720781980515, 11448.174076068542, 8493.0, 8661.220490155916, 8709.390342675952, 8754.51850148248, 8936.50849203274, 9682.806343873224, 9809.607615695577, 9892.15916647093, 9904.554295056596, 9905.554250058909], "unit": "score", "name": "yui.html", "value": 6163.252986092749}], "name": "dromaeo_css", "value": 6759.209325485704}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 107.0, 111.0, 111.0, 111.0, 101.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [164.0, 123.0, 153.0, 161.0, 127.0, 151.0, 149.0, 124.0, 159.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 143.7}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 161.0, 160.0, 161.0, 159.0, 163.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 96.0, 101.0, 74.0, 75.0, 75.0, 119.0, 89.0, 70.0], "unit": "score", "name": "audio-fft", "value": 84.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 144.0, 96.0, 95.0, 97.0, 139.0, 95.0, 95.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 147.0, 146.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 58.0, 56.0, 55.0, 55.0, 56.0, 63.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 73.0, 68.0, 67.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 82.0, 83.0, 81.0, 82.0, 84.0, 85.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [123.0, 113.0, 118.0, 112.0, 119.0, 119.0, 122.0, 117.0, 117.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.3}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 142.0, 143.0, 142.0, 135.0, 143.0, 142.0, 154.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 66.0, 68.0, 66.0, 68.0, 69.0, 67.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1491.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.98252981689905], "unit": "score", "name": "Richards", "value": 210.15280599999997}, {"lowerIsBetter": false, "replicates": [190.11406844106463], "unit": "score", "name": "DeltaBlue", "value": 347.7806799999999}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1976.2845849802372], "unit": "score", "name": "RayTrace", "value": 374.434434}, {"lowerIsBetter": false, "replicates": [788.6435331230284], "unit": "score", "name": "Earley", "value": 845.075084}, {"lowerIsBetter": false, "replicates": [12329.268292682927], "unit": "score", "name": "Boyer", "value": 54.05535707220569}, {"lowerIsBetter": false, "replicates": [42854.166666666664], "unit": "score", "name": "RegExp", "value": 21.257792902284876}, {"lowerIsBetter": false, "replicates": [654.0222367560497], "unit": "score", "name": "Splay", "value": 124.59973900000001}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 18684.347310067988}]} 07:51:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "18684.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1491.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6759.21"}}} 07:51:24 INFO - Return code: 0 07:51:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:51:24 INFO - # TBPL SUCCESS # 07:51:24 INFO - Running post-action listener: _resource_record_post_action 07:51:24 INFO - Running post-run listener: _resource_record_post_run 07:51:25 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 541696000; Read time: 0; Write time: 497848 07:51:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 239144960; Read time: 0; Write time: 207580 07:51:25 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 302551040; Read time: 0; Write time: 290268 07:51:25 INFO - Running post-run listener: _upload_blobber_files 07:51:25 INFO - Blob upload gear active. 07:51:25 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:51:25 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 07:51:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:51:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:51:25 INFO - (blobuploader) - INFO - Open directory for files ... 07:51:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:51:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:51:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:26 INFO - (blobuploader) - INFO - Done attempting. 07:51:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:51:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:51:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:27 INFO - (blobuploader) - INFO - Done attempting. 07:51:27 INFO - (blobuploader) - INFO - Iteration through files over. 07:51:27 INFO - Return code: 0 07:51:27 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:51:27 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:51:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/110b0acfe2a7a6a191247c707363879ee55c510c6ec87d9b79b111627046d21626bc81fae487902fce0fc328f16837dc1350f9ce491324ef9f436770371b8f41", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6daed6772b2b6b8b307d40fa0b3a17e5406defa59ffe3e145f95541aefddaea7129b4291ed1d5db9554e947dcd22eaa2c442f6b81766af8bd0782a4a29721c5a"} 07:51:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:51:27 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:51:27 INFO - Contents: 07:51:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/110b0acfe2a7a6a191247c707363879ee55c510c6ec87d9b79b111627046d21626bc81fae487902fce0fc328f16837dc1350f9ce491324ef9f436770371b8f41", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6daed6772b2b6b8b307d40fa0b3a17e5406defa59ffe3e145f95541aefddaea7129b4291ed1d5db9554e947dcd22eaa2c442f6b81766af8bd0782a4a29721c5a"} 07:51:27 INFO - Copying logs to upload dir... 07:51:27 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.547908 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-14 07:51:27.589867) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 07:51:27.593510) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/110b0acfe2a7a6a191247c707363879ee55c510c6ec87d9b79b111627046d21626bc81fae487902fce0fc328f16837dc1350f9ce491324ef9f436770371b8f41", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6daed6772b2b6b8b307d40fa0b3a17e5406defa59ffe3e145f95541aefddaea7129b4291ed1d5db9554e947dcd22eaa2c442f6b81766af8bd0782a4a29721c5a"} build_url:https://queue.taskcluster.net/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/S2hztez3Q3WNfYpXfeOI8w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/110b0acfe2a7a6a191247c707363879ee55c510c6ec87d9b79b111627046d21626bc81fae487902fce0fc328f16837dc1350f9ce491324ef9f436770371b8f41", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6daed6772b2b6b8b307d40fa0b3a17e5406defa59ffe3e145f95541aefddaea7129b4291ed1d5db9554e947dcd22eaa2c442f6b81766af8bd0782a4a29721c5a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 07:51:27.617963) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:51:27.618290) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452785410.408635-1423364366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004763 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:51:27.703113) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 07:51:27.703442) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 07:51:27.703743) ========= ========= Total master_lag: 0.44 =========