builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1453241352.84 results: success (0) buildid: 20160119113035 builduid: aca5da4e285d4b31a002cc9518623d10 revision: f58d8d338d4f526f62d9f983e1c5c497683f8169 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:12.844552) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:12.844990) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:12.845277) ========= 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=82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006556 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:12.871719) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:12.872005) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:12.885075) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:12.885370) ========= 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=82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:12.939393) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:12.939652) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:12.940160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:12.940432) ========= 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=82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 14:09:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.4M=0s 2016-01-19 14:09:13 (37.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154176 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:13.107725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:13.108047) ========= 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=82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018526 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:13.157878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:13.158254) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f58d8d338d4f526f62d9f983e1c5c497683f8169 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f58d8d338d4f526f62d9f983e1c5c497683f8169 --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=82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 14:09:13,533 truncating revision to first 12 chars 2016-01-19 14:09:13,533 Setting DEBUG logging. 2016-01-19 14:09:13,533 attempt 1/10 2016-01-19 14:09:13,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f58d8d338d4f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 14:09:13,774 unpacking tar archive at: fx-team-f58d8d338d4f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.523234 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:13.693851) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:13.694196) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.003436 script_repo_revision: '%(revision)s' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:13.741681) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:13.742035) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:13.752234) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:13.752633) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 14:09:13.753086) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-19 14:09:13.753471) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:09:14 INFO - MultiFileLogger online at 20160119 14:09:14 in /builds/slave/test-pgo 14:09:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:09:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:09:14 INFO - {'append_to_log': False, 14:09:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:09:14 INFO - 'blob_upload_branch': 'Fx-Team', 14:09:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:09:14 INFO - 'branch': 'Fx-Team', 14:09:14 INFO - 'buildbot_json_path': 'buildprops.json', 14:09:14 INFO - 'config_files': ('talos/linux_config.py',), 14:09:14 INFO - 'default_actions': ('clobber', 14:09:14 INFO - 'read-buildbot-config', 14:09:14 INFO - 'download-and-extract', 14:09:14 INFO - 'populate-webroot', 14:09:14 INFO - 'create-virtualenv', 14:09:14 INFO - 'install', 14:09:14 INFO - 'run-tests'), 14:09:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:09:14 INFO - 'download_minidump_stackwalk': True, 14:09:14 INFO - 'download_symbols': 'ondemand', 14:09:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:09:14 INFO - 'tooltool.py': '/tools/tooltool.py', 14:09:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:09:14 INFO - '/tools/misc-python/virtualenv.py')}, 14:09:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:09:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:09:14 INFO - 'installer_path': 'installer.exe', 14:09:14 INFO - 'log_level': 'info', 14:09:14 INFO - 'log_name': 'talos', 14:09:14 INFO - 'log_to_console': True, 14:09:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:09:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:09:14 INFO - 'opt_config_files': (), 14:09:14 INFO - 'pip_index': False, 14:09:14 INFO - 'sps_profile': False, 14:09:14 INFO - 'sps_profile_interval': 0, 14:09:14 INFO - 'suite': 'dromaeojs-e10s', 14:09:14 INFO - 'system_bits': '32', 14:09:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:09:14 INFO - 'title': 'talos-linux64-ix-055', 14:09:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:09:14 INFO - 'use_talos_json': True, 14:09:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:09:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:09:14 INFO - 'work_dir': 'build'} 14:09:14 INFO - ##### 14:09:14 INFO - ##### Running clobber step. 14:09:14 INFO - ##### 14:09:14 INFO - Running pre-action listener: _resource_record_pre_action 14:09:14 INFO - Running main action method: clobber 14:09:14 INFO - rmtree: /builds/slave/test-pgo/build 14:09:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:09:14 INFO - Running post-action listener: _resource_record_post_action 14:09:14 INFO - ##### 14:09:14 INFO - ##### Running read-buildbot-config step. 14:09:14 INFO - ##### 14:09:14 INFO - Running pre-action listener: _resource_record_pre_action 14:09:14 INFO - Running main action method: read_buildbot_config 14:09:14 INFO - Using buildbot properties: 14:09:14 INFO - { 14:09:14 INFO - "project": "", 14:09:14 INFO - "product": "firefox", 14:09:14 INFO - "script_repo_revision": "production", 14:09:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:09:14 INFO - "repository": "", 14:09:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:09:14 INFO - "buildid": "20160119113035", 14:09:14 INFO - "pgo_build": "True", 14:09:14 INFO - "basedir": "/builds/slave/test-pgo", 14:09:14 INFO - "buildnumber": 221, 14:09:14 INFO - "slavename": "talos-linux64-ix-055", 14:09:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:09:14 INFO - "platform": "ubuntu64_hw", 14:09:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:09:14 INFO - "branch": "fx-team", 14:09:14 INFO - "repo_path": "integration/fx-team", 14:09:14 INFO - "revision": "f58d8d338d4f526f62d9f983e1c5c497683f8169", 14:09:14 INFO - "stage_platform": "linux64-pgo", 14:09:14 INFO - "builduid": "aca5da4e285d4b31a002cc9518623d10", 14:09:14 INFO - "slavebuilddir": "test" 14:09:14 INFO - } 14:09:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:09:14 INFO - Running post-action listener: _resource_record_post_action 14:09:14 INFO - ##### 14:09:14 INFO - ##### Running download-and-extract step. 14:09:14 INFO - ##### 14:09:14 INFO - Running pre-action listener: _resource_record_pre_action 14:09:14 INFO - Running main action method: download_and_extract 14:09:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:14 INFO - https://queue.taskcluster.net/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:09:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/test_packages.json 14:09:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/test_packages.json 14:09:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:09:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:09:15 INFO - Downloaded 1448 bytes. 14:09:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:09:15 INFO - Using the following test package requirements: 14:09:15 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:09:15 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:09:15 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:09:15 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:15 INFO - u'jsshell-linux-x86_64.zip'], 14:09:15 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:09:15 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:09:15 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:09:15 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:09:15 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:09:15 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:09:15 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:09:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:09:15 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:15 INFO - https://queue.taskcluster.net/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:09:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:09:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:09:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/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 14:09:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/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 14:09:16 INFO - Downloaded 22484667 bytes. 14:09:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:09:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:09:17 INFO - Return code: 0 14:09:17 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 14:09:17 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')]} 14:09:17 INFO - https://queue.taskcluster.net/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:09:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:09:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:09:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/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 14:09:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/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 14:09:19 INFO - Downloaded 22484667 bytes. 14:09:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:09:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:09:20 INFO - Return code: 0 14:09:20 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')]} 14:09:20 INFO - https://queue.taskcluster.net/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/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 14:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/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 14:09:22 INFO - Downloaded 11132144 bytes. 14:09:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:09:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 14:09:22 INFO - Return code: 0 14:09:22 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')]} 14:09:22 INFO - https://queue.taskcluster.net/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:09:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:09:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:09:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/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 14:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SJF6CwQNRnud-9gOWWTJBA/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 14:09:24 INFO - Downloaded 55931213 bytes. 14:09:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:09:24 INFO - mkdir: /builds/slave/test-pgo/properties 14:09:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:09:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:09:24 INFO - Contents: 14:09:24 INFO - build_url:https://queue.taskcluster.net/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:09:24 INFO - Running post-action listener: _resource_record_post_action 14:09:24 INFO - Running post-action listener: set_extra_try_arguments 14:09:24 INFO - ##### 14:09:24 INFO - ##### Running populate-webroot step. 14:09:24 INFO - ##### 14:09:24 INFO - Running pre-action listener: _resource_record_pre_action 14:09:24 INFO - Running main action method: populate_webroot 14:09:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:09:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:09:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:09:24 INFO - '--tppagecycles', 14:09:24 INFO - '7'], 14:09:24 INFO - 'tests': ['tsvgm']}}, 14:09:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:09:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:09:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:09:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:09:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:09:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:09:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:24 INFO - 'talos_options': ['--e10s'], 14:09:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:24 INFO - 'tests': ['damp', 'tps']}, 14:09:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:24 INFO - 'talos_options': ['--e10s'], 14:09:24 INFO - 'tests': ['damp', 'tps']}, 14:09:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:09:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:09:24 INFO - 'other': {'tests': ['a11yr', 14:09:24 INFO - 'ts_paint', 14:09:24 INFO - 'tpaint', 14:09:24 INFO - 'sessionrestore', 14:09:24 INFO - 'sessionrestore_no_auto_restore']}, 14:09:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:09:24 INFO - 'tests': ['a11yr', 14:09:24 INFO - 'ts_paint', 14:09:24 INFO - 'tpaint', 14:09:24 INFO - 'sessionrestore', 14:09:24 INFO - 'sessionrestore_no_auto_restore']}, 14:09:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:09:24 INFO - 'tests': ['a11yr', 14:09:24 INFO - 'ts_paint', 14:09:24 INFO - 'tpaint', 14:09:24 INFO - 'sessionrestore', 14:09:24 INFO - 'sessionrestore_no_auto_restore']}, 14:09:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:09:24 INFO - 'tests': ['a11yr', 14:09:24 INFO - 'ts_paint', 14:09:24 INFO - 'tpaint', 14:09:24 INFO - 'sessionrestore', 14:09:24 INFO - 'sessionrestore_no_auto_restore']}, 14:09:24 INFO - 'other_l64': {'tests': ['a11yr', 14:09:24 INFO - 'ts_paint', 14:09:24 INFO - 'tpaint', 14:09:24 INFO - 'sessionrestore', 14:09:24 INFO - 'sessionrestore_no_auto_restore']}, 14:09:24 INFO - 'other_nol64': {'tests': ['a11yr', 14:09:24 INFO - 'ts_paint', 14:09:24 INFO - 'tpaint', 14:09:24 INFO - 'sessionrestore', 14:09:24 INFO - 'sessionrestore_no_auto_restore']}, 14:09:24 INFO - 'svgr': {'tests': ['tsvgx', 14:09:24 INFO - 'tsvgr_opacity', 14:09:24 INFO - 'tart', 14:09:24 INFO - 'tscrollx', 14:09:24 INFO - 'cart']}, 14:09:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:09:24 INFO - 'tests': ['tsvgx', 14:09:24 INFO - 'tsvgr_opacity', 14:09:24 INFO - 'tart', 14:09:24 INFO - 'tscrollx', 14:09:24 INFO - 'cart']}, 14:09:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:24 INFO - 'tests': ['tp5o']}, 14:09:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:24 INFO - 'talos_options': ['--e10s'], 14:09:24 INFO - 'tests': ['tp5o']}, 14:09:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:24 INFO - 'talos_options': ['--xperf_path', 14:09:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:24 INFO - 'tests': ['tp5n']}, 14:09:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:24 INFO - 'talos_options': ['--e10s', 14:09:24 INFO - '--xperf_path', 14:09:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:24 INFO - 'tests': ['tp5n']}}, 14:09:24 INFO - 'talos.zip': {'path': '', 14:09:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:09:24 INFO - Running post-action listener: _resource_record_post_action 14:09:24 INFO - ##### 14:09:24 INFO - ##### Running create-virtualenv step. 14:09:24 INFO - ##### 14:09:24 INFO - Running pre-action listener: _resource_record_pre_action 14:09:24 INFO - Running main action method: create_virtualenv 14:09:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:09:24 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 14:09:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:09:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:09:25 INFO - Using real prefix '/usr' 14:09:25 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:09:25 INFO - Installing distribute.............................................................................................................................................................................................done. 14:09:27 INFO - Installing pip.................done. 14:09:27 INFO - Return code: 0 14:09:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:27 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 0x7f716aa9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe540>, '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 0x16ff440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', '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 14:09:27 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 14:09:27 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 14:09:27 INFO - Using env: {'DISPLAY': ':0', 14:09:27 INFO - 'HOME': '/home/cltbld', 14:09:27 INFO - 'LANG': 'en_US.UTF-8', 14:09:27 INFO - 'LANGUAGE': 'en_US:en', 14:09:27 INFO - 'LOGNAME': 'cltbld', 14:09:27 INFO - 'MAIL': '/var/mail/cltbld', 14:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:27 INFO - 'MOZ_NO_REMOTE': '1', 14:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:27 INFO - 'NO_EM_RESTART': '1', 14:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:27 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:27 INFO - 'SHELL': '/bin/bash', 14:09:27 INFO - 'SHLVL': '1', 14:09:27 INFO - 'TERM': 'linux', 14:09:27 INFO - 'TMOUT': '86400', 14:09:27 INFO - 'USER': 'cltbld', 14:09:27 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', 14:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:27 INFO - '_': '/tools/buildbot/bin/python'} 14:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:27 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 14:09:27 INFO - Cleaning up... 14:09:27 INFO - Return code: 0 14:09:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:27 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 0x7f716aa9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe540>, '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 0x16ff440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', '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 14:09:27 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 14:09:27 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 14:09:27 INFO - Using env: {'DISPLAY': ':0', 14:09:27 INFO - 'HOME': '/home/cltbld', 14:09:27 INFO - 'LANG': 'en_US.UTF-8', 14:09:27 INFO - 'LANGUAGE': 'en_US:en', 14:09:27 INFO - 'LOGNAME': 'cltbld', 14:09:27 INFO - 'MAIL': '/var/mail/cltbld', 14:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:27 INFO - 'MOZ_NO_REMOTE': '1', 14:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:27 INFO - 'NO_EM_RESTART': '1', 14:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:27 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:27 INFO - 'SHELL': '/bin/bash', 14:09:27 INFO - 'SHLVL': '1', 14:09:27 INFO - 'TERM': 'linux', 14:09:27 INFO - 'TMOUT': '86400', 14:09:27 INFO - 'USER': 'cltbld', 14:09:27 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', 14:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:27 INFO - '_': '/tools/buildbot/bin/python'} 14:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:27 INFO - Downloading/unpacking psutil>=0.7.1 14:09:27 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 14:09:27 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 14:09:27 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 14:09:27 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 14:09:27 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 14:09:27 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 14:09:29 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:09:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:09:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:09:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:29 INFO - Installing collected packages: psutil 14:09:29 INFO - Running setup.py install for psutil 14:09:29 INFO - building 'psutil._psutil_linux' extension 14:09:29 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 14:09:30 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 14:09:30 INFO - building 'psutil._psutil_posix' extension 14:09:30 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 14:09:30 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 14:09:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:30 INFO - Successfully installed psutil 14:09:30 INFO - Cleaning up... 14:09:30 INFO - Return code: 0 14:09:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:09:30 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')]} 14:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:30 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')]} 14:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:30 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 0x7f716aa9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe540>, '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 0x16ff440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', '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 14:09:30 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 14:09:30 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 14:09:30 INFO - Using env: {'DISPLAY': ':0', 14:09:30 INFO - 'HOME': '/home/cltbld', 14:09:30 INFO - 'LANG': 'en_US.UTF-8', 14:09:30 INFO - 'LANGUAGE': 'en_US:en', 14:09:30 INFO - 'LOGNAME': 'cltbld', 14:09:30 INFO - 'MAIL': '/var/mail/cltbld', 14:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:30 INFO - 'MOZ_NO_REMOTE': '1', 14:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:30 INFO - 'NO_EM_RESTART': '1', 14:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:30 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:30 INFO - 'SHELL': '/bin/bash', 14:09:30 INFO - 'SHLVL': '1', 14:09:30 INFO - 'TERM': 'linux', 14:09:30 INFO - 'TMOUT': '86400', 14:09:30 INFO - 'USER': 'cltbld', 14:09:30 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', 14:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:30 INFO - '_': '/tools/buildbot/bin/python'} 14:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:09:30 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 14:09:30 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 14:09:30 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 14:09:30 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 14:09:30 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 14:09:30 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 14:09:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:09:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:09:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:09:32 INFO - Installing collected packages: mozsystemmonitor 14:09:32 INFO - Running setup.py install for mozsystemmonitor 14:09:32 INFO - Successfully installed mozsystemmonitor 14:09:32 INFO - Cleaning up... 14:09:32 INFO - Return code: 0 14:09:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:09: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')]} 14:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:32 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 0x7f716aa9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe540>, '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 0x16ff440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', '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 14:09:32 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 14:09:32 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 14:09:32 INFO - Using env: {'DISPLAY': ':0', 14:09:32 INFO - 'HOME': '/home/cltbld', 14:09:32 INFO - 'LANG': 'en_US.UTF-8', 14:09:32 INFO - 'LANGUAGE': 'en_US:en', 14:09:32 INFO - 'LOGNAME': 'cltbld', 14:09:32 INFO - 'MAIL': '/var/mail/cltbld', 14:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:32 INFO - 'MOZ_NO_REMOTE': '1', 14:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:32 INFO - 'NO_EM_RESTART': '1', 14:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:32 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:32 INFO - 'SHELL': '/bin/bash', 14:09:32 INFO - 'SHLVL': '1', 14:09:32 INFO - 'TERM': 'linux', 14:09:32 INFO - 'TMOUT': '86400', 14:09:32 INFO - 'USER': 'cltbld', 14:09:32 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', 14:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:32 INFO - '_': '/tools/buildbot/bin/python'} 14:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:32 INFO - Downloading/unpacking blobuploader==1.2.4 14:09:32 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 14:09:32 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 14:09:32 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 14:09:32 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 14:09:32 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 14:09:32 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 14:09:34 INFO - Downloading blobuploader-1.2.4.tar.gz 14:09:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:09:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:09:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:09:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:09:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:35 INFO - Downloading docopt-0.6.1.tar.gz 14:09:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:09:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:09:35 INFO - Installing collected packages: blobuploader, requests, docopt 14:09:35 INFO - Running setup.py install for blobuploader 14:09:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:09:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:09:35 INFO - Running setup.py install for requests 14:09:35 INFO - Running setup.py install for docopt 14:09:35 INFO - Successfully installed blobuploader requests docopt 14:09:35 INFO - Cleaning up... 14:09:35 INFO - Return code: 0 14:09:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:35 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 0x7f716aa9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe540>, '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 0x16ff440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', '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 14:09:35 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 14:09:35 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 14:09:35 INFO - Using env: {'DISPLAY': ':0', 14:09:35 INFO - 'HOME': '/home/cltbld', 14:09:35 INFO - 'LANG': 'en_US.UTF-8', 14:09:35 INFO - 'LANGUAGE': 'en_US:en', 14:09:35 INFO - 'LOGNAME': 'cltbld', 14:09:35 INFO - 'MAIL': '/var/mail/cltbld', 14:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:35 INFO - 'MOZ_NO_REMOTE': '1', 14:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:35 INFO - 'NO_EM_RESTART': '1', 14:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:35 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:35 INFO - 'SHELL': '/bin/bash', 14:09:35 INFO - 'SHLVL': '1', 14:09:35 INFO - 'TERM': 'linux', 14:09:35 INFO - 'TMOUT': '86400', 14:09:35 INFO - 'USER': 'cltbld', 14:09:35 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', 14:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:35 INFO - '_': '/tools/buildbot/bin/python'} 14:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:09:35 INFO - Running setup.py (path:/tmp/pip-lGEyki-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:09:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:09:35 INFO - Running setup.py (path:/tmp/pip-tym_Ei-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:09:36 INFO - Running setup.py (path:/tmp/pip-japtqK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:09:36 INFO - Running setup.py (path:/tmp/pip-4iGTVz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:09:36 INFO - Running setup.py (path:/tmp/pip-zy5ZnY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:09:36 INFO - Running setup.py (path:/tmp/pip-uFXDUt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:09:36 INFO - Running setup.py (path:/tmp/pip-veHysX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:09:36 INFO - Running setup.py (path:/tmp/pip-8_syjt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:09:36 INFO - Running setup.py (path:/tmp/pip-W8wWdT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:09:36 INFO - Running setup.py (path:/tmp/pip-_JPp2T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:09:36 INFO - Running setup.py (path:/tmp/pip-x6FGsX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:09:36 INFO - Running setup.py (path:/tmp/pip-8pf8LU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:09:36 INFO - Running setup.py (path:/tmp/pip-Mv0CXr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:09:36 INFO - Running setup.py (path:/tmp/pip-4Q1ezJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:09:36 INFO - Running setup.py (path:/tmp/pip-4N1KYU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:09:36 INFO - Running setup.py (path:/tmp/pip-fAT0j3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:09:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:09:37 INFO - Running setup.py (path:/tmp/pip-lcWO8y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:09:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:09:37 INFO - Running setup.py install for manifestparser 14:09:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:09:37 INFO - Running setup.py install for mozcrash 14:09:37 INFO - Running setup.py install for mozdebug 14:09:37 INFO - Running setup.py install for mozdevice 14:09:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:09:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:09:37 INFO - Running setup.py install for mozfile 14:09:37 INFO - Running setup.py install for mozhttpd 14:09:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:09:37 INFO - Running setup.py install for mozinfo 14:09:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:09:37 INFO - Running setup.py install for mozInstall 14:09:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:09:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:09:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:09:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:09:37 INFO - Running setup.py install for mozleak 14:09:37 INFO - Running setup.py install for mozlog 14:09:38 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:09:38 INFO - Running setup.py install for moznetwork 14:09:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:09:38 INFO - Running setup.py install for mozprocess 14:09:38 INFO - Running setup.py install for mozprofile 14:09:38 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:09:38 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:09:38 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:09:38 INFO - Running setup.py install for mozrunner 14:09:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:09:38 INFO - Running setup.py install for mozscreenshot 14:09:38 INFO - Running setup.py install for moztest 14:09:38 INFO - Running setup.py install for mozversion 14:09:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:09:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:09:38 INFO - Cleaning up... 14:09:38 INFO - Return code: 0 14:09:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f716aa9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe540>, '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 0x16ff440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', '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 14:09:38 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 14:09:38 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 14:09:38 INFO - Using env: {'DISPLAY': ':0', 14:09:38 INFO - 'HOME': '/home/cltbld', 14:09:38 INFO - 'LANG': 'en_US.UTF-8', 14:09:38 INFO - 'LANGUAGE': 'en_US:en', 14:09:38 INFO - 'LOGNAME': 'cltbld', 14:09:38 INFO - 'MAIL': '/var/mail/cltbld', 14:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:38 INFO - 'MOZ_NO_REMOTE': '1', 14:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:38 INFO - 'NO_EM_RESTART': '1', 14:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:38 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:38 INFO - 'SHELL': '/bin/bash', 14:09:38 INFO - 'SHLVL': '1', 14:09:38 INFO - 'TERM': 'linux', 14:09:38 INFO - 'TMOUT': '86400', 14:09:38 INFO - 'USER': 'cltbld', 14:09:38 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', 14:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:38 INFO - '_': '/tools/buildbot/bin/python'} 14:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:09:39 INFO - Running setup.py (path:/tmp/pip-60M_OT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:09:39 INFO - Running setup.py (path:/tmp/pip-_oQh2B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:09:39 INFO - Running setup.py (path:/tmp/pip-Uq_AL3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:09:39 INFO - Running setup.py (path:/tmp/pip-9sQmnk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:09:39 INFO - Running setup.py (path:/tmp/pip-TzctuO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:09:39 INFO - Running setup.py (path:/tmp/pip-Qiu2sj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:09:39 INFO - Running setup.py (path:/tmp/pip-Z6de_U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:09:39 INFO - Running setup.py (path:/tmp/pip-onEzpB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:09:39 INFO - Running setup.py (path:/tmp/pip-UjuPPp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:09:39 INFO - Running setup.py (path:/tmp/pip-P3ET0S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:09:39 INFO - Running setup.py (path:/tmp/pip-IIXWwD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:09:39 INFO - Running setup.py (path:/tmp/pip-G_n9AG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:09:39 INFO - Running setup.py (path:/tmp/pip-mZCP47-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:09:40 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)) 14:09:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:09:40 INFO - Running setup.py (path:/tmp/pip-gly0el-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:09:40 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)) 14:09:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:09:40 INFO - Running setup.py (path:/tmp/pip-3SZAyu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:09:40 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)) 14:09:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:09:40 INFO - Running setup.py (path:/tmp/pip-8e4PG5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:09:40 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)) 14:09:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:09:40 INFO - Running setup.py (path:/tmp/pip-NtL8jc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:09:40 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)) 14:09:40 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)) 14:09:40 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)) 14:09:40 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)) 14:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:09:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:42 INFO - Downloading blessings-1.5.1.tar.gz 14:09:42 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 14:09:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:09:42 INFO - Installing collected packages: blessings 14:09:42 INFO - Running setup.py install for blessings 14:09:42 INFO - Successfully installed blessings 14:09:42 INFO - Cleaning up... 14:09:42 INFO - Return code: 0 14:09:42 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:09:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:09:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:09:42 INFO - Reading from file tmpfile_stdout 14:09:42 INFO - Current package versions: 14:09:42 INFO - argparse == 1.2.1 14:09:42 INFO - blessings == 1.5.1 14:09:42 INFO - blobuploader == 1.2.4 14:09:42 INFO - docopt == 0.6.1 14:09:42 INFO - manifestparser == 1.1 14:09:42 INFO - mozInstall == 1.12 14:09:42 INFO - mozcrash == 0.16 14:09:42 INFO - mozdebug == 0.1 14:09:42 INFO - mozdevice == 0.48 14:09:42 INFO - mozfile == 1.2 14:09:42 INFO - mozhttpd == 0.7 14:09:42 INFO - mozinfo == 0.9 14:09:42 INFO - mozleak == 0.1 14:09:42 INFO - mozlog == 3.1 14:09:42 INFO - moznetwork == 0.27 14:09:42 INFO - mozprocess == 0.22 14:09:42 INFO - mozprofile == 0.28 14:09:42 INFO - mozrunner == 6.11 14:09:42 INFO - mozscreenshot == 0.1 14:09:42 INFO - mozsystemmonitor == 0.0 14:09:42 INFO - moztest == 0.7 14:09:42 INFO - mozversion == 1.4 14:09:42 INFO - psutil == 3.1.1 14:09:42 INFO - requests == 1.2.3 14:09:42 INFO - wsgiref == 0.1.2 14:09:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:09: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')]} 14:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:42 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 0x7f716aa9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe540>, '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 0x16ff440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', '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 14:09:42 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 14:09:42 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 14:09:42 INFO - Using env: {'DISPLAY': ':0', 14:09:42 INFO - 'HOME': '/home/cltbld', 14:09:42 INFO - 'LANG': 'en_US.UTF-8', 14:09:42 INFO - 'LANGUAGE': 'en_US:en', 14:09:42 INFO - 'LOGNAME': 'cltbld', 14:09:42 INFO - 'MAIL': '/var/mail/cltbld', 14:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:42 INFO - 'MOZ_NO_REMOTE': '1', 14:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:42 INFO - 'NO_EM_RESTART': '1', 14:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:42 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:42 INFO - 'SHELL': '/bin/bash', 14:09:42 INFO - 'SHLVL': '1', 14:09:42 INFO - 'TERM': 'linux', 14:09:42 INFO - 'TMOUT': '86400', 14:09:42 INFO - 'USER': 'cltbld', 14:09:42 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', 14:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:42 INFO - '_': '/tools/buildbot/bin/python'} 14:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:42 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)) 14:09:42 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)) 14:09:42 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)) 14:09:42 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)) 14:09:42 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)) 14:09:42 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)) 14:09:42 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)) 14:09:42 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)) 14:09:42 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)) 14:09:42 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)) 14:09:42 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)) 14:09:42 INFO - Cleaning up... 14:09:42 INFO - Return code: 0 14:09:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:09: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')]} 14:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:42 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 0x7f716aa9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe540>, '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 0x16ff440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', '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 14:09:42 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 14:09:42 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 14:09:42 INFO - Using env: {'DISPLAY': ':0', 14:09:42 INFO - 'HOME': '/home/cltbld', 14:09:42 INFO - 'LANG': 'en_US.UTF-8', 14:09:42 INFO - 'LANGUAGE': 'en_US:en', 14:09:42 INFO - 'LOGNAME': 'cltbld', 14:09:42 INFO - 'MAIL': '/var/mail/cltbld', 14:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:42 INFO - 'MOZ_NO_REMOTE': '1', 14:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:42 INFO - 'NO_EM_RESTART': '1', 14:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:42 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:42 INFO - 'SHELL': '/bin/bash', 14:09:42 INFO - 'SHLVL': '1', 14:09:42 INFO - 'TERM': 'linux', 14:09:42 INFO - 'TMOUT': '86400', 14:09:42 INFO - 'USER': 'cltbld', 14:09:42 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', 14:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:42 INFO - '_': '/tools/buildbot/bin/python'} 14:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:42 INFO - Downloading/unpacking jsonschema 14:09:42 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 14:09:42 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 14:09:42 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 14:09:42 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 14:09:42 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 14:09:42 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 14:09:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:09:44 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 14:09:44 INFO - Downloading/unpacking functools32 (from jsonschema) 14:09:44 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 14:09:44 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 14:09:44 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 14:09:44 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 14:09:44 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 14:09:44 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 14:09:44 INFO - Downloading functools32-3.2.3-2.tar.gz 14:09:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:09:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:09:44 INFO - warning: no files found matching '*.txt' 14:09:44 INFO - no previously-included directories found matching 'build' 14:09:44 INFO - no previously-included directories found matching 'dist' 14:09:44 INFO - no previously-included directories found matching '.git*' 14:09:44 INFO - Installing collected packages: jsonschema, functools32 14:09:44 INFO - Running setup.py install for functools32 14:09:45 INFO - warning: no files found matching '*.txt' 14:09:45 INFO - no previously-included directories found matching 'build' 14:09:45 INFO - no previously-included directories found matching 'dist' 14:09:45 INFO - no previously-included directories found matching '.git*' 14:09:45 INFO - Successfully installed jsonschema functools32 14:09:45 INFO - Cleaning up... 14:09:45 INFO - Return code: 0 14:09:45 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:45 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 0x7f716aa9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe540>, '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 0x16ff440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', '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 14:09:45 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 14:09:45 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 14:09:45 INFO - Using env: {'DISPLAY': ':0', 14:09:45 INFO - 'HOME': '/home/cltbld', 14:09:45 INFO - 'LANG': 'en_US.UTF-8', 14:09:45 INFO - 'LANGUAGE': 'en_US:en', 14:09:45 INFO - 'LOGNAME': 'cltbld', 14:09:45 INFO - 'MAIL': '/var/mail/cltbld', 14:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:45 INFO - 'MOZ_NO_REMOTE': '1', 14:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:45 INFO - 'NO_EM_RESTART': '1', 14:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:45 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:45 INFO - 'SHELL': '/bin/bash', 14:09:45 INFO - 'SHLVL': '1', 14:09:45 INFO - 'TERM': 'linux', 14:09:45 INFO - 'TMOUT': '86400', 14:09:45 INFO - 'USER': 'cltbld', 14:09:45 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', 14:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:45 INFO - '_': '/tools/buildbot/bin/python'} 14:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:45 INFO - Downloading/unpacking flake8 14:09:45 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 14:09:45 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 14:09:45 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 14:09:45 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 14:09:45 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 14:09:45 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 14:09:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:09:47 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 14:09:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:09:47 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 14:09:47 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 14:09:47 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 14:09:47 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 14:09:47 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 14:09:47 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 14:09:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:09:47 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 14:09:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:09:47 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 14:09:47 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 14:09:47 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 14:09:47 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 14:09:47 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 14:09:47 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 14:09:47 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 14:09:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:09:47 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 14:09:47 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 14:09:47 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 14:09:47 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 14:09:47 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 14:09:47 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 14:09:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:09:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:09:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:09:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:09:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:09:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:09:47 INFO - no previously-included directories found matching 'docs/_build' 14:09:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:09:47 INFO - Running setup.py install for pep8 14:09:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:09:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:09:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:09:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:09:47 INFO - no previously-included directories found matching 'docs/_build' 14:09:47 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:09:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:09:47 INFO - Cleaning up... 14:09:47 INFO - Return code: 0 14:09:47 INFO - Running post-action listener: _resource_record_post_action 14:09:47 INFO - Running post-action listener: _start_resource_monitoring 14:09:47 INFO - Starting resource monitoring. 14:09:47 INFO - ##### 14:09:47 INFO - ##### Running install step. 14:09:47 INFO - ##### 14:09:47 INFO - Running pre-action listener: _resource_record_pre_action 14:09:47 INFO - Running main action method: install 14:09:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:09:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:09:48 INFO - Reading from file tmpfile_stdout 14:09:48 INFO - Detecting whether we're running mozinstall >=1.0... 14:09:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:09:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:09:48 INFO - Reading from file tmpfile_stdout 14:09:48 INFO - Output received: 14:09:48 INFO - Usage: mozinstall [options] installer 14:09:48 INFO - Options: 14:09:48 INFO - -h, --help show this help message and exit 14:09:48 INFO - -d DEST, --destination=DEST 14:09:48 INFO - Directory to install application into. [default: 14:09:48 INFO - "/builds/slave/test-pgo"] 14:09:48 INFO - --app=APP Application being installed. [default: firefox] 14:09:48 INFO - mkdir: /builds/slave/test-pgo/build/application 14:09:48 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'] 14:09:48 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 14:10:04 INFO - Reading from file tmpfile_stdout 14:10:04 INFO - Output received: 14:10:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:10:04 INFO - Running post-action listener: _resource_record_post_action 14:10:04 INFO - ##### 14:10:04 INFO - ##### Running run-tests step. 14:10:04 INFO - ##### 14:10:04 INFO - Running pre-action listener: _resource_record_pre_action 14:10:04 INFO - Running main action method: run_tests 14:10:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:10:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:10:04 INFO - Python 2.7.3 14:10:04 INFO - Return code: 0 14:10:04 INFO - grabbing minidump binary from tooltool 14:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:04 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 0x16fe540>, '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 0x16ff440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:10:04 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 14:10:04 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 14:10:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:10:04 INFO - Return code: 0 14:10:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:10:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:10:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:10:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:10:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:10:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:10:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:10:05 INFO - Return code: 0 14:10:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 14:10:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:10:05 INFO - Using env: {'DISPLAY': ':0', 14:10:05 INFO - 'HOME': '/home/cltbld', 14:10:05 INFO - 'LANG': 'en_US.UTF-8', 14:10:05 INFO - 'LANGUAGE': 'en_US:en', 14:10:05 INFO - 'LOGNAME': 'cltbld', 14:10:05 INFO - 'MAIL': '/var/mail/cltbld', 14:10:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:10:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:05 INFO - 'MOZ_NO_REMOTE': '1', 14:10:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:05 INFO - 'NO_EM_RESTART': '1', 14:10:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:10:05 INFO - 'PWD': '/builds/slave/test-pgo', 14:10:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:10:05 INFO - 'SHELL': '/bin/bash', 14:10:05 INFO - 'SHLVL': '1', 14:10:05 INFO - 'TERM': 'linux', 14:10:05 INFO - 'TMOUT': '86400', 14:10:05 INFO - 'USER': 'cltbld', 14:10:05 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849', 14:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:05 INFO - '_': '/tools/buildbot/bin/python'} 14:10:05 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:10:05 INFO - mozversion application_buildid: 20160119113035 14:10:05 INFO - mozversion application_changeset: f58d8d338d4f526f62d9f983e1c5c497683f8169 14:10:05 INFO - mozversion application_display_name: Nightly 14:10:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:10:05 INFO - mozversion application_name: Firefox 14:10:05 INFO - mozversion application_remotingname: firefox 14:10:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:10:05 INFO - mozversion application_vendor: Mozilla 14:10:05 INFO - mozversion application_version: 46.0a1 14:10:05 INFO - mozversion platform_buildid: 20160119113035 14:10:05 INFO - mozversion platform_changeset: f58d8d338d4f526f62d9f983e1c5c497683f8169 14:10:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:10:05 INFO - mozversion platform_version: 46.0a1 14:10:05 INFO - using testdate: 1453241405 14:10:05 INFO - actual date: 1453241405 14:10:05 INFO - starting webserver on 'localhost:43744' 14:10:05 INFO - SUITE-START | Running 3 tests 14:10:05 INFO - TEST-START | dromaeo_css 14:10:05 INFO - operating with platform_type : linux_ 14:10:05 INFO - Initialising browser for dromaeo_css test... 14:10:05 INFO - TEST-INFO | started process 13107 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAlNtDm/profile http://localhost:43744/getInfo.html) 14:10:08 INFO - PROCESS | 13107 | 14:10:08 INFO - PROCESS | 13107 | (process:13192): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:10:09 INFO - PROCESS | 13107 | __metrics Screen width/height:1600/1200 14:10:09 INFO - PROCESS | 13107 | colorDepth:24 14:10:09 INFO - PROCESS | 13107 | Browser inner width/height: 1024/697 14:10:09 INFO - PROCESS | 13107 | __metrics 14:10:09 INFO - PROCESS | 13107 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:10:10 INFO - TEST-INFO | 13107: exit 0 14:10:10 INFO - Browser initialized. 14:10:10 INFO - Running cycle 1/1 for dromaeo_css test... 14:10:10 INFO - TEST-INFO | started process 13241 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAlNtDm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:11 INFO - PROCESS | 13241 | -- checkerboarding starts below -- 14:10:11 INFO - PROCESS | 13241 | RENDERTRACE 0.039639 rect red 0 0 10 10 // viewport 14:10:11 INFO - PROCESS | 13241 | RENDERTRACE 50.6185 rect brown 0 0 10 10 // page 14:10:11 INFO - PROCESS | 13241 | RENDERTRACE 50.6428 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 14:10:11 INFO - PROCESS | 13241 | Checkerboarded for 1 frames (52.1442 ms), 100 peak, 1 severity. 14:10:12 INFO - PROCESS | 13241 | 14:10:12 INFO - PROCESS | 13241 | (process:13301): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:10:22 INFO - PROCESS | 13241 | RSS: Main: 150450176 14:10:22 INFO - PROCESS | 13241 | 14:11:12 INFO - PROCESS | 13241 | 1453241472126 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] 14:13:20 INFO - PROCESS | 13241 | Cycle 1(1): loaded http://localhost:43744/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43744/tests/dromaeo/cssquery-ext.html) 14:13:21 INFO - PROCESS | 13241 | RSS: Main: 155791360 14:13:21 INFO - PROCESS | 13241 | 14:16:23 INFO - PROCESS | 13241 | Cycle 1(1): loaded http://localhost:43744/tests/dromaeo/cssquery-ext.html (next: http://localhost:43744/tests/dromaeo/cssquery-jquery.html) 14:16:24 INFO - PROCESS | 13241 | RSS: Main: 151945216 14:16:24 INFO - PROCESS | 13241 | 14:19:26 INFO - PROCESS | 13241 | Cycle 1(1): loaded http://localhost:43744/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43744/tests/dromaeo/cssquery-mootools.html) 14:19:26 INFO - PROCESS | 13241 | RSS: Main: 151183360 14:19:26 INFO - PROCESS | 13241 | 14:22:28 INFO - PROCESS | 13241 | Cycle 1(1): loaded http://localhost:43744/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43744/tests/dromaeo/cssquery-prototype.html) 14:22:29 INFO - PROCESS | 13241 | RSS: Main: 150589440 14:22:29 INFO - PROCESS | 13241 | 14:25:31 INFO - PROCESS | 13241 | Cycle 1(1): loaded http://localhost:43744/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43744/tests/dromaeo/cssquery-yui.html) 14:25:32 INFO - PROCESS | 13241 | RSS: Main: 151359488 14:25:32 INFO - PROCESS | 13241 | 14:28:34 INFO - PROCESS | 13241 | Cycle 1(1): loaded http://localhost:43744/tests/dromaeo/cssquery-yui.html (next: http://localhost:43744/tests/dromaeo/cssquery-dojo.html) 14:28:34 INFO - PROCESS | 13241 | RSS: Main: 153382912 14:28:34 INFO - PROCESS | 13241 | 14:28:34 INFO - PROCESS | 13241 | __start_tp_report 14:28:34 INFO - PROCESS | 13241 | _x_x_mozilla_page_load 14:28:34 INFO - PROCESS | 13241 | _x_x_mozilla_page_load_details 14:28:34 INFO - PROCESS | 13241 | |i|pagename|runs| 14:28:34 INFO - PROCESS | 13241 | |0;dojo.html;3173.190836336734;3177.8411079446037;3203.5034569641684;3219.1308346746378;3231.3537292541496;5142.331496905397;5142.382914050315;5180.274761533388;5197.8700532486655;5231.738413079341;5030.320906677597;5243.292155558998;5252.212168174776;5281.339832520935;5288;4705.694129881564;4716.976415117928;4734.763261836894;4808.591269742076;4840.177169881111;4496.685232033759;4770.809167633291;4786.928196077044;4801.008857290393;4884.633652476061;4644.930326045112;4678.789454474557;4714.669973101884;4727.101850648401;4768.713877167381;4763.261694437368;4764.499727528629;4773.618110551148;4784.856454306341;4813.109574728686;4681.133990211822;4748.5014073522125;4761.119192949315;4761.928571071437;4793.71237725734;5097.260897169889;5115.667481613683;5132.974335128338;5135.871603209912;5136.5377116059735;5610.158476228557;5615.326160860682;5637.971810140964;5639.774409023634;5655.0386434306265;5540.972295138539;5628.212050312918;5669.036263835158;5684.090545512699;5755.827325180251;5214.243934629458;5224.712640804754;5242.764075616568;5250.789968401221;5292.417834038252;5757.309122905278;5765.221695071112;5765.4522820332;5787.450192231731;5795.681237531892;5377.865553361119;5447.319085114361;5556.833295001156;5574.303212098488;5612.691301978349;5692.288463942007;5716.942830571641;5718.228039214653;5718.828435146952;5759.913601295984;5621.381648018714;5654.37801841797;5664.405237450091;5668.801591944345;5678.545716342765;5419.132938729785;5520.337559492887;5564.693941833157;5663.575231857627;5684.118961560965;4322.827086916488;4346.630536404377;4348.478182618042;4375.081232941055;4407.6914615976575;3931.017245688578;3941.8226179821977;3952.8418863245724;3978.264021156095;3987.521497420328;5194.68831870089;5275.762590683352;5288.603354748409;5304.257403963448;5348.893022139536;5601.943980560224;5648.293963254593;5660.971695141498;5663.490285874209;5690.715464226772;5326.46735326472;5328.200769884471;5337.466253374631;5346.625736198506;5381.273528073738;4709.646776491777;4767.594754445841;4769.2369220925175;4770.570648641639;4772.260299653559;5868.295804503487;5891.9705401473575;5900.734466948998;5915.645061296336;5953.851153721192;5653.321601407857;5660.122680984454;5669.744861481326;5678.403767604342;5681.431856814285;5744.3394009687745;5776.018076926848;5843.883122337445;5915.970420148044;5984.820455386345;5511.807086751945;5515.834524964257;5518.227448157341;5518.2826232589505;5572.721363931706;5595.04884169684;5609.579281553818;5614.1017437211485;5624.57815663835;5642;5423.29497165366;5473.0969390050195;5526.861828454321;5539.390667026543;5550.611457197957;5502.80740174092;5526;5535.059039963136;5537.058700021086;5540.529055030368;5399.217113518596;5446.101393270224;5447.891042179213;5472.315960504937;5526.419725928719;5312.362516498045;5328.7602057906715;5533.529649979797;5586.413426590149;5659.9151012735665;5401.270828438111;5416.377116631637;5470.671759694431;5472.562195024469;5488.396276409671 14:28:34 INFO - PROCESS | 13241 | |1;ext.html;536.5868281423304;548.0929062401724;568.9971550142249;571.3258355140937;571.3431049955129;35115.47326790097;36403.63596364039;36484.45273320902;36490.27019459616;36509.817450912706;39024;39731.60268397322;39789.801050994705;39882.20235595286;39974.60025399745;8443.324534037278;8533.530655813927;8594.398392112524;8600;8606.139386061406;8336;8471;8489.066202717697;8606.053334133241;8642.178992995656;8588.269997050258;8620.396572239946;8646.265067469272;8663.870041949376;8703.912960870373;8583.399162058658;8664.566771661392;8667;8670.436421632605;8684.218420342137;8327.292180164693;8383.11977242393;8434.072252052269;8434.493930364199;8441.535715535643;38859.22281554353;39326.21347573033;39362;39416;39511;3274.4106060909025;3293.670632936711;3313.884014059496;3360.6807353301397;3603.549556305462;29658.851705741334;30191.547126793117;30311.24221894448;30554.236144096354;30602.387952241053;3269.444194486919;3287.935135027782;3320.7841490303053;3321.684439978198;3452.6349450626403;246929.18424894565;247283;247761;248707;249455;41060.58939410568;41410.79294603508;41959.580404196175;55491.16763248554;55693;41227;41237.79381103075;41401.1719765609;41413.37879931804;41499.377509337384;13666.52167174144;13690.178589284675;13744.312784360942;13778.242196679279;13789.724205515833;10461.320014199053;10510.73723156912;10527.84208236877;10542.314749541256;10557.366558006544;14445.494407695891;14459.27703614815;14517.201553914636;14575.125492470486;14584.708305833823;5886.381929897385;5934.851628709231;5985.845095765521;6014.548908831767;6093.299270583851;971.4656938683696;973.4062222044547;1030.175859312562;1045.1429827541342;1134.5121597713062;28440.28899277493;28975.13074607765;30966.22584435407;31598.684013160033;32278.35443291168;1007.7631756537207;1026.5021464589668;1036.3056751976194;1054.7257712994524;1120.8598925134359;14809.48166814178;15040;15074.472393466396;15101.546953591409;15122.39510419571;380299;381175;382819;384357;384685;52789;52886.20670689943;53325.73337133289;53357.46642533525;53478.73260633672;1306.353355089218;1306.9607911762662;1369.9863001369858;1374.113696665665;1374.9587512374644;28068;28744;28812.42375152527;28832.711672883004;28904.277393065342;49223.50776492333;49780.253296201314;50104;50279.49720502894;50328;305796;308107;308721;308778;309187;41849.372259415526;42415;42634.14731705286;42717.35923961205;43084.35373469463;45256.54743452524;45879;46090.30864537102;46141.30788038115;46777.76611116923;34889.12607607091;35235.64764352324;35998.820005899805;36211.637883620824;37252.813735931144;36760.44859327059;36811.63188368189;37093.81453092717;37324.62675373212;37534.62465375311;38228.42657360197;38405.23189536249;38639.80680096582;38862.2227555453;39221.803890980365;28937.56593651055;29670;30575.541366879068;31966.200844979063;32011.519827203076;24129.51740965136;24197.637035444834;24332.635010474503;24673;24749.381265468506 14:28:34 INFO - PROCESS | 13241 | |2;jquery.html;348.37814501115514;351.37630705497736;353.13658105930995;355.8292019830483;358.27985748645233;15619.921900390496;15965.84034159658;16795.83204167958;16886.57783555412;17644.11779411031;10292.536835842386;10312.793744125112;11208.831867521994;11468.082553395729;11553.249038812472;4939.086269040221;5128.8974220515565;5151.072806894757;5191.195364718475;5398.4871437213405;5321.654092483996;5323.0152421801895;5385.272988146608;5390.946090539083;5394.271773310592;5012.398512178544;5028.145215313387;5215.713135777531;5246.42607217835;5385.946140538584;5214.191800270964;5221.738913054332;5235.947640523622;5245.973770131144;5283.260343551906;5344.91982620261;5351.277577527062;5351.518363347279;5353.357597088336;5357.919631205535;12576.308303043328;12828.102032857703;12849.229046257255;12885.484580616763;12960.092793504458;2004.8997550122435;2055.98972005139;2076.0761461149796;2097.832173426122;2178.7712290209456;9463.905360946372;9494.145526902612;9522.904770952271;9641.566129524188;9725.270604704605;1736.0712019069863;1755.6525938945554;1762.7884653841493;1763.1801212436278;1773.556610847288;51224;51255.74372128153;52040.47959520394;52586.7370663148;54921.725391373184;9353.953230233805;9635.470049147223;9657.661981830603;9731.318807683394;9857.654982075735;13460.057795954384;13550.728985420434;13596.25220612856;13607.863921360859;13650.453981840616;6841.486888483284;6872.518923675395;6891.241963384024;6950.200726916368;6985.755498557526;6474.935250647527;6506.60960342381;6528.738850446024;6559.278479367265;6561.015847622799;4246.278132717445;4300.204462174508;4371.125774845043;4446.3552784846015;4464.977675111603;1831.9633607327778;1847.990760046191;1866.9626607467774;1872.8127187281164;1910.503269150031;854.7734850264685;993.8509223616516;1051.374432212832;1055.6885718712845;1068.941208233539;15839.128847913475;15893.364265429253;16220.432284869972;16484.752728709078;16557.337706491606;910.1080940678172;912.2792993535165;916.8395530782086;923.4874644572193;949.7293271417751;9439.622415103318;9503.382280151767;9508.144267016001;9544.665936692183;9628.951855240679;524319;566179;572638;581136;581506;69469;72548.63725681443;72692;72932.89469737174;74898.25101749021;1071.0574694268994;1074.6292529077455;1077.5258886090096;1108.0415440643947;1113.3932007056173;14559.636009099857;14816.333265003317;14836.851631483547;14980.775288370465;14982.175980321186;30226.093217203517;30867.536986945663;33371.49942750812;34646.30707385889;35539.82230088833;43650.56349436592;43675.78162109169;45296.547034529234;45969;46692;9384.202342800665;9754.268429867647;9851.310408271638;10003.649872254437;10004.325496064712;11321.830172547583;11432.657020289405;11659.53361865516;11896.643100706993;12030.75938481208;6918.792436226921;6926;7459.216782238004;7474.215207403145;7623.733169339046;7612.505187162817;7612.961935190288;7643.541387516544;7722.652480638497;7735.806604834699;7753.302202801775;7831.412644051833;7846.215378462108;7859.4891332063235;7893.052833659997;8869.290456763314;9976.20190384782;10089.596416143271;10163.339382940085;10192.694219173436;8496.95751521263;9023.729288121367;9039.367244292836;9060.864087038832;9146.268298535968 14:28:34 INFO - PROCESS | 13241 | |3;mootools.html;1474.69768697417;1488.2707473338064;1658.469289827255;1801.4775715042638;1825.7352683860831;7269.963650181749;7362.705491780336;7397.519161254521;7428.0343555337795;7620.237976202377;7572.091349038109;7699.345555627779;7734.071911370644;7737.419693522994;7819.648115834787;2306.296579543243;2328.6739856420113;2330.2193765088714;2330.2310237621546;2337.590921588715;2339.1345202275184;2339.2280547419396;2349.4243910242017;2362;2372.4543355028354;2259.435141214696;2315.641075633271;2319;2329.6272596384583;2343.95312093758;2274.80664143548;2313.456337760625;2324.6861673674093;2330.207729372005;2332.6617640442128;2297.1959814065112;2314.9768502315096;2317.3279748872806;2319.652052192168;2331.5803155432013;7480.513766605153;7564.092308922909;7635;7644.388448924073;7659.348955338803;4686.133065382915;4731.313959475891;4736.407949006374;4742.9525704742855;4806.0628177505405;2954.2466670998756;2968.1095671298526;3020.154356780083;3033.7421319187674;3039;923.1968187676697;927.7031349968013;956.9186619137382;975.990240097597;1015.9492025398774;10215.182785377227;10277.48612569376;10305.484725763681;10314.48427578618;10359.27485076045;4258.361245813153;4329.0259691569145;4333.826646934151;4382.408374869352;4398.098389830077;8388.07731149573;8476.110008449148;8493.617787199591;8501.107383724744;8512.659493620185;4745.525447455227;4762.095201911626;4765.571098601143;4780.11567859947;4802.6638135330195;4365.825366985348;4412.139632771578;4412.558744125626;4421.867343979621;4432.711873728197;3358.1940334320075;3424.126847653832;3430.8456119474686;3432.622411534729;3464.133966508373;990.029770824596;992.3252188511736;1012.9493525323704;1065.7708592652616;1096.6655170173015;1317.7693903566837;1319.729455461628;1342.4428862022346;1348.8179095821938;1352.75650382932;7195.748148814766;7244.637768111574;7341.412686985029;7347.8163045924275;7371.447141464411;1133.0935251798528;1135.2450620337547;1143.5654451308449;1150.511032811052;1159.4840296068337;5610.326760788732;5706.82879513607;5737.139429085671;5739.311282646026;5748.425157484218;8662.003869555081;8722.258608018263;8801.559922003875;9069.682561110329;9108.043655416219;8958;9008.41445306066;9349.065093490597;9375.812483750287;9404;7220.0613920190035;7241.203467618558;7256.637168141572;7334.66993985272;7412.18465968743;6850.725970961305;6851.3491218334175;7000.544964577286;7065.540739851893;7097.9290207097265;8184;8269.83460330802;8284.08875023759;8341.45780524264;8406.243438090602;8379.45533540318;8561.400701950804;8591.699290525052;8603.053664096818;8606.225439710455;6492.740290388331;6554.246261679968;6756.479792046946;6856.588604683735;6865.965670171618;7477.626118694152;7515.398768098648;7527.1720110788865;7529.8494030118;7573.431992600687;6647.335266473314;6755.763548275787;6849.31506849331;6986.895196571953;7108.680109395193;6443.613383197023;6497.740090396331;6520.478361731145;6603.372679595431;6640.203175618956;6549.148610680581;6554.868902621825;6596.5052621052655;6637.6349300788925;6644.103046088716;6051.606645568024;6089.269287685506;6121.4490695837585;6124.601900876607;6152.261728592419;5907;6019.759209631741;6028.969855150696;6032.4570788629235;6036.185115009594 14:28:34 INFO - PROCESS | 13241 | |4;prototype.html;339.6891843962774;341.6941837055835;349.40426572693553;350.1386588991082;354.90772399176205;6037.788677396292;6179.938200617992;6230.439260466557;6239.5008399328;6275.403836635518;5969;6056.4851987581;6079.574429789916;6093.756249750005;6171.074338849175;4682.531746825307;4695.812167513295;4700.388949436586;4708.246680531116;4714.339992401066;4680.368150299717;4693.694909830867;4697.06058788242;4706;4724.97637511812;4463.486699029604;4556.384888040122;4614.838480653178;4623.8844028899375;4664.370310008157;4583.312503124558;4596.425446819131;4596.862094137181;4618.769061546909;4619.74591397473;3949.0917089069676;3986.980065099685;3998.540167880702;4019.8191081401405;4051.817668204938;5854.795082172146;5870.941290587082;5885.087811389199;5891.05743081105;5908.852278693024;5445.646033007882;5451.574049547953;5461.863453413656;5463.371712253102;5463.453654634544;6538.150040494753;6580.506462015368;6609.239937407212;6615.437687796495;6628.105205797204;4327.156204540116;4418.933715994231;4437.356583295436;4452.109578084396;4453.599176074136;6752.426043786284;6816.420604248645;6821.317868213188;6859.759908403182;6888.207856096513;4539.954600453953;4568.817247310137;4581.885452863705;4584.908301833944;4590.793414296365;4469.4636643602325;4627.537246275346;4636.142313671981;4643.048175124091;4668.089722504079;5365.678059316376;5396.271503347077;5406.756695948613;5409.864753381118;5422.186671999231;6560.179977502812;6581.835454113685;6620.569662971891;6636.601803891782;6642.302558231413;1650.5873531617096;1660.618057846702;1662.1606088925016;1663.2349119404967;1664.0431751742797;1093.786711591248;1094.2121672395863;1099.5766629847406;1119.361963680694;1125.009991207732;6313.463355614732;6318.684065796691;6346.936530634727;6367.968160159169;6368.363163683594;6804.08144900442;6813.897791533131;6822.965885170642;6824.7952561423235;6830.521863469509;6186.319504854462;6266.279377871603;6271.78048768291;6276.529260305495;6285.9057114143325;3679.5952445231005;3700.4634328022285;3717.9442308365396;3727.7390582659496;3736.0286325555553;7013.228544860061;7210.567365958059;7213.567185968858;7234.131904171428;7260.056192694916;6973.3375329343635;7002.614856182857;7015.859682806417;7017.438604911595;7034.2262351141335;7030.367266945999;7115.217326094125;7177.820554486179;7186.317299856505;7226.385757210696;6815.625140617313;6833.863322733418;6837.453003759588;6842.863142737017;6855.314468553105;6763.154605674291;6771.52599318043;6773.221079575912;6777.423918966746;6785.2536221016635;7039.225685174524;7161.534500257467;7177.2463891292755;7187.353138217585;7200.49596528238;4639.35049093134;4664.253719405015;4675.13510000651;4685.695429797052;4691.061787642417;6760.628165450948;6832.555883867532;6848.14398200225;6855.383015528626;6904.792856214322;6499.252585952487;6646.767363142267;6652.501062420241;6658.700358483783;6673.099131617169;6629.834254143685;6635.933640663531;6662.333766623299;6662.766803161866;6683.43190828785;6533.967330163318;6534.183227096613;6542.018697195459;6548.738050477928;6573.605583664996;6581.3418658133805;6660.6336651484635;6703.095082164041;6707;6710.194776626836;6549.410553050248;6609.074729537772;6613.074169616354;6621.668916554249;6622.337766223339 14:28:34 INFO - PROCESS | 13241 | |5;yui.html;775.8254392761629;795.4272923495083;809.0897740042452;812.6708682983394;823.8266898089772;13577.253251071199;13706.383212755425;13751.312434378291;13753.106048106878;13786.17282963023;12743.23540587563;12763.04277179213;12821.807672884914;12831.807522887164;12912.806307905366;817.7219745286601;817.8282560662253;825.2078005115096;835.0480452284401;839.6095815445816;820.63481750621;823.5840900345318;830.3108420011406;830.3979614779297;830.6054624053587;854.5257382152903;857.1428571428571;861.5304658960881;865.1867244789909;865.2818160926447;842.3093063687778;856.4261944497171;861.4013260783757;864.2740098317381;865.9567021648892;624.3787431505635;628.4249911331126;632.4940047961659;632.5666918161074;633.3033662970695;13431.865681343159;13482.595522134352;13517.32413379327;13526.391312390966;13747;12609.43257553403;12727.109102362838;12798.48806047757;12847.229166250056;12877.742445151138;10001.449920254383;10033.297669163161;10090.293679442442;11081.279716818462;11211.439428028565;3657.2319812839337;3667.339878821811;3683.4843121962945;3689.2252626948375;3762.698984081267;43983.78008109939;45331.77334113341;45480;45537.316940245924;45701.31448028315;9629.229661627052;9637.132658060807;9792.853107203398;9821.817461888762;10135.543900524493;17039.062851543036;17691.115444227737;17694.203760830795;17702.557436064202;17746.37887673925;7147.213806481387;7232.566046037149;7294.234105418961;7419.703211871572;7441.255874412515;3844.8077596120643;3890.6692931100606;3891.7859517726797;3907.5897030811925;3954.387070004154;3129.687031296852;3138.7489000879873;3145.5753473280815;3147.8583463744185;3172.1118086935694;540.1276937745513;550.2544052808387;553.698234462219;572.5562688916124;584.7894757887158;498.3645851539316;506.5972551821311;532.5074306266688;636.0078277886512;643.2698886763557;8095.595220238964;8678.69819527076;8678.913210867811;8758.737237882873;8767.298616110696;551.635920292605;608.8873558391712;647.4205586000503;650.9544331896722;655.6983787457823;3915.569287378386;4111.773852438145;4164.66682665386;4195.727277726938;4254.510731265944;55372.72313638406;55955;56114.158287625716;56268;56701;48499.272510912364;50261;50889.745551272004;51601;51877.48122518802;41984;42386.364204536956;42901.14197716028;45284.77357613257;46988;8634.309255259439;8707.216350528483;9023.097690230925;9083.409578377385;9128.224100951493;33114;33452.49821252634;34113.658863411045;34230.31539369149;34231.65768342285;42922;43448.34827477654;43690.56309436992;43709.34435983526;44148.11703765971;11193.608223712132;11254.38100904458;11344.546218151181;11361.54553817838;11385.601503947322;12760;13077.869221308045;13078.607641770763;13213.603591892259;13230.536931207747;11080.335179889233;11133.777324453627;11328;11482.196246262682;11680.591179308683;11268.7746245073;11715.121365897763;11717.296962182296;11795;12108.75782484363;10880.67357979262;11168.776624467302;11306.321620702784;11565.248258863146;11724.355160466257;9217.677381291622;9308.208802251884;9329.766755831159;9354;9479.763005924908;8688.91311086881;8755.824883502168;9709.056547470973;9867.950660246654;9967.45179015132 14:28:34 INFO - PROCESS | 13241 | __end_tp_report 14:28:34 INFO - PROCESS | 13241 | __start_cc_report 14:28:34 INFO - PROCESS | 13241 | _x_x_mozilla_cycle_collect,307 14:28:34 INFO - PROCESS | 13241 | __end_cc_report 14:28:34 INFO - PROCESS | 13241 | __startTimestamp1453242514805__endTimestamp 14:28:34 INFO - PROCESS | 13241 | 14:28:34 INFO - PROCESS | 13241 | ------- Summary: start ------- 14:28:34 INFO - PROCESS | 13241 | Number of tests: 6 14:28:34 INFO - PROCESS | 13241 | 14:28:34 INFO - PROCESS | 13241 | [#0] dojo.html Cycles:165 Average:5229.96 Median:5423.29 stddev:580.28 (10.7%) stddev-sans-first:559.17 14:28:34 INFO - PROCESS | 13241 | Values: 3173.2 3177.8 3203.5 3219.1 3231.4 5142.3 5142.4 5180.3 5197.9 5231.7 5030.3 5243.3 5252.2 5281.3 5288.0 4705.7 4717.0 4734.8 4808.6 4840.2 4496.7 4770.8 4786.9 4801.0 4884.6 4644.9 4678.8 4714.7 4727.1 4768.7 4763.3 4764.5 4773.6 4784.9 4813.1 4681.1 4748.5 4761.1 4761.9 4793.7 5097.3 5115.7 5133.0 5135.9 5136.5 5610.2 5615.3 5638.0 5639.8 5655.0 5541.0 5628.2 5669.0 5684.1 5755.8 5214.2 5224.7 5242.8 5250.8 5292.4 5757.3 5765.2 5765.5 5787.5 5795.7 5377.9 5447.3 5556.8 5574.3 5612.7 5692.3 5716.9 5718.2 5718.8 5759.9 5621.4 5654.4 5664.4 5668.8 5678.5 5419.1 5520.3 5564.7 5663.6 5684.1 4322.8 4346.6 4348.5 4375.1 4407.7 3931.0 3941.8 3952.8 3978.3 3987.5 5194.7 5275.8 5288.6 5304.3 5348.9 5601.9 5648.3 5661.0 5663.5 5690.7 5326.5 5328.2 5337.5 5346.6 5381.3 4709.6 4767.6 4769.2 4770.6 4772.3 5868.3 5892.0 5900.7 5915.6 5953.9 5653.3 5660.1 5669.7 5678.4 5681.4 5744.3 5776.0 5843.9 5916.0 5984.8 5511.8 5515.8 5518.2 5518.3 5572.7 5595.0 5609.6 5614.1 5624.6 5642.0 5423.3 5473.1 5526.9 5539.4 5550.6 5502.8 5526.0 5535.1 5537.1 5540.5 5399.2 5446.1 5447.9 5472.3 5526.4 5312.4 5328.8 5533.5 5586.4 5659.9 5401.3 5416.4 5470.7 5472.6 5488.4 14:28:34 INFO - PROCESS | 13241 | 14:28:34 INFO - PROCESS | 13241 | [#1] ext.html Cycles:180 Average:47319.77 Median:37288.72 stddev:83477.71 (223.9%) stddev-sans-first:83637.99 14:28:34 INFO - PROCESS | 13241 | Values: 536.6 548.1 569.0 571.3 571.3 35115.5 36403.6 36484.5 36490.3 36509.8 39024.0 39731.6 39789.8 39882.2 39974.6 8443.3 8533.5 8594.4 8600.0 8606.1 8336.0 8471.0 8489.1 8606.1 8642.2 8588.3 8620.4 8646.3 8663.9 8703.9 8583.4 8664.6 8667.0 8670.4 8684.2 8327.3 8383.1 8434.1 8434.5 8441.5 38859.2 39326.2 39362.0 39416.0 39511.0 3274.4 3293.7 3313.9 3360.7 3603.5 29658.9 30191.5 30311.2 30554.2 30602.4 3269.4 3287.9 3320.8 3321.7 3452.6 246929.2 247283.0 247761.0 248707.0 249455.0 41060.6 41410.8 41959.6 55491.2 55693.0 41227.0 41237.8 41401.2 41413.4 41499.4 13666.5 13690.2 13744.3 13778.2 13789.7 10461.3 10510.7 10527.8 10542.3 10557.4 14445.5 14459.3 14517.2 14575.1 14584.7 5886.4 5934.9 5985.8 6014.5 6093.3 971.5 973.4 1030.2 1045.1 1134.5 28440.3 28975.1 30966.2 31598.7 32278.4 1007.8 1026.5 1036.3 1054.7 1120.9 14809.5 15040.0 15074.5 15101.5 15122.4 380299.0 381175.0 382819.0 384357.0 384685.0 52789.0 52886.2 53325.7 53357.5 53478.7 1306.4 1307.0 1370.0 1374.1 1375.0 28068.0 28744.0 28812.4 28832.7 28904.3 49223.5 49780.3 50104.0 50279.5 50328.0 305796.0 308107.0 308721.0 308778.0 309187.0 41849.4 42415.0 42634.1 42717.4 43084.4 45256.5 45879.0 46090.3 46141.3 46777.8 34889.1 35235.6 35998.8 36211.6 37252.8 36760.4 36811.6 37093.8 37324.6 37534.6 38228.4 38405.2 38639.8 38862.2 39221.8 28937.6 29670.0 30575.5 31966.2 32011.5 24129.5 24197.6 24332.6 24673.0 24749.4 14:28:34 INFO - PROCESS | 13241 | 14:28:34 INFO - PROCESS | 13241 | [#2] jquery.html Cycles:180 Average:27722.45 Median:28615.84 stddev:92401.21 (322.9%) stddev-sans-first:92637.55 14:28:34 INFO - PROCESS | 13241 | Values: 348.4 351.4 353.1 355.8 358.3 15619.9 15965.8 16795.8 16886.6 17644.1 10292.5 10312.8 11208.8 11468.1 11553.2 4939.1 5128.9 5151.1 5191.2 5398.5 5321.7 5323.0 5385.3 5390.9 5394.3 5012.4 5028.1 5215.7 5246.4 5385.9 5214.2 5221.7 5235.9 5246.0 5283.3 5344.9 5351.3 5351.5 5353.4 5357.9 12576.3 12828.1 12849.2 12885.5 12960.1 2004.9 2056.0 2076.1 2097.8 2178.8 9463.9 9494.1 9522.9 9641.6 9725.3 1736.1 1755.7 1762.8 1763.2 1773.6 51224.0 51255.7 52040.5 52586.7 54921.7 9354.0 9635.5 9657.7 9731.3 9857.7 13460.1 13550.7 13596.3 13607.9 13650.5 6841.5 6872.5 6891.2 6950.2 6985.8 6474.9 6506.6 6528.7 6559.3 6561.0 4246.3 4300.2 4371.1 4446.4 4465.0 1832.0 1848.0 1867.0 1872.8 1910.5 854.8 993.9 1051.4 1055.7 1068.9 15839.1 15893.4 16220.4 16484.8 16557.3 910.1 912.3 916.8 923.5 949.7 9439.6 9503.4 9508.1 9544.7 9629.0 524319.0 566179.0 572638.0 581136.0 581506.0 69469.0 72548.6 72692.0 72932.9 74898.3 1071.1 1074.6 1077.5 1108.0 1113.4 14559.6 14816.3 14836.9 14980.8 14982.2 30226.1 30867.5 33371.5 34646.3 35539.8 43650.6 43675.8 45296.5 45969.0 46692.0 9384.2 9754.3 9851.3 10003.6 10004.3 11321.8 11432.7 11659.5 11896.6 12030.8 6918.8 6926.0 7459.2 7474.2 7623.7 7612.5 7613.0 7643.5 7722.7 7735.8 7753.3 7831.4 7846.2 7859.5 7893.1 8869.3 9976.2 10089.6 10163.3 10192.7 8497.0 9023.7 9039.4 9060.9 9146.3 14:28:34 INFO - PROCESS | 13241 | 14:28:34 INFO - PROCESS | 13241 | [#3] mootools.html Cycles:180 Average:5346.87 Median:6105.36 stddev:2704.38 (44.3%) stddev-sans-first:2696.31 14:28:34 INFO - PROCESS | 13241 | Values: 1474.7 1488.3 1658.5 1801.5 1825.7 7270.0 7362.7 7397.5 7428.0 7620.2 7572.1 7699.3 7734.1 7737.4 7819.6 2306.3 2328.7 2330.2 2330.2 2337.6 2339.1 2339.2 2349.4 2362.0 2372.5 2259.4 2315.6 2319.0 2329.6 2344.0 2274.8 2313.5 2324.7 2330.2 2332.7 2297.2 2315.0 2317.3 2319.7 2331.6 7480.5 7564.1 7635.0 7644.4 7659.3 4686.1 4731.3 4736.4 4743.0 4806.1 2954.2 2968.1 3020.2 3033.7 3039.0 923.2 927.7 956.9 976.0 1015.9 10215.2 10277.5 10305.5 10314.5 10359.3 4258.4 4329.0 4333.8 4382.4 4398.1 8388.1 8476.1 8493.6 8501.1 8512.7 4745.5 4762.1 4765.6 4780.1 4802.7 4365.8 4412.1 4412.6 4421.9 4432.7 3358.2 3424.1 3430.8 3432.6 3464.1 990.0 992.3 1012.9 1065.8 1096.7 1317.8 1319.7 1342.4 1348.8 1352.8 7195.7 7244.6 7341.4 7347.8 7371.4 1133.1 1135.2 1143.6 1150.5 1159.5 5610.3 5706.8 5737.1 5739.3 5748.4 8662.0 8722.3 8801.6 9069.7 9108.0 8958.0 9008.4 9349.1 9375.8 9404.0 7220.1 7241.2 7256.6 7334.7 7412.2 6850.7 6851.3 7000.5 7065.5 7097.9 8184.0 8269.8 8284.1 8341.5 8406.2 8379.5 8561.4 8591.7 8603.1 8606.2 6492.7 6554.2 6756.5 6856.6 6866.0 7477.6 7515.4 7527.2 7529.8 7573.4 6647.3 6755.8 6849.3 6986.9 7108.7 6443.6 6497.7 6520.5 6603.4 6640.2 6549.1 6554.9 6596.5 6637.6 6644.1 6051.6 6089.3 6121.4 6124.6 6152.3 5907.0 6019.8 6029.0 6032.5 6036.2 14:28:34 INFO - PROCESS | 13241 | 14:28:34 INFO - PROCESS | 13241 | [#4] prototype.html Cycles:180 Average:5505.35 Median:6269.03 stddev:1694.35 (27.0%) stddev-sans-first:1654.15 14:28:34 INFO - PROCESS | 13241 | Values: 339.7 341.7 349.4 350.1 354.9 6037.8 6179.9 6230.4 6239.5 6275.4 5969.0 6056.5 6079.6 6093.8 6171.1 4682.5 4695.8 4700.4 4708.2 4714.3 4680.4 4693.7 4697.1 4706.0 4725.0 4463.5 4556.4 4614.8 4623.9 4664.4 4583.3 4596.4 4596.9 4618.8 4619.7 3949.1 3987.0 3998.5 4019.8 4051.8 5854.8 5870.9 5885.1 5891.1 5908.9 5445.6 5451.6 5461.9 5463.4 5463.5 6538.2 6580.5 6609.2 6615.4 6628.1 4327.2 4418.9 4437.4 4452.1 4453.6 6752.4 6816.4 6821.3 6859.8 6888.2 4540.0 4568.8 4581.9 4584.9 4590.8 4469.5 4627.5 4636.1 4643.0 4668.1 5365.7 5396.3 5406.8 5409.9 5422.2 6560.2 6581.8 6620.6 6636.6 6642.3 1650.6 1660.6 1662.2 1663.2 1664.0 1093.8 1094.2 1099.6 1119.4 1125.0 6313.5 6318.7 6346.9 6368.0 6368.4 6804.1 6813.9 6823.0 6824.8 6830.5 6186.3 6266.3 6271.8 6276.5 6285.9 3679.6 3700.5 3717.9 3727.7 3736.0 7013.2 7210.6 7213.6 7234.1 7260.1 6973.3 7002.6 7015.9 7017.4 7034.2 7030.4 7115.2 7177.8 7186.3 7226.4 6815.6 6833.9 6837.5 6842.9 6855.3 6763.2 6771.5 6773.2 6777.4 6785.3 7039.2 7161.5 7177.2 7187.4 7200.5 4639.4 4664.3 4675.1 4685.7 4691.1 6760.6 6832.6 6848.1 6855.4 6904.8 6499.3 6646.8 6652.5 6658.7 6673.1 6629.8 6635.9 6662.3 6662.8 6683.4 6534.0 6534.2 6542.0 6548.7 6573.6 6581.3 6660.6 6703.1 6707.0 6710.2 6549.4 6609.1 6613.1 6621.7 6622.3 14:28:34 INFO - PROCESS | 13241 | 14:28:34 INFO - PROCESS | 13241 | [#5] yui.html Cycles:180 Average:13546.74 Median:45308.27 stddev:15385.31 (34.0%) stddev-sans-first:15398.58 14:28:34 INFO - PROCESS | 13241 | Values: 775.8 795.4 809.1 812.7 823.8 13577.3 13706.4 13751.3 13753.1 13786.2 12743.2 12763.0 12821.8 12831.8 12912.8 817.7 817.8 825.2 835.0 839.6 820.6 823.6 830.3 830.4 830.6 854.5 857.1 861.5 865.2 865.3 842.3 856.4 861.4 864.3 866.0 624.4 628.4 632.5 632.6 633.3 13431.9 13482.6 13517.3 13526.4 13747.0 12609.4 12727.1 12798.5 12847.2 12877.7 10001.4 10033.3 10090.3 11081.3 11211.4 3657.2 3667.3 3683.5 3689.2 3762.7 43983.8 45331.8 45480.0 45537.3 45701.3 9629.2 9637.1 9792.9 9821.8 10135.5 17039.1 17691.1 17694.2 17702.6 17746.4 7147.2 7232.6 7294.2 7419.7 7441.3 3844.8 3890.7 3891.8 3907.6 3954.4 3129.7 3138.7 3145.6 3147.9 3172.1 540.1 550.3 553.7 572.6 584.8 498.4 506.6 532.5 636.0 643.3 8095.6 8678.7 8678.9 8758.7 8767.3 551.6 608.9 647.4 651.0 655.7 3915.6 4111.8 4164.7 4195.7 4254.5 55372.7 55955.0 56114.2 56268.0 56701.0 48499.3 50261.0 50889.7 51601.0 51877.5 41984.0 42386.4 42901.1 45284.8 46988.0 8634.3 8707.2 9023.1 9083.4 9128.2 33114.0 33452.5 34113.7 34230.3 34231.7 42922.0 43448.3 43690.6 43709.3 44148.1 11193.6 11254.4 11344.5 11361.5 11385.6 12760.0 13077.9 13078.6 13213.6 13230.5 11080.3 11133.8 11328.0 11482.2 11680.6 11268.8 11715.1 11717.3 11795.0 12108.8 10880.7 11168.8 11306.3 11565.2 11724.4 9217.7 9308.2 9329.8 9354.0 9479.8 8688.9 8755.8 9709.1 9868.0 9967.5 14:28:34 INFO - PROCESS | 13241 | -------- Summary: end -------- 14:28:34 INFO - PROCESS | 13241 | 14:28:35 INFO - TEST-INFO | 13241: exit 0 14:28:35 INFO - TEST-OK | dromaeo_css | took 1109860ms 14:28:35 INFO - TEST-START | kraken 14:28:35 INFO - operating with platform_type : linux_ 14:28:35 INFO - Initialising browser for kraken test... 14:28:35 INFO - TEST-INFO | started process 13488 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpU3g05v/profile http://localhost:43744/getInfo.html) 14:28:38 INFO - PROCESS | 13488 | 14:28:38 INFO - PROCESS | 13488 | (process:13558): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:28:39 INFO - PROCESS | 13488 | __metrics Screen width/height:1600/1200 14:28:39 INFO - PROCESS | 13488 | colorDepth:24 14:28:39 INFO - PROCESS | 13488 | Browser inner width/height: 1024/697 14:28:39 INFO - PROCESS | 13488 | __metrics 14:28:39 INFO - PROCESS | 13488 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:28:40 INFO - TEST-INFO | 13488: exit 0 14:28:40 INFO - Browser initialized. 14:28:40 INFO - Running cycle 1/1 for kraken test... 14:28:40 INFO - TEST-INFO | started process 13607 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpU3g05v/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:41 INFO - PROCESS | 13607 | -- checkerboarding starts below -- 14:28:41 INFO - PROCESS | 13607 | RENDERTRACE 0.060138 rect red 0 0 10 10 // viewport 14:28:41 INFO - PROCESS | 13607 | RENDERTRACE 34.53 rect brown 0 0 10 10 // page 14:28:41 INFO - PROCESS | 13607 | RENDERTRACE 34.5531 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 14:28:41 INFO - PROCESS | 13607 | Checkerboarded for 1 frames (35.4686 ms), 100 peak, 2 severity. 14:28:41 INFO - PROCESS | 13607 | 14:28:41 INFO - PROCESS | 13607 | (process:13668): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:28:52 INFO - PROCESS | 13607 | RSS: Main: 150417408 14:28:52 INFO - PROCESS | 13607 | 14:28:54 INFO - PROCESS | 13607 | Cycle 1(1): loaded http://localhost:43744/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43744/tests/kraken/driver.html?testName=audio-beat-detection) 14:28:55 INFO - PROCESS | 13607 | RSS: Main: 150708224 14:28:55 INFO - PROCESS | 13607 | 14:28:58 INFO - PROCESS | 13607 | Cycle 1(1): loaded http://localhost:43744/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43744/tests/kraken/driver.html?testName=audio-dft) 14:28:58 INFO - PROCESS | 13607 | RSS: Main: 154640384 14:28:58 INFO - PROCESS | 13607 | 14:29:01 INFO - PROCESS | 13607 | Cycle 1(1): loaded http://localhost:43744/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43744/tests/kraken/driver.html?testName=audio-fft) 14:29:02 INFO - PROCESS | 13607 | RSS: Main: 145866752 14:29:02 INFO - PROCESS | 13607 | 14:29:04 INFO - PROCESS | 13607 | Cycle 1(1): loaded http://localhost:43744/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43744/tests/kraken/driver.html?testName=audio-oscillator) 14:29:05 INFO - PROCESS | 13607 | RSS: Main: 147066880 14:29:05 INFO - PROCESS | 13607 | 14:29:07 INFO - PROCESS | 13607 | Cycle 1(1): loaded http://localhost:43744/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43744/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:29:07 INFO - PROCESS | 13607 | RSS: Main: 148680704 14:29:07 INFO - PROCESS | 13607 | 14:29:10 INFO - PROCESS | 13607 | Cycle 1(1): loaded http://localhost:43744/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43744/tests/kraken/driver.html?testName=imaging-darkroom) 14:29:11 INFO - PROCESS | 13607 | RSS: Main: 146788352 14:29:11 INFO - PROCESS | 13607 | 14:29:14 INFO - PROCESS | 13607 | Cycle 1(1): loaded http://localhost:43744/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43744/tests/kraken/driver.html?testName=imaging-desaturate) 14:29:15 INFO - PROCESS | 13607 | RSS: Main: 148238336 14:29:15 INFO - PROCESS | 13607 | 14:29:18 INFO - PROCESS | 13607 | Cycle 1(1): loaded http://localhost:43744/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43744/tests/kraken/driver.html?testName=json-parse-financial) 14:29:18 INFO - PROCESS | 13607 | RSS: Main: 150241280 14:29:18 INFO - PROCESS | 13607 | 14:29:20 INFO - PROCESS | 13607 | Cycle 1(1): loaded http://localhost:43744/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43744/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:29:21 INFO - PROCESS | 13607 | RSS: Main: 148762624 14:29:21 INFO - PROCESS | 13607 | 14:29:22 INFO - PROCESS | 13607 | Cycle 1(1): loaded http://localhost:43744/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43744/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:29:23 INFO - PROCESS | 13607 | RSS: Main: 150876160 14:29:23 INFO - PROCESS | 13607 | 14:29:25 INFO - PROCESS | 13607 | Cycle 1(1): loaded http://localhost:43744/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43744/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:29:26 INFO - PROCESS | 13607 | RSS: Main: 150978560 14:29:26 INFO - PROCESS | 13607 | 14:29:28 INFO - PROCESS | 13607 | Cycle 1(1): loaded http://localhost:43744/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43744/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:29:29 INFO - PROCESS | 13607 | RSS: Main: 149250048 14:29:29 INFO - PROCESS | 13607 | 14:29:31 INFO - PROCESS | 13607 | Cycle 1(1): loaded http://localhost:43744/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43744/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:29:32 INFO - PROCESS | 13607 | RSS: Main: 150409216 14:29:32 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | Cycle 1(1): loaded http://localhost:43744/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43744/tests/kraken/driver.html?testName=ai-astar) 14:29:34 INFO - PROCESS | 13607 | RSS: Main: 151310336 14:29:34 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | __start_tp_report 14:29:34 INFO - PROCESS | 13607 | _x_x_mozilla_page_load 14:29:34 INFO - PROCESS | 13607 | _x_x_mozilla_page_load_details 14:29:34 INFO - PROCESS | 13607 | |i|pagename|runs| 14:29:34 INFO - PROCESS | 13607 | |0;ai-astar;114;109;115;110;113;123;112;110;112;111 14:29:34 INFO - PROCESS | 13607 | |1;audio-beat-detection;152;126;147;164;130;154;155;136;167;128 14:29:34 INFO - PROCESS | 13607 | |2;audio-dft;162;162;162;164;163;162;166;168;164;163 14:29:34 INFO - PROCESS | 13607 | |3;audio-fft;75;73;85;75;74;129;72;74;73;72 14:29:34 INFO - PROCESS | 13607 | |4;audio-oscillator;97;96;142;97;96;97;142;97;96;146 14:29:34 INFO - PROCESS | 13607 | |5;imaging-gaussian-blur;110;109;110;110;109;110;110;110;109;110 14:29:34 INFO - PROCESS | 13607 | |6;imaging-darkroom;146;147;147;146;147;146;147;145;146;146 14:29:34 INFO - PROCESS | 13607 | |7;imaging-desaturate;97;96;96;98;97;97;96;97;96;96 14:29:34 INFO - PROCESS | 13607 | |8;json-parse-financial;61;62;59;60;60;65;72;60;78;58 14:29:34 INFO - PROCESS | 13607 | |9;json-stringify-tinderbox;68;69;68;69;68;69;68;68;71;69 14:29:34 INFO - PROCESS | 13607 | |10;stanford-crypto-aes;80;81;82;83;85;82;83;86;85;90 14:29:34 INFO - PROCESS | 13607 | |11;stanford-crypto-ccm;118;123;119;130;118;128;119;115;129;129 14:29:34 INFO - PROCESS | 13607 | |12;stanford-crypto-pbkdf2;133;144;135;144;147;132;154;143;148;143 14:29:34 INFO - PROCESS | 13607 | |13;stanford-crypto-sha256-iterative;68;65;66;69;70;68;67;65;66;69 14:29:34 INFO - PROCESS | 13607 | __end_tp_report 14:29:34 INFO - PROCESS | 13607 | __start_cc_report 14:29:34 INFO - PROCESS | 13607 | _x_x_mozilla_cycle_collect,750 14:29:34 INFO - PROCESS | 13607 | __end_cc_report 14:29:34 INFO - PROCESS | 13607 | __startTimestamp1453242574273__endTimestamp 14:29:34 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | ------- Summary: start ------- 14:29:34 INFO - PROCESS | 13607 | Number of tests: 14 14:29:34 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | [#0] ai-astar Cycles:10 Average:112.90 Median:112.50 stddev:4.01 (3.6%) stddev-sans-first:4.24 14:29:34 INFO - PROCESS | 13607 | Values: 114.0 109.0 115.0 110.0 113.0 123.0 112.0 110.0 112.0 111.0 14:29:34 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:153.00 stddev:15.01 (9.8%) stddev-sans-first:15.75 14:29:34 INFO - PROCESS | 13607 | Values: 152.0 126.0 147.0 164.0 130.0 154.0 155.0 136.0 167.0 128.0 14:29:34 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.01 (1.2%) stddev-sans-first:2.05 14:29:34 INFO - PROCESS | 13607 | Values: 162.0 162.0 162.0 164.0 163.0 162.0 166.0 168.0 164.0 163.0 14:29:34 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | [#3] audio-fft Cycles:10 Average:80.20 Median:74.00 stddev:17.55 (23.7%) stddev-sans-first:18.52 14:29:34 INFO - PROCESS | 13607 | Values: 75.0 73.0 85.0 75.0 74.0 129.0 72.0 74.0 73.0 72.0 14:29:34 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:96.50 stddev:22.62 (23.4%) stddev-sans-first:23.45 14:29:34 INFO - PROCESS | 13607 | Values: 97.0 96.0 142.0 97.0 96.0 97.0 142.0 97.0 96.0 146.0 14:29:34 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:29:34 INFO - PROCESS | 13607 | Values: 110.0 109.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 110.0 14:29:34 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 14:29:34 INFO - PROCESS | 13607 | Values: 146.0 147.0 147.0 146.0 147.0 146.0 147.0 145.0 146.0 146.0 14:29:34 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 14:29:34 INFO - PROCESS | 13607 | Values: 97.0 96.0 96.0 98.0 97.0 97.0 96.0 97.0 96.0 96.0 14:29:34 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:61.50 stddev:6.50 (10.6%) stddev-sans-first:6.83 14:29:34 INFO - PROCESS | 13607 | Values: 61.0 62.0 59.0 60.0 60.0 65.0 72.0 60.0 78.0 58.0 14:29:34 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 14:29:34 INFO - PROCESS | 13607 | Values: 68.0 69.0 68.0 69.0 68.0 69.0 68.0 68.0 71.0 69.0 14:29:34 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:2.91 (3.5%) stddev-sans-first:2.76 14:29:34 INFO - PROCESS | 13607 | Values: 80.0 81.0 82.0 83.0 85.0 82.0 83.0 86.0 85.0 90.0 14:29:34 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:125.50 stddev:5.69 (4.5%) stddev-sans-first:5.77 14:29:34 INFO - PROCESS | 13607 | Values: 118.0 123.0 119.0 130.0 118.0 128.0 119.0 115.0 129.0 129.0 14:29:34 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:144.00 stddev:7.02 (4.9%) stddev-sans-first:6.60 14:29:34 INFO - PROCESS | 13607 | Values: 133.0 144.0 135.0 144.0 147.0 132.0 154.0 143.0 148.0 143.0 14:29:34 INFO - PROCESS | 13607 | 14:29:34 INFO - PROCESS | 13607 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.77 (2.6%) stddev-sans-first:1.86 14:29:34 INFO - PROCESS | 13607 | Values: 68.0 65.0 66.0 69.0 70.0 68.0 67.0 65.0 66.0 69.0 14:29:34 INFO - PROCESS | 13607 | -------- Summary: end -------- 14:29:34 INFO - PROCESS | 13607 | 14:29:35 INFO - TEST-INFO | 13607: exit 0 14:29:35 INFO - TEST-OK | kraken | took 59938ms 14:29:35 INFO - TEST-START | v8_7 14:29:35 INFO - operating with platform_type : linux_ 14:29:35 INFO - Initialising browser for v8_7 test... 14:29:35 INFO - TEST-INFO | started process 13897 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFp1rKU/profile http://localhost:43744/getInfo.html) 14:29:38 INFO - PROCESS | 13897 | -- checkerboarding starts below -- 14:29:38 INFO - PROCESS | 13897 | RENDERTRACE 0.037043 rect red 0 0 1024 768 // viewport 14:29:38 INFO - PROCESS | 13897 | RENDERTRACE 267.72 rect brown 0 0 1024 768 // page 14:29:38 INFO - PROCESS | 13897 | RENDERTRACE 267.752 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 14:29:38 INFO - PROCESS | 13897 | Checkerboarded for 1 frames (283.539 ms), 786432 peak, 11608 severity. 14:29:38 INFO - PROCESS | 13897 | 14:29:38 INFO - PROCESS | 13897 | (process:13967): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:29:39 INFO - PROCESS | 13897 | __metrics Screen width/height:1600/1200 14:29:39 INFO - PROCESS | 13897 | colorDepth:24 14:29:39 INFO - PROCESS | 13897 | Browser inner width/height: 1024/697 14:29:39 INFO - PROCESS | 13897 | __metrics 14:29:39 INFO - PROCESS | 13897 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:29:40 INFO - TEST-INFO | 13897: exit 0 14:29:40 INFO - Browser initialized. 14:29:40 INFO - Running cycle 1/1 for v8_7 test... 14:29:40 INFO - TEST-INFO | started process 14017 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFp1rKU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:29:41 INFO - PROCESS | 14017 | -- checkerboarding starts below -- 14:29:41 INFO - PROCESS | 14017 | RENDERTRACE 0.040768 rect red 0 0 10 10 // viewport 14:29:41 INFO - PROCESS | 14017 | RENDERTRACE 29.8424 rect brown 0 0 10 10 // page 14:29:41 INFO - PROCESS | 14017 | RENDERTRACE 29.8633 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 14:29:41 INFO - PROCESS | 14017 | Checkerboarded for 1 frames (29.9335 ms), 100 peak, 1 severity. 14:29:41 INFO - PROCESS | 14017 | 14:29:41 INFO - PROCESS | 14017 | (process:14075): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:29:52 INFO - PROCESS | 14017 | RSS: Main: 150740992 14:29:52 INFO - PROCESS | 14017 | 14:30:14 INFO - PROCESS | 14017 | Cycle 1(1): loaded http://localhost:43744/tests/v8_7/run.html (next: http://localhost:43744/tests/v8_7/run.html) 14:30:14 INFO - PROCESS | 14017 | RSS: Main: 147152896 14:30:14 INFO - PROCESS | 14017 | 14:30:14 INFO - PROCESS | 14017 | __start_tp_report 14:30:14 INFO - PROCESS | 14017 | _x_x_mozilla_page_load 14:30:14 INFO - PROCESS | 14017 | _x_x_mozilla_page_load_details 14:30:14 INFO - PROCESS | 14017 | |i|pagename|runs| 14:30:14 INFO - PROCESS | 14017 | |0;Richards;170.7067258449983 14:30:14 INFO - PROCESS | 14017 | |1;DeltaBlue;188.040616773223 14:30:14 INFO - PROCESS | 14017 | |2;Encrypt;279.72027972027973 14:30:14 INFO - PROCESS | 14017 | |3;Decrypt;5246.073298429319 14:30:14 INFO - PROCESS | 14017 | |4;RayTrace;1070.6638115631692 14:30:14 INFO - PROCESS | 14017 | |5;Earley;758.1501137225171 14:30:14 INFO - PROCESS | 14017 | |6;Boyer;12370.37037037037 14:30:14 INFO - PROCESS | 14017 | |7;RegExp;40760 14:30:14 INFO - PROCESS | 14017 | |8;Splay;587.8894767783656 14:30:14 INFO - PROCESS | 14017 | |9;NavierStokes;4830.917874396136 14:30:14 INFO - PROCESS | 14017 | __end_tp_report 14:30:14 INFO - PROCESS | 14017 | __startTimestamp1453242614776__endTimestamp 14:30:14 INFO - PROCESS | 14017 | 14:30:14 INFO - PROCESS | 14017 | ------- Summary: start ------- 14:30:14 INFO - PROCESS | 14017 | Number of tests: 10 14:30:14 INFO - PROCESS | 14017 | 14:30:14 INFO - PROCESS | 14017 | [#0] Richards Cycles:1 Average:170.71 Median:170.71 stddev:0.00 (0.0%) 14:30:14 INFO - PROCESS | 14017 | Values: 170.7 14:30:14 INFO - PROCESS | 14017 | 14:30:14 INFO - PROCESS | 14017 | [#1] DeltaBlue Cycles:1 Average:188.04 Median:188.04 stddev:0.00 (0.0%) 14:30:14 INFO - PROCESS | 14017 | Values: 188.0 14:30:14 INFO - PROCESS | 14017 | 14:30:14 INFO - PROCESS | 14017 | [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 14:30:14 INFO - PROCESS | 14017 | Values: 279.7 14:30:14 INFO - PROCESS | 14017 | 14:30:14 INFO - PROCESS | 14017 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 14:30:14 INFO - PROCESS | 14017 | Values: 5246.1 14:30:14 INFO - PROCESS | 14017 | 14:30:14 INFO - PROCESS | 14017 | [#4] RayTrace Cycles:1 Average:1070.66 Median:1070.66 stddev:0.00 (0.0%) 14:30:14 INFO - PROCESS | 14017 | Values: 1070.7 14:30:14 INFO - PROCESS | 14017 | 14:30:14 INFO - PROCESS | 14017 | [#5] Earley Cycles:1 Average:758.15 Median:758.15 stddev:0.00 (0.0%) 14:30:14 INFO - PROCESS | 14017 | Values: 758.2 14:30:14 INFO - PROCESS | 14017 | 14:30:14 INFO - PROCESS | 14017 | [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 14:30:14 INFO - PROCESS | 14017 | Values: 12370.4 14:30:14 INFO - PROCESS | 14017 | 14:30:14 INFO - PROCESS | 14017 | [#7] RegExp Cycles:1 Average:40760.00 Median:40760.00 stddev:0.00 (0.0%) 14:30:14 INFO - PROCESS | 14017 | Values: 40760.0 14:30:14 INFO - PROCESS | 14017 | 14:30:14 INFO - PROCESS | 14017 | [#8] Splay Cycles:1 Average:587.89 Median:587.89 stddev:0.00 (0.0%) 14:30:14 INFO - PROCESS | 14017 | Values: 587.9 14:30:14 INFO - PROCESS | 14017 | 14:30:14 INFO - PROCESS | 14017 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 14:30:14 INFO - PROCESS | 14017 | Values: 4830.9 14:30:14 INFO - PROCESS | 14017 | -------- Summary: end -------- 14:30:14 INFO - PROCESS | 14017 | 14:30:15 INFO - TEST-INFO | 14017: exit 0 14:30:15 INFO - TEST-OK | v8_7 | took 40294ms 14:30:15 INFO - SUITE-END | took 1210s 14:30:15 INFO - Completed test suite (00:20:10) 14:30:15 INFO - Working with test: dromaeo_css 14:30:15 INFO - Generating results file: dromaeo_css 14:30:15 INFO - Working with test: kraken 14:30:15 INFO - Generating results file: kraken 14:30:15 INFO - javascript benchmark 14:30:15 INFO - Working with test: v8_7 14:30:15 INFO - Generating results file: v8_7 14:30:15 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:30:15 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 14:30:15 INFO - process_Request line: dromaeo_css 6822.44 graph.html#tests=[[72,64,43]] 14:30:15 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:30:15 INFO - process_Request line: kraken 1514.10 graph.html#tests=[[232,64,43]] 14:30:15 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:30:16 INFO - process_Request line: v8_7 20241.39 graph.html#tests=[[230,64,43]] 14:30:16 INFO - RETURN: dromaeo_css: 6822.44 14:30:16 INFO - RETURN: kraken: 1514.10 14:30:16 INFO - RETURN: v8_7: 20241.39 14:30:16 INFO - javascript benchmark 14:30:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3173.190836336734, 3177.8411079446037, 3203.5034569641684, 3219.1308346746378, 3231.3537292541496, 5142.331496905397, 5142.382914050315, 5180.274761533388, 5197.8700532486655, 5231.738413079341, 5030.320906677597, 5243.292155558998, 5252.212168174776, 5281.339832520935, 5288.0, 4705.694129881564, 4716.976415117928, 4734.763261836894, 4808.591269742076, 4840.177169881111, 4496.685232033759, 4770.809167633291, 4786.928196077044, 4801.008857290393, 4884.633652476061, 4644.930326045112, 4678.789454474557, 4714.669973101884, 4727.101850648401, 4768.713877167381, 4763.261694437368, 4764.499727528629, 4773.618110551148, 4784.856454306341, 4813.109574728686, 4681.133990211822, 4748.5014073522125, 4761.119192949315, 4761.928571071437, 4793.71237725734, 5097.260897169889, 5115.667481613683, 5132.974335128338, 5135.871603209912, 5136.5377116059735, 5610.158476228557, 5615.326160860682, 5637.971810140964, 5639.774409023634, 5655.0386434306265, 5540.972295138539, 5628.212050312918, 5669.036263835158, 5684.090545512699, 5755.827325180251, 5214.243934629458, 5224.712640804754, 5242.764075616568, 5250.789968401221, 5292.417834038252, 5757.309122905278, 5765.221695071112, 5765.4522820332, 5787.450192231731, 5795.681237531892, 5377.865553361119, 5447.319085114361, 5556.833295001156, 5574.303212098488, 5612.691301978349, 5692.288463942007, 5716.942830571641, 5718.228039214653, 5718.828435146952, 5759.913601295984, 5621.381648018714, 5654.37801841797, 5664.405237450091, 5668.801591944345, 5678.545716342765, 5419.132938729785, 5520.337559492887, 5564.693941833157, 5663.575231857627, 5684.118961560965, 4322.827086916488, 4346.630536404377, 4348.478182618042, 4375.081232941055, 4407.6914615976575, 3931.017245688578, 3941.8226179821977, 3952.8418863245724, 3978.264021156095, 3987.521497420328, 5194.68831870089, 5275.762590683352, 5288.603354748409, 5304.257403963448, 5348.893022139536, 5601.943980560224, 5648.293963254593, 5660.971695141498, 5663.490285874209, 5690.715464226772, 5326.46735326472, 5328.200769884471, 5337.466253374631, 5346.625736198506, 5381.273528073738, 4709.646776491777, 4767.594754445841, 4769.2369220925175, 4770.570648641639, 4772.260299653559, 5868.295804503487, 5891.9705401473575, 5900.734466948998, 5915.645061296336, 5953.851153721192, 5653.321601407857, 5660.122680984454, 5669.744861481326, 5678.403767604342, 5681.431856814285, 5744.3394009687745, 5776.018076926848, 5843.883122337445, 5915.970420148044, 5984.820455386345, 5511.807086751945, 5515.834524964257, 5518.227448157341, 5518.2826232589505, 5572.721363931706, 5595.04884169684, 5609.579281553818, 5614.1017437211485, 5624.57815663835, 5642.0, 5423.29497165366, 5473.0969390050195, 5526.861828454321, 5539.390667026543, 5550.611457197957, 5502.80740174092, 5526.0, 5535.059039963136, 5537.058700021086, 5540.529055030368, 5399.217113518596, 5446.101393270224, 5447.891042179213, 5472.315960504937, 5526.419725928719, 5312.362516498045, 5328.7602057906715, 5533.529649979797, 5586.413426590149, 5659.9151012735665, 5401.270828438111, 5416.377116631637, 5470.671759694431, 5472.562195024469, 5488.396276409671], "unit": "score", "name": "dojo.html", "value": 5193.015077454043}, {"lowerIsBetter": false, "replicates": [536.5868281423304, 548.0929062401724, 568.9971550142249, 571.3258355140937, 571.3431049955129, 35115.47326790097, 36403.63596364039, 36484.45273320902, 36490.27019459616, 36509.817450912706, 39024.0, 39731.60268397322, 39789.801050994705, 39882.20235595286, 39974.60025399745, 8443.324534037278, 8533.530655813927, 8594.398392112524, 8600.0, 8606.139386061406, 8336.0, 8471.0, 8489.066202717697, 8606.053334133241, 8642.178992995656, 8588.269997050258, 8620.396572239946, 8646.265067469272, 8663.870041949376, 8703.912960870373, 8583.399162058658, 8664.566771661392, 8667.0, 8670.436421632605, 8684.218420342137, 8327.292180164693, 8383.11977242393, 8434.072252052269, 8434.493930364199, 8441.535715535643, 38859.22281554353, 39326.21347573033, 39362.0, 39416.0, 39511.0, 3274.4106060909025, 3293.670632936711, 3313.884014059496, 3360.6807353301397, 3603.549556305462, 29658.851705741334, 30191.547126793117, 30311.24221894448, 30554.236144096354, 30602.387952241053, 3269.444194486919, 3287.935135027782, 3320.7841490303053, 3321.684439978198, 3452.6349450626403, 246929.18424894565, 247283.0, 247761.0, 248707.0, 249455.0, 41060.58939410568, 41410.79294603508, 41959.580404196175, 55491.16763248554, 55693.0, 41227.0, 41237.79381103075, 41401.1719765609, 41413.37879931804, 41499.377509337384, 13666.52167174144, 13690.178589284675, 13744.312784360942, 13778.242196679279, 13789.724205515833, 10461.320014199053, 10510.73723156912, 10527.84208236877, 10542.314749541256, 10557.366558006544, 14445.494407695891, 14459.27703614815, 14517.201553914636, 14575.125492470486, 14584.708305833823, 5886.381929897385, 5934.851628709231, 5985.845095765521, 6014.548908831767, 6093.299270583851, 971.4656938683696, 973.4062222044547, 1030.175859312562, 1045.1429827541342, 1134.5121597713062, 28440.28899277493, 28975.13074607765, 30966.22584435407, 31598.684013160033, 32278.35443291168, 1007.7631756537207, 1026.5021464589668, 1036.3056751976194, 1054.7257712994524, 1120.8598925134359, 14809.48166814178, 15040.0, 15074.472393466396, 15101.546953591409, 15122.39510419571, 380299.0, 381175.0, 382819.0, 384357.0, 384685.0, 52789.0, 52886.20670689943, 53325.73337133289, 53357.46642533525, 53478.73260633672, 1306.353355089218, 1306.9607911762662, 1369.9863001369858, 1374.113696665665, 1374.9587512374644, 28068.0, 28744.0, 28812.42375152527, 28832.711672883004, 28904.277393065342, 49223.50776492333, 49780.253296201314, 50104.0, 50279.49720502894, 50328.0, 305796.0, 308107.0, 308721.0, 308778.0, 309187.0, 41849.372259415526, 42415.0, 42634.14731705286, 42717.35923961205, 43084.35373469463, 45256.54743452524, 45879.0, 46090.30864537102, 46141.30788038115, 46777.76611116923, 34889.12607607091, 35235.64764352324, 35998.820005899805, 36211.637883620824, 37252.813735931144, 36760.44859327059, 36811.63188368189, 37093.81453092717, 37324.62675373212, 37534.62465375311, 38228.42657360197, 38405.23189536249, 38639.80680096582, 38862.2227555453, 39221.803890980365, 28937.56593651055, 29670.0, 30575.541366879068, 31966.200844979063, 32011.519827203076, 24129.51740965136, 24197.637035444834, 24332.635010474503, 24673.0, 24749.381265468506], "unit": "score", "name": "ext.html", "value": 17931.741374215446}, {"lowerIsBetter": false, "replicates": [348.37814501115514, 351.37630705497736, 353.13658105930995, 355.8292019830483, 358.27985748645233, 15619.921900390496, 15965.84034159658, 16795.83204167958, 16886.57783555412, 17644.11779411031, 10292.536835842386, 10312.793744125112, 11208.831867521994, 11468.082553395729, 11553.249038812472, 4939.086269040221, 5128.8974220515565, 5151.072806894757, 5191.195364718475, 5398.4871437213405, 5321.654092483996, 5323.0152421801895, 5385.272988146608, 5390.946090539083, 5394.271773310592, 5012.398512178544, 5028.145215313387, 5215.713135777531, 5246.42607217835, 5385.946140538584, 5214.191800270964, 5221.738913054332, 5235.947640523622, 5245.973770131144, 5283.260343551906, 5344.91982620261, 5351.277577527062, 5351.518363347279, 5353.357597088336, 5357.919631205535, 12576.308303043328, 12828.102032857703, 12849.229046257255, 12885.484580616763, 12960.092793504458, 2004.8997550122435, 2055.98972005139, 2076.0761461149796, 2097.832173426122, 2178.7712290209456, 9463.905360946372, 9494.145526902612, 9522.904770952271, 9641.566129524188, 9725.270604704605, 1736.0712019069863, 1755.6525938945554, 1762.7884653841493, 1763.1801212436278, 1773.556610847288, 51224.0, 51255.74372128153, 52040.47959520394, 52586.7370663148, 54921.725391373184, 9353.953230233805, 9635.470049147223, 9657.661981830603, 9731.318807683394, 9857.654982075735, 13460.057795954384, 13550.728985420434, 13596.25220612856, 13607.863921360859, 13650.453981840616, 6841.486888483284, 6872.518923675395, 6891.241963384024, 6950.200726916368, 6985.755498557526, 6474.935250647527, 6506.60960342381, 6528.738850446024, 6559.278479367265, 6561.015847622799, 4246.278132717445, 4300.204462174508, 4371.125774845043, 4446.3552784846015, 4464.977675111603, 1831.9633607327778, 1847.990760046191, 1866.9626607467774, 1872.8127187281164, 1910.503269150031, 854.7734850264685, 993.8509223616516, 1051.374432212832, 1055.6885718712845, 1068.941208233539, 15839.128847913475, 15893.364265429253, 16220.432284869972, 16484.752728709078, 16557.337706491606, 910.1080940678172, 912.2792993535165, 916.8395530782086, 923.4874644572193, 949.7293271417751, 9439.622415103318, 9503.382280151767, 9508.144267016001, 9544.665936692183, 9628.951855240679, 524319.0, 566179.0, 572638.0, 581136.0, 581506.0, 69469.0, 72548.63725681443, 72692.0, 72932.89469737174, 74898.25101749021, 1071.0574694268994, 1074.6292529077455, 1077.5258886090096, 1108.0415440643947, 1113.3932007056173, 14559.636009099857, 14816.333265003317, 14836.851631483547, 14980.775288370465, 14982.175980321186, 30226.093217203517, 30867.536986945663, 33371.49942750812, 34646.30707385889, 35539.82230088833, 43650.56349436592, 43675.78162109169, 45296.547034529234, 45969.0, 46692.0, 9384.202342800665, 9754.268429867647, 9851.310408271638, 10003.649872254437, 10004.325496064712, 11321.830172547583, 11432.657020289405, 11659.53361865516, 11896.643100706993, 12030.75938481208, 6918.792436226921, 6926.0, 7459.216782238004, 7474.215207403145, 7623.733169339046, 7612.505187162817, 7612.961935190288, 7643.541387516544, 7722.652480638497, 7735.806604834699, 7753.302202801775, 7831.412644051833, 7846.215378462108, 7859.4891332063235, 7893.052833659997, 8869.290456763314, 9976.20190384782, 10089.596416143271, 10163.339382940085, 10192.694219173436, 8496.95751521263, 9023.729288121367, 9039.367244292836, 9060.864087038832, 9146.268298535968], "unit": "score", "name": "jquery.html", "value": 7873.081745410535}, {"lowerIsBetter": false, "replicates": [1474.69768697417, 1488.2707473338064, 1658.469289827255, 1801.4775715042638, 1825.7352683860831, 7269.963650181749, 7362.705491780336, 7397.519161254521, 7428.0343555337795, 7620.237976202377, 7572.091349038109, 7699.345555627779, 7734.071911370644, 7737.419693522994, 7819.648115834787, 2306.296579543243, 2328.6739856420113, 2330.2193765088714, 2330.2310237621546, 2337.590921588715, 2339.1345202275184, 2339.2280547419396, 2349.4243910242017, 2362.0, 2372.4543355028354, 2259.435141214696, 2315.641075633271, 2319.0, 2329.6272596384583, 2343.95312093758, 2274.80664143548, 2313.456337760625, 2324.6861673674093, 2330.207729372005, 2332.6617640442128, 2297.1959814065112, 2314.9768502315096, 2317.3279748872806, 2319.652052192168, 2331.5803155432013, 7480.513766605153, 7564.092308922909, 7635.0, 7644.388448924073, 7659.348955338803, 4686.133065382915, 4731.313959475891, 4736.407949006374, 4742.9525704742855, 4806.0628177505405, 2954.2466670998756, 2968.1095671298526, 3020.154356780083, 3033.7421319187674, 3039.0, 923.1968187676697, 927.7031349968013, 956.9186619137382, 975.990240097597, 1015.9492025398774, 10215.182785377227, 10277.48612569376, 10305.484725763681, 10314.48427578618, 10359.27485076045, 4258.361245813153, 4329.0259691569145, 4333.826646934151, 4382.408374869352, 4398.098389830077, 8388.07731149573, 8476.110008449148, 8493.617787199591, 8501.107383724744, 8512.659493620185, 4745.525447455227, 4762.095201911626, 4765.571098601143, 4780.11567859947, 4802.6638135330195, 4365.825366985348, 4412.139632771578, 4412.558744125626, 4421.867343979621, 4432.711873728197, 3358.1940334320075, 3424.126847653832, 3430.8456119474686, 3432.622411534729, 3464.133966508373, 990.029770824596, 992.3252188511736, 1012.9493525323704, 1065.7708592652616, 1096.6655170173015, 1317.7693903566837, 1319.729455461628, 1342.4428862022346, 1348.8179095821938, 1352.75650382932, 7195.748148814766, 7244.637768111574, 7341.412686985029, 7347.8163045924275, 7371.447141464411, 1133.0935251798528, 1135.2450620337547, 1143.5654451308449, 1150.511032811052, 1159.4840296068337, 5610.326760788732, 5706.82879513607, 5737.139429085671, 5739.311282646026, 5748.425157484218, 8662.003869555081, 8722.258608018263, 8801.559922003875, 9069.682561110329, 9108.043655416219, 8958.0, 9008.41445306066, 9349.065093490597, 9375.812483750287, 9404.0, 7220.0613920190035, 7241.203467618558, 7256.637168141572, 7334.66993985272, 7412.18465968743, 6850.725970961305, 6851.3491218334175, 7000.544964577286, 7065.540739851893, 7097.9290207097265, 8184.0, 8269.83460330802, 8284.08875023759, 8341.45780524264, 8406.243438090602, 8379.45533540318, 8561.400701950804, 8591.699290525052, 8603.053664096818, 8606.225439710455, 6492.740290388331, 6554.246261679968, 6756.479792046946, 6856.588604683735, 6865.965670171618, 7477.626118694152, 7515.398768098648, 7527.1720110788865, 7529.8494030118, 7573.431992600687, 6647.335266473314, 6755.763548275787, 6849.31506849331, 6986.895196571953, 7108.680109395193, 6443.613383197023, 6497.740090396331, 6520.478361731145, 6603.372679595431, 6640.203175618956, 6549.148610680581, 6554.868902621825, 6596.5052621052655, 6637.6349300788925, 6644.103046088716, 6051.606645568024, 6089.269287685506, 6121.4490695837585, 6124.601900876607, 6152.261728592419, 5907.0, 6019.759209631741, 6028.969855150696, 6032.4570788629235, 6036.185115009594], "unit": "score", "name": "mootools.html", "value": 4434.481448904988}, {"lowerIsBetter": false, "replicates": [339.6891843962774, 341.6941837055835, 349.40426572693553, 350.1386588991082, 354.90772399176205, 6037.788677396292, 6179.938200617992, 6230.439260466557, 6239.5008399328, 6275.403836635518, 5969.0, 6056.4851987581, 6079.574429789916, 6093.756249750005, 6171.074338849175, 4682.531746825307, 4695.812167513295, 4700.388949436586, 4708.246680531116, 4714.339992401066, 4680.368150299717, 4693.694909830867, 4697.06058788242, 4706.0, 4724.97637511812, 4463.486699029604, 4556.384888040122, 4614.838480653178, 4623.8844028899375, 4664.370310008157, 4583.312503124558, 4596.425446819131, 4596.862094137181, 4618.769061546909, 4619.74591397473, 3949.0917089069676, 3986.980065099685, 3998.540167880702, 4019.8191081401405, 4051.817668204938, 5854.795082172146, 5870.941290587082, 5885.087811389199, 5891.05743081105, 5908.852278693024, 5445.646033007882, 5451.574049547953, 5461.863453413656, 5463.371712253102, 5463.453654634544, 6538.150040494753, 6580.506462015368, 6609.239937407212, 6615.437687796495, 6628.105205797204, 4327.156204540116, 4418.933715994231, 4437.356583295436, 4452.109578084396, 4453.599176074136, 6752.426043786284, 6816.420604248645, 6821.317868213188, 6859.759908403182, 6888.207856096513, 4539.954600453953, 4568.817247310137, 4581.885452863705, 4584.908301833944, 4590.793414296365, 4469.4636643602325, 4627.537246275346, 4636.142313671981, 4643.048175124091, 4668.089722504079, 5365.678059316376, 5396.271503347077, 5406.756695948613, 5409.864753381118, 5422.186671999231, 6560.179977502812, 6581.835454113685, 6620.569662971891, 6636.601803891782, 6642.302558231413, 1650.5873531617096, 1660.618057846702, 1662.1606088925016, 1663.2349119404967, 1664.0431751742797, 1093.786711591248, 1094.2121672395863, 1099.5766629847406, 1119.361963680694, 1125.009991207732, 6313.463355614732, 6318.684065796691, 6346.936530634727, 6367.968160159169, 6368.363163683594, 6804.08144900442, 6813.897791533131, 6822.965885170642, 6824.7952561423235, 6830.521863469509, 6186.319504854462, 6266.279377871603, 6271.78048768291, 6276.529260305495, 6285.9057114143325, 3679.5952445231005, 3700.4634328022285, 3717.9442308365396, 3727.7390582659496, 3736.0286325555553, 7013.228544860061, 7210.567365958059, 7213.567185968858, 7234.131904171428, 7260.056192694916, 6973.3375329343635, 7002.614856182857, 7015.859682806417, 7017.438604911595, 7034.2262351141335, 7030.367266945999, 7115.217326094125, 7177.820554486179, 7186.317299856505, 7226.385757210696, 6815.625140617313, 6833.863322733418, 6837.453003759588, 6842.863142737017, 6855.314468553105, 6763.154605674291, 6771.52599318043, 6773.221079575912, 6777.423918966746, 6785.2536221016635, 7039.225685174524, 7161.534500257467, 7177.2463891292755, 7187.353138217585, 7200.49596528238, 4639.35049093134, 4664.253719405015, 4675.13510000651, 4685.695429797052, 4691.061787642417, 6760.628165450948, 6832.555883867532, 6848.14398200225, 6855.383015528626, 6904.792856214322, 6499.252585952487, 6646.767363142267, 6652.501062420241, 6658.700358483783, 6673.099131617169, 6629.834254143685, 6635.933640663531, 6662.333766623299, 6662.766803161866, 6683.43190828785, 6533.967330163318, 6534.183227096613, 6542.018697195459, 6548.738050477928, 6573.605583664996, 6581.3418658133805, 6660.6336651484635, 6703.095082164041, 6707.0, 6710.194776626836, 6549.410553050248, 6609.074729537772, 6613.074169616354, 6621.668916554249, 6622.337766223339], "unit": "score", "name": "prototype.html", "value": 4954.810071426949}, {"lowerIsBetter": false, "replicates": [775.8254392761629, 795.4272923495083, 809.0897740042452, 812.6708682983394, 823.8266898089772, 13577.253251071199, 13706.383212755425, 13751.312434378291, 13753.106048106878, 13786.17282963023, 12743.23540587563, 12763.04277179213, 12821.807672884914, 12831.807522887164, 12912.806307905366, 817.7219745286601, 817.8282560662253, 825.2078005115096, 835.0480452284401, 839.6095815445816, 820.63481750621, 823.5840900345318, 830.3108420011406, 830.3979614779297, 830.6054624053587, 854.5257382152903, 857.1428571428571, 861.5304658960881, 865.1867244789909, 865.2818160926447, 842.3093063687778, 856.4261944497171, 861.4013260783757, 864.2740098317381, 865.9567021648892, 624.3787431505635, 628.4249911331126, 632.4940047961659, 632.5666918161074, 633.3033662970695, 13431.865681343159, 13482.595522134352, 13517.32413379327, 13526.391312390966, 13747.0, 12609.43257553403, 12727.109102362838, 12798.48806047757, 12847.229166250056, 12877.742445151138, 10001.449920254383, 10033.297669163161, 10090.293679442442, 11081.279716818462, 11211.439428028565, 3657.2319812839337, 3667.339878821811, 3683.4843121962945, 3689.2252626948375, 3762.698984081267, 43983.78008109939, 45331.77334113341, 45480.0, 45537.316940245924, 45701.31448028315, 9629.229661627052, 9637.132658060807, 9792.853107203398, 9821.817461888762, 10135.543900524493, 17039.062851543036, 17691.115444227737, 17694.203760830795, 17702.557436064202, 17746.37887673925, 7147.213806481387, 7232.566046037149, 7294.234105418961, 7419.703211871572, 7441.255874412515, 3844.8077596120643, 3890.6692931100606, 3891.7859517726797, 3907.5897030811925, 3954.387070004154, 3129.687031296852, 3138.7489000879873, 3145.5753473280815, 3147.8583463744185, 3172.1118086935694, 540.1276937745513, 550.2544052808387, 553.698234462219, 572.5562688916124, 584.7894757887158, 498.3645851539316, 506.5972551821311, 532.5074306266688, 636.0078277886512, 643.2698886763557, 8095.595220238964, 8678.69819527076, 8678.913210867811, 8758.737237882873, 8767.298616110696, 551.635920292605, 608.8873558391712, 647.4205586000503, 650.9544331896722, 655.6983787457823, 3915.569287378386, 4111.773852438145, 4164.66682665386, 4195.727277726938, 4254.510731265944, 55372.72313638406, 55955.0, 56114.158287625716, 56268.0, 56701.0, 48499.272510912364, 50261.0, 50889.745551272004, 51601.0, 51877.48122518802, 41984.0, 42386.364204536956, 42901.14197716028, 45284.77357613257, 46988.0, 8634.309255259439, 8707.216350528483, 9023.097690230925, 9083.409578377385, 9128.224100951493, 33114.0, 33452.49821252634, 34113.658863411045, 34230.31539369149, 34231.65768342285, 42922.0, 43448.34827477654, 43690.56309436992, 43709.34435983526, 44148.11703765971, 11193.608223712132, 11254.38100904458, 11344.546218151181, 11361.54553817838, 11385.601503947322, 12760.0, 13077.869221308045, 13078.607641770763, 13213.603591892259, 13230.536931207747, 11080.335179889233, 11133.777324453627, 11328.0, 11482.196246262682, 11680.591179308683, 11268.7746245073, 11715.121365897763, 11717.296962182296, 11795.0, 12108.75782484363, 10880.67357979262, 11168.776624467302, 11306.321620702784, 11565.248258863146, 11724.355160466257, 9217.677381291622, 9308.208802251884, 9329.766755831159, 9354.0, 9479.763005924908, 8688.91311086881, 8755.824883502168, 9709.056547470973, 9867.950660246654, 9967.45179015132], "unit": "score", "name": "yui.html", "value": 6259.581074911666}], "name": "dromaeo_css", "value": 6822.4389868811595}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 115.0, 110.0, 113.0, 123.0, 112.0, 110.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [152.0, 126.0, 147.0, 164.0, 130.0, 154.0, 155.0, 136.0, 167.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 164.0, 163.0, 162.0, 166.0, 168.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 85.0, 75.0, 74.0, 129.0, 72.0, 74.0, 73.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 142.0, 97.0, 96.0, 97.0, 142.0, 97.0, 96.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 98.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 59.0, 60.0, 60.0, 65.0, 72.0, 60.0, 78.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 63.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 71.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 82.0, 83.0, 85.0, 82.0, 83.0, 86.0, 85.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [118.0, 123.0, 119.0, 130.0, 118.0, 128.0, 119.0, 115.0, 129.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.8}, {"lowerIsBetter": true, "replicates": [133.0, 144.0, 135.0, 144.0, 147.0, 132.0, 154.0, 143.0, 148.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 66.0, 69.0, 70.0, 68.0, 67.0, 65.0, 66.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1514.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.7067258449983], "unit": "score", "name": "Richards", "value": 206.79911599999994}, {"lowerIsBetter": false, "replicates": [188.040616773223], "unit": "score", "name": "DeltaBlue", "value": 351.6155239999999}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1070.6638115631692], "unit": "score", "name": "RayTrace", "value": 691.1497260000002}, {"lowerIsBetter": false, "replicates": [758.1501137225171], "unit": "score", "name": "Earley", "value": 879.0646969999996}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [40760.0], "unit": "score", "name": "RegExp", "value": 22.349975466143274}, {"lowerIsBetter": false, "replicates": [587.8894767783656], "unit": "score", "name": "Splay", "value": 138.616191}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20241.389919645142}]} 14:30:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20241.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1514.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6822.44"}}} 14:30:16 INFO - Return code: 0 14:30:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:30:16 INFO - # TBPL SUCCESS # 14:30:16 INFO - Running post-action listener: _resource_record_post_action 14:30:16 INFO - Running post-run listener: _resource_record_post_run 14:30:17 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 566190080; Read time: 12; Write time: 589856 14:30:17 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 247517184; Read time: 0; Write time: 347356 14:30:17 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 314630144; Read time: 12; Write time: 242204 14:30:17 INFO - Running post-run listener: _upload_blobber_files 14:30:17 INFO - Blob upload gear active. 14:30:17 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:30:17 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 14:30:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:30:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:30:17 INFO - (blobuploader) - INFO - Open directory for files ... 14:30:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:30:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:30:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:18 INFO - (blobuploader) - INFO - Done attempting. 14:30:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:30:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:30:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:19 INFO - (blobuploader) - INFO - Done attempting. 14:30:19 INFO - (blobuploader) - INFO - Iteration through files over. 14:30:19 INFO - Return code: 0 14:30:19 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:30:19 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:30:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3571e2e85c90290a2e88afc0d85b02ad980fde5e942570a49747518d9edc57a5be54abbf1620daceaf8778c980fdf58c4a14d5b4aa90c3a432b2d3d5ee7a9e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abee884aa75c9a2f59b55cef59afa5b9d2d1bff7f7d62a50e13c92a7f0394686eb54e9138551c3dc97346bc2996776a6de65efc00bed2c701b8adc067a8b9e56"} 14:30:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:30:19 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:30:19 INFO - Contents: 14:30:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3571e2e85c90290a2e88afc0d85b02ad980fde5e942570a49747518d9edc57a5be54abbf1620daceaf8778c980fdf58c4a14d5b4aa90c3a432b2d3d5ee7a9e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abee884aa75c9a2f59b55cef59afa5b9d2d1bff7f7d62a50e13c92a7f0394686eb54e9138551c3dc97346bc2996776a6de65efc00bed2c701b8adc067a8b9e56"} 14:30:19 INFO - Running post-run listener: copy_logs_to_upload_dir 14:30:19 INFO - Copying logs to upload dir... 14:30:19 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:30:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.493222 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-19 14:30:19.255067) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 14:30:19.258392) ========= 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=82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3571e2e85c90290a2e88afc0d85b02ad980fde5e942570a49747518d9edc57a5be54abbf1620daceaf8778c980fdf58c4a14d5b4aa90c3a432b2d3d5ee7a9e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abee884aa75c9a2f59b55cef59afa5b9d2d1bff7f7d62a50e13c92a7f0394686eb54e9138551c3dc97346bc2996776a6de65efc00bed2c701b8adc067a8b9e56"} build_url:https://queue.taskcluster.net/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011384 build_url: 'https://queue.taskcluster.net/v1/task/SJF6CwQNRnud-9gOWWTJBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3571e2e85c90290a2e88afc0d85b02ad980fde5e942570a49747518d9edc57a5be54abbf1620daceaf8778c980fdf58c4a14d5b4aa90c3a432b2d3d5ee7a9e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abee884aa75c9a2f59b55cef59afa5b9d2d1bff7f7d62a50e13c92a7f0394686eb54e9138551c3dc97346bc2996776a6de65efc00bed2c701b8adc067a8b9e56"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 14:30:19.283186) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 14:30:19.283509) ========= 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=82e07478c745e68b1fe4678a000001bc-1453240483.5786-1587734849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 14:30:19.367651) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 14:30:19.367975) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 14:30:19.368259) ========= ========= Total master_lag: 0.27 =========