builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1451578112.62 results: success (0) buildid: 20151231053005 builduid: daefb5c0c3da4d7f9bdf299414510c68 revision: 67bb1f081804c860ae1f463394407a922aa51c77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:32.619784) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:32.620296) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:32.620608) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006372 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:32.651891) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:32.652175) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:32.669034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:32.669331) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004651 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:32.718273) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:32.718589) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:32.718953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:32.719228) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-31 08:08:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.8M=0s 2015-12-31 08:08:33 (43.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098016 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:32.830120) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:32.830494) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020911 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:32.880612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:32.880986) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 67bb1f081804c860ae1f463394407a922aa51c77 --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 67bb1f081804c860ae1f463394407a922aa51c77 --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=8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-31 08:08:33,722 truncating revision to first 12 chars 2015-12-31 08:08:33,722 Setting DEBUG logging. 2015-12-31 08:08:33,722 attempt 1/10 2015-12-31 08:08:33,722 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/67bb1f081804?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-31 08:08:34,037 unpacking tar archive at: b2g-inbound-67bb1f081804/testing/mozharness/ program finished with exit code 0 elapsedTime=0.604651 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:33.498614) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:33.498945) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:33.738895) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:33.739511) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 08:08:33.740259) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-31 08:08:33.740807) ========= /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=8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:08:34 INFO - MultiFileLogger online at 20151231 08:08:34 in /builds/slave/test-pgo 08:08:34 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 08:08:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:08:34 INFO - {'append_to_log': False, 08:08:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:08:34 INFO - 'blob_upload_branch': 'B2G-Inbound', 08:08:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:08:34 INFO - 'branch': 'B2G-Inbound', 08:08:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:34 INFO - 'config_files': ('talos/linux_config.py',), 08:08:34 INFO - 'default_actions': ('clobber', 08:08:34 INFO - 'read-buildbot-config', 08:08:34 INFO - 'download-and-extract', 08:08:34 INFO - 'populate-webroot', 08:08:34 INFO - 'create-virtualenv', 08:08:34 INFO - 'install', 08:08:34 INFO - 'run-tests'), 08:08:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:34 INFO - 'download_minidump_stackwalk': True, 08:08:34 INFO - 'download_symbols': 'ondemand', 08:08:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:34 INFO - 'installer_path': 'installer.exe', 08:08:34 INFO - 'log_level': 'info', 08:08:34 INFO - 'log_name': 'talos', 08:08:34 INFO - 'log_to_console': True, 08:08:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:08:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:08:34 INFO - 'opt_config_files': (), 08:08:34 INFO - 'pip_index': False, 08:08:34 INFO - 'sps_profile': False, 08:08:34 INFO - 'sps_profile_interval': 0, 08:08:34 INFO - 'suite': 'dromaeojs', 08:08:34 INFO - 'system_bits': '32', 08:08:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:34 INFO - 'title': 'talos-linux64-ix-004', 08:08:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:34 INFO - 'use_talos_json': True, 08:08:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:08:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:34 INFO - 'work_dir': 'build'} 08:08:34 INFO - ##### 08:08:34 INFO - ##### Running clobber step. 08:08:34 INFO - ##### 08:08:34 INFO - Running pre-action listener: _resource_record_pre_action 08:08:34 INFO - Running main action method: clobber 08:08:34 INFO - rmtree: /builds/slave/test-pgo/build 08:08:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:08:35 INFO - Running post-action listener: _resource_record_post_action 08:08:35 INFO - ##### 08:08:35 INFO - ##### Running read-buildbot-config step. 08:08:35 INFO - ##### 08:08:35 INFO - Running pre-action listener: _resource_record_pre_action 08:08:35 INFO - Running main action method: read_buildbot_config 08:08:35 INFO - Using buildbot properties: 08:08:35 INFO - { 08:08:35 INFO - "project": "", 08:08:35 INFO - "product": "firefox", 08:08:35 INFO - "script_repo_revision": "production", 08:08:35 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 08:08:35 INFO - "repository": "", 08:08:35 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 08:08:35 INFO - "buildid": "20151231053005", 08:08:35 INFO - "pgo_build": "True", 08:08:35 INFO - "basedir": "/builds/slave/test-pgo", 08:08:35 INFO - "buildnumber": 171, 08:08:35 INFO - "slavename": "talos-linux64-ix-004", 08:08:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:08:35 INFO - "platform": "ubuntu64_hw", 08:08:35 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 08:08:35 INFO - "branch": "b2g-inbound", 08:08:35 INFO - "repo_path": "integration/b2g-inbound", 08:08:35 INFO - "revision": "67bb1f081804c860ae1f463394407a922aa51c77", 08:08:35 INFO - "stage_platform": "linux64-pgo", 08:08:35 INFO - "builduid": "daefb5c0c3da4d7f9bdf299414510c68", 08:08:35 INFO - "slavebuilddir": "test" 08:08:35 INFO - } 08:08:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:08:35 INFO - Running post-action listener: _resource_record_post_action 08:08:35 INFO - ##### 08:08:35 INFO - ##### Running download-and-extract step. 08:08:35 INFO - ##### 08:08:35 INFO - Running pre-action listener: _resource_record_pre_action 08:08:35 INFO - Running main action method: download_and_extract 08:08:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:35 INFO - https://queue.taskcluster.net/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:08:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/test_packages.json 08:08:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/test_packages.json 08:08:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:08:37 INFO - Downloaded 1302 bytes. 08:08:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:08:37 INFO - Using the following test package requirements: 08:08:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:08:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:37 INFO - u'jsshell-linux-x86_64.zip'], 08:08:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:08:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:08:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:08:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:08:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:08:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:37 INFO - https://queue.taskcluster.net/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:08:38 INFO - Downloaded 23195217 bytes. 08:08:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 08:08:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:08:39 INFO - Return code: 0 08:08:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:39 INFO - https://queue.taskcluster.net/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:08:43 INFO - Downloaded 23195217 bytes. 08:08:43 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 08:08:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:43 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 08:08:45 INFO - Return code: 0 08:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:45 INFO - https://queue.taskcluster.net/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:08:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:08:46 INFO - Downloaded 11132285 bytes. 08:08:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 08:08:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 08:08:46 INFO - Return code: 0 08:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:46 INFO - https://queue.taskcluster.net/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:08:48 INFO - Downloaded 54937526 bytes. 08:08:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:48 INFO - mkdir: /builds/slave/test-pgo/properties 08:08:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:08:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:08:48 INFO - Contents: 08:08:48 INFO - build_url:https://queue.taskcluster.net/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:48 INFO - Running post-action listener: _resource_record_post_action 08:08:48 INFO - Running post-action listener: set_extra_try_arguments 08:08:48 INFO - ##### 08:08:48 INFO - ##### Running populate-webroot step. 08:08:48 INFO - ##### 08:08:48 INFO - Running pre-action listener: _resource_record_pre_action 08:08:48 INFO - Running main action method: populate_webroot 08:08:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:08:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:08:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:08:48 INFO - '--tppagecycles', 08:08:48 INFO - '7'], 08:08:48 INFO - 'tests': ['tsvgm']}}, 08:08:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:08:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:08:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:08:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:08:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:08:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:08:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:48 INFO - 'talos_options': ['--e10s'], 08:08:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:48 INFO - 'tests': ['damp', 'tps']}, 08:08:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:48 INFO - 'talos_options': ['--e10s'], 08:08:48 INFO - 'tests': ['damp', 'tps']}, 08:08:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:08:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:08:48 INFO - 'other': {'tests': ['a11yr', 08:08:48 INFO - 'ts_paint', 08:08:48 INFO - 'tpaint', 08:08:48 INFO - 'sessionrestore', 08:08:48 INFO - 'sessionrestore_no_auto_restore']}, 08:08:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:08:48 INFO - 'tests': ['a11yr', 08:08:48 INFO - 'ts_paint', 08:08:48 INFO - 'tpaint', 08:08:48 INFO - 'sessionrestore', 08:08:48 INFO - 'sessionrestore_no_auto_restore']}, 08:08:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:08:48 INFO - 'tests': ['a11yr', 08:08:48 INFO - 'ts_paint', 08:08:48 INFO - 'tpaint', 08:08:48 INFO - 'sessionrestore', 08:08:48 INFO - 'sessionrestore_no_auto_restore']}, 08:08:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:08:48 INFO - 'tests': ['a11yr', 08:08:48 INFO - 'ts_paint', 08:08:48 INFO - 'tpaint', 08:08:48 INFO - 'sessionrestore', 08:08:48 INFO - 'sessionrestore_no_auto_restore']}, 08:08:48 INFO - 'other_l64': {'tests': ['a11yr', 08:08:48 INFO - 'ts_paint', 08:08:48 INFO - 'tpaint', 08:08:48 INFO - 'sessionrestore', 08:08:48 INFO - 'sessionrestore_no_auto_restore']}, 08:08:48 INFO - 'other_nol64': {'tests': ['a11yr', 08:08:48 INFO - 'ts_paint', 08:08:48 INFO - 'tpaint', 08:08:48 INFO - 'sessionrestore', 08:08:48 INFO - 'sessionrestore_no_auto_restore']}, 08:08:48 INFO - 'svgr': {'tests': ['tsvgx', 08:08:48 INFO - 'tsvgr_opacity', 08:08:48 INFO - 'tart', 08:08:48 INFO - 'tscrollx', 08:08:48 INFO - 'cart']}, 08:08:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:08:48 INFO - 'tests': ['tsvgx', 08:08:48 INFO - 'tsvgr_opacity', 08:08:48 INFO - 'tart', 08:08:48 INFO - 'tscrollx', 08:08:48 INFO - 'cart']}, 08:08:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:48 INFO - 'tests': ['tp5o']}, 08:08:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:48 INFO - 'talos_options': ['--e10s'], 08:08:48 INFO - 'tests': ['tp5o']}, 08:08:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:48 INFO - 'talos_options': ['--xperf_path', 08:08:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:48 INFO - 'tests': ['tp5n']}, 08:08:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:48 INFO - 'talos_options': ['--e10s', 08:08:48 INFO - '--xperf_path', 08:08:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:48 INFO - 'tests': ['tp5n']}}, 08:08:48 INFO - 'talos.zip': {'path': '', 08:08:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:08:48 INFO - Running post-action listener: _resource_record_post_action 08:08:48 INFO - ##### 08:08:48 INFO - ##### Running create-virtualenv step. 08:08:48 INFO - ##### 08:08:48 INFO - Running pre-action listener: _resource_record_pre_action 08:08:48 INFO - Running main action method: create_virtualenv 08:08:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:08:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 08:08:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:08:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:08:48 INFO - Using real prefix '/usr' 08:08:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:08:48 INFO - Installing distribute.............................................................................................................................................................................................done. 08:08:50 INFO - Installing pip.................done. 08:08:50 INFO - Return code: 0 08:08:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:50 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 0x7f6b7bbc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc840>, '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 0x2b496b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b49b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:08:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:08:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:08:50 INFO - Using env: {'DISPLAY': ':0', 08:08:50 INFO - 'HOME': '/home/cltbld', 08:08:50 INFO - 'LANG': 'en_US.UTF-8', 08:08:50 INFO - 'LANGUAGE': 'en_US:en', 08:08:50 INFO - 'LOGNAME': 'cltbld', 08:08:50 INFO - 'MAIL': '/var/mail/cltbld', 08:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:50 INFO - 'MOZ_NO_REMOTE': '1', 08:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:50 INFO - 'NO_EM_RESTART': '1', 08:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:50 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:50 INFO - 'SHELL': '/bin/bash', 08:08:50 INFO - 'SHLVL': '1', 08:08:50 INFO - 'TERM': 'linux', 08:08:50 INFO - 'TMOUT': '86400', 08:08:50 INFO - 'USER': 'cltbld', 08:08:50 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 08:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:50 INFO - '_': '/tools/buildbot/bin/python'} 08:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:08:50 INFO - Cleaning up... 08:08:50 INFO - Return code: 0 08:08:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:50 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 0x7f6b7bbc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc840>, '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 0x2b496b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b49b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:08:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:08:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:08:50 INFO - Using env: {'DISPLAY': ':0', 08:08:50 INFO - 'HOME': '/home/cltbld', 08:08:50 INFO - 'LANG': 'en_US.UTF-8', 08:08:50 INFO - 'LANGUAGE': 'en_US:en', 08:08:50 INFO - 'LOGNAME': 'cltbld', 08:08:50 INFO - 'MAIL': '/var/mail/cltbld', 08:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:50 INFO - 'MOZ_NO_REMOTE': '1', 08:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:50 INFO - 'NO_EM_RESTART': '1', 08:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:50 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:50 INFO - 'SHELL': '/bin/bash', 08:08:50 INFO - 'SHLVL': '1', 08:08:50 INFO - 'TERM': 'linux', 08:08:50 INFO - 'TMOUT': '86400', 08:08:50 INFO - 'USER': 'cltbld', 08:08:50 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 08:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:50 INFO - '_': '/tools/buildbot/bin/python'} 08:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:51 INFO - Downloading/unpacking psutil>=0.7.1 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:08:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:08:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:08:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:52 INFO - Installing collected packages: psutil 08:08:52 INFO - Running setup.py install for psutil 08:08:53 INFO - building 'psutil._psutil_linux' extension 08:08:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:08:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:08:53 INFO - building 'psutil._psutil_posix' extension 08:08:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:08:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:08:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:53 INFO - Successfully installed psutil 08:08:53 INFO - Cleaning up... 08:08:53 INFO - Return code: 0 08:08:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:53 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 0x7f6b7bbc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc840>, '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 0x2b496b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b49b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:08:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:08:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:08:53 INFO - Using env: {'DISPLAY': ':0', 08:08:53 INFO - 'HOME': '/home/cltbld', 08:08:53 INFO - 'LANG': 'en_US.UTF-8', 08:08:53 INFO - 'LANGUAGE': 'en_US:en', 08:08:53 INFO - 'LOGNAME': 'cltbld', 08:08:53 INFO - 'MAIL': '/var/mail/cltbld', 08:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:53 INFO - 'MOZ_NO_REMOTE': '1', 08:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:53 INFO - 'NO_EM_RESTART': '1', 08:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:53 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:53 INFO - 'SHELL': '/bin/bash', 08:08:53 INFO - 'SHLVL': '1', 08:08:53 INFO - 'TERM': 'linux', 08:08:53 INFO - 'TMOUT': '86400', 08:08:53 INFO - 'USER': 'cltbld', 08:08:53 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 08:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:53 INFO - '_': '/tools/buildbot/bin/python'} 08:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:08:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:08:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:08:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:08:55 INFO - Installing collected packages: mozsystemmonitor 08:08:55 INFO - Running setup.py install for mozsystemmonitor 08:08:55 INFO - Successfully installed mozsystemmonitor 08:08:55 INFO - Cleaning up... 08:08:55 INFO - Return code: 0 08:08:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:55 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 0x7f6b7bbc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc840>, '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 0x2b496b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b49b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:08:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:08:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:08:55 INFO - Using env: {'DISPLAY': ':0', 08:08:55 INFO - 'HOME': '/home/cltbld', 08:08:55 INFO - 'LANG': 'en_US.UTF-8', 08:08:55 INFO - 'LANGUAGE': 'en_US:en', 08:08:55 INFO - 'LOGNAME': 'cltbld', 08:08:55 INFO - 'MAIL': '/var/mail/cltbld', 08:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:55 INFO - 'MOZ_NO_REMOTE': '1', 08:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:55 INFO - 'NO_EM_RESTART': '1', 08:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:55 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:55 INFO - 'SHELL': '/bin/bash', 08:08:55 INFO - 'SHLVL': '1', 08:08:55 INFO - 'TERM': 'linux', 08:08:55 INFO - 'TMOUT': '86400', 08:08:55 INFO - 'USER': 'cltbld', 08:08:55 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 08:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:55 INFO - '_': '/tools/buildbot/bin/python'} 08:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:55 INFO - Downloading/unpacking blobuploader==1.2.4 08:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:57 INFO - Downloading blobuploader-1.2.4.tar.gz 08:08:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:08:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:08:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:08:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:08:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:58 INFO - Downloading docopt-0.6.1.tar.gz 08:08:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:08:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:08:58 INFO - Installing collected packages: blobuploader, requests, docopt 08:08:58 INFO - Running setup.py install for blobuploader 08:08:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:08:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:08:58 INFO - Running setup.py install for requests 08:08:59 INFO - Running setup.py install for docopt 08:08:59 INFO - Successfully installed blobuploader requests docopt 08:08:59 INFO - Cleaning up... 08:08:59 INFO - Return code: 0 08:08:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:59 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 0x7f6b7bbc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc840>, '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 0x2b496b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b49b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:08:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:08:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:08:59 INFO - Using env: {'DISPLAY': ':0', 08:08:59 INFO - 'HOME': '/home/cltbld', 08:08:59 INFO - 'LANG': 'en_US.UTF-8', 08:08:59 INFO - 'LANGUAGE': 'en_US:en', 08:08:59 INFO - 'LOGNAME': 'cltbld', 08:08:59 INFO - 'MAIL': '/var/mail/cltbld', 08:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:59 INFO - 'MOZ_NO_REMOTE': '1', 08:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:59 INFO - 'NO_EM_RESTART': '1', 08:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:59 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:59 INFO - 'SHELL': '/bin/bash', 08:08:59 INFO - 'SHLVL': '1', 08:08:59 INFO - 'TERM': 'linux', 08:08:59 INFO - 'TMOUT': '86400', 08:08:59 INFO - 'USER': 'cltbld', 08:08:59 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 08:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:59 INFO - '_': '/tools/buildbot/bin/python'} 08:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:59 INFO - Running setup.py (path:/tmp/pip-6Dg0hK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:59 INFO - Running setup.py (path:/tmp/pip-MZkeFe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:59 INFO - Running setup.py (path:/tmp/pip-7JBgHR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:59 INFO - Running setup.py (path:/tmp/pip-w3_eUe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:59 INFO - Running setup.py (path:/tmp/pip-ubkjbv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:59 INFO - Running setup.py (path:/tmp/pip-3eWO4o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:59 INFO - Running setup.py (path:/tmp/pip-Bgu3aF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:59 INFO - Running setup.py (path:/tmp/pip-iYIpJz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:59 INFO - Running setup.py (path:/tmp/pip-U0yPOX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:09:00 INFO - Running setup.py (path:/tmp/pip-EsQwo6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:09:00 INFO - Running setup.py (path:/tmp/pip-S7QWT5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:09:00 INFO - Running setup.py (path:/tmp/pip-23DOLa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:09:00 INFO - Running setup.py (path:/tmp/pip-ol5sbh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:09:00 INFO - Running setup.py (path:/tmp/pip-IwUmSA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:09:00 INFO - Running setup.py (path:/tmp/pip-zWLGME-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:09:00 INFO - Running setup.py (path:/tmp/pip-fbKF7D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:09:00 INFO - Running setup.py (path:/tmp/pip-RMH5CE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:09:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:00 INFO - Running setup.py install for manifestparser 08:09:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:09:00 INFO - Running setup.py install for mozcrash 08:09:00 INFO - Running setup.py install for mozdebug 08:09:00 INFO - Running setup.py install for mozdevice 08:09:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:09:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:09:01 INFO - Running setup.py install for mozfile 08:09:01 INFO - Running setup.py install for mozhttpd 08:09:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:09:01 INFO - Running setup.py install for mozinfo 08:09:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:09:01 INFO - Running setup.py install for mozInstall 08:09:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:09:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:09:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:09:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:09:01 INFO - Running setup.py install for mozleak 08:09:01 INFO - Running setup.py install for mozlog 08:09:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:09:01 INFO - Running setup.py install for moznetwork 08:09:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:09:01 INFO - Running setup.py install for mozprocess 08:09:01 INFO - Running setup.py install for mozprofile 08:09:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:09:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:09:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:09:01 INFO - Running setup.py install for mozrunner 08:09:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:09:02 INFO - Running setup.py install for mozscreenshot 08:09:02 INFO - Running setup.py install for moztest 08:09:02 INFO - Running setup.py install for mozversion 08:09:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:09:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:02 INFO - Cleaning up... 08:09:02 INFO - Return code: 0 08:09:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:02 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 0x7f6b7bbc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc840>, '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 0x2b496b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b49b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:09:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:02 INFO - Using env: {'DISPLAY': ':0', 08:09:02 INFO - 'HOME': '/home/cltbld', 08:09:02 INFO - 'LANG': 'en_US.UTF-8', 08:09:02 INFO - 'LANGUAGE': 'en_US:en', 08:09:02 INFO - 'LOGNAME': 'cltbld', 08:09:02 INFO - 'MAIL': '/var/mail/cltbld', 08:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:02 INFO - 'MOZ_NO_REMOTE': '1', 08:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:02 INFO - 'NO_EM_RESTART': '1', 08:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:02 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:02 INFO - 'SHELL': '/bin/bash', 08:09:02 INFO - 'SHLVL': '1', 08:09:02 INFO - 'TERM': 'linux', 08:09:02 INFO - 'TMOUT': '86400', 08:09:02 INFO - 'USER': 'cltbld', 08:09:02 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 08:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:02 INFO - '_': '/tools/buildbot/bin/python'} 08:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:09:02 INFO - Running setup.py (path:/tmp/pip-Gnlump-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:09:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 08:09:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:09:02 INFO - Running setup.py (path:/tmp/pip-PsPrTI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:09:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:09:02 INFO - Running setup.py (path:/tmp/pip-5iPCw7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:09:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 08:09:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:09:02 INFO - Running setup.py (path:/tmp/pip-zIAmfC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:09:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:09:02 INFO - Running setup.py (path:/tmp/pip-LMsjnm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 08:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:09:03 INFO - Running setup.py (path:/tmp/pip-DB_MKT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 08:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:09:03 INFO - Running setup.py (path:/tmp/pip-tEf9X9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 08:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:09:03 INFO - Running setup.py (path:/tmp/pip-TbNuLG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 08:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:09:03 INFO - Running setup.py (path:/tmp/pip-1s4bT0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 08:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:09:03 INFO - Running setup.py (path:/tmp/pip-VOThB4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:09:03 INFO - Running setup.py (path:/tmp/pip-0m_gFj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 08:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:09:03 INFO - Running setup.py (path:/tmp/pip-jJeYno-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 08:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:09:03 INFO - Running setup.py (path:/tmp/pip-fmh0aJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 08:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:09:03 INFO - Running setup.py (path:/tmp/pip-b0MBZf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 08:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:09:03 INFO - Running setup.py (path:/tmp/pip-sdBovq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 08:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:09:03 INFO - Running setup.py (path:/tmp/pip-WD7wxq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 08:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:09:03 INFO - Running setup.py (path:/tmp/pip-tNUzVz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:05 INFO - Downloading blessings-1.5.1.tar.gz 08:09:05 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:09:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:05 INFO - Installing collected packages: blessings 08:09:05 INFO - Running setup.py install for blessings 08:09:05 INFO - Successfully installed blessings 08:09:05 INFO - Cleaning up... 08:09:05 INFO - Return code: 0 08:09:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:09:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:09:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:09:06 INFO - Reading from file tmpfile_stdout 08:09:06 INFO - Current package versions: 08:09:06 INFO - argparse == 1.2.1 08:09:06 INFO - blessings == 1.5.1 08:09:06 INFO - blobuploader == 1.2.4 08:09:06 INFO - docopt == 0.6.1 08:09:06 INFO - manifestparser == 1.1 08:09:06 INFO - mozInstall == 1.12 08:09:06 INFO - mozcrash == 0.16 08:09:06 INFO - mozdebug == 0.1 08:09:06 INFO - mozdevice == 0.47 08:09:06 INFO - mozfile == 1.2 08:09:06 INFO - mozhttpd == 0.7 08:09:06 INFO - mozinfo == 0.9 08:09:06 INFO - mozleak == 0.1 08:09:06 INFO - mozlog == 3.1 08:09:06 INFO - moznetwork == 0.27 08:09:06 INFO - mozprocess == 0.22 08:09:06 INFO - mozprofile == 0.28 08:09:06 INFO - mozrunner == 6.11 08:09:06 INFO - mozscreenshot == 0.1 08:09:06 INFO - mozsystemmonitor == 0.0 08:09:06 INFO - moztest == 0.7 08:09:06 INFO - mozversion == 1.4 08:09:06 INFO - psutil == 3.1.1 08:09:06 INFO - requests == 1.2.3 08:09:06 INFO - wsgiref == 0.1.2 08:09:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f6b7bbc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc840>, '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 0x2b496b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b49b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 08:09:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:06 INFO - Using env: {'DISPLAY': ':0', 08:09:06 INFO - 'HOME': '/home/cltbld', 08:09:06 INFO - 'LANG': 'en_US.UTF-8', 08:09:06 INFO - 'LANGUAGE': 'en_US:en', 08:09:06 INFO - 'LOGNAME': 'cltbld', 08:09:06 INFO - 'MAIL': '/var/mail/cltbld', 08:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:06 INFO - 'MOZ_NO_REMOTE': '1', 08:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:06 INFO - 'NO_EM_RESTART': '1', 08:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:06 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:06 INFO - 'SHELL': '/bin/bash', 08:09:06 INFO - 'SHLVL': '1', 08:09:06 INFO - 'TERM': 'linux', 08:09:06 INFO - 'TMOUT': '86400', 08:09:06 INFO - 'USER': 'cltbld', 08:09:06 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 08:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:06 INFO - '_': '/tools/buildbot/bin/python'} 08:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:09:06 INFO - Cleaning up... 08:09:06 INFO - Return code: 0 08:09:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6b7bbc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc840>, '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 0x2b496b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b49b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 08:09:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:09:06 INFO - Using env: {'DISPLAY': ':0', 08:09:06 INFO - 'HOME': '/home/cltbld', 08:09:06 INFO - 'LANG': 'en_US.UTF-8', 08:09:06 INFO - 'LANGUAGE': 'en_US:en', 08:09:06 INFO - 'LOGNAME': 'cltbld', 08:09:06 INFO - 'MAIL': '/var/mail/cltbld', 08:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:06 INFO - 'MOZ_NO_REMOTE': '1', 08:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:06 INFO - 'NO_EM_RESTART': '1', 08:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:06 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:06 INFO - 'SHELL': '/bin/bash', 08:09:06 INFO - 'SHLVL': '1', 08:09:06 INFO - 'TERM': 'linux', 08:09:06 INFO - 'TMOUT': '86400', 08:09:06 INFO - 'USER': 'cltbld', 08:09:06 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 08:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:06 INFO - '_': '/tools/buildbot/bin/python'} 08:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:06 INFO - Downloading/unpacking jsonschema 08:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:09:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:09:08 INFO - Downloading/unpacking functools32 (from jsonschema) 08:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:08 INFO - Downloading functools32-3.2.3-2.tar.gz 08:09:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:09:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:09:08 INFO - warning: no files found matching '*.txt' 08:09:08 INFO - no previously-included directories found matching 'build' 08:09:08 INFO - no previously-included directories found matching 'dist' 08:09:08 INFO - no previously-included directories found matching '.git*' 08:09:08 INFO - Installing collected packages: jsonschema, functools32 08:09:08 INFO - Running setup.py install for functools32 08:09:08 INFO - warning: no files found matching '*.txt' 08:09:08 INFO - no previously-included directories found matching 'build' 08:09:08 INFO - no previously-included directories found matching 'dist' 08:09:08 INFO - no previously-included directories found matching '.git*' 08:09:08 INFO - Successfully installed jsonschema functools32 08:09:08 INFO - Cleaning up... 08:09:08 INFO - Return code: 0 08:09:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f6b7bbc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc840>, '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 0x2b496b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b49b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:09:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:09:08 INFO - Using env: {'DISPLAY': ':0', 08:09:08 INFO - 'HOME': '/home/cltbld', 08:09:08 INFO - 'LANG': 'en_US.UTF-8', 08:09:08 INFO - 'LANGUAGE': 'en_US:en', 08:09:08 INFO - 'LOGNAME': 'cltbld', 08:09:08 INFO - 'MAIL': '/var/mail/cltbld', 08:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:08 INFO - 'MOZ_NO_REMOTE': '1', 08:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:08 INFO - 'NO_EM_RESTART': '1', 08:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:08 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:08 INFO - 'SHELL': '/bin/bash', 08:09:08 INFO - 'SHLVL': '1', 08:09:08 INFO - 'TERM': 'linux', 08:09:08 INFO - 'TMOUT': '86400', 08:09:08 INFO - 'USER': 'cltbld', 08:09:08 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 08:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:08 INFO - '_': '/tools/buildbot/bin/python'} 08:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:09 INFO - Downloading/unpacking flake8 08:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:09:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 08:09:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:09:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 08:09:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 08:09:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:09:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:11 INFO - no previously-included directories found matching 'docs/_build' 08:09:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:09:11 INFO - Running setup.py install for pep8 08:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:11 INFO - no previously-included directories found matching 'docs/_build' 08:09:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:09:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:09:11 INFO - Cleaning up... 08:09:11 INFO - Return code: 0 08:09:11 INFO - Running post-action listener: _resource_record_post_action 08:09:11 INFO - Running post-action listener: _start_resource_monitoring 08:09:11 INFO - Starting resource monitoring. 08:09:11 INFO - ##### 08:09:11 INFO - ##### Running install step. 08:09:11 INFO - ##### 08:09:11 INFO - Running pre-action listener: _resource_record_pre_action 08:09:11 INFO - Running main action method: install 08:09:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:09:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:09:11 INFO - Reading from file tmpfile_stdout 08:09:11 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:09:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:09:11 INFO - Reading from file tmpfile_stdout 08:09:11 INFO - Output received: 08:09:11 INFO - Usage: mozinstall [options] installer 08:09:11 INFO - Options: 08:09:11 INFO - -h, --help show this help message and exit 08:09:11 INFO - -d DEST, --destination=DEST 08:09:11 INFO - Directory to install application into. [default: 08:09:11 INFO - "/builds/slave/test-pgo"] 08:09:11 INFO - --app=APP Application being installed. [default: firefox] 08:09:11 INFO - mkdir: /builds/slave/test-pgo/build/application 08:09:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 08:09:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 08:09:27 INFO - Reading from file tmpfile_stdout 08:09:27 INFO - Output received: 08:09:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:09:27 INFO - Running post-action listener: _resource_record_post_action 08:09:27 INFO - ##### 08:09:27 INFO - ##### Running run-tests step. 08:09:27 INFO - ##### 08:09:27 INFO - Running pre-action listener: _resource_record_pre_action 08:09:27 INFO - Running main action method: run_tests 08:09:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:09:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:09:27 INFO - Python 2.7.3 08:09:27 INFO - Return code: 0 08:09:27 INFO - grabbing minidump binary from tooltool 08:09: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')]} 08:09:27 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 0x2bdc840>, '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 0x2b496b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b49b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:09:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 08:09:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:09:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:09:27 INFO - Return code: 0 08:09:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:09:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:09:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:09:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:09:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:09:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:09:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:09:28 INFO - Return code: 0 08:09:28 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/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 08:09:28 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/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 08:09:28 INFO - Using env: {'DISPLAY': ':0', 08:09:28 INFO - 'HOME': '/home/cltbld', 08:09:28 INFO - 'LANG': 'en_US.UTF-8', 08:09:28 INFO - 'LANGUAGE': 'en_US:en', 08:09:28 INFO - 'LOGNAME': 'cltbld', 08:09:28 INFO - 'MAIL': '/var/mail/cltbld', 08:09:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:09:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:28 INFO - 'MOZ_NO_REMOTE': '1', 08:09:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:28 INFO - 'NO_EM_RESTART': '1', 08:09:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:28 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:09:28 INFO - 'SHELL': '/bin/bash', 08:09:28 INFO - 'SHLVL': '1', 08:09:28 INFO - 'TERM': 'linux', 08:09:28 INFO - 'TMOUT': '86400', 08:09:28 INFO - 'USER': 'cltbld', 08:09:28 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371', 08:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:28 INFO - '_': '/tools/buildbot/bin/python'} 08:09:28 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/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:09:28 INFO - mozversion application_buildid: 20151231053005 08:09:28 INFO - mozversion application_changeset: 67bb1f081804c860ae1f463394407a922aa51c77 08:09:28 INFO - mozversion application_display_name: Nightly 08:09:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:09:28 INFO - mozversion application_name: Firefox 08:09:28 INFO - mozversion application_remotingname: firefox 08:09:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 08:09:28 INFO - mozversion application_vendor: Mozilla 08:09:28 INFO - mozversion application_version: 46.0a1 08:09:28 INFO - mozversion platform_buildid: 20151231053005 08:09:28 INFO - mozversion platform_changeset: 67bb1f081804c860ae1f463394407a922aa51c77 08:09:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 08:09:28 INFO - mozversion platform_version: 46.0a1 08:09:28 INFO - using testdate: 1451578168 08:09:28 INFO - actual date: 1451578168 08:09:28 INFO - starting webserver on 'localhost:58240' 08:09:28 INFO - SUITE-START | Running 3 tests 08:09:28 INFO - TEST-START | dromaeo_css 08:09:28 INFO - operating with platform_type : linux_ 08:09:28 INFO - Initialising browser for dromaeo_css test... 08:09:28 INFO - TEST-INFO | started process 12740 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4E8qby/profile http://localhost:58240/getInfo.html) 08:09:32 INFO - PROCESS | 12740 | __metrics Screen width/height:1600/1200 08:09:32 INFO - PROCESS | 12740 | colorDepth:24 08:09:32 INFO - PROCESS | 12740 | Browser inner width/height: 1024/697 08:09:32 INFO - PROCESS | 12740 | __metrics 08:09:32 INFO - PROCESS | 12740 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:09:32 INFO - PROCESS | 12740 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:09:33 INFO - TEST-INFO | 12740: exit 0 08:09:33 INFO - Browser initialized. 08:09:33 INFO - Running cycle 1/1 for dromaeo_css test... 08:09:33 INFO - TEST-INFO | started process 12833 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4E8qby/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:09:45 INFO - PROCESS | 12833 | RSS: Main: 149831680 08:09:45 INFO - PROCESS | 12833 | 08:10:37 INFO - PROCESS | 12833 | 1451578237245 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:12:45 INFO - PROCESS | 12833 | Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58240/tests/dromaeo/cssquery-ext.html) 08:12:46 INFO - PROCESS | 12833 | RSS: Main: 272375808 08:12:46 INFO - PROCESS | 12833 | 08:15:49 INFO - PROCESS | 12833 | Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-ext.html (next: http://localhost:58240/tests/dromaeo/cssquery-jquery.html) 08:15:50 INFO - PROCESS | 12833 | RSS: Main: 236236800 08:15:50 INFO - PROCESS | 12833 | 08:18:51 INFO - PROCESS | 12833 | Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58240/tests/dromaeo/cssquery-mootools.html) 08:18:52 INFO - PROCESS | 12833 | RSS: Main: 232665088 08:18:52 INFO - PROCESS | 12833 | 08:21:54 INFO - PROCESS | 12833 | Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58240/tests/dromaeo/cssquery-prototype.html) 08:21:54 INFO - PROCESS | 12833 | RSS: Main: 210546688 08:21:54 INFO - PROCESS | 12833 | 08:24:57 INFO - PROCESS | 12833 | Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58240/tests/dromaeo/cssquery-yui.html) 08:24:58 INFO - PROCESS | 12833 | RSS: Main: 215379968 08:24:58 INFO - PROCESS | 12833 | 08:28:00 INFO - PROCESS | 12833 | Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-yui.html (next: http://localhost:58240/tests/dromaeo/cssquery-dojo.html) 08:28:00 INFO - PROCESS | 12833 | RSS: Main: 307154944 08:28:00 INFO - PROCESS | 12833 | 08:28:00 INFO - PROCESS | 12833 | __start_tp_report 08:28:00 INFO - PROCESS | 12833 | _x_x_mozilla_page_load 08:28:00 INFO - PROCESS | 12833 | _x_x_mozilla_page_load_details 08:28:00 INFO - PROCESS | 12833 | |i|pagename|runs| 08:28:00 INFO - PROCESS | 12833 | |0;dojo.html;3154.306052668413;3180.363927214558;3222.6777322267776;3232.7898686585354;3264.412405766961;5174.146265866128;5264.552513036387;5295.894082118355;5304.893902121955;5316.494932981361;5324.387695415028;5371.060064488718;5405.432429594885;5425.104857698485;5440.510354068133;4840.273958906166;4858.271259311114;4882.121218180726;4886.291487734276;4945.208766597345;4768.809247630091;4772.188727916263;4787.784549695255;4844.346013288196;4851.854444366674;4815.422149342084;4818.638602104838;4881.243407271843;4914.14002549556;4950.628702847265;4846.127697014536;4847.854564363075;4848.17581011229;4849.781759820817;4895.828645997373;4833.516648335139;4836.395450568679;4837.61299096075;4856.077345304381;4880.755962201875;5047.116754567936;5140.614453915971;5143.819966301199;5241.3710354757295;5285.867853303698;5677.574181936371;5686.658800471943;5688.203651488795;5689.772409103631;5692.857678558069;5695.202671625934;5705.115707065412;5731.742071606787;5733.226014488033;5734.311882574118;5333.1733581294575;5361.383440904307;5389.865253368658;5454.7272636368025;5485.561155107582;5815.069588865761;5837.766489340379;5841.269841269841;5849.181114643953;5902.527797776168;5648.51987581052;5661.065924122474;5661.716914154358;5662.490375866109;5665.3768085510565;5606.6916319602815;5666.518345940559;5702.600817942787;5721.628094173865;5845.035569131046;5694.231278777312;5710.314762228559;5719.542436605062;5747.48272655463;5750.3099628044065;5719.19931209631;5737.3975732548315;5739.540836733051;5743.741531631086;5751.281089863767;4282.764447955392;4333.393324934512;4392.099619577979;4403.713758605681;4451.755153466591;3870.53553573573;3872.7095467839463;3880.5731369549326;3915.314819906505;3917.6278253565865;5269.051570717231;5271.05121078202;5273.050850846807;5275.683458992473;5282.2340760589495;5575.637583557137;5704.3154821421695;5705.144228365778;5725.8568535786935;5877.94122058774;5323.760430780624;5337.359516858002;5339.065663508871;5342.332208473941;5345.839624811262;4896.314515967767;4900.313956046157;4902.068606964665;4903.509649035139;4944.060628480577;5815.9709201453725;5863.413658634017;5973.074173503114;5977.342492325841;5998.25021872266;5771.134329850388;5805.158252053513;5807.535397168132;5814.098814683731;5833.125031245348;5980.43185897339;6012.909806352821;6015.488683461955;6017.217761690952;6025.337212906489;5477.397486276427;5548.334199896039;5602.915956260741;5605.1872478491205;5665.206871037975;5687.573431992534;5733.197352370588;5733.569982251264;5740.540756739534;5743.10981797822;5590.888182236414;5601.60788744784;5602.13166959122;5602.299712535933;5607.271054763018;5380.865478363072;5547.944520554743;5564.443555644403;5645.181448689999;5651.745671444713;5477.370102438271;5487.670739755627;5487.972560137334;5490.066688663017;5492.917606235989;5449.400565937823;5559.749811258423;5590.580706446952;5603.971980140073;5608.85977850557;5461.15352120422;5471.699056551928;5537.612367134262;5538.556915446674;5600.85997850057 08:28:00 INFO - PROCESS | 12833 | |1;ext.html;545.342861851469;549.0282200505106;564.4355644355644;573.4151165810873;586.9060950247962;27444.176674699742;27890;27897.3025674358;27915.441691166216;27933;35943.10142246445;36524.81737591315;36635.26729465409;36698;36772.999999999935;8401.747947561584;8534.786630334229;8540.530270835101;8570.700025499109;8573.699920502784;7520.059992500937;7647.464677472579;8268.338532917382;8373.07896131425;9976.152027077707;9918.355306905029;10043.045910638477;10052;10052.899471005307;10053.497325133714;9691.660791872286;9763.316567840255;9778.093271811927;9817.214622830228;9824.557894894711;7570.242975702386;7753.612319384065;9957.701268961942;10176.236782241362;10201.43892085935;35575.82212088949;36257.09357266063;36282.63717362819;36291.81854090739;36311.273774524365;2954.793164478487;3169.4611915974338;3558.839852206657;3611.9705883822985;4055.9391609125887;25793.484130317287;27505.31236719078;28986.42027159466;29239.56140657892;29991.850040749876;3872.67082298005;3906.4211050273766;3924.1955399143394;4014.41790940312;4084.9591504084874;275497;277236.99999999796;277642;277805;278813;57978.420215797305;58148.418515815145;58222;58400.415995839496;58498.70750646305;56030;57122.71438642863;64155.67922160453;64997.07513161919;65021;15790.36838526446;15906.363745450284;15923.840761592235;16018.75971860423;16039.759403608956;11398.373089480157;11532.308061516336;11539.71150721222;11542.13433992454;11543.422828858524;19033.61932761337;19045.142968566448;19163.137658805386;19174.61650767005;19210.327638532865;7835.451518393657;8092.595370231583;8203.753887383387;8233.46482478637;8253.917460825434;919.6367434863191;951.7002144324516;1054.4938429553856;1059.3537941855461;1064.669952314785;28082.29794255119;28582.714172858006;29827.552586711216;31044.844775775975;31239.375212495623;1029.330934892311;1031.2729525684374;1074.3768614203743;1126.2622981946838;1129.0459561670375;15668.921655391878;16219.080565498323;16232.918835405748;16334.75497867533;16479.505614831574;378541;384888;386242;387340;387371;55136.72431637816;55712.72143639337;55772.16341754877;55792.442075579536;55886.72056639691;1285.3637449462576;1342.3623778705232;1362.434589645286;1363.5704753002772;1376.4287820554357;23980.488290485693;28431.431371372044;30400.543991840583;31978.52032219472;32346.514802277514;47353.76323118362;47886.28170577374;47955.28067078927;47969.280460793816;48117.75941120272;281914;282645;284145;284490;288410;26410.339741506617;30087.398252035273;30394.240143996576;30725.692743072283;30956;37050.44424333691;40105;40135;40469.1906161881;40668;33830;34084.659153408145;34245.828770856984;34346;34651.4802277961;34511.96464106081;34753.1311717199;34838.82580587081;34895;38488.6151138485;35464;35574.64425355713;35847;38113.618863811;38933.80533097316;29476.263093421978;30337.393252134392;31222.843885780425;31352.37295254128;31407.68592314139;24752.752472475764;24895.434812773743;24933.376665583506;24968.625470618317;25059.248222553353 08:28:00 INFO - PROCESS | 12833 | |2;jquery.html;363.3731812623224;363.4348587945745;364.5060942423017;365.48101695592254;370.8535128624195;13680.65798355039;13774.44902203913;16304.673906521863;16744.246508907097;18181.545461363472;15721.84278157218;16207.270672819723;16218.675626487464;16363.59091022725;17134.22895969681;5338.652987555806;5489.533389661883;5491.450854914517;5494.780208791643;5494.917576236359;4034.435179074917;4163.708540402173;5439.129739241722;5485.807996720116;5780.335261444925;5780.450857168562;5821.476067153955;5829.329627092896;5831.037878750001;5904;5604;5757.769689212427;5785.53715702747;5787.826365209051;5804.564657650693;5072.771725272371;5076.111680455905;5081.704165437826;5081.923771143436;5112.539871411554;18880.339188128488;20591.58816823655;20900.5819883603;21150.471238219016;21162.153513859583;2087.77034526202;2107.89460526973;2149.817265532416;2420.854748715065;2448.4368595223023;13082.869171308355;13121.278329691862;13321.26733029683;13522;13595.592132236048;1790.7672002639704;1823.79026411963;1825.7443957845912;1852.0739630184908;1901.6957286834179;57362;59985.10022349668;60450;60470.395296047354;60498.79002419971;9184.403013804082;9457.43255404678;10079.530515023866;10105.797884042278;10166.491675416348;13276;13328.400221990034;13357.79596366608;13377.398017089254;13409.32953352348;7565.394768418513;7568.5458872466725;7598.35413989806;7644.885326720104;7762;7409.147947985943;7418.851622967511;7449.329560339595;7500.849983000418;7527.661255243527;5954.46409823118;6056.939430605726;6065.181200537871;6065.484433823174;6102.511799056065;1653.9338426463048;1734.453647101159;1757.1214392803597;1768.3191971090964;1809.972850407245;392.39962856829095;395.48191868652157;902.1835239108486;932.0539652252969;942.7595963029383;9786.706398807904;9996;10190.949045254874;15981.714784350297;16584.253708583143;900.1718419054486;938.0572524612857;938.8450905600499;944.6882528765491;986.1962500562018;8663.263622592025;8703.95648021756;8710.390272680977;8885.511296878605;8999.865002024975;522228;534714;539797;543212;567980;41525.58474415217;41533.58466415297;79038.20961790308;81919.18080819116;84234.15765842385;1080.1089101491143;1125.97748045037;1130.1354463835173;1131.2081542919989;1145.387217838469;14498.275086245856;14774.113553186844;14974.925125374304;15319.540413787605;15760;35077.824610876785;35190.29619407649;35217.47173792344;35592.82203588966;36697.81651091728;46347.53652463432;47511.28733069076;47889;48120;48502.5149748498;9119.544022798966;9510.286728495252;9512.714618561455;9513.381630194015;9526.285528585246;16974.830251697324;17280.395186168425;17418.12909354502;17680.91159544194;18047.368342107962;9000.594973226089;13176;13385.129966552144;13858.722825543635;13860.653483662585;11674.241174323643;13091.279979601213;13754.037217394687;13952.58142255734;14219.431222750974;13200.273984930922;13300.733985320432;13391.200239449423;14130.929345353208;14136.15183089018;9411.576479058596;9417.764555886157;9674.419534827934;9784.461854598065;9933.602655893683;9680.75798105053;14017.299135043411;14409.78385324242;14722.852771472148;14764.261786910396 08:28:00 INFO - PROCESS | 12833 | |3;mootools.html;1298.7727147749142;1446.7106578684263;1461.408129707468;1622.3348427144865;1825.9908700456497;6817.62503062332;7392.039034925466;7488.775336739893;7498.6625601847845;7524.322810947014;7311.341979221869;7501.4748967572295;7502.849943001137;7505.4370922180915;7520.924790752091;2211.977880221193;2271.1483193802324;2271.3299576624936;2271.897764600597;2274.4768703198274;2230.810381117607;2258.5144193998285;2290.393045842853;2291.679164916913;2299;2237.686723858661;2242.260054182116;2246.2362796649136;2246.4833088389682;2274.55646149001;2199.978000220009;2203.55928814237;2233.274185889576;2236.13908645172;2238.3620668109593;2147.0552956699003;2155.8275337972923;2173.673948907661;2175.369142948543;2178.5860686469678;7408.925910740877;7539.132999705049;7551.584662843541;7553.546787192786;7565.848683026364;4404.4494438195225;4445.688801783876;4461.040876211598;4478.596926276618;4504.459464864237;3085.1670049086847;3092.273315770792;3195.344954284366;3223.1458663454205;3236.838158092086;1085.7068591480336;1091.6397588795678;1097.3744965369742;1117.083991127276;1121.2039451989097;10457;10474.528646210938;10474.528646210938;10493.213009024354;10499.107575856062;4071.91856162881;4116.073883376216;4180.811863466151;4181.832726690959;4190;8997.055309192572;9003.279737620975;9007.414518056305;9015.233705135006;9015.459072455673;4613.169629466728;4622.537746225418;4625.398698169284;4654.511276315938;4666.32338310943;3744.2698673758355;3761.285355782393;4152.43942067823;4240.936385954213;4245.12974840157;3604.7296452766145;3614.2590768892314;3629.328574213779;3665.4135338345736;3716.758410703296;1131.9490622921824;1141.6974501756874;1182.5210789630214;1188.3107797477442;1196.8503937007874;928.9674861379955;948.8719022931816;949.4730424614268;1079.9514021868877;1096.9907684929883;7151.141862976372;7171.820704482429;7189.352958233784;7209.567425954459;7241.131064272321;1112.2436743014666;1120.3725913488472;1162.041315914374;1167.4746364136172;1185.8576970763563;5579.2746942897975;5741.339745929188;5772;5773.134029895466;5797.24635797352;9182.219511341611;9220.44677319363;9256.8611470828;9383.202427793714;9417.011213822587;9192.540372981324;9312.115349041831;9318.90681093194;9324.347295689373;9339.673111441067;7250.383717384081;7252.492325537267;7275.090613673291;7440.14438339587;7447.85104297911;6887.793366199022;6928.099347084847;6935.618540980295;6937.236903940461;6956.617386043817;8092.231238032377;8348.582570871311;8411.411201215857;8441.66233350659;8444.071152173134;8169.142240064945;8181.468204566922;8201.83596328082;8337.916620833957;8599.785005374915;6624.403803657501;6752.527323087336;6840.965795170992;6903.965480172567;6922.134733158356;7283.2352602975925;7327.670254838438;7333.120025596749;7338.339549440576;7343.596102214429;6559.114519539992;6669.266380698023;6716.194056713226;6744.426723728342;6821.965890170517;6553.344665533599;6557.475401967736;6569.671516424064;6611.074449576967;6647.867042659023;6674.299198584079;6698.2631910488835;6702.798916032527;6708.563943343667;6710.228323742636;6033.276006879027;6104.20645316106;6129.785457509144;6144.846378840565;6182;6217.689115544114;6293.779717709858;6300.401461861299;6300.432961033529;6307.24313082433 08:28:00 INFO - PROCESS | 12833 | |4;prototype.html;328.90626171541106;338.9542411774411;345.4748781851584;347.58290051937684;356.4830995057166;5855.121731740241;5904.0553511438175;5992.970035149823;6008.519318454524;6015.3082395524525;5919.585629005971;5923.614965027281;5939.7921072762465;5940.227770389854;5942.257217847769;4539.296409056601;4624.699394539361;4631.583157515823;4645.790939407718;4647.581717645411;4605.838795642153;4615.907681846378;4630.675852690313;4631.791569379386;4634.23535116707;4577.839775607855;4582.404287442628;4593.724376537419;4593.862184134465;4603.723776573416;4358.041230929206;4435.467743870724;4437.800298986521;4571.5428457154185;4575.679702420832;3955.48578684772;3978.423128646359;3993.7603743775176;4000.959990400117;4012.578679238696;5532.3637781655225;5617.606767526275;5619.129034999582;5631.2960879890015;5640.069388550925;5045.117104506697;5146.047981123466;5165.819196328111;5303.310569625963;5329.493698098674;6258.74965001404;6259.217597800275;6272.372762723737;6279.843003924892;6283.371662833726;4508.165989291959;4511.075229577928;4511.661625378077;4512.45850497939;4515.277555591122;6407.519436042316;6454.580452270588;6517.315681853384;6519.217693876765;6524.6737663116655;4612.285095810154;4629.907401851944;4633.0733853229485;4633.675642704979;4639.489656137822;4698.765061746967;4699.671023028355;4705.058988202373;4705.176594096088;4707.082118986765;5334.91997620036;5347.893042139213;5352.00987817255;5352.090144675414;5352.705601191894;6192.256929168529;6306.306306306303;6308;6308.653024083719;6322.4942004639515;1639.7950256217973;1669.6577201673629;1669.9165041747865;1671.7408801635765;1672.7323628219426;1081.0918828184363;1123.4495097402378;1138.345451365468;1138.8519492465925;1140.2702270546856;5975.312839023481;5976.73104710289;5986.132010858489;5988.161657367972;5995.790147344822;6497.415232629086;6499.512536559777;6510.25132109804;6511.9348806511325;6514.088027676129;5868.471837534642;5972.910406343908;5974.984252676968;5983;5984.790532331347;3476.774009689362;3525.3125640499857;3527.2592755521628;3527.3474407234744;3528.752987290865;6664.1336626239245;6740.764073257413;6748.527603067836;6752.561083529555;6768.76309329181;6486.156799616019;6558.573692709959;6675.86648267032;6677.966610166918;6688.732450702015;6344.238691356974;6757.526973111835;6850.3149685032095;6875.931240687529;6879.690413931486;6614.702338394687;6614.966925165343;6615.206175259;6617.669116544057;6618.768343107968;6509.641969691523;6517.3808488193545;6518.869622607616;6522.706478208587;6524.4780417565535;6695.794756943602;6844.452443804584;6858.622775747382;6859.691313890787;6860.8284792878585;4704.811807527661;4704.858854234379;4705.317728929354;4708.223143181337;4710.010897711382;6590.209174899042;6592.80221593353;6601.273859875314;6603.438707709898;6606.504512161511;6214.098955651496;6327.070243575569;6329.873402531832;6418.807435776934;6438.67806609677;6360.872782544416;6379.649119298298;6400.615963042233;6401.743930242738;6419.679016049272;6269.592476489013;6269.843253918506;6281.371862813682;6284.057391391145;6297.275813281348;6312.116303717575;6397.712102955471;6413.967930160319;6428.19647544057;6432.549721519449;6244.625322480666;6256.562040657111;6265.310815810349;6265.373462653698;6280.717367718372 08:28:00 INFO - PROCESS | 12833 | |5;yui.html;703.8873780195169;736.318905012863;739.7854622159574;759.2710997442455;772.1776308231729;12394.752104957895;12567.622971310853;12601.180923239983;12614.621561353162;12639.052071094658;12927.288999105045;13051.804222936664;13056.151350162232;13057.542985995493;13074.411651475682;668.3283300283221;680.2823021712092;795.936325093994;822.5311572403732;823.7034667519688;825.7398919340388;825.9174082591753;832.92087251711;833.6582001379436;833.8582440985017;713.6110819603329;724.3770357492552;856.327782690588;869.2437579306013;870.3863776037878;853.90180129285;871.0288028847853;872.1365847810654;873.1879352202449;873.2402809555696;635.0791352538837;637.6492928889093;638.2659941067762;640.6540468147194;640.6732566391128;13515.864841351558;13673.863261367358;13676.931615341959;13694.863051369559;13696.726065478735;11899.583514577034;12051.457684404222;12318.81521777174;12321.75356492874;12450.190737602026;10063.899361006443;10112.443815590139;10155.949220253926;10457.372557646566;10457.633982810641;3592.4790905318846;3646.690031347339;3676.0442285006093;3679.22736225393;3759.5300587426573;45413.545864541265;45437.545624543665;46224.075518489444;46966.53033469656;46988.29517557205;9078.409903356262;9572.234221262283;9592.232621390272;9592.969611124228;9725.56234969428;17472.388466403616;17543.122843857756;17546.56133596645;17548.649027019645;17550.210240539207;7392.852142957111;7575.393968482508;7594.240575942362;7595;7756.185600511978;3974.980125099356;4137.110521237948;4156.127213285244;4205.474315710536;4321.783910804447;3132.7807053506035;3136.2159460134967;3155.4477966355794;3164.620245570546;3168;587.1486344799972;598.7934162713857;601.6089541797779;604.3139640403314;608.1151923950641;508.08037452211613;518.2019689677854;520.3989392251955;525.324957429701;528.7409169506914;7444.255574442513;7670.693172273047;7684.385249180053;7692.499987500794;7845.568493732785;570.30159416186;592;620.5904103291806;648.7761722205831;686.989695154573;3612.440071788877;3725.441183822394;3763.6236376362144;3912.5109361329833;3974.205158968218;49890.750546247036;51194.48805511897;51556.74221628943;51557;53292;46999.29501057487;47039.29441058387;47151;47218;47593.52406475891;43028.13943721108;43226.783866081096;43276.567234327886;43552.78223608862;44336.55663443389;7775.961120194589;8136.145704701158;8171.632276547451;8182.304504117216;8318.126596707501;32220.19449513781;32760.508592370657;33032.83483582567;33190;33437.498437523944;38434;40660.79669601633;42776.14447711091;42897.35653965131;42912.78543607262;9289.396189247947;10494.422806745702;10710.678679639623;10818.404987725751;10961.232713709964;10248.795024099625;10299.094667486539;10780.892191077988;11106.555737770723;11556.755302988706;9749.415035097916;9799.461029643438;10075.71461262179;10165.796684066425;10457.947710261704;10356.119729823049;10526.31578947366;10628.25602207838;10850.348979061282;10947.397893115955;6806.965965170142;8643.484944524467;9242.537873106452;9409.623615055594;10203.285769996326;8790.42862213954;9063.592138353923;9796.51017449139;9833.508324583885;10058.547365368722;7881.684732610632;8385;8642.827143457222;8674;8811.251043661361 08:28:00 INFO - PROCESS | 12833 | __end_tp_report 08:28:00 INFO - PROCESS | 12833 | __start_cc_report 08:28:00 INFO - PROCESS | 12833 | _x_x_mozilla_cycle_collect,942 08:28:00 INFO - PROCESS | 12833 | __end_cc_report 08:28:00 INFO - PROCESS | 12833 | __startTimestamp1451579280895__endTimestamp 08:28:00 INFO - PROCESS | 12833 | 08:28:00 INFO - PROCESS | 12833 | ------- Summary: start ------- 08:28:00 INFO - PROCESS | 12833 | Number of tests: 6 08:28:00 INFO - PROCESS | 12833 | 08:28:00 INFO - PROCESS | 12833 | [#0] dojo.html Cycles:165 Average:5305.82 Median:5487.97 stddev:596.26 (10.9%) stddev-sans-first:573.71 08:28:00 INFO - PROCESS | 12833 | Values: 3154.3 3180.4 3222.7 3232.8 3264.4 5174.1 5264.6 5295.9 5304.9 5316.5 5324.4 5371.1 5405.4 5425.1 5440.5 4840.3 4858.3 4882.1 4886.3 4945.2 4768.8 4772.2 4787.8 4844.3 4851.9 4815.4 4818.6 4881.2 4914.1 4950.6 4846.1 4847.9 4848.2 4849.8 4895.8 4833.5 4836.4 4837.6 4856.1 4880.8 5047.1 5140.6 5143.8 5241.4 5285.9 5677.6 5686.7 5688.2 5689.8 5692.9 5695.2 5705.1 5731.7 5733.2 5734.3 5333.2 5361.4 5389.9 5454.7 5485.6 5815.1 5837.8 5841.3 5849.2 5902.5 5648.5 5661.1 5661.7 5662.5 5665.4 5606.7 5666.5 5702.6 5721.6 5845.0 5694.2 5710.3 5719.5 5747.5 5750.3 5719.2 5737.4 5739.5 5743.7 5751.3 4282.8 4333.4 4392.1 4403.7 4451.8 3870.5 3872.7 3880.6 3915.3 3917.6 5269.1 5271.1 5273.1 5275.7 5282.2 5575.6 5704.3 5705.1 5725.9 5877.9 5323.8 5337.4 5339.1 5342.3 5345.8 4896.3 4900.3 4902.1 4903.5 4944.1 5816.0 5863.4 5973.1 5977.3 5998.3 5771.1 5805.2 5807.5 5814.1 5833.1 5980.4 6012.9 6015.5 6017.2 6025.3 5477.4 5548.3 5602.9 5605.2 5665.2 5687.6 5733.2 5733.6 5740.5 5743.1 5590.9 5601.6 5602.1 5602.3 5607.3 5380.9 5547.9 5564.4 5645.2 5651.7 5477.4 5487.7 5488.0 5490.1 5492.9 5449.4 5559.7 5590.6 5604.0 5608.9 5461.2 5471.7 5537.6 5538.6 5600.9 08:28:00 INFO - PROCESS | 12833 | 08:28:00 INFO - PROCESS | 12833 | [#1] ext.html Cycles:180 Average:47708.59 Median:34581.72 stddev:83883.87 (242.6%) stddev-sans-first:84044.44 08:28:00 INFO - PROCESS | 12833 | Values: 545.3 549.0 564.4 573.4 586.9 27444.2 27890.0 27897.3 27915.4 27933.0 35943.1 36524.8 36635.3 36698.0 36773.0 8401.7 8534.8 8540.5 8570.7 8573.7 7520.1 7647.5 8268.3 8373.1 9976.2 9918.4 10043.0 10052.0 10052.9 10053.5 9691.7 9763.3 9778.1 9817.2 9824.6 7570.2 7753.6 9957.7 10176.2 10201.4 35575.8 36257.1 36282.6 36291.8 36311.3 2954.8 3169.5 3558.8 3612.0 4055.9 25793.5 27505.3 28986.4 29239.6 29991.9 3872.7 3906.4 3924.2 4014.4 4085.0 275497.0 277237.0 277642.0 277805.0 278813.0 57978.4 58148.4 58222.0 58400.4 58498.7 56030.0 57122.7 64155.7 64997.1 65021.0 15790.4 15906.4 15923.8 16018.8 16039.8 11398.4 11532.3 11539.7 11542.1 11543.4 19033.6 19045.1 19163.1 19174.6 19210.3 7835.5 8092.6 8203.8 8233.5 8253.9 919.6 951.7 1054.5 1059.4 1064.7 28082.3 28582.7 29827.6 31044.8 31239.4 1029.3 1031.3 1074.4 1126.3 1129.0 15668.9 16219.1 16232.9 16334.8 16479.5 378541.0 384888.0 386242.0 387340.0 387371.0 55136.7 55712.7 55772.2 55792.4 55886.7 1285.4 1342.4 1362.4 1363.6 1376.4 23980.5 28431.4 30400.5 31978.5 32346.5 47353.8 47886.3 47955.3 47969.3 48117.8 281914.0 282645.0 284145.0 284490.0 288410.0 26410.3 30087.4 30394.2 30725.7 30956.0 37050.4 40105.0 40135.0 40469.2 40668.0 33830.0 34084.7 34245.8 34346.0 34651.5 34512.0 34753.1 34838.8 34895.0 38488.6 35464.0 35574.6 35847.0 38113.6 38933.8 29476.3 30337.4 31222.8 31352.4 31407.7 24752.8 24895.4 24933.4 24968.6 25059.2 08:28:00 INFO - PROCESS | 12833 | 08:28:00 INFO - PROCESS | 12833 | [#2] jquery.html Cycles:180 Average:28405.21 Median:2214.96 stddev:88387.52 (3990.5%) stddev-sans-first:88610.39 08:28:00 INFO - PROCESS | 12833 | Values: 363.4 363.4 364.5 365.5 370.9 13680.7 13774.4 16304.7 16744.2 18181.5 15721.8 16207.3 16218.7 16363.6 17134.2 5338.7 5489.5 5491.5 5494.8 5494.9 4034.4 4163.7 5439.1 5485.8 5780.3 5780.5 5821.5 5829.3 5831.0 5904.0 5604.0 5757.8 5785.5 5787.8 5804.6 5072.8 5076.1 5081.7 5081.9 5112.5 18880.3 20591.6 20900.6 21150.5 21162.2 2087.8 2107.9 2149.8 2420.9 2448.4 13082.9 13121.3 13321.3 13522.0 13595.6 1790.8 1823.8 1825.7 1852.1 1901.7 57362.0 59985.1 60450.0 60470.4 60498.8 9184.4 9457.4 10079.5 10105.8 10166.5 13276.0 13328.4 13357.8 13377.4 13409.3 7565.4 7568.5 7598.4 7644.9 7762.0 7409.1 7418.9 7449.3 7500.8 7527.7 5954.5 6056.9 6065.2 6065.5 6102.5 1653.9 1734.5 1757.1 1768.3 1810.0 392.4 395.5 902.2 932.1 942.8 9786.7 9996.0 10190.9 15981.7 16584.3 900.2 938.1 938.8 944.7 986.2 8663.3 8704.0 8710.4 8885.5 8999.9 522228.0 534714.0 539797.0 543212.0 567980.0 41525.6 41533.6 79038.2 81919.2 84234.2 1080.1 1126.0 1130.1 1131.2 1145.4 14498.3 14774.1 14974.9 15319.5 15760.0 35077.8 35190.3 35217.5 35592.8 36697.8 46347.5 47511.3 47889.0 48120.0 48502.5 9119.5 9510.3 9512.7 9513.4 9526.3 16974.8 17280.4 17418.1 17680.9 18047.4 9000.6 13176.0 13385.1 13858.7 13860.7 11674.2 13091.3 13754.0 13952.6 14219.4 13200.3 13300.7 13391.2 14130.9 14136.2 9411.6 9417.8 9674.4 9784.5 9933.6 9680.8 14017.3 14409.8 14722.9 14764.3 08:28:00 INFO - PROCESS | 12833 | 08:28:00 INFO - PROCESS | 12833 | [#3] mootools.html Cycles:180 Average:5332.81 Median:6163.42 stddev:2756.24 (44.7%) stddev-sans-first:2747.29 08:28:00 INFO - PROCESS | 12833 | Values: 1298.8 1446.7 1461.4 1622.3 1826.0 6817.6 7392.0 7488.8 7498.7 7524.3 7311.3 7501.5 7502.8 7505.4 7520.9 2212.0 2271.1 2271.3 2271.9 2274.5 2230.8 2258.5 2290.4 2291.7 2299.0 2237.7 2242.3 2246.2 2246.5 2274.6 2200.0 2203.6 2233.3 2236.1 2238.4 2147.1 2155.8 2173.7 2175.4 2178.6 7408.9 7539.1 7551.6 7553.5 7565.8 4404.4 4445.7 4461.0 4478.6 4504.5 3085.2 3092.3 3195.3 3223.1 3236.8 1085.7 1091.6 1097.4 1117.1 1121.2 10457.0 10474.5 10474.5 10493.2 10499.1 4071.9 4116.1 4180.8 4181.8 4190.0 8997.1 9003.3 9007.4 9015.2 9015.5 4613.2 4622.5 4625.4 4654.5 4666.3 3744.3 3761.3 4152.4 4240.9 4245.1 3604.7 3614.3 3629.3 3665.4 3716.8 1131.9 1141.7 1182.5 1188.3 1196.9 929.0 948.9 949.5 1080.0 1097.0 7151.1 7171.8 7189.4 7209.6 7241.1 1112.2 1120.4 1162.0 1167.5 1185.9 5579.3 5741.3 5772.0 5773.1 5797.2 9182.2 9220.4 9256.9 9383.2 9417.0 9192.5 9312.1 9318.9 9324.3 9339.7 7250.4 7252.5 7275.1 7440.1 7447.9 6887.8 6928.1 6935.6 6937.2 6956.6 8092.2 8348.6 8411.4 8441.7 8444.1 8169.1 8181.5 8201.8 8337.9 8599.8 6624.4 6752.5 6841.0 6904.0 6922.1 7283.2 7327.7 7333.1 7338.3 7343.6 6559.1 6669.3 6716.2 6744.4 6822.0 6553.3 6557.5 6569.7 6611.1 6647.9 6674.3 6698.3 6702.8 6708.6 6710.2 6033.3 6104.2 6129.8 6144.8 6182.0 6217.7 6293.8 6300.4 6300.4 6307.2 08:28:00 INFO - PROCESS | 12833 | 08:28:00 INFO - PROCESS | 12833 | [#4] prototype.html Cycles:180 Average:5315.54 Median:5976.02 stddev:1578.33 (26.4%) stddev-sans-first:1537.74 08:28:00 INFO - PROCESS | 12833 | Values: 328.9 339.0 345.5 347.6 356.5 5855.1 5904.1 5993.0 6008.5 6015.3 5919.6 5923.6 5939.8 5940.2 5942.3 4539.3 4624.7 4631.6 4645.8 4647.6 4605.8 4615.9 4630.7 4631.8 4634.2 4577.8 4582.4 4593.7 4593.9 4603.7 4358.0 4435.5 4437.8 4571.5 4575.7 3955.5 3978.4 3993.8 4001.0 4012.6 5532.4 5617.6 5619.1 5631.3 5640.1 5045.1 5146.0 5165.8 5303.3 5329.5 6258.7 6259.2 6272.4 6279.8 6283.4 4508.2 4511.1 4511.7 4512.5 4515.3 6407.5 6454.6 6517.3 6519.2 6524.7 4612.3 4629.9 4633.1 4633.7 4639.5 4698.8 4699.7 4705.1 4705.2 4707.1 5334.9 5347.9 5352.0 5352.1 5352.7 6192.3 6306.3 6308.0 6308.7 6322.5 1639.8 1669.7 1669.9 1671.7 1672.7 1081.1 1123.4 1138.3 1138.9 1140.3 5975.3 5976.7 5986.1 5988.2 5995.8 6497.4 6499.5 6510.3 6511.9 6514.1 5868.5 5972.9 5975.0 5983.0 5984.8 3476.8 3525.3 3527.3 3527.3 3528.8 6664.1 6740.8 6748.5 6752.6 6768.8 6486.2 6558.6 6675.9 6678.0 6688.7 6344.2 6757.5 6850.3 6875.9 6879.7 6614.7 6615.0 6615.2 6617.7 6618.8 6509.6 6517.4 6518.9 6522.7 6524.5 6695.8 6844.5 6858.6 6859.7 6860.8 4704.8 4704.9 4705.3 4708.2 4710.0 6590.2 6592.8 6601.3 6603.4 6606.5 6214.1 6327.1 6329.9 6418.8 6438.7 6360.9 6379.6 6400.6 6401.7 6419.7 6269.6 6269.8 6281.4 6284.1 6297.3 6312.1 6397.7 6414.0 6428.2 6432.5 6244.6 6256.6 6265.3 6265.4 6280.7 08:28:00 INFO - PROCESS | 12833 | 08:28:00 INFO - PROCESS | 12833 | [#5] yui.html Cycles:180 Average:12915.33 Median:47095.15 stddev:14767.79 (31.4%) stddev-sans-first:14780.74 08:28:00 INFO - PROCESS | 12833 | Values: 703.9 736.3 739.8 759.3 772.2 12394.8 12567.6 12601.2 12614.6 12639.1 12927.3 13051.8 13056.2 13057.5 13074.4 668.3 680.3 795.9 822.5 823.7 825.7 825.9 832.9 833.7 833.9 713.6 724.4 856.3 869.2 870.4 853.9 871.0 872.1 873.2 873.2 635.1 637.6 638.3 640.7 640.7 13515.9 13673.9 13676.9 13694.9 13696.7 11899.6 12051.5 12318.8 12321.8 12450.2 10063.9 10112.4 10155.9 10457.4 10457.6 3592.5 3646.7 3676.0 3679.2 3759.5 45413.5 45437.5 46224.1 46966.5 46988.3 9078.4 9572.2 9592.2 9593.0 9725.6 17472.4 17543.1 17546.6 17548.6 17550.2 7392.9 7575.4 7594.2 7595.0 7756.2 3975.0 4137.1 4156.1 4205.5 4321.8 3132.8 3136.2 3155.4 3164.6 3168.0 587.1 598.8 601.6 604.3 608.1 508.1 518.2 520.4 525.3 528.7 7444.3 7670.7 7684.4 7692.5 7845.6 570.3 592.0 620.6 648.8 687.0 3612.4 3725.4 3763.6 3912.5 3974.2 49890.8 51194.5 51556.7 51557.0 53292.0 46999.3 47039.3 47151.0 47218.0 47593.5 43028.1 43226.8 43276.6 43552.8 44336.6 7776.0 8136.1 8171.6 8182.3 8318.1 32220.2 32760.5 33032.8 33190.0 33437.5 38434.0 40660.8 42776.1 42897.4 42912.8 9289.4 10494.4 10710.7 10818.4 10961.2 10248.8 10299.1 10780.9 11106.6 11556.8 9749.4 9799.5 10075.7 10165.8 10457.9 10356.1 10526.3 10628.3 10850.3 10947.4 6807.0 8643.5 9242.5 9409.6 10203.3 8790.4 9063.6 9796.5 9833.5 10058.5 7881.7 8385.0 8642.8 8674.0 8811.3 08:28:00 INFO - PROCESS | 12833 | -------- Summary: end -------- 08:28:00 INFO - PROCESS | 12833 | 08:28:01 INFO - TEST-INFO | 12833: exit 0 08:28:01 INFO - TEST-OK | dromaeo_css | took 1112747ms 08:28:01 INFO - TEST-START | kraken 08:28:01 INFO - operating with platform_type : linux_ 08:28:01 INFO - Initialising browser for kraken test... 08:28:01 INFO - TEST-INFO | started process 13033 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvGO3ta/profile http://localhost:58240/getInfo.html) 08:28:05 INFO - PROCESS | 13033 | __metrics Screen width/height:1600/1200 08:28:05 INFO - PROCESS | 13033 | colorDepth:24 08:28:05 INFO - PROCESS | 13033 | Browser inner width/height: 1024/697 08:28:05 INFO - PROCESS | 13033 | __metrics 08:28:05 INFO - PROCESS | 13033 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:28:05 INFO - PROCESS | 13033 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:28:06 INFO - TEST-INFO | 13033: exit 0 08:28:06 INFO - Browser initialized. 08:28:06 INFO - Running cycle 1/1 for kraken test... 08:28:06 INFO - TEST-INFO | started process 13119 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvGO3ta/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:28:18 INFO - PROCESS | 13119 | RSS: Main: 149463040 08:28:18 INFO - PROCESS | 13119 | 08:28:20 INFO - PROCESS | 13119 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58240/tests/kraken/driver.html?testName=audio-beat-detection) 08:28:21 INFO - PROCESS | 13119 | RSS: Main: 182779904 08:28:21 INFO - PROCESS | 13119 | 08:28:23 INFO - PROCESS | 13119 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58240/tests/kraken/driver.html?testName=audio-dft) 08:28:24 INFO - PROCESS | 13119 | RSS: Main: 173264896 08:28:24 INFO - PROCESS | 13119 | 08:28:27 INFO - PROCESS | 13119 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58240/tests/kraken/driver.html?testName=audio-fft) 08:28:28 INFO - PROCESS | 13119 | RSS: Main: 159252480 08:28:28 INFO - PROCESS | 13119 | 08:28:30 INFO - PROCESS | 13119 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58240/tests/kraken/driver.html?testName=audio-oscillator) 08:28:30 INFO - PROCESS | 13119 | RSS: Main: 162193408 08:28:30 INFO - PROCESS | 13119 | 08:28:32 INFO - PROCESS | 13119 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:28:33 INFO - PROCESS | 13119 | RSS: Main: 165531648 08:28:33 INFO - PROCESS | 13119 | 08:28:36 INFO - PROCESS | 13119 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58240/tests/kraken/driver.html?testName=imaging-darkroom) 08:28:36 INFO - PROCESS | 13119 | RSS: Main: 163790848 08:28:36 INFO - PROCESS | 13119 | 08:28:40 INFO - PROCESS | 13119 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58240/tests/kraken/driver.html?testName=imaging-desaturate) 08:28:40 INFO - PROCESS | 13119 | RSS: Main: 165703680 08:28:40 INFO - PROCESS | 13119 | 08:28:43 INFO - PROCESS | 13119 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58240/tests/kraken/driver.html?testName=json-parse-financial) 08:28:44 INFO - PROCESS | 13119 | RSS: Main: 164134912 08:28:44 INFO - PROCESS | 13119 | 08:28:45 INFO - PROCESS | 13119 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:28:46 INFO - PROCESS | 13119 | RSS: Main: 176820224 08:28:46 INFO - PROCESS | 13119 | 08:28:48 INFO - PROCESS | 13119 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:28:48 INFO - PROCESS | 13119 | RSS: Main: 175681536 08:28:48 INFO - PROCESS | 13119 | 08:28:50 INFO - PROCESS | 13119 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:28:51 INFO - PROCESS | 13119 | RSS: Main: 190697472 08:28:51 INFO - PROCESS | 13119 | 08:28:53 INFO - PROCESS | 13119 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:28:54 INFO - PROCESS | 13119 | RSS: Main: 191578112 08:28:54 INFO - PROCESS | 13119 | 08:28:56 INFO - PROCESS | 13119 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:28:57 INFO - PROCESS | 13119 | RSS: Main: 191873024 08:28:57 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58240/tests/kraken/driver.html?testName=ai-astar) 08:28:59 INFO - PROCESS | 13119 | RSS: Main: 248659968 08:28:59 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | __start_tp_report 08:28:59 INFO - PROCESS | 13119 | _x_x_mozilla_page_load 08:28:59 INFO - PROCESS | 13119 | _x_x_mozilla_page_load_details 08:28:59 INFO - PROCESS | 13119 | |i|pagename|runs| 08:28:59 INFO - PROCESS | 13119 | |0;ai-astar;109;110;105;110;112;112;99;111;110;102 08:28:59 INFO - PROCESS | 13119 | |1;audio-beat-detection;158;126;149;172;128;156;152;127;164;126 08:28:59 INFO - PROCESS | 13119 | |2;audio-dft;161;161;161;161;161;162;160;161;161;163 08:28:59 INFO - PROCESS | 13119 | |3;audio-fft;75;72;85;94;75;72;74;110;93;71 08:28:59 INFO - PROCESS | 13119 | |4;audio-oscillator;97;97;143;97;97;96;146;96;96;141 08:28:59 INFO - PROCESS | 13119 | |5;imaging-gaussian-blur;110;110;109;109;109;109;109;109;109;108 08:28:59 INFO - PROCESS | 13119 | |6;imaging-darkroom;145;145;146;145;146;145;146;145;146;146 08:28:59 INFO - PROCESS | 13119 | |7;imaging-desaturate;96;95;96;97;96;96;97;97;97;97 08:28:59 INFO - PROCESS | 13119 | |8;json-parse-financial;57;57;57;57;56;57;60;67;56;56 08:28:59 INFO - PROCESS | 13119 | |9;json-stringify-tinderbox;69;69;69;68;70;69;69;68;69;69 08:28:59 INFO - PROCESS | 13119 | |10;stanford-crypto-aes;87;87;88;87;86;88;89;89;90;89 08:28:59 INFO - PROCESS | 13119 | |11;stanford-crypto-ccm;125;116;126;117;118;117;114;118;117;116 08:28:59 INFO - PROCESS | 13119 | |12;stanford-crypto-pbkdf2;141;153;153;150;153;142;152;152;150;139 08:28:59 INFO - PROCESS | 13119 | |13;stanford-crypto-sha256-iterative;67;69;67;67;70;68;69;67;67;68 08:28:59 INFO - PROCESS | 13119 | __end_tp_report 08:28:59 INFO - PROCESS | 13119 | __start_cc_report 08:28:59 INFO - PROCESS | 13119 | _x_x_mozilla_cycle_collect,931 08:28:59 INFO - PROCESS | 13119 | __end_cc_report 08:28:59 INFO - PROCESS | 13119 | __startTimestamp1451579339488__endTimestamp 08:28:59 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | ------- Summary: start ------- 08:28:59 INFO - PROCESS | 13119 | Number of tests: 14 08:28:59 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | [#0] ai-astar Cycles:10 Average:108.00 Median:110.50 stddev:4.47 (4.0%) stddev-sans-first:4.73 08:28:59 INFO - PROCESS | 13119 | Values: 109.0 110.0 105.0 110.0 112.0 112.0 99.0 111.0 110.0 102.0 08:28:59 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:154.00 stddev:17.55 (11.4%) stddev-sans-first:18.06 08:28:59 INFO - PROCESS | 13119 | Values: 158.0 126.0 149.0 172.0 128.0 156.0 152.0 127.0 164.0 126.0 08:28:59 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 08:28:59 INFO - PROCESS | 13119 | Values: 161.0 161.0 161.0 161.0 161.0 162.0 160.0 161.0 161.0 163.0 08:28:59 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:13.08 (17.4%) stddev-sans-first:13.62 08:28:59 INFO - PROCESS | 13119 | Values: 75.0 72.0 85.0 94.0 75.0 72.0 74.0 110.0 93.0 71.0 08:28:59 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:96.50 stddev:22.62 (23.4%) stddev-sans-first:23.45 08:28:59 INFO - PROCESS | 13119 | Values: 97.0 97.0 143.0 97.0 97.0 96.0 146.0 96.0 96.0 141.0 08:28:59 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 08:28:59 INFO - PROCESS | 13119 | Values: 110.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 108.0 08:28:59 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:28:59 INFO - PROCESS | 13119 | Values: 145.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 146.0 08:28:59 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 08:28:59 INFO - PROCESS | 13119 | Values: 96.0 95.0 96.0 97.0 96.0 96.0 97.0 97.0 97.0 97.0 08:28:59 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.00 stddev:3.37 (5.9%) stddev-sans-first:3.55 08:28:59 INFO - PROCESS | 13119 | Values: 57.0 57.0 57.0 57.0 56.0 57.0 60.0 67.0 56.0 56.0 08:28:59 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 08:28:59 INFO - PROCESS | 13119 | Values: 69.0 69.0 69.0 68.0 70.0 69.0 69.0 68.0 69.0 69.0 08:28:59 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:88.50 stddev:1.25 (1.4%) stddev-sans-first:1.27 08:28:59 INFO - PROCESS | 13119 | Values: 87.0 87.0 88.0 87.0 86.0 88.0 89.0 89.0 90.0 89.0 08:28:59 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:117.50 stddev:3.92 (3.3%) stddev-sans-first:3.35 08:28:59 INFO - PROCESS | 13119 | Values: 125.0 116.0 126.0 117.0 118.0 117.0 114.0 118.0 117.0 116.0 08:28:59 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.50 Median:152.00 stddev:5.56 (3.7%) stddev-sans-first:5.20 08:28:59 INFO - PROCESS | 13119 | Values: 141.0 153.0 153.0 150.0 153.0 142.0 152.0 152.0 150.0 139.0 08:28:59 INFO - PROCESS | 13119 | 08:28:59 INFO - PROCESS | 13119 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 08:28:59 INFO - PROCESS | 13119 | Values: 67.0 69.0 67.0 67.0 70.0 68.0 69.0 67.0 67.0 68.0 08:28:59 INFO - PROCESS | 13119 | -------- Summary: end -------- 08:28:59 INFO - PROCESS | 13119 | 08:29:00 INFO - TEST-INFO | 13119: exit 0 08:29:00 INFO - TEST-OK | kraken | took 58731ms 08:29:00 INFO - TEST-START | v8_7 08:29:00 INFO - operating with platform_type : linux_ 08:29:00 INFO - Initialising browser for v8_7 test... 08:29:00 INFO - TEST-INFO | started process 13367 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEThmKO/profile http://localhost:58240/getInfo.html) 08:29:03 INFO - PROCESS | 13367 | __metrics Screen width/height:1600/1200 08:29:03 INFO - PROCESS | 13367 | colorDepth:24 08:29:03 INFO - PROCESS | 13367 | Browser inner width/height: 1024/697 08:29:03 INFO - PROCESS | 13367 | __metrics 08:29:04 INFO - PROCESS | 13367 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:29:04 INFO - PROCESS | 13367 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:29:05 INFO - TEST-INFO | 13367: exit 0 08:29:05 INFO - Browser initialized. 08:29:05 INFO - Running cycle 1/1 for v8_7 test... 08:29:05 INFO - TEST-INFO | started process 13451 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEThmKO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:16 INFO - PROCESS | 13451 | RSS: Main: 149168128 08:29:16 INFO - PROCESS | 13451 | 08:29:38 INFO - PROCESS | 13451 | Cycle 1(1): loaded http://localhost:58240/tests/v8_7/run.html (next: http://localhost:58240/tests/v8_7/run.html) 08:29:38 INFO - PROCESS | 13451 | RSS: Main: 536346624 08:29:38 INFO - PROCESS | 13451 | 08:29:38 INFO - PROCESS | 13451 | __start_tp_report 08:29:38 INFO - PROCESS | 13451 | _x_x_mozilla_page_load 08:29:38 INFO - PROCESS | 13451 | _x_x_mozilla_page_load_details 08:29:38 INFO - PROCESS | 13451 | |i|pagename|runs| 08:29:38 INFO - PROCESS | 13451 | |0;Richards;168.18028927009755 08:29:38 INFO - PROCESS | 13451 | |1;DeltaBlue;192.67822736030828 08:29:38 INFO - PROCESS | 13451 | |2;Encrypt;286.1230329041488 08:29:38 INFO - PROCESS | 13451 | |3;Decrypt;5175.257731958763 08:29:38 INFO - PROCESS | 13451 | |4;RayTrace;1962.7450980392157 08:29:38 INFO - PROCESS | 13451 | |5;Earley;775.7951900698216 08:29:38 INFO - PROCESS | 13451 | |6;Boyer;12500 08:29:38 INFO - PROCESS | 13451 | |7;RegExp;26333.333333333332 08:29:38 INFO - PROCESS | 13451 | |8;Splay;582.2196397443347 08:29:38 INFO - PROCESS | 13451 | |9;NavierStokes;4822.115384615385 08:29:38 INFO - PROCESS | 13451 | __end_tp_report 08:29:38 INFO - PROCESS | 13451 | __startTimestamp1451579378705__endTimestamp 08:29:38 INFO - PROCESS | 13451 | 08:29:38 INFO - PROCESS | 13451 | ------- Summary: start ------- 08:29:38 INFO - PROCESS | 13451 | Number of tests: 10 08:29:38 INFO - PROCESS | 13451 | 08:29:38 INFO - PROCESS | 13451 | [#0] Richards Cycles:1 Average:168.18 Median:168.18 stddev:0.00 (0.0%) 08:29:38 INFO - PROCESS | 13451 | Values: 168.2 08:29:38 INFO - PROCESS | 13451 | 08:29:38 INFO - PROCESS | 13451 | [#1] DeltaBlue Cycles:1 Average:192.68 Median:192.68 stddev:0.00 (0.0%) 08:29:38 INFO - PROCESS | 13451 | Values: 192.7 08:29:38 INFO - PROCESS | 13451 | 08:29:38 INFO - PROCESS | 13451 | [#2] Encrypt Cycles:1 Average:286.12 Median:286.12 stddev:0.00 (0.0%) 08:29:38 INFO - PROCESS | 13451 | Values: 286.1 08:29:38 INFO - PROCESS | 13451 | 08:29:38 INFO - PROCESS | 13451 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 08:29:38 INFO - PROCESS | 13451 | Values: 5175.3 08:29:38 INFO - PROCESS | 13451 | 08:29:38 INFO - PROCESS | 13451 | [#4] RayTrace Cycles:1 Average:1962.75 Median:1962.75 stddev:0.00 (0.0%) 08:29:38 INFO - PROCESS | 13451 | Values: 1962.7 08:29:38 INFO - PROCESS | 13451 | 08:29:38 INFO - PROCESS | 13451 | [#5] Earley Cycles:1 Average:775.80 Median:775.80 stddev:0.00 (0.0%) 08:29:38 INFO - PROCESS | 13451 | Values: 775.8 08:29:38 INFO - PROCESS | 13451 | 08:29:38 INFO - PROCESS | 13451 | [#6] Boyer Cycles:1 Average:12500.00 Median:12500.00 stddev:0.00 (0.0%) 08:29:38 INFO - PROCESS | 13451 | Values: 12500.0 08:29:38 INFO - PROCESS | 13451 | 08:29:38 INFO - PROCESS | 13451 | [#7] RegExp Cycles:1 Average:26333.33 Median:26333.33 stddev:0.00 (0.0%) 08:29:38 INFO - PROCESS | 13451 | Values: 26333.3 08:29:38 INFO - PROCESS | 13451 | 08:29:38 INFO - PROCESS | 13451 | [#8] Splay Cycles:1 Average:582.22 Median:582.22 stddev:0.00 (0.0%) 08:29:38 INFO - PROCESS | 13451 | Values: 582.2 08:29:38 INFO - PROCESS | 13451 | 08:29:38 INFO - PROCESS | 13451 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 08:29:38 INFO - PROCESS | 13451 | Values: 4822.1 08:29:38 INFO - PROCESS | 13451 | -------- Summary: end -------- 08:29:38 INFO - PROCESS | 13451 | 08:29:39 INFO - TEST-INFO | 13451: exit 0 08:29:39 INFO - TEST-OK | v8_7 | took 39166ms 08:29:39 INFO - SUITE-END | took 1210s 08:29:39 INFO - Completed test suite (00:20:10) 08:29:39 INFO - Working with test: dromaeo_css 08:29:39 INFO - Generating results file: dromaeo_css 08:29:39 INFO - Working with test: kraken 08:29:39 INFO - Generating results file: kraken 08:29:39 INFO - javascript benchmark 08:29:39 INFO - Working with test: v8_7 08:29:39 INFO - Generating results file: v8_7 08:29:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 08:29:39 INFO - process_Request line: dromaeo_css 6896.61 graph.html#tests=[[72,201,35]] 08:29:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:39 INFO - process_Request line: kraken 1508.40 graph.html#tests=[[232,201,35]] 08:29:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:39 INFO - process_Request line: v8_7 19791.25 graph.html#tests=[[230,201,35]] 08:29:39 INFO - RETURN: dromaeo_css: 6896.61 08:29:39 INFO - RETURN: kraken: 1508.40 08:29:39 INFO - RETURN: v8_7: 19791.25 08:29:39 INFO - javascript benchmark 08:29:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3154.306052668413, 3180.363927214558, 3222.6777322267776, 3232.7898686585354, 3264.412405766961, 5174.146265866128, 5264.552513036387, 5295.894082118355, 5304.893902121955, 5316.494932981361, 5324.387695415028, 5371.060064488718, 5405.432429594885, 5425.104857698485, 5440.510354068133, 4840.273958906166, 4858.271259311114, 4882.121218180726, 4886.291487734276, 4945.208766597345, 4768.809247630091, 4772.188727916263, 4787.784549695255, 4844.346013288196, 4851.854444366674, 4815.422149342084, 4818.638602104838, 4881.243407271843, 4914.14002549556, 4950.628702847265, 4846.127697014536, 4847.854564363075, 4848.17581011229, 4849.781759820817, 4895.828645997373, 4833.516648335139, 4836.395450568679, 4837.61299096075, 4856.077345304381, 4880.755962201875, 5047.116754567936, 5140.614453915971, 5143.819966301199, 5241.3710354757295, 5285.867853303698, 5677.574181936371, 5686.658800471943, 5688.203651488795, 5689.772409103631, 5692.857678558069, 5695.202671625934, 5705.115707065412, 5731.742071606787, 5733.226014488033, 5734.311882574118, 5333.1733581294575, 5361.383440904307, 5389.865253368658, 5454.7272636368025, 5485.561155107582, 5815.069588865761, 5837.766489340379, 5841.269841269841, 5849.181114643953, 5902.527797776168, 5648.51987581052, 5661.065924122474, 5661.716914154358, 5662.490375866109, 5665.3768085510565, 5606.6916319602815, 5666.518345940559, 5702.600817942787, 5721.628094173865, 5845.035569131046, 5694.231278777312, 5710.314762228559, 5719.542436605062, 5747.48272655463, 5750.3099628044065, 5719.19931209631, 5737.3975732548315, 5739.540836733051, 5743.741531631086, 5751.281089863767, 4282.764447955392, 4333.393324934512, 4392.099619577979, 4403.713758605681, 4451.755153466591, 3870.53553573573, 3872.7095467839463, 3880.5731369549326, 3915.314819906505, 3917.6278253565865, 5269.051570717231, 5271.05121078202, 5273.050850846807, 5275.683458992473, 5282.2340760589495, 5575.637583557137, 5704.3154821421695, 5705.144228365778, 5725.8568535786935, 5877.94122058774, 5323.760430780624, 5337.359516858002, 5339.065663508871, 5342.332208473941, 5345.839624811262, 4896.314515967767, 4900.313956046157, 4902.068606964665, 4903.509649035139, 4944.060628480577, 5815.9709201453725, 5863.413658634017, 5973.074173503114, 5977.342492325841, 5998.25021872266, 5771.134329850388, 5805.158252053513, 5807.535397168132, 5814.098814683731, 5833.125031245348, 5980.43185897339, 6012.909806352821, 6015.488683461955, 6017.217761690952, 6025.337212906489, 5477.397486276427, 5548.334199896039, 5602.915956260741, 5605.1872478491205, 5665.206871037975, 5687.573431992534, 5733.197352370588, 5733.569982251264, 5740.540756739534, 5743.10981797822, 5590.888182236414, 5601.60788744784, 5602.13166959122, 5602.299712535933, 5607.271054763018, 5380.865478363072, 5547.944520554743, 5564.443555644403, 5645.181448689999, 5651.745671444713, 5477.370102438271, 5487.670739755627, 5487.972560137334, 5490.066688663017, 5492.917606235989, 5449.400565937823, 5559.749811258423, 5590.580706446952, 5603.971980140073, 5608.85977850557, 5461.15352120422, 5471.699056551928, 5537.612367134262, 5538.556915446674, 5600.85997850057], "unit": "score", "name": "dojo.html", "value": 5266.822913054846}, {"lowerIsBetter": false, "replicates": [545.342861851469, 549.0282200505106, 564.4355644355644, 573.4151165810873, 586.9060950247962, 27444.176674699742, 27890.0, 27897.3025674358, 27915.441691166216, 27933.0, 35943.10142246445, 36524.81737591315, 36635.26729465409, 36698.0, 36772.999999999935, 8401.747947561584, 8534.786630334229, 8540.530270835101, 8570.700025499109, 8573.699920502784, 7520.059992500937, 7647.464677472579, 8268.338532917382, 8373.07896131425, 9976.152027077707, 9918.355306905029, 10043.045910638477, 10052.0, 10052.899471005307, 10053.497325133714, 9691.660791872286, 9763.316567840255, 9778.093271811927, 9817.214622830228, 9824.557894894711, 7570.242975702386, 7753.612319384065, 9957.701268961942, 10176.236782241362, 10201.43892085935, 35575.82212088949, 36257.09357266063, 36282.63717362819, 36291.81854090739, 36311.273774524365, 2954.793164478487, 3169.4611915974338, 3558.839852206657, 3611.9705883822985, 4055.9391609125887, 25793.484130317287, 27505.31236719078, 28986.42027159466, 29239.56140657892, 29991.850040749876, 3872.67082298005, 3906.4211050273766, 3924.1955399143394, 4014.41790940312, 4084.9591504084874, 275497.0, 277236.99999999796, 277642.0, 277805.0, 278813.0, 57978.420215797305, 58148.418515815145, 58222.0, 58400.415995839496, 58498.70750646305, 56030.0, 57122.71438642863, 64155.67922160453, 64997.07513161919, 65021.0, 15790.36838526446, 15906.363745450284, 15923.840761592235, 16018.75971860423, 16039.759403608956, 11398.373089480157, 11532.308061516336, 11539.71150721222, 11542.13433992454, 11543.422828858524, 19033.61932761337, 19045.142968566448, 19163.137658805386, 19174.61650767005, 19210.327638532865, 7835.451518393657, 8092.595370231583, 8203.753887383387, 8233.46482478637, 8253.917460825434, 919.6367434863191, 951.7002144324516, 1054.4938429553856, 1059.3537941855461, 1064.669952314785, 28082.29794255119, 28582.714172858006, 29827.552586711216, 31044.844775775975, 31239.375212495623, 1029.330934892311, 1031.2729525684374, 1074.3768614203743, 1126.2622981946838, 1129.0459561670375, 15668.921655391878, 16219.080565498323, 16232.918835405748, 16334.75497867533, 16479.505614831574, 378541.0, 384888.0, 386242.0, 387340.0, 387371.0, 55136.72431637816, 55712.72143639337, 55772.16341754877, 55792.442075579536, 55886.72056639691, 1285.3637449462576, 1342.3623778705232, 1362.434589645286, 1363.5704753002772, 1376.4287820554357, 23980.488290485693, 28431.431371372044, 30400.543991840583, 31978.52032219472, 32346.514802277514, 47353.76323118362, 47886.28170577374, 47955.28067078927, 47969.280460793816, 48117.75941120272, 281914.0, 282645.0, 284145.0, 284490.0, 288410.0, 26410.339741506617, 30087.398252035273, 30394.240143996576, 30725.692743072283, 30956.0, 37050.44424333691, 40105.0, 40135.0, 40469.1906161881, 40668.0, 33830.0, 34084.659153408145, 34245.828770856984, 34346.0, 34651.4802277961, 34511.96464106081, 34753.1311717199, 34838.82580587081, 34895.0, 38488.6151138485, 35464.0, 35574.64425355713, 35847.0, 38113.618863811, 38933.80533097316, 29476.263093421978, 30337.393252134392, 31222.843885780425, 31352.37295254128, 31407.68592314139, 24752.752472475764, 24895.434812773743, 24933.376665583506, 24968.625470618317, 25059.248222553353], "unit": "score", "name": "ext.html", "value": 18422.699132278638}, {"lowerIsBetter": false, "replicates": [363.3731812623224, 363.4348587945745, 364.5060942423017, 365.48101695592254, 370.8535128624195, 13680.65798355039, 13774.44902203913, 16304.673906521863, 16744.246508907097, 18181.545461363472, 15721.84278157218, 16207.270672819723, 16218.675626487464, 16363.59091022725, 17134.22895969681, 5338.652987555806, 5489.533389661883, 5491.450854914517, 5494.780208791643, 5494.917576236359, 4034.435179074917, 4163.708540402173, 5439.129739241722, 5485.807996720116, 5780.335261444925, 5780.450857168562, 5821.476067153955, 5829.329627092896, 5831.037878750001, 5904.0, 5604.0, 5757.769689212427, 5785.53715702747, 5787.826365209051, 5804.564657650693, 5072.771725272371, 5076.111680455905, 5081.704165437826, 5081.923771143436, 5112.539871411554, 18880.339188128488, 20591.58816823655, 20900.5819883603, 21150.471238219016, 21162.153513859583, 2087.77034526202, 2107.89460526973, 2149.817265532416, 2420.854748715065, 2448.4368595223023, 13082.869171308355, 13121.278329691862, 13321.26733029683, 13522.0, 13595.592132236048, 1790.7672002639704, 1823.79026411963, 1825.7443957845912, 1852.0739630184908, 1901.6957286834179, 57362.0, 59985.10022349668, 60450.0, 60470.395296047354, 60498.79002419971, 9184.403013804082, 9457.43255404678, 10079.530515023866, 10105.797884042278, 10166.491675416348, 13276.0, 13328.400221990034, 13357.79596366608, 13377.398017089254, 13409.32953352348, 7565.394768418513, 7568.5458872466725, 7598.35413989806, 7644.885326720104, 7762.0, 7409.147947985943, 7418.851622967511, 7449.329560339595, 7500.849983000418, 7527.661255243527, 5954.46409823118, 6056.939430605726, 6065.181200537871, 6065.484433823174, 6102.511799056065, 1653.9338426463048, 1734.453647101159, 1757.1214392803597, 1768.3191971090964, 1809.972850407245, 392.39962856829095, 395.48191868652157, 902.1835239108486, 932.0539652252969, 942.7595963029383, 9786.706398807904, 9996.0, 10190.949045254874, 15981.714784350297, 16584.253708583143, 900.1718419054486, 938.0572524612857, 938.8450905600499, 944.6882528765491, 986.1962500562018, 8663.263622592025, 8703.95648021756, 8710.390272680977, 8885.511296878605, 8999.865002024975, 522228.0, 534714.0, 539797.0, 543212.0, 567980.0, 41525.58474415217, 41533.58466415297, 79038.20961790308, 81919.18080819116, 84234.15765842385, 1080.1089101491143, 1125.97748045037, 1130.1354463835173, 1131.2081542919989, 1145.387217838469, 14498.275086245856, 14774.113553186844, 14974.925125374304, 15319.540413787605, 15760.0, 35077.824610876785, 35190.29619407649, 35217.47173792344, 35592.82203588966, 36697.81651091728, 46347.53652463432, 47511.28733069076, 47889.0, 48120.0, 48502.5149748498, 9119.544022798966, 9510.286728495252, 9512.714618561455, 9513.381630194015, 9526.285528585246, 16974.830251697324, 17280.395186168425, 17418.12909354502, 17680.91159544194, 18047.368342107962, 9000.594973226089, 13176.0, 13385.129966552144, 13858.722825543635, 13860.653483662585, 11674.241174323643, 13091.279979601213, 13754.037217394687, 13952.58142255734, 14219.431222750974, 13200.273984930922, 13300.733985320432, 13391.200239449423, 14130.929345353208, 14136.15183089018, 9411.576479058596, 9417.764555886157, 9674.419534827934, 9784.461854598065, 9933.602655893683, 9680.75798105053, 14017.299135043411, 14409.78385324242, 14722.852771472148, 14764.261786910396], "unit": "score", "name": "jquery.html", "value": 8763.96690904285}, {"lowerIsBetter": false, "replicates": [1298.7727147749142, 1446.7106578684263, 1461.408129707468, 1622.3348427144865, 1825.9908700456497, 6817.62503062332, 7392.039034925466, 7488.775336739893, 7498.6625601847845, 7524.322810947014, 7311.341979221869, 7501.4748967572295, 7502.849943001137, 7505.4370922180915, 7520.924790752091, 2211.977880221193, 2271.1483193802324, 2271.3299576624936, 2271.897764600597, 2274.4768703198274, 2230.810381117607, 2258.5144193998285, 2290.393045842853, 2291.679164916913, 2299.0, 2237.686723858661, 2242.260054182116, 2246.2362796649136, 2246.4833088389682, 2274.55646149001, 2199.978000220009, 2203.55928814237, 2233.274185889576, 2236.13908645172, 2238.3620668109593, 2147.0552956699003, 2155.8275337972923, 2173.673948907661, 2175.369142948543, 2178.5860686469678, 7408.925910740877, 7539.132999705049, 7551.584662843541, 7553.546787192786, 7565.848683026364, 4404.4494438195225, 4445.688801783876, 4461.040876211598, 4478.596926276618, 4504.459464864237, 3085.1670049086847, 3092.273315770792, 3195.344954284366, 3223.1458663454205, 3236.838158092086, 1085.7068591480336, 1091.6397588795678, 1097.3744965369742, 1117.083991127276, 1121.2039451989097, 10457.0, 10474.528646210938, 10474.528646210938, 10493.213009024354, 10499.107575856062, 4071.91856162881, 4116.073883376216, 4180.811863466151, 4181.832726690959, 4190.0, 8997.055309192572, 9003.279737620975, 9007.414518056305, 9015.233705135006, 9015.459072455673, 4613.169629466728, 4622.537746225418, 4625.398698169284, 4654.511276315938, 4666.32338310943, 3744.2698673758355, 3761.285355782393, 4152.43942067823, 4240.936385954213, 4245.12974840157, 3604.7296452766145, 3614.2590768892314, 3629.328574213779, 3665.4135338345736, 3716.758410703296, 1131.9490622921824, 1141.6974501756874, 1182.5210789630214, 1188.3107797477442, 1196.8503937007874, 928.9674861379955, 948.8719022931816, 949.4730424614268, 1079.9514021868877, 1096.9907684929883, 7151.141862976372, 7171.820704482429, 7189.352958233784, 7209.567425954459, 7241.131064272321, 1112.2436743014666, 1120.3725913488472, 1162.041315914374, 1167.4746364136172, 1185.8576970763563, 5579.2746942897975, 5741.339745929188, 5772.0, 5773.134029895466, 5797.24635797352, 9182.219511341611, 9220.44677319363, 9256.8611470828, 9383.202427793714, 9417.011213822587, 9192.540372981324, 9312.115349041831, 9318.90681093194, 9324.347295689373, 9339.673111441067, 7250.383717384081, 7252.492325537267, 7275.090613673291, 7440.14438339587, 7447.85104297911, 6887.793366199022, 6928.099347084847, 6935.618540980295, 6937.236903940461, 6956.617386043817, 8092.231238032377, 8348.582570871311, 8411.411201215857, 8441.66233350659, 8444.071152173134, 8169.142240064945, 8181.468204566922, 8201.83596328082, 8337.916620833957, 8599.785005374915, 6624.403803657501, 6752.527323087336, 6840.965795170992, 6903.965480172567, 6922.134733158356, 7283.2352602975925, 7327.670254838438, 7333.120025596749, 7338.339549440576, 7343.596102214429, 6559.114519539992, 6669.266380698023, 6716.194056713226, 6744.426723728342, 6821.965890170517, 6553.344665533599, 6557.475401967736, 6569.671516424064, 6611.074449576967, 6647.867042659023, 6674.299198584079, 6698.2631910488835, 6702.798916032527, 6708.563943343667, 6710.228323742636, 6033.276006879027, 6104.20645316106, 6129.785457509144, 6144.846378840565, 6182.0, 6217.689115544114, 6293.779717709858, 6300.401461861299, 6300.432961033529, 6307.24313082433], "unit": "score", "name": "mootools.html", "value": 4394.814835737879}, {"lowerIsBetter": false, "replicates": [328.90626171541106, 338.9542411774411, 345.4748781851584, 347.58290051937684, 356.4830995057166, 5855.121731740241, 5904.0553511438175, 5992.970035149823, 6008.519318454524, 6015.3082395524525, 5919.585629005971, 5923.614965027281, 5939.7921072762465, 5940.227770389854, 5942.257217847769, 4539.296409056601, 4624.699394539361, 4631.583157515823, 4645.790939407718, 4647.581717645411, 4605.838795642153, 4615.907681846378, 4630.675852690313, 4631.791569379386, 4634.23535116707, 4577.839775607855, 4582.404287442628, 4593.724376537419, 4593.862184134465, 4603.723776573416, 4358.041230929206, 4435.467743870724, 4437.800298986521, 4571.5428457154185, 4575.679702420832, 3955.48578684772, 3978.423128646359, 3993.7603743775176, 4000.959990400117, 4012.578679238696, 5532.3637781655225, 5617.606767526275, 5619.129034999582, 5631.2960879890015, 5640.069388550925, 5045.117104506697, 5146.047981123466, 5165.819196328111, 5303.310569625963, 5329.493698098674, 6258.74965001404, 6259.217597800275, 6272.372762723737, 6279.843003924892, 6283.371662833726, 4508.165989291959, 4511.075229577928, 4511.661625378077, 4512.45850497939, 4515.277555591122, 6407.519436042316, 6454.580452270588, 6517.315681853384, 6519.217693876765, 6524.6737663116655, 4612.285095810154, 4629.907401851944, 4633.0733853229485, 4633.675642704979, 4639.489656137822, 4698.765061746967, 4699.671023028355, 4705.058988202373, 4705.176594096088, 4707.082118986765, 5334.91997620036, 5347.893042139213, 5352.00987817255, 5352.090144675414, 5352.705601191894, 6192.256929168529, 6306.306306306303, 6308.0, 6308.653024083719, 6322.4942004639515, 1639.7950256217973, 1669.6577201673629, 1669.9165041747865, 1671.7408801635765, 1672.7323628219426, 1081.0918828184363, 1123.4495097402378, 1138.345451365468, 1138.8519492465925, 1140.2702270546856, 5975.312839023481, 5976.73104710289, 5986.132010858489, 5988.161657367972, 5995.790147344822, 6497.415232629086, 6499.512536559777, 6510.25132109804, 6511.9348806511325, 6514.088027676129, 5868.471837534642, 5972.910406343908, 5974.984252676968, 5983.0, 5984.790532331347, 3476.774009689362, 3525.3125640499857, 3527.2592755521628, 3527.3474407234744, 3528.752987290865, 6664.1336626239245, 6740.764073257413, 6748.527603067836, 6752.561083529555, 6768.76309329181, 6486.156799616019, 6558.573692709959, 6675.86648267032, 6677.966610166918, 6688.732450702015, 6344.238691356974, 6757.526973111835, 6850.3149685032095, 6875.931240687529, 6879.690413931486, 6614.702338394687, 6614.966925165343, 6615.206175259, 6617.669116544057, 6618.768343107968, 6509.641969691523, 6517.3808488193545, 6518.869622607616, 6522.706478208587, 6524.4780417565535, 6695.794756943602, 6844.452443804584, 6858.622775747382, 6859.691313890787, 6860.8284792878585, 4704.811807527661, 4704.858854234379, 4705.317728929354, 4708.223143181337, 4710.010897711382, 6590.209174899042, 6592.80221593353, 6601.273859875314, 6603.438707709898, 6606.504512161511, 6214.098955651496, 6327.070243575569, 6329.873402531832, 6418.807435776934, 6438.67806609677, 6360.872782544416, 6379.649119298298, 6400.615963042233, 6401.743930242738, 6419.679016049272, 6269.592476489013, 6269.843253918506, 6281.371862813682, 6284.057391391145, 6297.275813281348, 6312.116303717575, 6397.712102955471, 6413.967930160319, 6428.19647544057, 6432.549721519449, 6244.625322480666, 6256.562040657111, 6265.310815810349, 6265.373462653698, 6280.717367718372], "unit": "score", "name": "prototype.html", "value": 4808.551881467661}, {"lowerIsBetter": false, "replicates": [703.8873780195169, 736.318905012863, 739.7854622159574, 759.2710997442455, 772.1776308231729, 12394.752104957895, 12567.622971310853, 12601.180923239983, 12614.621561353162, 12639.052071094658, 12927.288999105045, 13051.804222936664, 13056.151350162232, 13057.542985995493, 13074.411651475682, 668.3283300283221, 680.2823021712092, 795.936325093994, 822.5311572403732, 823.7034667519688, 825.7398919340388, 825.9174082591753, 832.92087251711, 833.6582001379436, 833.8582440985017, 713.6110819603329, 724.3770357492552, 856.327782690588, 869.2437579306013, 870.3863776037878, 853.90180129285, 871.0288028847853, 872.1365847810654, 873.1879352202449, 873.2402809555696, 635.0791352538837, 637.6492928889093, 638.2659941067762, 640.6540468147194, 640.6732566391128, 13515.864841351558, 13673.863261367358, 13676.931615341959, 13694.863051369559, 13696.726065478735, 11899.583514577034, 12051.457684404222, 12318.81521777174, 12321.75356492874, 12450.190737602026, 10063.899361006443, 10112.443815590139, 10155.949220253926, 10457.372557646566, 10457.633982810641, 3592.4790905318846, 3646.690031347339, 3676.0442285006093, 3679.22736225393, 3759.5300587426573, 45413.545864541265, 45437.545624543665, 46224.075518489444, 46966.53033469656, 46988.29517557205, 9078.409903356262, 9572.234221262283, 9592.232621390272, 9592.969611124228, 9725.56234969428, 17472.388466403616, 17543.122843857756, 17546.56133596645, 17548.649027019645, 17550.210240539207, 7392.852142957111, 7575.393968482508, 7594.240575942362, 7595.0, 7756.185600511978, 3974.980125099356, 4137.110521237948, 4156.127213285244, 4205.474315710536, 4321.783910804447, 3132.7807053506035, 3136.2159460134967, 3155.4477966355794, 3164.620245570546, 3168.0, 587.1486344799972, 598.7934162713857, 601.6089541797779, 604.3139640403314, 608.1151923950641, 508.08037452211613, 518.2019689677854, 520.3989392251955, 525.324957429701, 528.7409169506914, 7444.255574442513, 7670.693172273047, 7684.385249180053, 7692.499987500794, 7845.568493732785, 570.30159416186, 592.0, 620.5904103291806, 648.7761722205831, 686.989695154573, 3612.440071788877, 3725.441183822394, 3763.6236376362144, 3912.5109361329833, 3974.205158968218, 49890.750546247036, 51194.48805511897, 51556.74221628943, 51557.0, 53292.0, 46999.29501057487, 47039.29441058387, 47151.0, 47218.0, 47593.52406475891, 43028.13943721108, 43226.783866081096, 43276.567234327886, 43552.78223608862, 44336.55663443389, 7775.961120194589, 8136.145704701158, 8171.632276547451, 8182.304504117216, 8318.126596707501, 32220.19449513781, 32760.508592370657, 33032.83483582567, 33190.0, 33437.498437523944, 38434.0, 40660.79669601633, 42776.14447711091, 42897.35653965131, 42912.78543607262, 9289.396189247947, 10494.422806745702, 10710.678679639623, 10818.404987725751, 10961.232713709964, 10248.795024099625, 10299.094667486539, 10780.892191077988, 11106.555737770723, 11556.755302988706, 9749.415035097916, 9799.461029643438, 10075.71461262179, 10165.796684066425, 10457.947710261704, 10356.119729823049, 10526.31578947366, 10628.25602207838, 10850.348979061282, 10947.397893115955, 6806.965965170142, 8643.484944524467, 9242.537873106452, 9409.623615055594, 10203.285769996326, 8790.42862213954, 9063.592138353923, 9796.51017449139, 9833.508324583885, 10058.547365368722, 7881.684732610632, 8385.0, 8642.827143457222, 8674.0, 8811.251043661361], "unit": "score", "name": "yui.html", "value": 5987.105170452196}], "name": "dromaeo_css", "value": 6896.609717814269}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 110.0, 112.0, 112.0, 99.0, 111.0, 110.0, 102.0], "unit": "score", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [158.0, 126.0, 149.0, 172.0, 128.0, 156.0, 152.0, 127.0, 164.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.8}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 160.0, 161.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 85.0, 94.0, 75.0, 72.0, 74.0, 110.0, 93.0, 71.0], "unit": "score", "name": "audio-fft", "value": 82.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 143.0, 97.0, 97.0, 96.0, 146.0, 96.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 97.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 57.0, 56.0, 57.0, 60.0, 67.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 68.0, 70.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 88.0, 87.0, 86.0, 88.0, 89.0, 89.0, 90.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.0}, {"lowerIsBetter": true, "replicates": [125.0, 116.0, 126.0, 117.0, 118.0, 117.0, 114.0, 118.0, 117.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [141.0, 153.0, 153.0, 150.0, 153.0, 142.0, 152.0, 152.0, 150.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.5}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 67.0, 70.0, 68.0, 69.0, 67.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1508.4000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.18028927009755], "unit": "score", "name": "Richards", "value": 209.90569199999996}, {"lowerIsBetter": false, "replicates": [192.67822736030828], "unit": "score", "name": "DeltaBlue", "value": 343.1524200000001}, {"lowerIsBetter": false, "replicates": [286.1230329041488], "unit": "score", "name": "Encrypt", "value": 930.302595}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1962.7450980392157], "unit": "score", "name": "RayTrace", "value": 377.0173726273725}, {"lowerIsBetter": false, "replicates": [775.7951900698216], "unit": "score", "name": "Earley", "value": 859.0708069999997}, {"lowerIsBetter": false, "replicates": [12500.0], "unit": "score", "name": "Boyer", "value": 53.31704}, {"lowerIsBetter": false, "replicates": [26333.333333333332], "unit": "score", "name": "RegExp", "value": 34.59436708860757}, {"lowerIsBetter": false, "replicates": [582.2196397443347], "unit": "score", "name": "Splay", "value": 139.9660788423154}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19791.250966939962}]} 08:29:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19791.25"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1508.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6896.61"}}} 08:29:40 INFO - Return code: 0 08:29:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:29:40 INFO - # TBPL SUCCESS # 08:29:40 INFO - Running post-action listener: _resource_record_post_action 08:29:40 INFO - Running post-run listener: _resource_record_post_run 08:29:41 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 560132096; Read time: 0; Write time: 614856 08:29:41 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 252084224; Read time: 0; Write time: 370324 08:29:41 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 307871744; Read time: 0; Write time: 244512 08:29:41 INFO - Running post-run listener: _upload_blobber_files 08:29:41 INFO - Blob upload gear active. 08:29:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:29:41 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:29:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:29:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:29:41 INFO - (blobuploader) - INFO - Open directory for files ... 08:29:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:29:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:29:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:42 INFO - (blobuploader) - INFO - Done attempting. 08:29:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:29:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:29:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:43 INFO - (blobuploader) - INFO - Done attempting. 08:29:43 INFO - (blobuploader) - INFO - Iteration through files over. 08:29:43 INFO - Return code: 0 08:29:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:29:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:29:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/c45c43770070650903cb7d9a90f06ae3974846e43999e4caf331761ecc39b92c4631e5b1568243f08f22a460a3b11978137e3f6e3cb3ea6fc410c0b252e0f284", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/508795e7c5918735df08ba6b7801263de69aa80e9fa7344b2aa75e1d2a854c6148655b65bcde247d1527a30aa6d93e6d06914a4756cf863cae4ff0b77f8f8f2e"} 08:29:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:29:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:29:43 INFO - Contents: 08:29:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/c45c43770070650903cb7d9a90f06ae3974846e43999e4caf331761ecc39b92c4631e5b1568243f08f22a460a3b11978137e3f6e3cb3ea6fc410c0b252e0f284", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/508795e7c5918735df08ba6b7801263de69aa80e9fa7344b2aa75e1d2a854c6148655b65bcde247d1527a30aa6d93e6d06914a4756cf863cae4ff0b77f8f8f2e"} 08:29:43 INFO - Copying logs to upload dir... 08:29:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.636014 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-31 08:29:42.391222) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 08:29:42.394834) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371 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/c45c43770070650903cb7d9a90f06ae3974846e43999e4caf331761ecc39b92c4631e5b1568243f08f22a460a3b11978137e3f6e3cb3ea6fc410c0b252e0f284", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/508795e7c5918735df08ba6b7801263de69aa80e9fa7344b2aa75e1d2a854c6148655b65bcde247d1527a30aa6d93e6d06914a4756cf863cae4ff0b77f8f8f2e"} build_url:https://queue.taskcluster.net/v1/task/WC0zFJcwQrmptwIMLmM66Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011384 build_url: 'https://queue.taskcluster.net/v1/task/WC0zFJcwQrmptwIMLmM66Q/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/c45c43770070650903cb7d9a90f06ae3974846e43999e4caf331761ecc39b92c4631e5b1568243f08f22a460a3b11978137e3f6e3cb3ea6fc410c0b252e0f284", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/508795e7c5918735df08ba6b7801263de69aa80e9fa7344b2aa75e1d2a854c6148655b65bcde247d1527a30aa6d93e6d06914a4756cf863cae4ff0b77f8f8f2e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 08:29:42.420103) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:29:42.420466) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1451573689.493907-1488318371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:29:42.504422) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 08:29:42.504772) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 08:29:42.505169) ========= ========= Total master_lag: 0.23 =========