builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1451631209.25 results: success (0) buildid: 20151231203242 builduid: c36f381271fe446da3db6da38a375274 revision: aa59dbc5def53c7e1e530aa05089b8988aa776bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:29.250906) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:29.251742) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:29.252266) ========= 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-1451622163.335512-1253099847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006502 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:29.302572) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:29.303149) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:29.418168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:29.418710) ========= 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-1451622163.335512-1253099847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004662 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:29.511023) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:29.514721) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:29.515455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:29.515842) ========= 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-1451622163.335512-1253099847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-31 22:53:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.9M=0s 2015-12-31 22:53:31 (43.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171227 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:29.715476) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:29.716138) ========= 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-1451622163.335512-1253099847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015714 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:29.772580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-31 22:53:29.772939) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev aa59dbc5def53c7e1e530aa05089b8988aa776bf --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 aa59dbc5def53c7e1e530aa05089b8988aa776bf --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-1451622163.335512-1253099847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-31 22:53:31,228 truncating revision to first 12 chars 2015-12-31 22:53:31,228 Setting DEBUG logging. 2015-12-31 22:53:31,228 attempt 1/10 2015-12-31 22:53:31,228 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/aa59dbc5def5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-31 22:53:31,943 unpacking tar archive at: b2g-inbound-aa59dbc5def5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.988785 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-31 22:53:30.781936) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:30.782326) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:30.794372) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:30.794783) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 22:53:30.795325) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-31 22:53:30.795656) ========= /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-1451622163.335512-1253099847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:53:32 INFO - MultiFileLogger online at 20151231 22:53:32 in /builds/slave/test-pgo 22:53:32 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 22:53:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:53:32 INFO - {'append_to_log': False, 22:53:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:53:32 INFO - 'blob_upload_branch': 'B2G-Inbound', 22:53:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:53:32 INFO - 'branch': 'B2G-Inbound', 22:53:32 INFO - 'buildbot_json_path': 'buildprops.json', 22:53:32 INFO - 'config_files': ('talos/linux_config.py',), 22:53:32 INFO - 'default_actions': ('clobber', 22:53:32 INFO - 'read-buildbot-config', 22:53:32 INFO - 'download-and-extract', 22:53:32 INFO - 'populate-webroot', 22:53:32 INFO - 'create-virtualenv', 22:53:32 INFO - 'install', 22:53:32 INFO - 'run-tests'), 22:53:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:53:32 INFO - 'download_minidump_stackwalk': True, 22:53:32 INFO - 'download_symbols': 'ondemand', 22:53:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:53:32 INFO - 'tooltool.py': '/tools/tooltool.py', 22:53:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:53:32 INFO - '/tools/misc-python/virtualenv.py')}, 22:53:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:53:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:53:32 INFO - 'installer_path': 'installer.exe', 22:53:32 INFO - 'log_level': 'info', 22:53:32 INFO - 'log_name': 'talos', 22:53:32 INFO - 'log_to_console': True, 22:53:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:53:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:53:32 INFO - 'opt_config_files': (), 22:53:32 INFO - 'pip_index': False, 22:53:32 INFO - 'sps_profile': False, 22:53:32 INFO - 'sps_profile_interval': 0, 22:53:32 INFO - 'suite': 'dromaeojs', 22:53:32 INFO - 'system_bits': '32', 22:53:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:53:32 INFO - 'title': 'talos-linux64-ix-004', 22:53:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:53:32 INFO - 'use_talos_json': True, 22:53:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:53:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:53:32 INFO - 'work_dir': 'build'} 22:53:32 INFO - ##### 22:53:32 INFO - ##### Running clobber step. 22:53:32 INFO - ##### 22:53:32 INFO - Running pre-action listener: _resource_record_pre_action 22:53:32 INFO - Running main action method: clobber 22:53:32 INFO - rmtree: /builds/slave/test-pgo/build 22:53:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:53:32 INFO - Running post-action listener: _resource_record_post_action 22:53:32 INFO - ##### 22:53:32 INFO - ##### Running read-buildbot-config step. 22:53:32 INFO - ##### 22:53:32 INFO - Running pre-action listener: _resource_record_pre_action 22:53:32 INFO - Running main action method: read_buildbot_config 22:53:32 INFO - Using buildbot properties: 22:53:32 INFO - { 22:53:32 INFO - "project": "", 22:53:32 INFO - "product": "firefox", 22:53:32 INFO - "script_repo_revision": "production", 22:53:32 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 22:53:32 INFO - "repository": "", 22:53:32 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 22:53:32 INFO - "buildid": "20151231203242", 22:53:32 INFO - "pgo_build": "True", 22:53:32 INFO - "basedir": "/builds/slave/test-pgo", 22:53:32 INFO - "buildnumber": 174, 22:53:32 INFO - "slavename": "talos-linux64-ix-004", 22:53:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:53:32 INFO - "platform": "ubuntu64_hw", 22:53:32 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 22:53:32 INFO - "branch": "b2g-inbound", 22:53:32 INFO - "repo_path": "integration/b2g-inbound", 22:53:32 INFO - "revision": "aa59dbc5def53c7e1e530aa05089b8988aa776bf", 22:53:32 INFO - "stage_platform": "linux64-pgo", 22:53:32 INFO - "builduid": "c36f381271fe446da3db6da38a375274", 22:53:32 INFO - "slavebuilddir": "test" 22:53:32 INFO - } 22:53:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:53:32 INFO - Running post-action listener: _resource_record_post_action 22:53:32 INFO - ##### 22:53:32 INFO - ##### Running download-and-extract step. 22:53:32 INFO - ##### 22:53:32 INFO - Running pre-action listener: _resource_record_pre_action 22:53:32 INFO - Running main action method: download_and_extract 22:53:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:53:32 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')]} 22:53:32 INFO - https://queue.taskcluster.net/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:53:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/test_packages.json 22:53:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/test_packages.json 22:53:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:53:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:53:34 INFO - Downloaded 1302 bytes. 22:53:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:53:34 INFO - Using the following test package requirements: 22:53:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:53:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:34 INFO - u'jsshell-linux-x86_64.zip'], 22:53:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:53:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:53:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:53:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:53:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:53:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:34 INFO - https://queue.taskcluster.net/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/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 22:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/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 22:53:35 INFO - Downloaded 23195217 bytes. 22:53:35 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 22:53:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:35 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 22:53:37 INFO - Return code: 0 22:53:37 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 22:53: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')]} 22:53:37 INFO - https://queue.taskcluster.net/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/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 22:53:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/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 22:53:41 INFO - Downloaded 23195217 bytes. 22:53:41 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 22:53:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:41 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 22:53:42 INFO - Return code: 0 22:53:42 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')]} 22:53:42 INFO - https://queue.taskcluster.net/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:53:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/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 22:53:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/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 22:53:44 INFO - Downloaded 11132285 bytes. 22:53:44 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 22:53:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:44 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 22:53:44 INFO - Return code: 0 22:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:44 INFO - https://queue.taskcluster.net/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:53:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/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 22:53:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTowPllaS22pT9Nrjf-ZLg/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 22:53:45 INFO - Downloaded 54943736 bytes. 22:53:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:45 INFO - mkdir: /builds/slave/test-pgo/properties 22:53:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:53:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:53:45 INFO - Contents: 22:53:45 INFO - build_url:https://queue.taskcluster.net/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:45 INFO - Running post-action listener: _resource_record_post_action 22:53:45 INFO - Running post-action listener: set_extra_try_arguments 22:53:45 INFO - ##### 22:53:45 INFO - ##### Running populate-webroot step. 22:53:45 INFO - ##### 22:53:45 INFO - Running pre-action listener: _resource_record_pre_action 22:53:45 INFO - Running main action method: populate_webroot 22:53:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:53:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:53:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:53:45 INFO - '--tppagecycles', 22:53:45 INFO - '7'], 22:53:45 INFO - 'tests': ['tsvgm']}}, 22:53:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:53:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:53:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:53:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:53:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:53:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:53:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:45 INFO - 'talos_options': ['--e10s'], 22:53:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:45 INFO - 'tests': ['damp', 'tps']}, 22:53:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:45 INFO - 'talos_options': ['--e10s'], 22:53:45 INFO - 'tests': ['damp', 'tps']}, 22:53:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:53:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:53:45 INFO - 'other': {'tests': ['a11yr', 22:53:45 INFO - 'ts_paint', 22:53:45 INFO - 'tpaint', 22:53:45 INFO - 'sessionrestore', 22:53:45 INFO - 'sessionrestore_no_auto_restore']}, 22:53:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:53:45 INFO - 'tests': ['a11yr', 22:53:45 INFO - 'ts_paint', 22:53:45 INFO - 'tpaint', 22:53:45 INFO - 'sessionrestore', 22:53:45 INFO - 'sessionrestore_no_auto_restore']}, 22:53:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:53:45 INFO - 'tests': ['a11yr', 22:53:45 INFO - 'ts_paint', 22:53:45 INFO - 'tpaint', 22:53:45 INFO - 'sessionrestore', 22:53:45 INFO - 'sessionrestore_no_auto_restore']}, 22:53:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:53:45 INFO - 'tests': ['a11yr', 22:53:45 INFO - 'ts_paint', 22:53:45 INFO - 'tpaint', 22:53:45 INFO - 'sessionrestore', 22:53:45 INFO - 'sessionrestore_no_auto_restore']}, 22:53:45 INFO - 'other_l64': {'tests': ['a11yr', 22:53:45 INFO - 'ts_paint', 22:53:45 INFO - 'tpaint', 22:53:45 INFO - 'sessionrestore', 22:53:45 INFO - 'sessionrestore_no_auto_restore']}, 22:53:45 INFO - 'other_nol64': {'tests': ['a11yr', 22:53:45 INFO - 'ts_paint', 22:53:45 INFO - 'tpaint', 22:53:45 INFO - 'sessionrestore', 22:53:45 INFO - 'sessionrestore_no_auto_restore']}, 22:53:45 INFO - 'svgr': {'tests': ['tsvgx', 22:53:45 INFO - 'tsvgr_opacity', 22:53:45 INFO - 'tart', 22:53:45 INFO - 'tscrollx', 22:53:45 INFO - 'cart']}, 22:53:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:53:45 INFO - 'tests': ['tsvgx', 22:53:45 INFO - 'tsvgr_opacity', 22:53:45 INFO - 'tart', 22:53:45 INFO - 'tscrollx', 22:53:45 INFO - 'cart']}, 22:53:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:45 INFO - 'tests': ['tp5o']}, 22:53:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:45 INFO - 'talos_options': ['--e10s'], 22:53:45 INFO - 'tests': ['tp5o']}, 22:53:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:45 INFO - 'talos_options': ['--xperf_path', 22:53:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:45 INFO - 'tests': ['tp5n']}, 22:53:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:45 INFO - 'talos_options': ['--e10s', 22:53:45 INFO - '--xperf_path', 22:53:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:45 INFO - 'tests': ['tp5n']}}, 22:53:45 INFO - 'talos.zip': {'path': '', 22:53:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:53:45 INFO - Running post-action listener: _resource_record_post_action 22:53:45 INFO - ##### 22:53:45 INFO - ##### Running create-virtualenv step. 22:53:45 INFO - ##### 22:53:45 INFO - Running pre-action listener: _resource_record_pre_action 22:53:45 INFO - Running main action method: create_virtualenv 22:53:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:53:45 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 22:53:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:53:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:53:45 INFO - Using real prefix '/usr' 22:53:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:53:46 INFO - Installing distribute.............................................................................................................................................................................................done. 22:53:48 INFO - Installing pip.................done. 22:53:48 INFO - Return code: 0 22:53:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6d4edb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934840>, '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 0x28a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a1b60>, '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-1451622163.335512-1253099847', '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 22:53:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:53:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:53:48 INFO - Using env: {'DISPLAY': ':0', 22:53:48 INFO - 'HOME': '/home/cltbld', 22:53:48 INFO - 'LANG': 'en_US.UTF-8', 22:53:48 INFO - 'LANGUAGE': 'en_US:en', 22:53:48 INFO - 'LOGNAME': 'cltbld', 22:53:48 INFO - 'MAIL': '/var/mail/cltbld', 22:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:48 INFO - 'MOZ_NO_REMOTE': '1', 22:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:48 INFO - 'NO_EM_RESTART': '1', 22:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:48 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:48 INFO - 'SHELL': '/bin/bash', 22:53:48 INFO - 'SHLVL': '1', 22:53:48 INFO - 'TERM': 'linux', 22:53:48 INFO - 'TMOUT': '86400', 22:53:48 INFO - 'USER': 'cltbld', 22:53:48 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451622163.335512-1253099847', 22:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:48 INFO - '_': '/tools/buildbot/bin/python'} 22:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:48 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 22:53:48 INFO - Cleaning up... 22:53:48 INFO - Return code: 0 22:53:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6d4edb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934840>, '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 0x28a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a1b60>, '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-1451622163.335512-1253099847', '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 22:53:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:53:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:53:48 INFO - Using env: {'DISPLAY': ':0', 22:53:48 INFO - 'HOME': '/home/cltbld', 22:53:48 INFO - 'LANG': 'en_US.UTF-8', 22:53:48 INFO - 'LANGUAGE': 'en_US:en', 22:53:48 INFO - 'LOGNAME': 'cltbld', 22:53:48 INFO - 'MAIL': '/var/mail/cltbld', 22:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:48 INFO - 'MOZ_NO_REMOTE': '1', 22:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:48 INFO - 'NO_EM_RESTART': '1', 22:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:48 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:48 INFO - 'SHELL': '/bin/bash', 22:53:48 INFO - 'SHLVL': '1', 22:53:48 INFO - 'TERM': 'linux', 22:53:48 INFO - 'TMOUT': '86400', 22:53:48 INFO - 'USER': 'cltbld', 22:53:48 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451622163.335512-1253099847', 22:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:48 INFO - '_': '/tools/buildbot/bin/python'} 22:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:48 INFO - Downloading/unpacking psutil>=0.7.1 22:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:53:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:53:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:53:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:50 INFO - Installing collected packages: psutil 22:53:50 INFO - Running setup.py install for psutil 22:53:50 INFO - building 'psutil._psutil_linux' extension 22:53:50 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 22:53:51 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 22:53:51 INFO - building 'psutil._psutil_posix' extension 22:53:51 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 22:53:51 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 22:53:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:51 INFO - Successfully installed psutil 22:53:51 INFO - Cleaning up... 22:53:51 INFO - Return code: 0 22:53:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6d4edb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934840>, '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 0x28a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a1b60>, '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-1451622163.335512-1253099847', '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 22:53:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:53:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:53:51 INFO - Using env: {'DISPLAY': ':0', 22:53:51 INFO - 'HOME': '/home/cltbld', 22:53:51 INFO - 'LANG': 'en_US.UTF-8', 22:53:51 INFO - 'LANGUAGE': 'en_US:en', 22:53:51 INFO - 'LOGNAME': 'cltbld', 22:53:51 INFO - 'MAIL': '/var/mail/cltbld', 22:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:51 INFO - 'MOZ_NO_REMOTE': '1', 22:53:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:51 INFO - 'NO_EM_RESTART': '1', 22:53:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:51 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:51 INFO - 'SHELL': '/bin/bash', 22:53:51 INFO - 'SHLVL': '1', 22:53:51 INFO - 'TERM': 'linux', 22:53:51 INFO - 'TMOUT': '86400', 22:53:51 INFO - 'USER': 'cltbld', 22:53:51 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451622163.335512-1253099847', 22:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:51 INFO - '_': '/tools/buildbot/bin/python'} 22:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:53:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:53:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:53:53 INFO - Installing collected packages: mozsystemmonitor 22:53:53 INFO - Running setup.py install for mozsystemmonitor 22:53:53 INFO - Successfully installed mozsystemmonitor 22:53:53 INFO - Cleaning up... 22:53:53 INFO - Return code: 0 22:53:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:53: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')]} 22:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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')]} 22:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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', '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 0x7f6d4edb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934840>, '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 0x28a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a1b60>, '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-1451622163.335512-1253099847', '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 22:53: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:53: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 blobuploader==1.2.4 22:53:53 INFO - Using env: {'DISPLAY': ':0', 22:53:53 INFO - 'HOME': '/home/cltbld', 22:53:53 INFO - 'LANG': 'en_US.UTF-8', 22:53:53 INFO - 'LANGUAGE': 'en_US:en', 22:53:53 INFO - 'LOGNAME': 'cltbld', 22:53:53 INFO - 'MAIL': '/var/mail/cltbld', 22:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:53 INFO - 'MOZ_NO_REMOTE': '1', 22:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:53 INFO - 'NO_EM_RESTART': '1', 22:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:53 INFO - 'SHELL': '/bin/bash', 22:53:53 INFO - 'SHLVL': '1', 22:53:53 INFO - 'TERM': 'linux', 22:53:53 INFO - 'TMOUT': '86400', 22:53:53 INFO - 'USER': 'cltbld', 22:53:53 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451622163.335512-1253099847', 22:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:53 INFO - '_': '/tools/buildbot/bin/python'} 22:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:53 INFO - Downloading/unpacking blobuploader==1.2.4 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53:55 INFO - Downloading blobuploader-1.2.4.tar.gz 22:53:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:53:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:53:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:53:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:53:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53:55 INFO - Downloading docopt-0.6.1.tar.gz 22:53:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:53:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:53:56 INFO - Installing collected packages: blobuploader, requests, docopt 22:53:56 INFO - Running setup.py install for blobuploader 22:53:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:53:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:53:56 INFO - Running setup.py install for requests 22:53:56 INFO - Running setup.py install for docopt 22:53:56 INFO - Successfully installed blobuploader requests docopt 22:53:56 INFO - Cleaning up... 22:53:56 INFO - Return code: 0 22:53:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:56 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 0x7f6d4edb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934840>, '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 0x28a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a1b60>, '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-1451622163.335512-1253099847', '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 22:53:56 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 22:53:56 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 22:53:56 INFO - Using env: {'DISPLAY': ':0', 22:53:56 INFO - 'HOME': '/home/cltbld', 22:53:56 INFO - 'LANG': 'en_US.UTF-8', 22:53:56 INFO - 'LANGUAGE': 'en_US:en', 22:53:56 INFO - 'LOGNAME': 'cltbld', 22:53:56 INFO - 'MAIL': '/var/mail/cltbld', 22:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:56 INFO - 'MOZ_NO_REMOTE': '1', 22:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:56 INFO - 'NO_EM_RESTART': '1', 22:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:56 INFO - 'SHELL': '/bin/bash', 22:53:56 INFO - 'SHLVL': '1', 22:53:56 INFO - 'TERM': 'linux', 22:53:56 INFO - 'TMOUT': '86400', 22:53:56 INFO - 'USER': 'cltbld', 22:53:56 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451622163.335512-1253099847', 22:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:56 INFO - '_': '/tools/buildbot/bin/python'} 22:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:53:56 INFO - Running setup.py (path:/tmp/pip-8NMlTK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:53:56 INFO - Running setup.py (path:/tmp/pip-QcjSBb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:53:56 INFO - Running setup.py (path:/tmp/pip-YDFSK6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:53:57 INFO - Running setup.py (path:/tmp/pip-VYryMq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:53:57 INFO - Running setup.py (path:/tmp/pip-jnOOuj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:53:57 INFO - Running setup.py (path:/tmp/pip-73giHc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:53:57 INFO - Running setup.py (path:/tmp/pip-xFmLff-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:53:57 INFO - Running setup.py (path:/tmp/pip-tC7S9h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:53:57 INFO - Running setup.py (path:/tmp/pip-aZ88qw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:53:57 INFO - Running setup.py (path:/tmp/pip-d4j6j4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:53:57 INFO - Running setup.py (path:/tmp/pip-nLP6Vc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:53:57 INFO - Running setup.py (path:/tmp/pip-jtNhtF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:53:57 INFO - Running setup.py (path:/tmp/pip-by3Ett-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:53:57 INFO - Running setup.py (path:/tmp/pip-vahGJb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:53:57 INFO - Running setup.py (path:/tmp/pip-FS1T6r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:53:57 INFO - Running setup.py (path:/tmp/pip-bMb_jO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:53:57 INFO - Running setup.py (path:/tmp/pip-dfshqZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:53:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:53:58 INFO - Running setup.py install for manifestparser 22:53:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:53:58 INFO - Running setup.py install for mozcrash 22:53:58 INFO - Running setup.py install for mozdebug 22:53:58 INFO - Running setup.py install for mozdevice 22:53:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:53:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:53:58 INFO - Running setup.py install for mozfile 22:53:58 INFO - Running setup.py install for mozhttpd 22:53:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:53:58 INFO - Running setup.py install for mozinfo 22:53:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:53:58 INFO - Running setup.py install for mozInstall 22:53:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:53:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:53:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:53:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:53:58 INFO - Running setup.py install for mozleak 22:53:58 INFO - Running setup.py install for mozlog 22:53:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:53:59 INFO - Running setup.py install for moznetwork 22:53:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:53:59 INFO - Running setup.py install for mozprocess 22:53:59 INFO - Running setup.py install for mozprofile 22:53:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:53:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:53:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:53:59 INFO - Running setup.py install for mozrunner 22:53:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:53:59 INFO - Running setup.py install for mozscreenshot 22:53:59 INFO - Running setup.py install for moztest 22:53:59 INFO - Running setup.py install for mozversion 22:53:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:53:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:53:59 INFO - Cleaning up... 22:53:59 INFO - Return code: 0 22:53:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:53: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')]} 22:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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')]} 22:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f6d4edb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934840>, '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 0x28a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a1b60>, '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-1451622163.335512-1253099847', '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 22:53:59 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 22:53:59 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 22:53:59 INFO - Using env: {'DISPLAY': ':0', 22:53:59 INFO - 'HOME': '/home/cltbld', 22:53:59 INFO - 'LANG': 'en_US.UTF-8', 22:53:59 INFO - 'LANGUAGE': 'en_US:en', 22:53:59 INFO - 'LOGNAME': 'cltbld', 22:53:59 INFO - 'MAIL': '/var/mail/cltbld', 22:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:59 INFO - 'MOZ_NO_REMOTE': '1', 22:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:59 INFO - 'NO_EM_RESTART': '1', 22:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:59 INFO - 'SHELL': '/bin/bash', 22:53:59 INFO - 'SHLVL': '1', 22:53:59 INFO - 'TERM': 'linux', 22:53:59 INFO - 'TMOUT': '86400', 22:53:59 INFO - 'USER': 'cltbld', 22:53:59 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451622163.335512-1253099847', 22:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:59 INFO - '_': '/tools/buildbot/bin/python'} 22:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:00 INFO - Running setup.py (path:/tmp/pip-o1Wpzs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:00 INFO - Running setup.py (path:/tmp/pip-zXu6K1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:00 INFO - Running setup.py (path:/tmp/pip-GTQTfJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:00 INFO - Running setup.py (path:/tmp/pip-oH4o4j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:00 INFO - Running setup.py (path:/tmp/pip-ULWtUb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:00 INFO - Running setup.py (path:/tmp/pip-wlPTW9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:00 INFO - Running setup.py (path:/tmp/pip-Dq5l3K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:00 INFO - Running setup.py (path:/tmp/pip-xESkR2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:00 INFO - Running setup.py (path:/tmp/pip-04yXUw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:00 INFO - Running setup.py (path:/tmp/pip-WTUgp1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:00 INFO - Running setup.py (path:/tmp/pip-y96q4v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:00 INFO - Running setup.py (path:/tmp/pip-qnT75E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:00 INFO - Running setup.py (path:/tmp/pip-MZCr9F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:00 INFO - Running setup.py (path:/tmp/pip-hDC73h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:01 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)) 22:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:01 INFO - Running setup.py (path:/tmp/pip-02OBKn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:01 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)) 22:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:01 INFO - Running setup.py (path:/tmp/pip-sC6oey-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:01 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)) 22:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:01 INFO - Running setup.py (path:/tmp/pip-8paa9x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:01 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)) 22:54:01 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)) 22:54:01 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)) 22:54:01 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)) 22:54:01 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)) 22:54:01 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)) 22:54:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:02 INFO - Downloading blessings-1.5.1.tar.gz 22:54:02 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 22:54:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:54:03 INFO - Installing collected packages: blessings 22:54:03 INFO - Running setup.py install for blessings 22:54:03 INFO - Successfully installed blessings 22:54:03 INFO - Cleaning up... 22:54:03 INFO - Return code: 0 22:54:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:54:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:54:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:54:03 INFO - Reading from file tmpfile_stdout 22:54:03 INFO - Current package versions: 22:54:03 INFO - argparse == 1.2.1 22:54:03 INFO - blessings == 1.5.1 22:54:03 INFO - blobuploader == 1.2.4 22:54:03 INFO - docopt == 0.6.1 22:54:03 INFO - manifestparser == 1.1 22:54:03 INFO - mozInstall == 1.12 22:54:03 INFO - mozcrash == 0.16 22:54:03 INFO - mozdebug == 0.1 22:54:03 INFO - mozdevice == 0.47 22:54:03 INFO - mozfile == 1.2 22:54:03 INFO - mozhttpd == 0.7 22:54:03 INFO - mozinfo == 0.9 22:54:03 INFO - mozleak == 0.1 22:54:03 INFO - mozlog == 3.1 22:54:03 INFO - moznetwork == 0.27 22:54:03 INFO - mozprocess == 0.22 22:54:03 INFO - mozprofile == 0.28 22:54:03 INFO - mozrunner == 6.11 22:54:03 INFO - mozscreenshot == 0.1 22:54:03 INFO - mozsystemmonitor == 0.0 22:54:03 INFO - moztest == 0.7 22:54:03 INFO - mozversion == 1.4 22:54:03 INFO - psutil == 3.1.1 22:54:03 INFO - requests == 1.2.3 22:54:03 INFO - wsgiref == 0.1.2 22:54:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f6d4edb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934840>, '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 0x28a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a1b60>, '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-1451622163.335512-1253099847', '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 22:54:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 22:54:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 22:54:03 INFO - Using env: {'DISPLAY': ':0', 22:54:03 INFO - 'HOME': '/home/cltbld', 22:54:03 INFO - 'LANG': 'en_US.UTF-8', 22:54:03 INFO - 'LANGUAGE': 'en_US:en', 22:54:03 INFO - 'LOGNAME': 'cltbld', 22:54:03 INFO - 'MAIL': '/var/mail/cltbld', 22:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:03 INFO - 'MOZ_NO_REMOTE': '1', 22:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:03 INFO - 'NO_EM_RESTART': '1', 22:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:03 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:03 INFO - 'SHELL': '/bin/bash', 22:54:03 INFO - 'SHLVL': '1', 22:54:03 INFO - 'TERM': 'linux', 22:54:03 INFO - 'TMOUT': '86400', 22:54:03 INFO - 'USER': 'cltbld', 22:54:03 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451622163.335512-1253099847', 22:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:03 INFO - '_': '/tools/buildbot/bin/python'} 22:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:54:03 INFO - Cleaning up... 22:54:03 INFO - Return code: 0 22:54:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f6d4edb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934840>, '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 0x28a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a1b60>, '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-1451622163.335512-1253099847', '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 22:54:03 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 22:54:03 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 22:54:03 INFO - Using env: {'DISPLAY': ':0', 22:54:03 INFO - 'HOME': '/home/cltbld', 22:54:03 INFO - 'LANG': 'en_US.UTF-8', 22:54:03 INFO - 'LANGUAGE': 'en_US:en', 22:54:03 INFO - 'LOGNAME': 'cltbld', 22:54:03 INFO - 'MAIL': '/var/mail/cltbld', 22:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:03 INFO - 'MOZ_NO_REMOTE': '1', 22:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:03 INFO - 'NO_EM_RESTART': '1', 22:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:03 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:03 INFO - 'SHELL': '/bin/bash', 22:54:03 INFO - 'SHLVL': '1', 22:54:03 INFO - 'TERM': 'linux', 22:54:03 INFO - 'TMOUT': '86400', 22:54:03 INFO - 'USER': 'cltbld', 22:54:03 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451622163.335512-1253099847', 22:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:03 INFO - '_': '/tools/buildbot/bin/python'} 22:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:03 INFO - Downloading/unpacking jsonschema 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:54:05 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 22:54:05 INFO - Downloading/unpacking functools32 (from jsonschema) 22:54:05 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 22:54:05 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 22:54:05 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 22:54:05 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 22:54:05 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 22:54:05 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 22:54:05 INFO - Downloading functools32-3.2.3-2.tar.gz 22:54:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:54:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:54:05 INFO - warning: no files found matching '*.txt' 22:54:05 INFO - no previously-included directories found matching 'build' 22:54:05 INFO - no previously-included directories found matching 'dist' 22:54:05 INFO - no previously-included directories found matching '.git*' 22:54:05 INFO - Installing collected packages: jsonschema, functools32 22:54:05 INFO - Running setup.py install for functools32 22:54:05 INFO - warning: no files found matching '*.txt' 22:54:05 INFO - no previously-included directories found matching 'build' 22:54:05 INFO - no previously-included directories found matching 'dist' 22:54:05 INFO - no previously-included directories found matching '.git*' 22:54:05 INFO - Successfully installed jsonschema functools32 22:54:05 INFO - Cleaning up... 22:54:05 INFO - Return code: 0 22:54:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:54:05 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')]} 22:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:05 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')]} 22:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:05 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 0x7f6d4edb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2934840>, '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 0x28a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a1b60>, '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-1451622163.335512-1253099847', '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 22:54:05 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 22:54:05 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 22:54:05 INFO - Using env: {'DISPLAY': ':0', 22:54:05 INFO - 'HOME': '/home/cltbld', 22:54:05 INFO - 'LANG': 'en_US.UTF-8', 22:54:05 INFO - 'LANGUAGE': 'en_US:en', 22:54:05 INFO - 'LOGNAME': 'cltbld', 22:54:05 INFO - 'MAIL': '/var/mail/cltbld', 22:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:05 INFO - 'MOZ_NO_REMOTE': '1', 22:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:05 INFO - 'NO_EM_RESTART': '1', 22:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:05 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:05 INFO - 'SHELL': '/bin/bash', 22:54:05 INFO - 'SHLVL': '1', 22:54:05 INFO - 'TERM': 'linux', 22:54:05 INFO - 'TMOUT': '86400', 22:54:05 INFO - 'USER': 'cltbld', 22:54:05 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451622163.335512-1253099847', 22:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:05 INFO - '_': '/tools/buildbot/bin/python'} 22:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:06 INFO - Downloading/unpacking flake8 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:54:07 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 22:54:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:54:08 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 22:54:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:08 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 22:54:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:54:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:54:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:08 INFO - no previously-included directories found matching 'docs/_build' 22:54:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:54:08 INFO - Running setup.py install for pep8 22:54:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:08 INFO - no previously-included directories found matching 'docs/_build' 22:54:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:54:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:54:08 INFO - Cleaning up... 22:54:08 INFO - Return code: 0 22:54:08 INFO - Running post-action listener: _resource_record_post_action 22:54:08 INFO - Running post-action listener: _start_resource_monitoring 22:54:08 INFO - Starting resource monitoring. 22:54:08 INFO - ##### 22:54:08 INFO - ##### Running install step. 22:54:08 INFO - ##### 22:54:08 INFO - Running pre-action listener: _resource_record_pre_action 22:54:08 INFO - Running main action method: install 22:54:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:54:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:54:08 INFO - Reading from file tmpfile_stdout 22:54:08 INFO - Detecting whether we're running mozinstall >=1.0... 22:54:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:54:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:54:09 INFO - Reading from file tmpfile_stdout 22:54:09 INFO - Output received: 22:54:09 INFO - Usage: mozinstall [options] installer 22:54:09 INFO - Options: 22:54:09 INFO - -h, --help show this help message and exit 22:54:09 INFO - -d DEST, --destination=DEST 22:54:09 INFO - Directory to install application into. [default: 22:54:09 INFO - "/builds/slave/test-pgo"] 22:54:09 INFO - --app=APP Application being installed. [default: firefox] 22:54:09 INFO - mkdir: /builds/slave/test-pgo/build/application 22:54:09 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'] 22:54:09 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 22:54:24 INFO - Reading from file tmpfile_stdout 22:54:24 INFO - Output received: 22:54:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:54:24 INFO - Running post-action listener: _resource_record_post_action 22:54:24 INFO - ##### 22:54:24 INFO - ##### Running run-tests step. 22:54:24 INFO - ##### 22:54:24 INFO - Running pre-action listener: _resource_record_pre_action 22:54:24 INFO - Running main action method: run_tests 22:54:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:54:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:54:24 INFO - Python 2.7.3 22:54:24 INFO - Return code: 0 22:54:24 INFO - grabbing minidump binary from tooltool 22:54:24 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')]} 22:54:24 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 0x2934840>, '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 0x28a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a1b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:54:24 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 22:54:24 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 22:54:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:54:24 INFO - Return code: 0 22:54:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:54:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:54:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:54:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:54:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:54:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:54:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:54:25 INFO - Return code: 0 22:54:25 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/CTowPllaS22pT9Nrjf-ZLg/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 22:54:25 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/CTowPllaS22pT9Nrjf-ZLg/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 22:54:25 INFO - Using env: {'DISPLAY': ':0', 22:54:25 INFO - 'HOME': '/home/cltbld', 22:54:25 INFO - 'LANG': 'en_US.UTF-8', 22:54:25 INFO - 'LANGUAGE': 'en_US:en', 22:54:25 INFO - 'LOGNAME': 'cltbld', 22:54:25 INFO - 'MAIL': '/var/mail/cltbld', 22:54:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:54:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:25 INFO - 'MOZ_NO_REMOTE': '1', 22:54:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:25 INFO - 'NO_EM_RESTART': '1', 22:54:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:25 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:54:25 INFO - 'SHELL': '/bin/bash', 22:54:25 INFO - 'SHLVL': '1', 22:54:25 INFO - 'TERM': 'linux', 22:54:25 INFO - 'TMOUT': '86400', 22:54:25 INFO - 'USER': 'cltbld', 22:54:25 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451622163.335512-1253099847', 22:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:25 INFO - '_': '/tools/buildbot/bin/python'} 22:54:25 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/CTowPllaS22pT9Nrjf-ZLg/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 22:54:26 INFO - mozversion application_buildid: 20151231203242 22:54:26 INFO - mozversion application_changeset: aa59dbc5def53c7e1e530aa05089b8988aa776bf 22:54:26 INFO - mozversion application_display_name: Nightly 22:54:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:54:26 INFO - mozversion application_name: Firefox 22:54:26 INFO - mozversion application_remotingname: firefox 22:54:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 22:54:26 INFO - mozversion application_vendor: Mozilla 22:54:26 INFO - mozversion application_version: 46.0a1 22:54:26 INFO - mozversion platform_buildid: 20151231203242 22:54:26 INFO - mozversion platform_changeset: aa59dbc5def53c7e1e530aa05089b8988aa776bf 22:54:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 22:54:26 INFO - mozversion platform_version: 46.0a1 22:54:26 INFO - using testdate: 1451631266 22:54:26 INFO - actual date: 1451631266 22:54:26 INFO - starting webserver on 'localhost:45149' 22:54:26 INFO - SUITE-START | Running 3 tests 22:54:26 INFO - TEST-START | dromaeo_css 22:54:26 INFO - operating with platform_type : linux_ 22:54:26 INFO - Initialising browser for dromaeo_css test... 22:54:26 INFO - TEST-INFO | started process 16468 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeZhAuL/profile http://localhost:45149/getInfo.html) 22:54:29 INFO - PROCESS | 16468 | __metrics Screen width/height:1600/1200 22:54:29 INFO - PROCESS | 16468 | colorDepth:24 22:54:29 INFO - PROCESS | 16468 | Browser inner width/height: 1024/697 22:54:29 INFO - PROCESS | 16468 | __metrics 22:54:30 INFO - PROCESS | 16468 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:54:30 INFO - PROCESS | 16468 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:54:31 INFO - TEST-INFO | 16468: exit 0 22:54:31 INFO - Browser initialized. 22:54:31 INFO - Running cycle 1/1 for dromaeo_css test... 22:54:31 INFO - TEST-INFO | started process 16563 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeZhAuL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:54:43 INFO - PROCESS | 16563 | RSS: Main: 149254144 22:54:43 INFO - PROCESS | 16563 | 22:55:33 INFO - PROCESS | 16563 | 1451631333920 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] 22:57:43 INFO - PROCESS | 16563 | Cycle 1(1): loaded http://localhost:45149/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45149/tests/dromaeo/cssquery-ext.html) 22:57:44 INFO - PROCESS | 16563 | RSS: Main: 261808128 22:57:44 INFO - PROCESS | 16563 | 23:00:47 INFO - PROCESS | 16563 | Cycle 1(1): loaded http://localhost:45149/tests/dromaeo/cssquery-ext.html (next: http://localhost:45149/tests/dromaeo/cssquery-jquery.html) 23:00:47 INFO - PROCESS | 16563 | RSS: Main: 234770432 23:00:47 INFO - PROCESS | 16563 | 23:03:49 INFO - PROCESS | 16563 | Cycle 1(1): loaded http://localhost:45149/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45149/tests/dromaeo/cssquery-mootools.html) 23:03:50 INFO - PROCESS | 16563 | RSS: Main: 224776192 23:03:50 INFO - PROCESS | 16563 | 23:06:52 INFO - PROCESS | 16563 | Cycle 1(1): loaded http://localhost:45149/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45149/tests/dromaeo/cssquery-prototype.html) 23:06:52 INFO - PROCESS | 16563 | RSS: Main: 212344832 23:06:52 INFO - PROCESS | 16563 | 23:09:55 INFO - PROCESS | 16563 | Cycle 1(1): loaded http://localhost:45149/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45149/tests/dromaeo/cssquery-yui.html) 23:09:55 INFO - PROCESS | 16563 | RSS: Main: 212824064 23:09:55 INFO - PROCESS | 16563 | 23:12:58 INFO - PROCESS | 16563 | Cycle 1(1): loaded http://localhost:45149/tests/dromaeo/cssquery-yui.html (next: http://localhost:45149/tests/dromaeo/cssquery-dojo.html) 23:12:58 INFO - PROCESS | 16563 | RSS: Main: 305098752 23:12:58 INFO - PROCESS | 16563 | 23:12:58 INFO - PROCESS | 16563 | __start_tp_report 23:12:58 INFO - PROCESS | 16563 | _x_x_mozilla_page_load 23:12:58 INFO - PROCESS | 16563 | _x_x_mozilla_page_load_details 23:12:58 INFO - PROCESS | 16563 | |i|pagename|runs| 23:12:58 INFO - PROCESS | 16563 | |0;dojo.html;3078.892238771643;3158.526221066841;3201.1676963989357;3202.6156861176664;3219.999999999999;5127.12838817401;5242.108841496945;5257.421683614804;5283.867903302415;5331.7334133293325;5240.423553409122;5275.472452754722;5317.521423071923;5326.893462130755;5348.732563371826;4783.521647835206;4825.276208568716;4866.78099485524;4956.851294461172;4989.401271847383;4912.435069966964;4941.2094064949615;4978.825741099062;4984.102861484931;5025.0703619830265;4733.219018861883;4746.738929358884;4828.251620998751;4832.855014349575;4905.117078925792;4771.594414474774;4778.761061946923;4781.354517140211;4821.059893320804;4828.855134345975;4726.243800991825;4766.785494652749;4777.761111944389;4788.042391521675;4821.325014497973;4961.4294356148785;5016.1723315653235;5104.821331253388;5121.052605268037;5137.61467889906;5622.409646987048;5632.042552765999;5634.295713035871;5650.180723795068;5660.405657405954;5678.034734095214;5686.829395118153;5692.402297758717;5700.572457065737;5708.001099807517;5172.482751724798;5263.131583288715;5290.180022096542;5292.2326262691695;5370.892582148414;5791.189233507313;5841.50347220491;5851.473367396955;5860.09168578871;5865.67738774363;5574.749136288877;5576.414476479992;5579.832605021856;5584.4136365681015;5594.888102238014;5478.58910581708;5515.669059856422;5573.637713548606;5656.519195868397;5656.943430565641;5571.637843540157;5622.887542249132;5628.127640215773;5631.211630371751;5672.7730890763905;5657.4908258256955;5671.602987790898;5674.801381951612;5675.659460432387;5680.97159514208;4305.074409002017;4375.474943006796;4385.166818304512;4395.252807022814;4431.889202769957;3897.3569361055675;3918.4122381642983;3934.901627459279;3950.3876899080688;3958.386450100239;5327.360716714019;5335.253064570963;5337.946620533823;5343.599230057684;5388.137897936312;5522.475364840334;5621.325440947113;5621.80323688669;5720.570957178228;5722.971385143131;5321.467853214647;5390.460953904657;5391.865203369947;5396.217548455452;5402.37872644643;4800.711957282574;4919.237518184687;4927.581155601814;4928.852134435972;4970.850874473772;5755.740991655385;5838.970805145947;5867.442592953663;5867.823965281048;5909.911351329733;5618.775248989995;5632.746526406239;5651.067573850269;5664.943350566607;5704.600677952503;5808.128780682931;5833.212516310414;5841.561882858718;5843.707814609167;5849.94150058511;5492.697901615449;5549.805756798654;5567.944320556742;5610.831675049755;5624.521915637217;5699.772009119754;5701.600887937971;5718.428157184248;5740.167675687086;5798.0143375627085;5463.945360546502;5529.944700552943;5532.2254884317035;5534.114541673474;5543.750531226186;5425.376081750649;5491.945080549303;5540.473655002768;5543.307086614173;5543.8891222176135;5391.81128660495;5462.972685136708;5463.043967305785;5463.125899856004;5500.532454741392;5347.679139251657;5388.084025715716;5399.29809124827;5419.512243897911;5425.782968681367;5283.101872681576;5313.734313284398;5343.919841202307;5380.139177731544;5421.674699518042 23:12:58 INFO - PROCESS | 16563 | |1;ext.html;527.6754795800579;554.4870994330244;555.9193916882052;563.3296377311;579.1688926390628;25438.61842072368;25978.74021259787;26055.957761689533;35670.2865942681;36353;42999.785001075026;43277;43320.783396082974;43439.34840977388;43484.56515434845;8661.696840610564;8819.206271435569;8837.027926928065;8852.336074794384;8854;7699.846003079935;7835.804104897395;10174.084332410082;10286.177105831515;10299.330543514685;10003;10098.545565449536;10099.798004039914;10105.696829095103;10124.190064794835;7785.610719464061;7952.244536768998;10110.848337274947;10207.336523125972;10218.591256349737;10035.899641003569;10311.381317120922;10313.84529232062;10314.432706201156;10316.329438586468;36705.63294367049;37022.44466333007;37237.06907327312;37283.81358093219;37358.25283494342;3260.6413294537583;3666.326641775539;3777.471154038409;3796.6583007529457;3813.3326667833016;28500.10422146562;28810.567841482396;28883.133505994854;30651.233719156975;31697.207569810707;3628.8185590720623;3649.7627654202392;3653.342398368293;3699.3341198584244;3792.089898424386;277746;278393;278548.60725696443;279322;279918;60698.39301607016;61258.38741612616;61324;61364;61398;54713;56002;62552.68723656444;62770.37229627645;64714;14827.77758333626;14938.402463901539;15024.17367044823;15060.849391505944;15070.849291506944;10219.335743176669;10252.743681408025;10270.435126067989;10299.279050466545;10302.227332950059;18840;18923.716144257847;19122.90438547826;19194;19222.423327300203;6994.475414343945;7284.890726639104;7321.78034658961;7375.299346562068;7410.851782964311;934.3973137326386;961.3222678011984;1048.9003544663396;1051.395447617623;1054.1408751867205;27951.32292062483;28043.859780700965;28629.85685071603;28648.283792905346;28757.42485150327;1030.2685093583489;1090.220492347975;1095.9397233152254;1111.777644471109;1133.7732453509332;15003.87470939684;15632.98385604932;15665;15901.125438100784;15912.706526563548;302058;306044;306308;307047;307227;53593.732031340376;54103.72948135234;54129;54300.45699543033;54365.72817135889;1086.97282567938;1089.1667874076338;1133.0935251798694;1365.9931700341435;1387.8334599848083;19698.005840217866;28561.143165705063;29458.852705736335;29548;29790.404191916474;42842.35736464018;43018.139637206456;43035;43265.3510197341;43389.783051084545;204136;204993;276949;283751;297399;29550;29578.408431831675;29736.553951690308;29916.401671966873;30008;40583.1883362337;40911.7954410226;41069.58930410658;41597.37603936004;41934.1613167741;34559.82720086384;34664.13339666528;34904.65095349115;35067.473987889694;35220.823895880356;34625.30749385049;34708.132296692784;35502;35602.643973559934;35759;32253.35493290168;32971.50542741813;32982.175445614055;35066.298674025864;35505.467417988235;31048;31939.562719678135;32689.509657354683;32738.672613273564;32753.836230818695;23380.76619233786;23911.348368521907;24031.51936961286;24049.879750601136;24054.75945240525 23:12:58 INFO - PROCESS | 16563 | |2;jquery.html;352.76188572713426;357.80142021178267;359.62598897146967;364.57526981067065;364.73921146380343;13492.595222143327;13855.584332470016;16241.593960151002;16292.42976495823;16740.49778506647;15124.504456764647;15158.317875695593;15689.84310156898;15690.37238510461;15725.60685982851;5073.264376665381;5343.118385466393;5353.571714262869;5358.142697168454;5366.221897824813;3907.6678482329035;4018.6584140348104;5279.894402111955;5803.564732645047;5937.821865344046;5854.8243552693275;5876.971529982257;5882.441168089024;5901.144334071557;5906.552894540843;5546.389897111315;6013.879722405549;6016.75932962681;6018.398160184012;6025.0359942409;5198.740062996835;5275.28783614211;5281.947180528184;5291.497307755757;5302;19957.30149444777;20193.8990305049;20328;20329.18683252668;20400.79599204004;2081.438011736838;2157.7842215778455;2248.4378905273684;2255.616545187322;2298.287530865437;12610.306433146174;12723.300218487979;12771.233725976472;12968.870311296861;13221.140625859289;1747.720364741648;1755.552334154795;1798.3256278895415;1850.5096149520389;1856.8793028453242;58700.706496467246;67690.32309676938;68050.65974670096;68399.65800171017;70220.99999999949;9904.702858914245;10037.44794036335;10083.394996300245;10115.494225288707;10143.123522148426;13338.399772010283;13345.799813002814;13362.532311369056;13368.732625347633;13379;7275.017872587133;7324.780256592311;7347.88978165328;7457.47797654159;7540.17058123606;6894.448444124458;6944.4444444444325;6961.756338528228;6970.546914450544;7004.089468369079;4372.497162826252;4398.428204333416;4402.7358358498595;4423.314386270069;4474.6420286377015;1704.6590681863677;1733.4972857871328;1773.627538216963;1817.6455591159597;1818.2454281473306;839.9832003359899;844.8225872566829;865.3899001204262;875.0811647769816;967.777411195429;13551.52569660057;15508.767368489256;15742.212889355487;16309.18454077315;16407.097609631586;889.8976617688919;932.841416959105;947.4220725357526;974.8294048541477;988.5650313861878;8459.577021148918;9212.769680758034;9345.579448924815;9516.143547080657;9907.851382229272;530776;536037;541639;550651;559913;79459;81126.18873811305;82241.17758822454;85013.57493212495;87794;990.2276224544867;1010.802893435773;1126.6620013995605;1198.1553005131361;1213.4175595714107;14981.625459363604;15070.945033847525;15279.465218717292;15482.303296351916;15542.300596473411;35738.28523429569;36170.27659446849;37195.81402092972;37609.4358584616;38046.8097659521;48484;48988;49677.25484117813;50291.49708503015;51319.74340128276;9505.952470237604;9531.428114313163;9654.420734755937;9667.226621870093;9769.560369783234;16250.431234906722;16932.40736574214;17268.827311727226;17316.826831732025;17904;13742.93128534351;13826.585202443943;13892.791608125684;14067.929660351632;14308.356123974238;13705.383257753225;13855.37650805696;14043.789343159657;14262.500812471513;14284.642883927985;13606;13608.115472494255;13947.232902190477;14090.647733806736;14218.644533886736;9681.48281446843;9752.122308992224;9759.072888075621;9840.852387214054;9893.01069893005;13473.191608503521;13486.190828550318;13634.727305454035;13946.232957187452;14392.640183995065 23:12:58 INFO - PROCESS | 16563 | |3;mootools.html;1320.3794216718138;1475.1812743927119;1475.2402512705958;1639.9508014759554;1816.9545761355973;6708.731650733971;7423.777286681395;7511.812204694886;7515.210902855197;7519.6616152273145;7279.199288078307;7470.96264518678;7478.364339031175;7487.064116985377;7491.887621685665;2215.1803832581927;2254.425121593991;2258.4579700871836;2258.7854153855355;2260.446190683285;2226.443389152712;2289.7710228977135;2310.9422264443356;2311.029367665576;2322.1756276521846;2247.5729611373786;2255.8082562982086;2261.819054475646;2261.8303627227942;2293.1859189987563;2258.2660635293596;2267.9319620411416;2296.4258935266184;2296.781805728453;2298.1726578431667;2321.4892723600783;2347.272345572878;2351.247600767755;2351.729551101628;2352.094443639211;7143.92856071443;7221.711131554784;7222.205557388683;7229.024081748949;7255.056842610426;4505.301678239845;4550.49944506104;4569.04050149469;4584.106099310636;4593.242115051013;3067.5091985282247;3089.212250876035;3147.6222853257527;3159.7314228290625;3196.3447493263825;979.9951000245024;996.1433167475965;996.6511720897701;1003.0721582536198;1006.7734759679014;10483.423411712352;10501.474926253657;10533.052025317758;10534.420606866619;10549.525271362807;4015.377616469452;4049.4128351389472;4116.950177704726;4118.876433706993;4118.979405103015;8894.066123056986;8945.19493245611;8965;8969.103089691109;8972.551372431482;4509.346144808985;4514.367988481616;4530.501644819067;4541.545845415498;4546.818127274872;3663.2673465307043;3750.1562148516364;4109.116539943867;4124.278251306009;4134.441850350225;3539.079839241764;3548.609652938175;3564.572251329857;3590.838412271454;3600.3339382214376;1084.4523515624717;1086.766345235778;1087.9891201088046;1089.9455027248605;1097.237419993113;1084.8426978088132;1090.3185509056839;1093.6281664234039;1099.725068732817;1129.8644162700527;6927.203371612329;7104.43164546835;7109.786706398816;7115.928840711526;7140.393066589294;1156.7570810129798;1217.1479964025218;1231.1382032577233;1235.2958813476412;1236.783562876511;5442.2380866678695;5457.945420545823;5524.281843360337;5524.613277070647;5531.834044978657;8824.38229323954;9022.413543119676;9079.182873541413;9099.681511147079;9127.68053118151;8996.685116020908;9011.459312441275;9038.186563209343;9043.954780226057;9069.682561110329;6610.471162307004;7085;7133.5719856808755;7155.606441645759;7161.4270858330165;6988.196357418962;7029.191642961125;7032.015517827406;7032.226455090038;7032.929670703227;7729.806754831175;7775.494592851673;7873.5275883447175;7876.40926930494;7893.960530197312;8091.676332946617;8103.149169337371;8169.632366543638;8237.258646721824;8258.793530161794;5639.6334238274385;5749.683767392834;6514.2834288229205;6514.771982980573;6631.3700198481065;6908.861822763416;6908.930910690829;6927.272636373108;6932.272111428228;6957.930420695729;6434.099226108442;6704.329567043256;6779.796606101825;6855.348741869514;6862.759803406857;6643.069970204078;6649.168853893263;6777.559458635173;6845.14435695538;6848.931510684829;6693.1298931138645;6755.3582409671;6808.148981377328;6810.28492008332;6843.520953533205;6355.332690067661;6377.2984971654005;6409.647469389229;6409.871802563829;6424.164858568356;6400.519961003037;6408.9038664421005;6460.870782584416;6467.126937863516;6469.417752402118 23:12:58 INFO - PROCESS | 16563 | |4;prototype.html;315.4778841018115;324.9155219642894;340.99147521311966;344.0555674673023;350.20852872508124;5826.359100498942;5915.733791979361;5951.196588460556;5969.9403005969925;5978.82063538094;5727.742251598677;5868.530517558595;5895.056790913454;5911;5913.2017177681;4552.180607490651;4565.817367305321;4576.382188404573;4577.153226653063;4590.931136032962;4309.525952145262;4379.430674012374;4495.595396414322;4590;4602.171609110359;4538.364628951949;4548.363229147922;4556.476005259405;4564.5435456454425;4566.862994110182;4533.478649955265;4539.59143677069;4570.748608826513;4578.130155270488;4587.495375508692;4017.216642754664;4018.0557568971267;4021.738586991836;4037.051292946155;4038;5529.861753456155;5634.887302253932;5641.943580564182;5695.686737229451;5715.799947001835;5279.656822306576;5281.36623605166;5281.52466278033;5281.947180528223;5291.656042357235;6003.6097653652805;6301.243850737941;6304.369563043659;6308.653024083674;6313.558050936436;4259.5740425957465;4306.267934451151;4370.475542934836;4380.934285985712;4380.956190438087;6489.513286503484;6571.474282057424;6581.30896255891;6587.934120658828;6604.174478190274;4356.49900261474;4360.738355698668;4360.934585981213;4361.542038085955;4363.978180109079;4346.130773845181;4419.138268037702;4420.447444069491;4423.248047831877;4448.065906159743;5165.560927321145;5168.328117344797;5173.224016397495;5175.818846340435;5176.223566465061;6320.936790632127;6325.209348831396;6331.398517140957;6338.144350512622;6340.112384266206;1599.6240883392393;1612.0972255536938;1613.491750098715;1613.572403313123;1613.6611311624456;1068.1988508618535;1074.6399956014666;1082.9350238985687;1089.9128069754402;1100.5597760895546;6042.154098426224;6043.667598282137;6045.395460453919;6052.152698622196;6062.302835173923;6495.610263384212;6496.350364963466;6519.348065193442;6532.510061745388;6546.509011824132;5921.2006379138265;6027.276726792813;6032.336442991267;6033.215681961317;6042.728077236535;3475.4786781982907;3523.4010218262956;3527.700145487662;3529.541159649229;3539.7876127432437;6818.897716534256;6827.829304267334;6837.111175547247;6839.213490448662;6840.657967101625;6690.163729533809;6693.431058359996;6695.732170713214;6699.330066993261;6709.29552397001;6663.666816659148;6833.384995350343;6854.760083397057;6912.930870691229;6922.100126983561;6328.7152078157515;6475.676216189266;6612.867742645024;6617.073609694743;6620.602763834186;6374.107624932606;6472.838179045561;6500.414962653384;6508.153939987771;6510.73957041732;6856.554323968926;6864.553804002724;6866.690998905161;6866.725330986705;6868.828279292858;4454.732716037048;4525.818967241274;4559.863204103882;4560.179167749704;4562.977185114053;6591.978243372285;6592.307807680125;6592.571482853599;6593;6598.439132673777;6402.327755585597;6403.807885763435;6415.390537898892;6416.165898433173;6416.358364163546;6238.844028899314;6387.457066149429;6405.615663060231;6407.679616019273;6410.1987251593555;6297.748090076346;6300.464460520907;6301.40136687014;6304.432601065926;6314.463270622048;6431.324710905475;6438.581492202992;6443.6455994920725;6449.290578036318;6456.12842266288;6082.996305609525;6212.9068063979985;6244.68776561161;6280.497560195265;6286.371362863677 23:12:58 INFO - PROCESS | 16563 | |5;yui.html;718.942484601232;753.3031945450457;757.3865169212937;819.6762129564613;852.2585350744853;12885.291308978003;13139;13140.737185256288;13155.342232888364;13169.934150329247;11879.465424055916;11962.461689223985;11969.521219151246;11978.820317695241;11987.940060299687;651.9543631945766;661.9338066193366;811.5901469757764;822.6298165825373;825.3562221467236;816.4570560577209;821.4414198345123;828.494618282847;828.6850996621275;830.4021104804531;871.037503558565;873.0309356614154;877.1623099939543;878.9033206347297;879.4503435352905;676.6582875647815;682.4744946391276;856.1139220906394;868.4224990381389;869.1829680100685;638.86903184847;643.2988043033116;643.719981807915;644.6679959820696;644.935506449356;12399.938000309941;12506.74986500274;12509;12520.81218781719;12529.248245105322;11281.210315277935;11575.652730418102;11759.35323557204;11988.160828741991;12053.276803391736;9805.460699661517;9893.604255829758;9923.671748556333;9942.254330925138;9967.601295948154;3569.37535931211;3570.410882204433;3596.3166998270244;3638.6725194732603;3714.3685573452576;45573.31640025402;45653.40213092526;45706;45712.3143152853;45757.54242457599;9531.809363812823;9534.809303813885;9620.230381569458;9681.951590242004;9774.95112524447;17761.822381776015;17771;17771.82228177702;17779.73330400045;17821.287148514173;6893.4140598048725;7161.355478007004;7360.07999000125;7489.85020299591;7626.084869815658;4318.52496225415;4323.2434323993175;4344.47866256045;4444.73331600105;4484.618807401407;2998.925026874302;3012.472817256971;3040.771942104351;3044.421559903611;3044.528098144791;567.2144080448609;568.0371769850065;568.5707290995355;570.2074116977404;582.830979016089;510.4410670315998;525.6425630571172;529.6107361089596;534.036064902854;547.3295213363598;7595.658195381221;7664.770056898302;7812.267196424137;7916.604169791487;7948.046234451903;523.5680563535022;533.6851257757942;534.8181618249736;537.8951104534578;571.9227904232959;3440.3119376124873;3556.395412779834;3631.6005239423644;3652.3243200008083;3783.1677031053123;48026.519734802205;48287;48316.27525587119;48352.27471587929;48506.757466212446;45097.77451112724;45402.545974540495;47852;47901.28148077782;48740.512594873595;40674.79662601668;41863.581364186575;41944.79027604903;42005;42058;7598.354139898171;7816.804579885548;8121.147279535564;8266.421350505647;8277.255047045795;32922.50616240806;33003.66996330006;33672.49491257584;35356.823215883756;35875;44941.550584493736;45040.54959450495;45149;45359.092818142795;46005;10375.429351385746;10432.843507347548;10447.373157610567;10660.230100587856;10689.358638481715;11108.833367499332;11247.550097996316;11409.771804564029;11604.187706860439;11780.175387722777;10107.292489525957;10132;10256.282060255711;10377.584896604354;10539.209559282932;9900.554475048497;10122.493875306352;10131.79736405253;10212.438315892698;10484.580616775243;10261.538230779484;10312.948435258077;10370.585176593153;10569.429376225478;10654.360738355723;8767.517786521803;9051.502167380857;9059.501727405055;9123.726288211365;9477.194438472532;8387.457951240818;8417.663293468193;8724.738257852021;8798.780030499032;9305.162535371848 23:12:58 INFO - PROCESS | 16563 | __end_tp_report 23:12:58 INFO - PROCESS | 16563 | __start_cc_report 23:12:58 INFO - PROCESS | 16563 | _x_x_mozilla_cycle_collect,897 23:12:58 INFO - PROCESS | 16563 | __end_cc_report 23:12:58 INFO - PROCESS | 16563 | __startTimestamp1451632378887__endTimestamp 23:12:58 INFO - PROCESS | 16563 | 23:12:58 INFO - PROCESS | 16563 | ------- Summary: start ------- 23:12:58 INFO - PROCESS | 16563 | Number of tests: 6 23:12:58 INFO - PROCESS | 16563 | 23:12:58 INFO - PROCESS | 16563 | [#0] dojo.html Cycles:165 Average:5254.28 Median:5402.38 stddev:571.00 (10.6%) stddev-sans-first:546.66 23:12:58 INFO - PROCESS | 16563 | Values: 3078.9 3158.5 3201.2 3202.6 3220.0 5127.1 5242.1 5257.4 5283.9 5331.7 5240.4 5275.5 5317.5 5326.9 5348.7 4783.5 4825.3 4866.8 4956.9 4989.4 4912.4 4941.2 4978.8 4984.1 5025.1 4733.2 4746.7 4828.3 4832.9 4905.1 4771.6 4778.8 4781.4 4821.1 4828.9 4726.2 4766.8 4777.8 4788.0 4821.3 4961.4 5016.2 5104.8 5121.1 5137.6 5622.4 5632.0 5634.3 5650.2 5660.4 5678.0 5686.8 5692.4 5700.6 5708.0 5172.5 5263.1 5290.2 5292.2 5370.9 5791.2 5841.5 5851.5 5860.1 5865.7 5574.7 5576.4 5579.8 5584.4 5594.9 5478.6 5515.7 5573.6 5656.5 5656.9 5571.6 5622.9 5628.1 5631.2 5672.8 5657.5 5671.6 5674.8 5675.7 5681.0 4305.1 4375.5 4385.2 4395.3 4431.9 3897.4 3918.4 3934.9 3950.4 3958.4 5327.4 5335.3 5337.9 5343.6 5388.1 5522.5 5621.3 5621.8 5720.6 5723.0 5321.5 5390.5 5391.9 5396.2 5402.4 4800.7 4919.2 4927.6 4928.9 4970.9 5755.7 5839.0 5867.4 5867.8 5909.9 5618.8 5632.7 5651.1 5664.9 5704.6 5808.1 5833.2 5841.6 5843.7 5849.9 5492.7 5549.8 5567.9 5610.8 5624.5 5699.8 5701.6 5718.4 5740.2 5798.0 5463.9 5529.9 5532.2 5534.1 5543.8 5425.4 5491.9 5540.5 5543.3 5543.9 5391.8 5463.0 5463.0 5463.1 5500.5 5347.7 5388.1 5399.3 5419.5 5425.8 5283.1 5313.7 5343.9 5380.1 5421.7 23:12:58 INFO - PROCESS | 16563 | 23:12:58 INFO - PROCESS | 16563 | [#1] ext.html Cycles:180 Average:44707.17 Median:169137.50 stddev:73459.64 (43.4%) stddev-sans-first:73590.82 23:12:58 INFO - PROCESS | 16563 | Values: 527.7 554.5 555.9 563.3 579.2 25438.6 25978.7 26056.0 35670.3 36353.0 42999.8 43277.0 43320.8 43439.3 43484.6 8661.7 8819.2 8837.0 8852.3 8854.0 7699.8 7835.8 10174.1 10286.2 10299.3 10003.0 10098.5 10099.8 10105.7 10124.2 7785.6 7952.2 10110.8 10207.3 10218.6 10035.9 10311.4 10313.8 10314.4 10316.3 36705.6 37022.4 37237.1 37283.8 37358.3 3260.6 3666.3 3777.5 3796.7 3813.3 28500.1 28810.6 28883.1 30651.2 31697.2 3628.8 3649.8 3653.3 3699.3 3792.1 277746.0 278393.0 278548.6 279322.0 279918.0 60698.4 61258.4 61324.0 61364.0 61398.0 54713.0 56002.0 62552.7 62770.4 64714.0 14827.8 14938.4 15024.2 15060.8 15070.8 10219.3 10252.7 10270.4 10299.3 10302.2 18840.0 18923.7 19122.9 19194.0 19222.4 6994.5 7284.9 7321.8 7375.3 7410.9 934.4 961.3 1048.9 1051.4 1054.1 27951.3 28043.9 28629.9 28648.3 28757.4 1030.3 1090.2 1095.9 1111.8 1133.8 15003.9 15633.0 15665.0 15901.1 15912.7 302058.0 306044.0 306308.0 307047.0 307227.0 53593.7 54103.7 54129.0 54300.5 54365.7 1087.0 1089.2 1133.1 1366.0 1387.8 19698.0 28561.1 29458.9 29548.0 29790.4 42842.4 43018.1 43035.0 43265.4 43389.8 204136.0 204993.0 276949.0 283751.0 297399.0 29550.0 29578.4 29736.6 29916.4 30008.0 40583.2 40911.8 41069.6 41597.4 41934.2 34559.8 34664.1 34904.7 35067.5 35220.8 34625.3 34708.1 35502.0 35602.6 35759.0 32253.4 32971.5 32982.2 35066.3 35505.5 31048.0 31939.6 32689.5 32738.7 32753.8 23380.8 23911.3 24031.5 24049.9 24054.8 23:12:58 INFO - PROCESS | 16563 | 23:12:58 INFO - PROCESS | 16563 | [#2] jquery.html Cycles:180 Average:29306.98 Median:37402.62 stddev:88998.56 (237.9%) stddev-sans-first:89221.67 23:12:58 INFO - PROCESS | 16563 | Values: 352.8 357.8 359.6 364.6 364.7 13492.6 13855.6 16241.6 16292.4 16740.5 15124.5 15158.3 15689.8 15690.4 15725.6 5073.3 5343.1 5353.6 5358.1 5366.2 3907.7 4018.7 5279.9 5803.6 5937.8 5854.8 5877.0 5882.4 5901.1 5906.6 5546.4 6013.9 6016.8 6018.4 6025.0 5198.7 5275.3 5281.9 5291.5 5302.0 19957.3 20193.9 20328.0 20329.2 20400.8 2081.4 2157.8 2248.4 2255.6 2298.3 12610.3 12723.3 12771.2 12968.9 13221.1 1747.7 1755.6 1798.3 1850.5 1856.9 58700.7 67690.3 68050.7 68399.7 70221.0 9904.7 10037.4 10083.4 10115.5 10143.1 13338.4 13345.8 13362.5 13368.7 13379.0 7275.0 7324.8 7347.9 7457.5 7540.2 6894.4 6944.4 6961.8 6970.5 7004.1 4372.5 4398.4 4402.7 4423.3 4474.6 1704.7 1733.5 1773.6 1817.6 1818.2 840.0 844.8 865.4 875.1 967.8 13551.5 15508.8 15742.2 16309.2 16407.1 889.9 932.8 947.4 974.8 988.6 8459.6 9212.8 9345.6 9516.1 9907.9 530776.0 536037.0 541639.0 550651.0 559913.0 79459.0 81126.2 82241.2 85013.6 87794.0 990.2 1010.8 1126.7 1198.2 1213.4 14981.6 15070.9 15279.5 15482.3 15542.3 35738.3 36170.3 37195.8 37609.4 38046.8 48484.0 48988.0 49677.3 50291.5 51319.7 9506.0 9531.4 9654.4 9667.2 9769.6 16250.4 16932.4 17268.8 17316.8 17904.0 13742.9 13826.6 13892.8 14067.9 14308.4 13705.4 13855.4 14043.8 14262.5 14284.6 13606.0 13608.1 13947.2 14090.6 14218.6 9681.5 9752.1 9759.1 9840.9 9893.0 13473.2 13486.2 13634.7 13946.2 14392.6 23:12:58 INFO - PROCESS | 16563 | 23:12:58 INFO - PROCESS | 16563 | [#3] mootools.html Cycles:180 Average:5266.66 Median:6388.91 stddev:2692.76 (42.1%) stddev-sans-first:2683.98 23:12:58 INFO - PROCESS | 16563 | Values: 1320.4 1475.2 1475.2 1640.0 1817.0 6708.7 7423.8 7511.8 7515.2 7519.7 7279.2 7471.0 7478.4 7487.1 7491.9 2215.2 2254.4 2258.5 2258.8 2260.4 2226.4 2289.8 2310.9 2311.0 2322.2 2247.6 2255.8 2261.8 2261.8 2293.2 2258.3 2267.9 2296.4 2296.8 2298.2 2321.5 2347.3 2351.2 2351.7 2352.1 7143.9 7221.7 7222.2 7229.0 7255.1 4505.3 4550.5 4569.0 4584.1 4593.2 3067.5 3089.2 3147.6 3159.7 3196.3 980.0 996.1 996.7 1003.1 1006.8 10483.4 10501.5 10533.1 10534.4 10549.5 4015.4 4049.4 4117.0 4118.9 4119.0 8894.1 8945.2 8965.0 8969.1 8972.6 4509.3 4514.4 4530.5 4541.5 4546.8 3663.3 3750.2 4109.1 4124.3 4134.4 3539.1 3548.6 3564.6 3590.8 3600.3 1084.5 1086.8 1088.0 1089.9 1097.2 1084.8 1090.3 1093.6 1099.7 1129.9 6927.2 7104.4 7109.8 7115.9 7140.4 1156.8 1217.1 1231.1 1235.3 1236.8 5442.2 5457.9 5524.3 5524.6 5531.8 8824.4 9022.4 9079.2 9099.7 9127.7 8996.7 9011.5 9038.2 9044.0 9069.7 6610.5 7085.0 7133.6 7155.6 7161.4 6988.2 7029.2 7032.0 7032.2 7032.9 7729.8 7775.5 7873.5 7876.4 7894.0 8091.7 8103.1 8169.6 8237.3 8258.8 5639.6 5749.7 6514.3 6514.8 6631.4 6908.9 6908.9 6927.3 6932.3 6957.9 6434.1 6704.3 6779.8 6855.3 6862.8 6643.1 6649.2 6777.6 6845.1 6848.9 6693.1 6755.4 6808.1 6810.3 6843.5 6355.3 6377.3 6409.6 6409.9 6424.2 6400.5 6408.9 6460.9 6467.1 6469.4 23:12:58 INFO - PROCESS | 16563 | 23:12:58 INFO - PROCESS | 16563 | [#4] prototype.html Cycles:180 Average:5293.80 Median:5991.22 stddev:1608.27 (26.8%) stddev-sans-first:1568.78 23:12:58 INFO - PROCESS | 16563 | Values: 315.5 324.9 341.0 344.1 350.2 5826.4 5915.7 5951.2 5969.9 5978.8 5727.7 5868.5 5895.1 5911.0 5913.2 4552.2 4565.8 4576.4 4577.2 4590.9 4309.5 4379.4 4495.6 4590.0 4602.2 4538.4 4548.4 4556.5 4564.5 4566.9 4533.5 4539.6 4570.7 4578.1 4587.5 4017.2 4018.1 4021.7 4037.1 4038.0 5529.9 5634.9 5641.9 5695.7 5715.8 5279.7 5281.4 5281.5 5281.9 5291.7 6003.6 6301.2 6304.4 6308.7 6313.6 4259.6 4306.3 4370.5 4380.9 4381.0 6489.5 6571.5 6581.3 6587.9 6604.2 4356.5 4360.7 4360.9 4361.5 4364.0 4346.1 4419.1 4420.4 4423.2 4448.1 5165.6 5168.3 5173.2 5175.8 5176.2 6320.9 6325.2 6331.4 6338.1 6340.1 1599.6 1612.1 1613.5 1613.6 1613.7 1068.2 1074.6 1082.9 1089.9 1100.6 6042.2 6043.7 6045.4 6052.2 6062.3 6495.6 6496.4 6519.3 6532.5 6546.5 5921.2 6027.3 6032.3 6033.2 6042.7 3475.5 3523.4 3527.7 3529.5 3539.8 6818.9 6827.8 6837.1 6839.2 6840.7 6690.2 6693.4 6695.7 6699.3 6709.3 6663.7 6833.4 6854.8 6912.9 6922.1 6328.7 6475.7 6612.9 6617.1 6620.6 6374.1 6472.8 6500.4 6508.2 6510.7 6856.6 6864.6 6866.7 6866.7 6868.8 4454.7 4525.8 4559.9 4560.2 4563.0 6592.0 6592.3 6592.6 6593.0 6598.4 6402.3 6403.8 6415.4 6416.2 6416.4 6238.8 6387.5 6405.6 6407.7 6410.2 6297.7 6300.5 6301.4 6304.4 6314.5 6431.3 6438.6 6443.6 6449.3 6456.1 6083.0 6212.9 6244.7 6280.5 6286.4 23:12:58 INFO - PROCESS | 16563 | 23:12:58 INFO - PROCESS | 16563 | [#5] yui.html Cycles:180 Average:12874.14 Median:46928.50 stddev:14661.98 (31.2%) stddev-sans-first:14674.69 23:12:58 INFO - PROCESS | 16563 | Values: 718.9 753.3 757.4 819.7 852.3 12885.3 13139.0 13140.7 13155.3 13169.9 11879.5 11962.5 11969.5 11978.8 11987.9 652.0 661.9 811.6 822.6 825.4 816.5 821.4 828.5 828.7 830.4 871.0 873.0 877.2 878.9 879.5 676.7 682.5 856.1 868.4 869.2 638.9 643.3 643.7 644.7 644.9 12399.9 12506.7 12509.0 12520.8 12529.2 11281.2 11575.7 11759.4 11988.2 12053.3 9805.5 9893.6 9923.7 9942.3 9967.6 3569.4 3570.4 3596.3 3638.7 3714.4 45573.3 45653.4 45706.0 45712.3 45757.5 9531.8 9534.8 9620.2 9682.0 9775.0 17761.8 17771.0 17771.8 17779.7 17821.3 6893.4 7161.4 7360.1 7489.9 7626.1 4318.5 4323.2 4344.5 4444.7 4484.6 2998.9 3012.5 3040.8 3044.4 3044.5 567.2 568.0 568.6 570.2 582.8 510.4 525.6 529.6 534.0 547.3 7595.7 7664.8 7812.3 7916.6 7948.0 523.6 533.7 534.8 537.9 571.9 3440.3 3556.4 3631.6 3652.3 3783.2 48026.5 48287.0 48316.3 48352.3 48506.8 45097.8 45402.5 47852.0 47901.3 48740.5 40674.8 41863.6 41944.8 42005.0 42058.0 7598.4 7816.8 8121.1 8266.4 8277.3 32922.5 33003.7 33672.5 35356.8 35875.0 44941.6 45040.5 45149.0 45359.1 46005.0 10375.4 10432.8 10447.4 10660.2 10689.4 11108.8 11247.6 11409.8 11604.2 11780.2 10107.3 10132.0 10256.3 10377.6 10539.2 9900.6 10122.5 10131.8 10212.4 10484.6 10261.5 10312.9 10370.6 10569.4 10654.4 8767.5 9051.5 9059.5 9123.7 9477.2 8387.5 8417.7 8724.7 8798.8 9305.2 23:12:58 INFO - PROCESS | 16563 | -------- Summary: end -------- 23:12:58 INFO - PROCESS | 16563 | 23:12:59 INFO - TEST-INFO | 16563: exit 0 23:12:59 INFO - TEST-OK | dromaeo_css | took 1113517ms 23:12:59 INFO - TEST-START | kraken 23:12:59 INFO - operating with platform_type : linux_ 23:12:59 INFO - Initialising browser for kraken test... 23:12:59 INFO - TEST-INFO | started process 16759 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHiXGHo/profile http://localhost:45149/getInfo.html) 23:13:03 INFO - PROCESS | 16759 | __metrics Screen width/height:1600/1200 23:13:03 INFO - PROCESS | 16759 | colorDepth:24 23:13:03 INFO - PROCESS | 16759 | Browser inner width/height: 1024/697 23:13:03 INFO - PROCESS | 16759 | __metrics 23:13:03 INFO - PROCESS | 16759 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:13:03 INFO - PROCESS | 16759 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:13:04 INFO - TEST-INFO | 16759: exit 0 23:13:04 INFO - Browser initialized. 23:13:04 INFO - Running cycle 1/1 for kraken test... 23:13:04 INFO - TEST-INFO | started process 16839 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHiXGHo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:13:16 INFO - PROCESS | 16839 | RSS: Main: 150253568 23:13:16 INFO - PROCESS | 16839 | 23:13:19 INFO - PROCESS | 16839 | Cycle 1(1): loaded http://localhost:45149/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45149/tests/kraken/driver.html?testName=audio-beat-detection) 23:13:19 INFO - PROCESS | 16839 | RSS: Main: 184074240 23:13:19 INFO - PROCESS | 16839 | 23:13:22 INFO - PROCESS | 16839 | Cycle 1(1): loaded http://localhost:45149/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45149/tests/kraken/driver.html?testName=audio-dft) 23:13:22 INFO - PROCESS | 16839 | RSS: Main: 174059520 23:13:22 INFO - PROCESS | 16839 | 23:13:25 INFO - PROCESS | 16839 | Cycle 1(1): loaded http://localhost:45149/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45149/tests/kraken/driver.html?testName=audio-fft) 23:13:26 INFO - PROCESS | 16839 | RSS: Main: 160227328 23:13:26 INFO - PROCESS | 16839 | 23:13:28 INFO - PROCESS | 16839 | Cycle 1(1): loaded http://localhost:45149/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45149/tests/kraken/driver.html?testName=audio-oscillator) 23:13:28 INFO - PROCESS | 16839 | RSS: Main: 162856960 23:13:28 INFO - PROCESS | 16839 | 23:13:31 INFO - PROCESS | 16839 | Cycle 1(1): loaded http://localhost:45149/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45149/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:13:31 INFO - PROCESS | 16839 | RSS: Main: 165576704 23:13:31 INFO - PROCESS | 16839 | 23:13:34 INFO - PROCESS | 16839 | Cycle 1(1): loaded http://localhost:45149/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45149/tests/kraken/driver.html?testName=imaging-darkroom) 23:13:35 INFO - PROCESS | 16839 | RSS: Main: 163516416 23:13:35 INFO - PROCESS | 16839 | 23:13:38 INFO - PROCESS | 16839 | Cycle 1(1): loaded http://localhost:45149/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45149/tests/kraken/driver.html?testName=imaging-desaturate) 23:13:39 INFO - PROCESS | 16839 | RSS: Main: 166219776 23:13:39 INFO - PROCESS | 16839 | 23:13:41 INFO - PROCESS | 16839 | Cycle 1(1): loaded http://localhost:45149/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45149/tests/kraken/driver.html?testName=json-parse-financial) 23:13:42 INFO - PROCESS | 16839 | RSS: Main: 166830080 23:13:42 INFO - PROCESS | 16839 | 23:13:44 INFO - PROCESS | 16839 | Cycle 1(1): loaded http://localhost:45149/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45149/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:13:44 INFO - PROCESS | 16839 | RSS: Main: 177528832 23:13:44 INFO - PROCESS | 16839 | 23:13:46 INFO - PROCESS | 16839 | Cycle 1(1): loaded http://localhost:45149/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45149/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:13:47 INFO - PROCESS | 16839 | RSS: Main: 176566272 23:13:47 INFO - PROCESS | 16839 | 23:13:49 INFO - PROCESS | 16839 | Cycle 1(1): loaded http://localhost:45149/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45149/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:13:49 INFO - PROCESS | 16839 | RSS: Main: 188309504 23:13:49 INFO - PROCESS | 16839 | 23:13:52 INFO - PROCESS | 16839 | Cycle 1(1): loaded http://localhost:45149/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:13:52 INFO - PROCESS | 16839 | RSS: Main: 196173824 23:13:52 INFO - PROCESS | 16839 | 23:13:55 INFO - PROCESS | 16839 | Cycle 1(1): loaded http://localhost:45149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:13:55 INFO - PROCESS | 16839 | RSS: Main: 192929792 23:13:55 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | Cycle 1(1): loaded http://localhost:45149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45149/tests/kraken/driver.html?testName=ai-astar) 23:13:57 INFO - PROCESS | 16839 | RSS: Main: 252051456 23:13:57 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | __start_tp_report 23:13:57 INFO - PROCESS | 16839 | _x_x_mozilla_page_load 23:13:57 INFO - PROCESS | 16839 | _x_x_mozilla_page_load_details 23:13:57 INFO - PROCESS | 16839 | |i|pagename|runs| 23:13:57 INFO - PROCESS | 16839 | |0;ai-astar;111;112;105;112;111;111;101;112;113;102 23:13:57 INFO - PROCESS | 16839 | |1;audio-beat-detection;153;126;146;171;127;149;149;127;162;129 23:13:57 INFO - PROCESS | 16839 | |2;audio-dft;163;162;160;161;164;161;163;162;166;162 23:13:57 INFO - PROCESS | 16839 | |3;audio-fft;75;73;82;92;74;72;73;128;90;71 23:13:57 INFO - PROCESS | 16839 | |4;audio-oscillator;97;96;141;96;95;95;141;95;96;138 23:13:57 INFO - PROCESS | 16839 | |5;imaging-gaussian-blur;109;109;109;109;109;110;108;109;109;109 23:13:57 INFO - PROCESS | 16839 | |6;imaging-darkroom;146;146;146;145;146;145;146;145;145;147 23:13:57 INFO - PROCESS | 16839 | |7;imaging-desaturate;95;96;95;96;95;95;95;95;96;96 23:13:57 INFO - PROCESS | 16839 | |8;json-parse-financial;58;59;57;58;57;60;61;72;56;59 23:13:57 INFO - PROCESS | 16839 | |9;json-stringify-tinderbox;69;69;68;69;68;69;68;69;68;69 23:13:57 INFO - PROCESS | 16839 | |10;stanford-crypto-aes;85;86;87;85;93;87;87;86;86;85 23:13:57 INFO - PROCESS | 16839 | |11;stanford-crypto-ccm;117;122;115;115;123;124;123;126;121;120 23:13:57 INFO - PROCESS | 16839 | |12;stanford-crypto-pbkdf2;140;162;152;150;152;139;151;152;150;143 23:13:57 INFO - PROCESS | 16839 | |13;stanford-crypto-sha256-iterative;73;66;71;67;68;67;66;69;69;67 23:13:57 INFO - PROCESS | 16839 | __end_tp_report 23:13:57 INFO - PROCESS | 16839 | __start_cc_report 23:13:57 INFO - PROCESS | 16839 | _x_x_mozilla_cycle_collect,933 23:13:57 INFO - PROCESS | 16839 | __end_cc_report 23:13:57 INFO - PROCESS | 16839 | __startTimestamp1451632437831__endTimestamp 23:13:57 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | ------- Summary: start ------- 23:13:57 INFO - PROCESS | 16839 | Number of tests: 14 23:13:57 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | [#0] ai-astar Cycles:10 Average:109.00 Median:111.50 stddev:4.52 (4.1%) stddev-sans-first:4.74 23:13:57 INFO - PROCESS | 16839 | Values: 111.0 112.0 105.0 112.0 111.0 111.0 101.0 112.0 113.0 102.0 23:13:57 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:149.00 stddev:16.04 (10.8%) stddev-sans-first:16.67 23:13:57 INFO - PROCESS | 16839 | Values: 153.0 126.0 146.0 171.0 127.0 149.0 149.0 127.0 162.0 129.0 23:13:57 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.71 (1.1%) stddev-sans-first:1.80 23:13:57 INFO - PROCESS | 16839 | Values: 163.0 162.0 160.0 161.0 164.0 161.0 163.0 162.0 166.0 162.0 23:13:57 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | [#3] audio-fft Cycles:10 Average:83.00 Median:74.50 stddev:17.53 (23.5%) stddev-sans-first:18.35 23:13:57 INFO - PROCESS | 16839 | Values: 75.0 73.0 82.0 92.0 74.0 72.0 73.0 128.0 90.0 71.0 23:13:57 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:95.50 stddev:21.42 (22.4%) stddev-sans-first:22.27 23:13:57 INFO - PROCESS | 16839 | Values: 97.0 96.0 141.0 96.0 95.0 95.0 141.0 95.0 96.0 138.0 23:13:57 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 23:13:57 INFO - PROCESS | 16839 | Values: 109.0 109.0 109.0 109.0 109.0 110.0 108.0 109.0 109.0 109.0 23:13:57 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 23:13:57 INFO - PROCESS | 16839 | Values: 146.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 145.0 147.0 23:13:57 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:13:57 INFO - PROCESS | 16839 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 23:13:57 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:59.00 stddev:4.57 (7.7%) stddev-sans-first:4.81 23:13:57 INFO - PROCESS | 16839 | Values: 58.0 59.0 57.0 58.0 57.0 60.0 61.0 72.0 56.0 59.0 23:13:57 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 23:13:57 INFO - PROCESS | 16839 | Values: 69.0 69.0 68.0 69.0 68.0 69.0 68.0 69.0 68.0 69.0 23:13:57 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.50 stddev:2.36 (2.7%) stddev-sans-first:2.42 23:13:57 INFO - PROCESS | 16839 | Values: 85.0 86.0 87.0 85.0 93.0 87.0 87.0 86.0 86.0 85.0 23:13:57 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:122.50 stddev:3.81 (3.1%) stddev-sans-first:3.81 23:13:57 INFO - PROCESS | 16839 | Values: 117.0 122.0 115.0 115.0 123.0 124.0 123.0 126.0 121.0 120.0 23:13:57 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.10 Median:151.50 stddev:6.82 (4.5%) stddev-sans-first:6.39 23:13:57 INFO - PROCESS | 16839 | Values: 140.0 162.0 152.0 150.0 152.0 139.0 151.0 152.0 150.0 143.0 23:13:57 INFO - PROCESS | 16839 | 23:13:57 INFO - PROCESS | 16839 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:2.26 (3.3%) stddev-sans-first:1.64 23:13:57 INFO - PROCESS | 16839 | Values: 73.0 66.0 71.0 67.0 68.0 67.0 66.0 69.0 69.0 67.0 23:13:57 INFO - PROCESS | 16839 | -------- Summary: end -------- 23:13:57 INFO - PROCESS | 16839 | 23:13:58 INFO - TEST-INFO | 16839: exit 0 23:13:58 INFO - TEST-OK | kraken | took 59134ms 23:13:58 INFO - TEST-START | v8_7 23:13:58 INFO - operating with platform_type : linux_ 23:13:58 INFO - Initialising browser for v8_7 test... 23:13:58 INFO - TEST-INFO | started process 17091 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYftn2M/profile http://localhost:45149/getInfo.html) 23:14:02 INFO - PROCESS | 17091 | __metrics Screen width/height:1600/1200 23:14:02 INFO - PROCESS | 17091 | colorDepth:24 23:14:02 INFO - PROCESS | 17091 | Browser inner width/height: 1024/697 23:14:02 INFO - PROCESS | 17091 | __metrics 23:14:02 INFO - PROCESS | 17091 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:14:02 INFO - PROCESS | 17091 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:14:03 INFO - TEST-INFO | 17091: exit 0 23:14:03 INFO - Browser initialized. 23:14:03 INFO - Running cycle 1/1 for v8_7 test... 23:14:03 INFO - TEST-INFO | started process 17176 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYftn2M/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:15 INFO - PROCESS | 17176 | RSS: Main: 149491712 23:14:15 INFO - PROCESS | 17176 | 23:14:37 INFO - PROCESS | 17176 | Cycle 1(1): loaded http://localhost:45149/tests/v8_7/run.html (next: http://localhost:45149/tests/v8_7/run.html) 23:14:37 INFO - PROCESS | 17176 | RSS: Main: 578752512 23:14:37 INFO - PROCESS | 17176 | 23:14:37 INFO - PROCESS | 17176 | __start_tp_report 23:14:37 INFO - PROCESS | 17176 | _x_x_mozilla_page_load 23:14:37 INFO - PROCESS | 17176 | _x_x_mozilla_page_load_details 23:14:37 INFO - PROCESS | 17176 | |i|pagename|runs| 23:14:37 INFO - PROCESS | 17176 | |0;Richards;166.55562958027983 23:14:37 INFO - PROCESS | 17176 | |1;DeltaBlue;190.65776930409913 23:14:37 INFO - PROCESS | 17176 | |2;Encrypt;281.0567734682406 23:14:37 INFO - PROCESS | 17176 | |3;Decrypt;5240.837696335078 23:14:37 INFO - PROCESS | 17176 | |4;RayTrace;2063.917525773196 23:14:37 INFO - PROCESS | 17176 | |5;Earley;810.3727714748784 23:14:37 INFO - PROCESS | 17176 | |6;Boyer;12708.860759493671 23:14:37 INFO - PROCESS | 17176 | |7;RegExp;25575 23:14:37 INFO - PROCESS | 17176 | |8;Splay;640.4350607805502 23:14:37 INFO - PROCESS | 17176 | |9;NavierStokes;4835.748792270531 23:14:37 INFO - PROCESS | 17176 | __end_tp_report 23:14:37 INFO - PROCESS | 17176 | __startTimestamp1451632477276__endTimestamp 23:14:37 INFO - PROCESS | 17176 | 23:14:37 INFO - PROCESS | 17176 | ------- Summary: start ------- 23:14:37 INFO - PROCESS | 17176 | Number of tests: 10 23:14:37 INFO - PROCESS | 17176 | 23:14:37 INFO - PROCESS | 17176 | [#0] Richards Cycles:1 Average:166.56 Median:166.56 stddev:0.00 (0.0%) 23:14:37 INFO - PROCESS | 17176 | Values: 166.6 23:14:37 INFO - PROCESS | 17176 | 23:14:37 INFO - PROCESS | 17176 | [#1] DeltaBlue Cycles:1 Average:190.66 Median:190.66 stddev:0.00 (0.0%) 23:14:37 INFO - PROCESS | 17176 | Values: 190.7 23:14:37 INFO - PROCESS | 17176 | 23:14:37 INFO - PROCESS | 17176 | [#2] Encrypt Cycles:1 Average:281.06 Median:281.06 stddev:0.00 (0.0%) 23:14:37 INFO - PROCESS | 17176 | Values: 281.1 23:14:37 INFO - PROCESS | 17176 | 23:14:37 INFO - PROCESS | 17176 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 23:14:37 INFO - PROCESS | 17176 | Values: 5240.8 23:14:37 INFO - PROCESS | 17176 | 23:14:37 INFO - PROCESS | 17176 | [#4] RayTrace Cycles:1 Average:2063.92 Median:2063.92 stddev:0.00 (0.0%) 23:14:37 INFO - PROCESS | 17176 | Values: 2063.9 23:14:37 INFO - PROCESS | 17176 | 23:14:37 INFO - PROCESS | 17176 | [#5] Earley Cycles:1 Average:810.37 Median:810.37 stddev:0.00 (0.0%) 23:14:37 INFO - PROCESS | 17176 | Values: 810.4 23:14:37 INFO - PROCESS | 17176 | 23:14:37 INFO - PROCESS | 17176 | [#6] Boyer Cycles:1 Average:12708.86 Median:12708.86 stddev:0.00 (0.0%) 23:14:37 INFO - PROCESS | 17176 | Values: 12708.9 23:14:37 INFO - PROCESS | 17176 | 23:14:37 INFO - PROCESS | 17176 | [#7] RegExp Cycles:1 Average:25575.00 Median:25575.00 stddev:0.00 (0.0%) 23:14:37 INFO - PROCESS | 17176 | Values: 25575.0 23:14:37 INFO - PROCESS | 17176 | 23:14:37 INFO - PROCESS | 17176 | [#8] Splay Cycles:1 Average:640.44 Median:640.44 stddev:0.00 (0.0%) 23:14:37 INFO - PROCESS | 17176 | Values: 640.4 23:14:37 INFO - PROCESS | 17176 | 23:14:37 INFO - PROCESS | 17176 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 23:14:37 INFO - PROCESS | 17176 | Values: 4835.7 23:14:37 INFO - PROCESS | 17176 | -------- Summary: end -------- 23:14:37 INFO - PROCESS | 17176 | 23:14:38 INFO - TEST-INFO | 17176: exit 0 23:14:38 INFO - TEST-OK | v8_7 | took 39359ms 23:14:38 INFO - SUITE-END | took 1212s 23:14:38 INFO - Completed test suite (00:20:12) 23:14:38 INFO - Working with test: dromaeo_css 23:14:38 INFO - Generating results file: dromaeo_css 23:14:38 INFO - Working with test: kraken 23:14:38 INFO - Generating results file: kraken 23:14:38 INFO - javascript benchmark 23:14:38 INFO - Working with test: v8_7 23:14:38 INFO - Generating results file: v8_7 23:14:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 23:14:38 INFO - process_Request line: dromaeo_css 6864.32 graph.html#tests=[[72,201,35]] 23:14:38 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:38 INFO - process_Request line: kraken 1510.40 graph.html#tests=[[232,201,35]] 23:14:38 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:38 INFO - process_Request line: v8_7 19488.70 graph.html#tests=[[230,201,35]] 23:14:38 INFO - RETURN: dromaeo_css: 6864.32 23:14:38 INFO - RETURN: kraken: 1510.40 23:14:38 INFO - RETURN: v8_7: 19488.70 23:14:38 INFO - javascript benchmark 23:14:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3078.892238771643, 3158.526221066841, 3201.1676963989357, 3202.6156861176664, 3219.999999999999, 5127.12838817401, 5242.108841496945, 5257.421683614804, 5283.867903302415, 5331.7334133293325, 5240.423553409122, 5275.472452754722, 5317.521423071923, 5326.893462130755, 5348.732563371826, 4783.521647835206, 4825.276208568716, 4866.78099485524, 4956.851294461172, 4989.401271847383, 4912.435069966964, 4941.2094064949615, 4978.825741099062, 4984.102861484931, 5025.0703619830265, 4733.219018861883, 4746.738929358884, 4828.251620998751, 4832.855014349575, 4905.117078925792, 4771.594414474774, 4778.761061946923, 4781.354517140211, 4821.059893320804, 4828.855134345975, 4726.243800991825, 4766.785494652749, 4777.761111944389, 4788.042391521675, 4821.325014497973, 4961.4294356148785, 5016.1723315653235, 5104.821331253388, 5121.052605268037, 5137.61467889906, 5622.409646987048, 5632.042552765999, 5634.295713035871, 5650.180723795068, 5660.405657405954, 5678.034734095214, 5686.829395118153, 5692.402297758717, 5700.572457065737, 5708.001099807517, 5172.482751724798, 5263.131583288715, 5290.180022096542, 5292.2326262691695, 5370.892582148414, 5791.189233507313, 5841.50347220491, 5851.473367396955, 5860.09168578871, 5865.67738774363, 5574.749136288877, 5576.414476479992, 5579.832605021856, 5584.4136365681015, 5594.888102238014, 5478.58910581708, 5515.669059856422, 5573.637713548606, 5656.519195868397, 5656.943430565641, 5571.637843540157, 5622.887542249132, 5628.127640215773, 5631.211630371751, 5672.7730890763905, 5657.4908258256955, 5671.602987790898, 5674.801381951612, 5675.659460432387, 5680.97159514208, 4305.074409002017, 4375.474943006796, 4385.166818304512, 4395.252807022814, 4431.889202769957, 3897.3569361055675, 3918.4122381642983, 3934.901627459279, 3950.3876899080688, 3958.386450100239, 5327.360716714019, 5335.253064570963, 5337.946620533823, 5343.599230057684, 5388.137897936312, 5522.475364840334, 5621.325440947113, 5621.80323688669, 5720.570957178228, 5722.971385143131, 5321.467853214647, 5390.460953904657, 5391.865203369947, 5396.217548455452, 5402.37872644643, 4800.711957282574, 4919.237518184687, 4927.581155601814, 4928.852134435972, 4970.850874473772, 5755.740991655385, 5838.970805145947, 5867.442592953663, 5867.823965281048, 5909.911351329733, 5618.775248989995, 5632.746526406239, 5651.067573850269, 5664.943350566607, 5704.600677952503, 5808.128780682931, 5833.212516310414, 5841.561882858718, 5843.707814609167, 5849.94150058511, 5492.697901615449, 5549.805756798654, 5567.944320556742, 5610.831675049755, 5624.521915637217, 5699.772009119754, 5701.600887937971, 5718.428157184248, 5740.167675687086, 5798.0143375627085, 5463.945360546502, 5529.944700552943, 5532.2254884317035, 5534.114541673474, 5543.750531226186, 5425.376081750649, 5491.945080549303, 5540.473655002768, 5543.307086614173, 5543.8891222176135, 5391.81128660495, 5462.972685136708, 5463.043967305785, 5463.125899856004, 5500.532454741392, 5347.679139251657, 5388.084025715716, 5399.29809124827, 5419.512243897911, 5425.782968681367, 5283.101872681576, 5313.734313284398, 5343.919841202307, 5380.139177731544, 5421.674699518042], "unit": "score", "name": "dojo.html", "value": 5217.956851591251}, {"lowerIsBetter": false, "replicates": [527.6754795800579, 554.4870994330244, 555.9193916882052, 563.3296377311, 579.1688926390628, 25438.61842072368, 25978.74021259787, 26055.957761689533, 35670.2865942681, 36353.0, 42999.785001075026, 43277.0, 43320.783396082974, 43439.34840977388, 43484.56515434845, 8661.696840610564, 8819.206271435569, 8837.027926928065, 8852.336074794384, 8854.0, 7699.846003079935, 7835.804104897395, 10174.084332410082, 10286.177105831515, 10299.330543514685, 10003.0, 10098.545565449536, 10099.798004039914, 10105.696829095103, 10124.190064794835, 7785.610719464061, 7952.244536768998, 10110.848337274947, 10207.336523125972, 10218.591256349737, 10035.899641003569, 10311.381317120922, 10313.84529232062, 10314.432706201156, 10316.329438586468, 36705.63294367049, 37022.44466333007, 37237.06907327312, 37283.81358093219, 37358.25283494342, 3260.6413294537583, 3666.326641775539, 3777.471154038409, 3796.6583007529457, 3813.3326667833016, 28500.10422146562, 28810.567841482396, 28883.133505994854, 30651.233719156975, 31697.207569810707, 3628.8185590720623, 3649.7627654202392, 3653.342398368293, 3699.3341198584244, 3792.089898424386, 277746.0, 278393.0, 278548.60725696443, 279322.0, 279918.0, 60698.39301607016, 61258.38741612616, 61324.0, 61364.0, 61398.0, 54713.0, 56002.0, 62552.68723656444, 62770.37229627645, 64714.0, 14827.77758333626, 14938.402463901539, 15024.17367044823, 15060.849391505944, 15070.849291506944, 10219.335743176669, 10252.743681408025, 10270.435126067989, 10299.279050466545, 10302.227332950059, 18840.0, 18923.716144257847, 19122.90438547826, 19194.0, 19222.423327300203, 6994.475414343945, 7284.890726639104, 7321.78034658961, 7375.299346562068, 7410.851782964311, 934.3973137326386, 961.3222678011984, 1048.9003544663396, 1051.395447617623, 1054.1408751867205, 27951.32292062483, 28043.859780700965, 28629.85685071603, 28648.283792905346, 28757.42485150327, 1030.2685093583489, 1090.220492347975, 1095.9397233152254, 1111.777644471109, 1133.7732453509332, 15003.87470939684, 15632.98385604932, 15665.0, 15901.125438100784, 15912.706526563548, 302058.0, 306044.0, 306308.0, 307047.0, 307227.0, 53593.732031340376, 54103.72948135234, 54129.0, 54300.45699543033, 54365.72817135889, 1086.97282567938, 1089.1667874076338, 1133.0935251798694, 1365.9931700341435, 1387.8334599848083, 19698.005840217866, 28561.143165705063, 29458.852705736335, 29548.0, 29790.404191916474, 42842.35736464018, 43018.139637206456, 43035.0, 43265.3510197341, 43389.783051084545, 204136.0, 204993.0, 276949.0, 283751.0, 297399.0, 29550.0, 29578.408431831675, 29736.553951690308, 29916.401671966873, 30008.0, 40583.1883362337, 40911.7954410226, 41069.58930410658, 41597.37603936004, 41934.1613167741, 34559.82720086384, 34664.13339666528, 34904.65095349115, 35067.473987889694, 35220.823895880356, 34625.30749385049, 34708.132296692784, 35502.0, 35602.643973559934, 35759.0, 32253.35493290168, 32971.50542741813, 32982.175445614055, 35066.298674025864, 35505.467417988235, 31048.0, 31939.562719678135, 32689.509657354683, 32738.672613273564, 32753.836230818695, 23380.76619233786, 23911.348368521907, 24031.51936961286, 24049.879750601136, 24054.75945240525], "unit": "score", "name": "ext.html", "value": 18158.416129079193}, {"lowerIsBetter": false, "replicates": [352.76188572713426, 357.80142021178267, 359.62598897146967, 364.57526981067065, 364.73921146380343, 13492.595222143327, 13855.584332470016, 16241.593960151002, 16292.42976495823, 16740.49778506647, 15124.504456764647, 15158.317875695593, 15689.84310156898, 15690.37238510461, 15725.60685982851, 5073.264376665381, 5343.118385466393, 5353.571714262869, 5358.142697168454, 5366.221897824813, 3907.6678482329035, 4018.6584140348104, 5279.894402111955, 5803.564732645047, 5937.821865344046, 5854.8243552693275, 5876.971529982257, 5882.441168089024, 5901.144334071557, 5906.552894540843, 5546.389897111315, 6013.879722405549, 6016.75932962681, 6018.398160184012, 6025.0359942409, 5198.740062996835, 5275.28783614211, 5281.947180528184, 5291.497307755757, 5302.0, 19957.30149444777, 20193.8990305049, 20328.0, 20329.18683252668, 20400.79599204004, 2081.438011736838, 2157.7842215778455, 2248.4378905273684, 2255.616545187322, 2298.287530865437, 12610.306433146174, 12723.300218487979, 12771.233725976472, 12968.870311296861, 13221.140625859289, 1747.720364741648, 1755.552334154795, 1798.3256278895415, 1850.5096149520389, 1856.8793028453242, 58700.706496467246, 67690.32309676938, 68050.65974670096, 68399.65800171017, 70220.99999999949, 9904.702858914245, 10037.44794036335, 10083.394996300245, 10115.494225288707, 10143.123522148426, 13338.399772010283, 13345.799813002814, 13362.532311369056, 13368.732625347633, 13379.0, 7275.017872587133, 7324.780256592311, 7347.88978165328, 7457.47797654159, 7540.17058123606, 6894.448444124458, 6944.4444444444325, 6961.756338528228, 6970.546914450544, 7004.089468369079, 4372.497162826252, 4398.428204333416, 4402.7358358498595, 4423.314386270069, 4474.6420286377015, 1704.6590681863677, 1733.4972857871328, 1773.627538216963, 1817.6455591159597, 1818.2454281473306, 839.9832003359899, 844.8225872566829, 865.3899001204262, 875.0811647769816, 967.777411195429, 13551.52569660057, 15508.767368489256, 15742.212889355487, 16309.18454077315, 16407.097609631586, 889.8976617688919, 932.841416959105, 947.4220725357526, 974.8294048541477, 988.5650313861878, 8459.577021148918, 9212.769680758034, 9345.579448924815, 9516.143547080657, 9907.851382229272, 530776.0, 536037.0, 541639.0, 550651.0, 559913.0, 79459.0, 81126.18873811305, 82241.17758822454, 85013.57493212495, 87794.0, 990.2276224544867, 1010.802893435773, 1126.6620013995605, 1198.1553005131361, 1213.4175595714107, 14981.625459363604, 15070.945033847525, 15279.465218717292, 15482.303296351916, 15542.300596473411, 35738.28523429569, 36170.27659446849, 37195.81402092972, 37609.4358584616, 38046.8097659521, 48484.0, 48988.0, 49677.25484117813, 50291.49708503015, 51319.74340128276, 9505.952470237604, 9531.428114313163, 9654.420734755937, 9667.226621870093, 9769.560369783234, 16250.431234906722, 16932.40736574214, 17268.827311727226, 17316.826831732025, 17904.0, 13742.93128534351, 13826.585202443943, 13892.791608125684, 14067.929660351632, 14308.356123974238, 13705.383257753225, 13855.37650805696, 14043.789343159657, 14262.500812471513, 14284.642883927985, 13606.0, 13608.115472494255, 13947.232902190477, 14090.647733806736, 14218.644533886736, 9681.48281446843, 9752.122308992224, 9759.072888075621, 9840.852387214054, 9893.01069893005, 13473.191608503521, 13486.190828550318, 13634.727305454035, 13946.232957187452, 14392.640183995065], "unit": "score", "name": "jquery.html", "value": 8912.3222850527}, {"lowerIsBetter": false, "replicates": [1320.3794216718138, 1475.1812743927119, 1475.2402512705958, 1639.9508014759554, 1816.9545761355973, 6708.731650733971, 7423.777286681395, 7511.812204694886, 7515.210902855197, 7519.6616152273145, 7279.199288078307, 7470.96264518678, 7478.364339031175, 7487.064116985377, 7491.887621685665, 2215.1803832581927, 2254.425121593991, 2258.4579700871836, 2258.7854153855355, 2260.446190683285, 2226.443389152712, 2289.7710228977135, 2310.9422264443356, 2311.029367665576, 2322.1756276521846, 2247.5729611373786, 2255.8082562982086, 2261.819054475646, 2261.8303627227942, 2293.1859189987563, 2258.2660635293596, 2267.9319620411416, 2296.4258935266184, 2296.781805728453, 2298.1726578431667, 2321.4892723600783, 2347.272345572878, 2351.247600767755, 2351.729551101628, 2352.094443639211, 7143.92856071443, 7221.711131554784, 7222.205557388683, 7229.024081748949, 7255.056842610426, 4505.301678239845, 4550.49944506104, 4569.04050149469, 4584.106099310636, 4593.242115051013, 3067.5091985282247, 3089.212250876035, 3147.6222853257527, 3159.7314228290625, 3196.3447493263825, 979.9951000245024, 996.1433167475965, 996.6511720897701, 1003.0721582536198, 1006.7734759679014, 10483.423411712352, 10501.474926253657, 10533.052025317758, 10534.420606866619, 10549.525271362807, 4015.377616469452, 4049.4128351389472, 4116.950177704726, 4118.876433706993, 4118.979405103015, 8894.066123056986, 8945.19493245611, 8965.0, 8969.103089691109, 8972.551372431482, 4509.346144808985, 4514.367988481616, 4530.501644819067, 4541.545845415498, 4546.818127274872, 3663.2673465307043, 3750.1562148516364, 4109.116539943867, 4124.278251306009, 4134.441850350225, 3539.079839241764, 3548.609652938175, 3564.572251329857, 3590.838412271454, 3600.3339382214376, 1084.4523515624717, 1086.766345235778, 1087.9891201088046, 1089.9455027248605, 1097.237419993113, 1084.8426978088132, 1090.3185509056839, 1093.6281664234039, 1099.725068732817, 1129.8644162700527, 6927.203371612329, 7104.43164546835, 7109.786706398816, 7115.928840711526, 7140.393066589294, 1156.7570810129798, 1217.1479964025218, 1231.1382032577233, 1235.2958813476412, 1236.783562876511, 5442.2380866678695, 5457.945420545823, 5524.281843360337, 5524.613277070647, 5531.834044978657, 8824.38229323954, 9022.413543119676, 9079.182873541413, 9099.681511147079, 9127.68053118151, 8996.685116020908, 9011.459312441275, 9038.186563209343, 9043.954780226057, 9069.682561110329, 6610.471162307004, 7085.0, 7133.5719856808755, 7155.606441645759, 7161.4270858330165, 6988.196357418962, 7029.191642961125, 7032.015517827406, 7032.226455090038, 7032.929670703227, 7729.806754831175, 7775.494592851673, 7873.5275883447175, 7876.40926930494, 7893.960530197312, 8091.676332946617, 8103.149169337371, 8169.632366543638, 8237.258646721824, 8258.793530161794, 5639.6334238274385, 5749.683767392834, 6514.2834288229205, 6514.771982980573, 6631.3700198481065, 6908.861822763416, 6908.930910690829, 6927.272636373108, 6932.272111428228, 6957.930420695729, 6434.099226108442, 6704.329567043256, 6779.796606101825, 6855.348741869514, 6862.759803406857, 6643.069970204078, 6649.168853893263, 6777.559458635173, 6845.14435695538, 6848.931510684829, 6693.1298931138645, 6755.3582409671, 6808.148981377328, 6810.28492008332, 6843.520953533205, 6355.332690067661, 6377.2984971654005, 6409.647469389229, 6409.871802563829, 6424.164858568356, 6400.519961003037, 6408.9038664421005, 6460.870782584416, 6467.126937863516, 6469.417752402118], "unit": "score", "name": "mootools.html", "value": 4361.452320573912}, {"lowerIsBetter": false, "replicates": [315.4778841018115, 324.9155219642894, 340.99147521311966, 344.0555674673023, 350.20852872508124, 5826.359100498942, 5915.733791979361, 5951.196588460556, 5969.9403005969925, 5978.82063538094, 5727.742251598677, 5868.530517558595, 5895.056790913454, 5911.0, 5913.2017177681, 4552.180607490651, 4565.817367305321, 4576.382188404573, 4577.153226653063, 4590.931136032962, 4309.525952145262, 4379.430674012374, 4495.595396414322, 4590.0, 4602.171609110359, 4538.364628951949, 4548.363229147922, 4556.476005259405, 4564.5435456454425, 4566.862994110182, 4533.478649955265, 4539.59143677069, 4570.748608826513, 4578.130155270488, 4587.495375508692, 4017.216642754664, 4018.0557568971267, 4021.738586991836, 4037.051292946155, 4038.0, 5529.861753456155, 5634.887302253932, 5641.943580564182, 5695.686737229451, 5715.799947001835, 5279.656822306576, 5281.36623605166, 5281.52466278033, 5281.947180528223, 5291.656042357235, 6003.6097653652805, 6301.243850737941, 6304.369563043659, 6308.653024083674, 6313.558050936436, 4259.5740425957465, 4306.267934451151, 4370.475542934836, 4380.934285985712, 4380.956190438087, 6489.513286503484, 6571.474282057424, 6581.30896255891, 6587.934120658828, 6604.174478190274, 4356.49900261474, 4360.738355698668, 4360.934585981213, 4361.542038085955, 4363.978180109079, 4346.130773845181, 4419.138268037702, 4420.447444069491, 4423.248047831877, 4448.065906159743, 5165.560927321145, 5168.328117344797, 5173.224016397495, 5175.818846340435, 5176.223566465061, 6320.936790632127, 6325.209348831396, 6331.398517140957, 6338.144350512622, 6340.112384266206, 1599.6240883392393, 1612.0972255536938, 1613.491750098715, 1613.572403313123, 1613.6611311624456, 1068.1988508618535, 1074.6399956014666, 1082.9350238985687, 1089.9128069754402, 1100.5597760895546, 6042.154098426224, 6043.667598282137, 6045.395460453919, 6052.152698622196, 6062.302835173923, 6495.610263384212, 6496.350364963466, 6519.348065193442, 6532.510061745388, 6546.509011824132, 5921.2006379138265, 6027.276726792813, 6032.336442991267, 6033.215681961317, 6042.728077236535, 3475.4786781982907, 3523.4010218262956, 3527.700145487662, 3529.541159649229, 3539.7876127432437, 6818.897716534256, 6827.829304267334, 6837.111175547247, 6839.213490448662, 6840.657967101625, 6690.163729533809, 6693.431058359996, 6695.732170713214, 6699.330066993261, 6709.29552397001, 6663.666816659148, 6833.384995350343, 6854.760083397057, 6912.930870691229, 6922.100126983561, 6328.7152078157515, 6475.676216189266, 6612.867742645024, 6617.073609694743, 6620.602763834186, 6374.107624932606, 6472.838179045561, 6500.414962653384, 6508.153939987771, 6510.73957041732, 6856.554323968926, 6864.553804002724, 6866.690998905161, 6866.725330986705, 6868.828279292858, 4454.732716037048, 4525.818967241274, 4559.863204103882, 4560.179167749704, 4562.977185114053, 6591.978243372285, 6592.307807680125, 6592.571482853599, 6593.0, 6598.439132673777, 6402.327755585597, 6403.807885763435, 6415.390537898892, 6416.165898433173, 6416.358364163546, 6238.844028899314, 6387.457066149429, 6405.615663060231, 6407.679616019273, 6410.1987251593555, 6297.748090076346, 6300.464460520907, 6301.40136687014, 6304.432601065926, 6314.463270622048, 6431.324710905475, 6438.581492202992, 6443.6455994920725, 6449.290578036318, 6456.12842266288, 6082.996305609525, 6212.9068063979985, 6244.68776561161, 6280.497560195265, 6286.371362863677], "unit": "score", "name": "prototype.html", "value": 4772.685339042192}, {"lowerIsBetter": false, "replicates": [718.942484601232, 753.3031945450457, 757.3865169212937, 819.6762129564613, 852.2585350744853, 12885.291308978003, 13139.0, 13140.737185256288, 13155.342232888364, 13169.934150329247, 11879.465424055916, 11962.461689223985, 11969.521219151246, 11978.820317695241, 11987.940060299687, 651.9543631945766, 661.9338066193366, 811.5901469757764, 822.6298165825373, 825.3562221467236, 816.4570560577209, 821.4414198345123, 828.494618282847, 828.6850996621275, 830.4021104804531, 871.037503558565, 873.0309356614154, 877.1623099939543, 878.9033206347297, 879.4503435352905, 676.6582875647815, 682.4744946391276, 856.1139220906394, 868.4224990381389, 869.1829680100685, 638.86903184847, 643.2988043033116, 643.719981807915, 644.6679959820696, 644.935506449356, 12399.938000309941, 12506.74986500274, 12509.0, 12520.81218781719, 12529.248245105322, 11281.210315277935, 11575.652730418102, 11759.35323557204, 11988.160828741991, 12053.276803391736, 9805.460699661517, 9893.604255829758, 9923.671748556333, 9942.254330925138, 9967.601295948154, 3569.37535931211, 3570.410882204433, 3596.3166998270244, 3638.6725194732603, 3714.3685573452576, 45573.31640025402, 45653.40213092526, 45706.0, 45712.3143152853, 45757.54242457599, 9531.809363812823, 9534.809303813885, 9620.230381569458, 9681.951590242004, 9774.95112524447, 17761.822381776015, 17771.0, 17771.82228177702, 17779.73330400045, 17821.287148514173, 6893.4140598048725, 7161.355478007004, 7360.07999000125, 7489.85020299591, 7626.084869815658, 4318.52496225415, 4323.2434323993175, 4344.47866256045, 4444.73331600105, 4484.618807401407, 2998.925026874302, 3012.472817256971, 3040.771942104351, 3044.421559903611, 3044.528098144791, 567.2144080448609, 568.0371769850065, 568.5707290995355, 570.2074116977404, 582.830979016089, 510.4410670315998, 525.6425630571172, 529.6107361089596, 534.036064902854, 547.3295213363598, 7595.658195381221, 7664.770056898302, 7812.267196424137, 7916.604169791487, 7948.046234451903, 523.5680563535022, 533.6851257757942, 534.8181618249736, 537.8951104534578, 571.9227904232959, 3440.3119376124873, 3556.395412779834, 3631.6005239423644, 3652.3243200008083, 3783.1677031053123, 48026.519734802205, 48287.0, 48316.27525587119, 48352.27471587929, 48506.757466212446, 45097.77451112724, 45402.545974540495, 47852.0, 47901.28148077782, 48740.512594873595, 40674.79662601668, 41863.581364186575, 41944.79027604903, 42005.0, 42058.0, 7598.354139898171, 7816.804579885548, 8121.147279535564, 8266.421350505647, 8277.255047045795, 32922.50616240806, 33003.66996330006, 33672.49491257584, 35356.823215883756, 35875.0, 44941.550584493736, 45040.54959450495, 45149.0, 45359.092818142795, 46005.0, 10375.429351385746, 10432.843507347548, 10447.373157610567, 10660.230100587856, 10689.358638481715, 11108.833367499332, 11247.550097996316, 11409.771804564029, 11604.187706860439, 11780.175387722777, 10107.292489525957, 10132.0, 10256.282060255711, 10377.584896604354, 10539.209559282932, 9900.554475048497, 10122.493875306352, 10131.79736405253, 10212.438315892698, 10484.580616775243, 10261.538230779484, 10312.948435258077, 10370.585176593153, 10569.429376225478, 10654.360738355723, 8767.517786521803, 9051.502167380857, 9059.501727405055, 9123.726288211365, 9477.194438472532, 8387.457951240818, 8417.663293468193, 8724.738257852021, 8798.780030499032, 9305.162535371848], "unit": "score", "name": "yui.html", "value": 5950.886486659694}], "name": "dromaeo_css", "value": 6864.318969879424}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 105.0, 112.0, 111.0, 111.0, 101.0, 112.0, 113.0, 102.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [153.0, 126.0, 146.0, 171.0, 127.0, 149.0, 149.0, 127.0, 162.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 143.9}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 160.0, 161.0, 164.0, 161.0, 163.0, 162.0, 166.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 82.0, 92.0, 74.0, 72.0, 73.0, 128.0, 90.0, 71.0], "unit": "score", "name": "audio-fft", "value": 83.0}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 141.0, 96.0, 95.0, 95.0, 141.0, 95.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 108.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 57.0, 58.0, 57.0, 60.0, 61.0, 72.0, 56.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 59.7}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 87.0, 85.0, 93.0, 87.0, 87.0, 86.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [117.0, 122.0, 115.0, 115.0, 123.0, 124.0, 123.0, 126.0, 121.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [140.0, 162.0, 152.0, 150.0, 152.0, 139.0, 151.0, 152.0, 150.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.1}, {"lowerIsBetter": true, "replicates": [73.0, 66.0, 71.0, 67.0, 68.0, 67.0, 66.0, 69.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1510.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.55562958027983], "unit": "score", "name": "Richards", "value": 211.95320800000005}, {"lowerIsBetter": false, "replicates": [190.65776930409913], "unit": "score", "name": "DeltaBlue", "value": 346.78891000000004}, {"lowerIsBetter": false, "replicates": [281.0567734682406], "unit": "score", "name": "Encrypt", "value": 947.0719979999998}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [2063.917525773196], "unit": "score", "name": "RayTrace", "value": 358.5361288711288}, {"lowerIsBetter": false, "replicates": [810.3727714748784], "unit": "score", "name": "Earley", "value": 822.4153420000002}, {"lowerIsBetter": false, "replicates": [12708.860759493671], "unit": "score", "name": "Boyer", "value": 52.440813745019945}, {"lowerIsBetter": false, "replicates": [25575.0], "unit": "score", "name": "RegExp", "value": 35.620136852394914}, {"lowerIsBetter": false, "replicates": [640.4350607805502], "unit": "score", "name": "Splay", "value": 127.24318981018986}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19488.70472429533}]} 23:14:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19488.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1510.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6864.32"}}} 23:14:38 INFO - Return code: 0 23:14:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:14:38 INFO - # TBPL SUCCESS # 23:14:38 INFO - Running post-action listener: _resource_record_post_action 23:14:38 INFO - Running post-run listener: _resource_record_post_run 23:14:39 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 567762944; Read time: 0; Write time: 600628 23:14:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246308864; Read time: 0; Write time: 360388 23:14:39 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 321150976; Read time: 0; Write time: 240216 23:14:39 INFO - Running post-run listener: _upload_blobber_files 23:14:39 INFO - Blob upload gear active. 23:14:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:14:39 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 23:14:39 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'] 23:14:39 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 23:14:40 INFO - (blobuploader) - INFO - Open directory for files ... 23:14:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:14:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:14:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:41 INFO - (blobuploader) - INFO - Done attempting. 23:14:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:14:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:14:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:41 INFO - (blobuploader) - INFO - Done attempting. 23:14:41 INFO - (blobuploader) - INFO - Iteration through files over. 23:14:41 INFO - Return code: 0 23:14:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:14:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:14:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0bcd25a16d62ab19f42700435cd923f14f8dea526c71379d4d0e36aab4cb83ecb36cf8935ba4bdabf2f10a541e2a6ba97922e81a991469a799c633a94645de9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1f00f9ae56b95c559863c6fd6f1b21ccff51dc8442fc523f39621f6128e0f2045d853f731c0ee99a475c9d60378f9b9a01985663a89a4617d70975800610ceeb"} 23:14:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:14:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:14:41 INFO - Contents: 23:14:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0bcd25a16d62ab19f42700435cd923f14f8dea526c71379d4d0e36aab4cb83ecb36cf8935ba4bdabf2f10a541e2a6ba97922e81a991469a799c633a94645de9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1f00f9ae56b95c559863c6fd6f1b21ccff51dc8442fc523f39621f6128e0f2045d853f731c0ee99a475c9d60378f9b9a01985663a89a4617d70975800610ceeb"} 23:14:41 INFO - Copying logs to upload dir... 23:14:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.612352 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-31 23:14:40.424937) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 23:14:40.428914) ========= 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-1451622163.335512-1253099847 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/0bcd25a16d62ab19f42700435cd923f14f8dea526c71379d4d0e36aab4cb83ecb36cf8935ba4bdabf2f10a541e2a6ba97922e81a991469a799c633a94645de9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1f00f9ae56b95c559863c6fd6f1b21ccff51dc8442fc523f39621f6128e0f2045d853f731c0ee99a475c9d60378f9b9a01985663a89a4617d70975800610ceeb"} build_url:https://queue.taskcluster.net/v1/task/CTowPllaS22pT9Nrjf-ZLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/CTowPllaS22pT9Nrjf-ZLg/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/0bcd25a16d62ab19f42700435cd923f14f8dea526c71379d4d0e36aab4cb83ecb36cf8935ba4bdabf2f10a541e2a6ba97922e81a991469a799c633a94645de9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1f00f9ae56b95c559863c6fd6f1b21ccff51dc8442fc523f39621f6128e0f2045d853f731c0ee99a475c9d60378f9b9a01985663a89a4617d70975800610ceeb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 23:14:40.454697) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 23:14:40.455044) ========= 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-1451622163.335512-1253099847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 23:14:40.539351) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 23:14:40.539938) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 23:14:40.540524) ========= ========= Total master_lag: 0.33 =========