builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1453290611.23 results: success (0) buildid: 20160120011919 builduid: 38798efed5764790a56a11ad5aa01a79 revision: 64ec448f156d99870a0f27b039a63f0cb488b17d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:11.229693) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:11.230144) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:11.230450) ========= 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=df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004402 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:11.248130) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:11.248460) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:11.268040) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:11.268437) ========= 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=df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024623 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:11.315695) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:11.316309) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:11.316692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:11.316961) ========= 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=df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 03:50:11-- 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% 60.3M=0s 2016-01-20 03:50:11 (60.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096635 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:11.426915) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:11.427557) ========= 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=df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.125382 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:11.566082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:11.566603) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 64ec448f156d99870a0f27b039a63f0cb488b17d --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 64ec448f156d99870a0f27b039a63f0cb488b17d --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=df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 03:50:12,047 truncating revision to first 12 chars 2016-01-20 03:50:12,047 Setting DEBUG logging. 2016-01-20 03:50:12,047 attempt 1/10 2016-01-20 03:50:12,048 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/64ec448f156d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 03:50:12,292 unpacking tar archive at: mozilla-aurora-64ec448f156d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.546894 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:12.127311) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:12.127679) ========= 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=df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004512 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:12.178053) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:12.178354) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:12.188282) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:12.188575) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 03:50:12.188948) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-01-20 03:50:12.189226) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:50:12 INFO - MultiFileLogger online at 20160120 03:50:12 in /builds/slave/test-pgo 03:50:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:50:12 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:50:12 INFO - {'append_to_log': False, 03:50:12 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:50:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:50:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:50:12 INFO - 'branch': 'Mozilla-Aurora', 03:50:12 INFO - 'buildbot_json_path': 'buildprops.json', 03:50:12 INFO - 'config_files': ('talos/linux_config.py',), 03:50:12 INFO - 'default_actions': ('clobber', 03:50:12 INFO - 'read-buildbot-config', 03:50:12 INFO - 'download-and-extract', 03:50:12 INFO - 'populate-webroot', 03:50:12 INFO - 'create-virtualenv', 03:50:12 INFO - 'install', 03:50:12 INFO - 'run-tests'), 03:50:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:50:12 INFO - 'download_minidump_stackwalk': True, 03:50:12 INFO - 'download_symbols': 'ondemand', 03:50:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:50:12 INFO - 'tooltool.py': '/tools/tooltool.py', 03:50:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:50:12 INFO - '/tools/misc-python/virtualenv.py')}, 03:50:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:50:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:50:12 INFO - 'installer_path': 'installer.exe', 03:50:12 INFO - 'log_level': 'info', 03:50:12 INFO - 'log_name': 'talos', 03:50:12 INFO - 'log_to_console': True, 03:50:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:50:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:50:12 INFO - 'opt_config_files': (), 03:50:12 INFO - 'pip_index': False, 03:50:12 INFO - 'sps_profile': False, 03:50:12 INFO - 'sps_profile_interval': 0, 03:50:12 INFO - 'suite': 'dromaeojs-e10s', 03:50:12 INFO - 'system_bits': '32', 03:50:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:50:12 INFO - 'title': 'talos-linux64-ix-021', 03:50:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:50:12 INFO - 'use_talos_json': True, 03:50:12 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:50:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:50:12 INFO - 'work_dir': 'build'} 03:50:12 INFO - ##### 03:50:12 INFO - ##### Running clobber step. 03:50:12 INFO - ##### 03:50:12 INFO - Running pre-action listener: _resource_record_pre_action 03:50:12 INFO - Running main action method: clobber 03:50:12 INFO - rmtree: /builds/slave/test-pgo/build 03:50:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:50:14 INFO - Running post-action listener: _resource_record_post_action 03:50:14 INFO - ##### 03:50:14 INFO - ##### Running read-buildbot-config step. 03:50:14 INFO - ##### 03:50:14 INFO - Running pre-action listener: _resource_record_pre_action 03:50:14 INFO - Running main action method: read_buildbot_config 03:50:14 INFO - Using buildbot properties: 03:50:14 INFO - { 03:50:14 INFO - "properties": { 03:50:14 INFO - "buildnumber": 96, 03:50:14 INFO - "product": "firefox", 03:50:14 INFO - "script_repo_revision": "production", 03:50:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:50:14 INFO - "repository": "", 03:50:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:50:14 INFO - "buildid": "20160120011919", 03:50:14 INFO - "slavename": "talos-linux64-ix-021", 03:50:14 INFO - "pgo_build": "True", 03:50:14 INFO - "basedir": "/builds/slave/test-pgo", 03:50:14 INFO - "project": "", 03:50:14 INFO - "platform": "ubuntu64_hw", 03:50:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:50:14 INFO - "slavebuilddir": "test", 03:50:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:50:14 INFO - "branch": "mozilla-aurora", 03:50:14 INFO - "repo_path": "releases/mozilla-aurora", 03:50:14 INFO - "stage_platform": "linux64-pgo", 03:50:14 INFO - "builduid": "38798efed5764790a56a11ad5aa01a79", 03:50:14 INFO - "revision": "64ec448f156d99870a0f27b039a63f0cb488b17d" 03:50:14 INFO - }, 03:50:14 INFO - "sourcestamp": { 03:50:14 INFO - "repository": "", 03:50:14 INFO - "hasPatch": false, 03:50:14 INFO - "project": "", 03:50:14 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:50:14 INFO - "changes": [ 03:50:14 INFO - { 03:50:14 INFO - "category": null, 03:50:14 INFO - "files": [ 03:50:14 INFO - { 03:50:14 INFO - "url": null, 03:50:14 INFO - "name": "https://queue.taskcluster.net/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 03:50:14 INFO - } 03:50:14 INFO - ], 03:50:14 INFO - "repository": "", 03:50:14 INFO - "rev": "64ec448f156d99870a0f27b039a63f0cb488b17d", 03:50:14 INFO - "who": "cbook@mozilla.com", 03:50:14 INFO - "when": 1453290501, 03:50:14 INFO - "number": 7484400, 03:50:14 INFO - "comments": "Backout 28 changesets (bug 1097464) a=backout, r=mattwoodrow, a=sylvestre\n\nChangesets:\n d3866546b914\n f950b7a04741\n 29a045cc36ac\n 7e18014be68d\n 885889d182fd\n 7a4447e71d7a\n afd640a20e2c\n 47c793c9547b\n f225e5b0663e\n 1496f9413788\n 3970cb487d1f\n fc0ac31d14eb\n 10fb062fb1ae\n ac7d0d74ced6\n 28033d08c40b\n 08819a7485b7\n 99f9e9779c40\n e19090d182fa\n 32b5ae598c63\n 732305d424f4\n 547905a13380\n 621ab19e86db\n cb6a976ec849\n ce91e635e21a\n 84031c74b6fd\n dc43e93fb4c2\n 37cc5cf46da4", 03:50:14 INFO - "project": "", 03:50:14 INFO - "at": "Wed 20 Jan 2016 03:48:21", 03:50:14 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:50:14 INFO - "revlink": "", 03:50:14 INFO - "properties": [ 03:50:14 INFO - [ 03:50:14 INFO - "buildid", 03:50:14 INFO - "20160120011919", 03:50:14 INFO - "Change" 03:50:14 INFO - ], 03:50:14 INFO - [ 03:50:14 INFO - "builduid", 03:50:14 INFO - "38798efed5764790a56a11ad5aa01a79", 03:50:14 INFO - "Change" 03:50:14 INFO - ], 03:50:14 INFO - [ 03:50:14 INFO - "pgo_build", 03:50:14 INFO - "True", 03:50:14 INFO - "Change" 03:50:14 INFO - ] 03:50:14 INFO - ], 03:50:14 INFO - "revision": "64ec448f156d99870a0f27b039a63f0cb488b17d" 03:50:14 INFO - } 03:50:14 INFO - ], 03:50:14 INFO - "revision": "64ec448f156d99870a0f27b039a63f0cb488b17d" 03:50:14 INFO - } 03:50:14 INFO - } 03:50:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 03:50:14 INFO - Running post-action listener: _resource_record_post_action 03:50:14 INFO - ##### 03:50:14 INFO - ##### Running download-and-extract step. 03:50:14 INFO - ##### 03:50:14 INFO - Running pre-action listener: _resource_record_pre_action 03:50:14 INFO - Running main action method: download_and_extract 03:50:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:50: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')]} 03:50:14 INFO - https://queue.taskcluster.net/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:50:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/test_packages.json 03:50:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/test_packages.json 03:50:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:50:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:50:15 INFO - Downloaded 1302 bytes. 03:50:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:50:15 INFO - Using the following test package requirements: 03:50:15 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:50:15 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:15 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:50:15 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:15 INFO - u'jsshell-linux-x86_64.zip'], 03:50:15 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:15 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:50:15 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:50:15 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:15 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:50:15 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:15 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:50:15 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:15 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:50:15 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:50:15 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:15 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:50:15 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:50: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')]} 03:50:15 INFO - https://queue.taskcluster.net/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:50:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:50:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:50:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:50:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:50:16 INFO - Downloaded 23024566 bytes. 03:50:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:50:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:50:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:50:17 INFO - Return code: 0 03:50:17 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:50: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')]} 03:50:17 INFO - https://queue.taskcluster.net/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:50:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:50:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:50:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:50:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:50:18 INFO - Downloaded 23024566 bytes. 03:50:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:50:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:50:18 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:50:19 INFO - Return code: 0 03:50:19 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')]} 03:50:19 INFO - https://queue.taskcluster.net/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:50:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:50:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:50:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:50:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:50:21 INFO - Downloaded 11132038 bytes. 03:50:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 03:50:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:50:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:50:21 INFO - Return code: 0 03:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:21 INFO - https://queue.taskcluster.net/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:50:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:50:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:50:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:50:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:50:22 INFO - Downloaded 58121673 bytes. 03:50:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:50:22 INFO - mkdir: /builds/slave/test-pgo/properties 03:50:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:50:22 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:50:22 INFO - Contents: 03:50:22 INFO - build_url:https://queue.taskcluster.net/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:50:22 INFO - Running post-action listener: _resource_record_post_action 03:50:22 INFO - Running post-action listener: set_extra_try_arguments 03:50:22 INFO - ##### 03:50:22 INFO - ##### Running populate-webroot step. 03:50:22 INFO - ##### 03:50:22 INFO - Running pre-action listener: _resource_record_pre_action 03:50:22 INFO - Running main action method: populate_webroot 03:50:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:50:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:50:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:50:22 INFO - '--tppagecycles', 03:50:22 INFO - '7'], 03:50:22 INFO - 'tests': ['tsvgm']}}, 03:50:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:50:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:50:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:50:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:50:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:50:22 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:50:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:22 INFO - 'talos_options': ['--e10s'], 03:50:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:22 INFO - 'tests': ['damp', 'tps']}, 03:50:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:22 INFO - 'talos_options': ['--e10s'], 03:50:22 INFO - 'tests': ['damp', 'tps']}, 03:50:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:50:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:50:22 INFO - 'other': {'tests': ['a11yr', 03:50:22 INFO - 'ts_paint', 03:50:22 INFO - 'tpaint', 03:50:22 INFO - 'sessionrestore', 03:50:22 INFO - 'sessionrestore_no_auto_restore']}, 03:50:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:50:22 INFO - 'tests': ['a11yr', 03:50:22 INFO - 'ts_paint', 03:50:22 INFO - 'tpaint', 03:50:22 INFO - 'sessionrestore', 03:50:22 INFO - 'sessionrestore_no_auto_restore']}, 03:50:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:50:22 INFO - 'tests': ['a11yr', 03:50:22 INFO - 'ts_paint', 03:50:22 INFO - 'tpaint', 03:50:22 INFO - 'sessionrestore', 03:50:22 INFO - 'sessionrestore_no_auto_restore']}, 03:50:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:50:22 INFO - 'tests': ['a11yr', 03:50:22 INFO - 'ts_paint', 03:50:22 INFO - 'tpaint', 03:50:22 INFO - 'sessionrestore', 03:50:22 INFO - 'sessionrestore_no_auto_restore']}, 03:50:22 INFO - 'other_l64': {'tests': ['a11yr', 03:50:22 INFO - 'ts_paint', 03:50:22 INFO - 'tpaint', 03:50:22 INFO - 'sessionrestore', 03:50:22 INFO - 'sessionrestore_no_auto_restore']}, 03:50:22 INFO - 'other_nol64': {'tests': ['a11yr', 03:50:22 INFO - 'ts_paint', 03:50:22 INFO - 'tpaint', 03:50:22 INFO - 'sessionrestore', 03:50:22 INFO - 'sessionrestore_no_auto_restore']}, 03:50:22 INFO - 'svgr': {'tests': ['tsvgx', 03:50:22 INFO - 'tsvgr_opacity', 03:50:22 INFO - 'tart', 03:50:22 INFO - 'tscrollx', 03:50:22 INFO - 'cart']}, 03:50:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:50:22 INFO - 'tests': ['tsvgx', 03:50:22 INFO - 'tsvgr_opacity', 03:50:22 INFO - 'tart', 03:50:22 INFO - 'tscrollx', 03:50:22 INFO - 'cart']}, 03:50:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:22 INFO - 'tests': ['tp5o']}, 03:50:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:22 INFO - 'talos_options': ['--e10s'], 03:50:22 INFO - 'tests': ['tp5o']}, 03:50:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:22 INFO - 'talos_options': ['--xperf_path', 03:50:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:22 INFO - 'tests': ['tp5n']}, 03:50:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:22 INFO - 'talos_options': ['--e10s', 03:50:22 INFO - '--xperf_path', 03:50:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:22 INFO - 'tests': ['tp5n']}}, 03:50:22 INFO - 'talos.zip': {'path': '', 03:50:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:50:22 INFO - Running post-action listener: _resource_record_post_action 03:50:22 INFO - ##### 03:50:22 INFO - ##### Running create-virtualenv step. 03:50:22 INFO - ##### 03:50:22 INFO - Running pre-action listener: _resource_record_pre_action 03:50:22 INFO - Running main action method: create_virtualenv 03:50:22 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:50:22 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 03:50:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:50:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:50:22 INFO - Using real prefix '/usr' 03:50:22 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:50:23 INFO - Installing distribute.............................................................................................................................................................................................done. 03:50:25 INFO - Installing pip.................done. 03:50:25 INFO - Return code: 0 03:50:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:50:25 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')]} 03:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:25 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')]} 03:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f133460af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139fa50>, '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 0x130b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130b9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', '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 03:50:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:50:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:50:25 INFO - Using env: {'DISPLAY': ':0', 03:50:25 INFO - 'HOME': '/home/cltbld', 03:50:25 INFO - 'LANG': 'en_US.UTF-8', 03:50:25 INFO - 'LANGUAGE': 'en_US:en', 03:50:25 INFO - 'LOGNAME': 'cltbld', 03:50:25 INFO - 'MAIL': '/var/mail/cltbld', 03:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:25 INFO - 'MOZ_NO_REMOTE': '1', 03:50:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:25 INFO - 'NO_EM_RESTART': '1', 03:50:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:25 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:25 INFO - 'SHELL': '/bin/bash', 03:50:25 INFO - 'SHLVL': '1', 03:50:25 INFO - 'TERM': 'linux', 03:50:25 INFO - 'TMOUT': '86400', 03:50:25 INFO - 'USER': 'cltbld', 03:50:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', 03:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:25 INFO - '_': '/tools/buildbot/bin/python'} 03:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:25 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 03:50:25 INFO - Cleaning up... 03:50:25 INFO - Return code: 0 03:50:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:50:25 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')]} 03:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:25 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')]} 03:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f133460af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139fa50>, '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 0x130b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130b9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', '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 03:50:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:50:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:50:25 INFO - Using env: {'DISPLAY': ':0', 03:50:25 INFO - 'HOME': '/home/cltbld', 03:50:25 INFO - 'LANG': 'en_US.UTF-8', 03:50:25 INFO - 'LANGUAGE': 'en_US:en', 03:50:25 INFO - 'LOGNAME': 'cltbld', 03:50:25 INFO - 'MAIL': '/var/mail/cltbld', 03:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:25 INFO - 'MOZ_NO_REMOTE': '1', 03:50:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:25 INFO - 'NO_EM_RESTART': '1', 03:50:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:25 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:25 INFO - 'SHELL': '/bin/bash', 03:50:25 INFO - 'SHLVL': '1', 03:50:25 INFO - 'TERM': 'linux', 03:50:25 INFO - 'TMOUT': '86400', 03:50:25 INFO - 'USER': 'cltbld', 03:50:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', 03:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:25 INFO - '_': '/tools/buildbot/bin/python'} 03:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:25 INFO - Downloading/unpacking psutil>=0.7.1 03:50:25 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 03:50:25 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 03:50:25 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 03:50:25 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 03:50:25 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 03:50:25 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 03:50:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:50:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:27 INFO - Installing collected packages: psutil 03:50:27 INFO - Running setup.py install for psutil 03:50:27 INFO - building 'psutil._psutil_linux' extension 03:50:27 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 03:50:27 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 03:50:27 INFO - building 'psutil._psutil_posix' extension 03:50:27 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 03:50:28 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 03:50:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:28 INFO - Successfully installed psutil 03:50:28 INFO - Cleaning up... 03:50:28 INFO - Return code: 0 03:50:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f133460af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139fa50>, '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 0x130b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130b9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', '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 03:50:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:50:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:50:28 INFO - Using env: {'DISPLAY': ':0', 03:50:28 INFO - 'HOME': '/home/cltbld', 03:50:28 INFO - 'LANG': 'en_US.UTF-8', 03:50:28 INFO - 'LANGUAGE': 'en_US:en', 03:50:28 INFO - 'LOGNAME': 'cltbld', 03:50:28 INFO - 'MAIL': '/var/mail/cltbld', 03:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:28 INFO - 'MOZ_NO_REMOTE': '1', 03:50:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:28 INFO - 'NO_EM_RESTART': '1', 03:50:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:28 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:28 INFO - 'SHELL': '/bin/bash', 03:50:28 INFO - 'SHLVL': '1', 03:50:28 INFO - 'TERM': 'linux', 03:50:28 INFO - 'TMOUT': '86400', 03:50:28 INFO - 'USER': 'cltbld', 03:50:28 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', 03:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:28 INFO - '_': '/tools/buildbot/bin/python'} 03:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:50:28 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 03:50:28 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 03:50:28 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 03:50:28 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 03:50:28 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 03:50:28 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 03:50:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:50:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:50:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:50:30 INFO - Installing collected packages: mozsystemmonitor 03:50:30 INFO - Running setup.py install for mozsystemmonitor 03:50:30 INFO - Successfully installed mozsystemmonitor 03:50:30 INFO - Cleaning up... 03:50:30 INFO - Return code: 0 03:50:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:50: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')]} 03:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50: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')]} 03:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f133460af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139fa50>, '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 0x130b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130b9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', '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 03:50:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:50:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:50:30 INFO - Using env: {'DISPLAY': ':0', 03:50:30 INFO - 'HOME': '/home/cltbld', 03:50:30 INFO - 'LANG': 'en_US.UTF-8', 03:50:30 INFO - 'LANGUAGE': 'en_US:en', 03:50:30 INFO - 'LOGNAME': 'cltbld', 03:50:30 INFO - 'MAIL': '/var/mail/cltbld', 03:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:30 INFO - 'MOZ_NO_REMOTE': '1', 03:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:30 INFO - 'NO_EM_RESTART': '1', 03:50:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:30 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:30 INFO - 'SHELL': '/bin/bash', 03:50:30 INFO - 'SHLVL': '1', 03:50:30 INFO - 'TERM': 'linux', 03:50:30 INFO - 'TMOUT': '86400', 03:50:30 INFO - 'USER': 'cltbld', 03:50:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', 03:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:30 INFO - '_': '/tools/buildbot/bin/python'} 03:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:30 INFO - Downloading/unpacking blobuploader==1.2.4 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50:32 INFO - Downloading blobuploader-1.2.4.tar.gz 03:50:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:50:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:50:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50:32 INFO - Downloading docopt-0.6.1.tar.gz 03:50:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:50:33 INFO - Installing collected packages: blobuploader, requests, docopt 03:50:33 INFO - Running setup.py install for blobuploader 03:50:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:50:33 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:50:33 INFO - Running setup.py install for requests 03:50:33 INFO - Running setup.py install for docopt 03:50:33 INFO - Successfully installed blobuploader requests docopt 03:50:33 INFO - Cleaning up... 03:50:33 INFO - Return code: 0 03:50:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f133460af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139fa50>, '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 0x130b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130b9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', '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 03:50:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 03:50:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 03:50:33 INFO - Using env: {'DISPLAY': ':0', 03:50:33 INFO - 'HOME': '/home/cltbld', 03:50:33 INFO - 'LANG': 'en_US.UTF-8', 03:50:33 INFO - 'LANGUAGE': 'en_US:en', 03:50:33 INFO - 'LOGNAME': 'cltbld', 03:50:33 INFO - 'MAIL': '/var/mail/cltbld', 03:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:33 INFO - 'MOZ_NO_REMOTE': '1', 03:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:33 INFO - 'NO_EM_RESTART': '1', 03:50:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:33 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:33 INFO - 'SHELL': '/bin/bash', 03:50:33 INFO - 'SHLVL': '1', 03:50:33 INFO - 'TERM': 'linux', 03:50:33 INFO - 'TMOUT': '86400', 03:50:33 INFO - 'USER': 'cltbld', 03:50:33 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', 03:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:33 INFO - '_': '/tools/buildbot/bin/python'} 03:50:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:50:33 INFO - Running setup.py (path:/tmp/pip-xsDi38-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:50:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:50:33 INFO - Running setup.py (path:/tmp/pip-9E1jS1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:50:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:50:33 INFO - Running setup.py (path:/tmp/pip-AMdeF7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:50:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:50:34 INFO - Running setup.py (path:/tmp/pip-zdYO2d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:50:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:50:34 INFO - Running setup.py (path:/tmp/pip-IYWTLR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:50:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:50:34 INFO - Running setup.py (path:/tmp/pip-xAzXYt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:50:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:50:34 INFO - Running setup.py (path:/tmp/pip-3Ak3Jm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:50:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:50:34 INFO - Running setup.py (path:/tmp/pip-jBaP6Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:50:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:50:34 INFO - Running setup.py (path:/tmp/pip-10BtYe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:50:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:50:34 INFO - Running setup.py (path:/tmp/pip-iFopbg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:50:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:50:34 INFO - Running setup.py (path:/tmp/pip-unVj19-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:50:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:50:34 INFO - Running setup.py (path:/tmp/pip-x4x247-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:50:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:50:34 INFO - Running setup.py (path:/tmp/pip-J4hNmA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:50:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:50:34 INFO - Running setup.py (path:/tmp/pip-8PNgsf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:50:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:50:34 INFO - Running setup.py (path:/tmp/pip-wqKHHN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:50:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:50:34 INFO - Running setup.py (path:/tmp/pip-Nkx4m8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:50:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:50:34 INFO - Running setup.py (path:/tmp/pip-3ZlqnA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:50:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:50:35 INFO - Running setup.py install for manifestparser 03:50:35 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:50:35 INFO - Running setup.py install for mozcrash 03:50:35 INFO - Running setup.py install for mozdebug 03:50:35 INFO - Running setup.py install for mozdevice 03:50:35 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:50:35 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:50:35 INFO - Running setup.py install for mozfile 03:50:35 INFO - Running setup.py install for mozhttpd 03:50:35 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:50:35 INFO - Running setup.py install for mozinfo 03:50:35 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:50:35 INFO - Running setup.py install for mozInstall 03:50:35 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:50:35 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:50:35 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:50:35 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:50:35 INFO - Running setup.py install for mozleak 03:50:35 INFO - Running setup.py install for mozlog 03:50:36 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:50:36 INFO - Running setup.py install for moznetwork 03:50:36 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:50:36 INFO - Running setup.py install for mozprocess 03:50:36 INFO - Running setup.py install for mozprofile 03:50:36 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:50:36 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:50:36 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:50:36 INFO - Running setup.py install for mozrunner 03:50:36 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:50:36 INFO - Running setup.py install for mozscreenshot 03:50:36 INFO - Running setup.py install for moztest 03:50:36 INFO - Running setup.py install for mozversion 03:50:36 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:50:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:50:36 INFO - Cleaning up... 03:50:36 INFO - Return code: 0 03:50:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f133460af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139fa50>, '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 0x130b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130b9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', '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 03:50:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:50:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:50:36 INFO - Using env: {'DISPLAY': ':0', 03:50:36 INFO - 'HOME': '/home/cltbld', 03:50:36 INFO - 'LANG': 'en_US.UTF-8', 03:50:36 INFO - 'LANGUAGE': 'en_US:en', 03:50:36 INFO - 'LOGNAME': 'cltbld', 03:50:36 INFO - 'MAIL': '/var/mail/cltbld', 03:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:36 INFO - 'MOZ_NO_REMOTE': '1', 03:50:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:36 INFO - 'NO_EM_RESTART': '1', 03:50:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:36 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:36 INFO - 'SHELL': '/bin/bash', 03:50:36 INFO - 'SHLVL': '1', 03:50:36 INFO - 'TERM': 'linux', 03:50:36 INFO - 'TMOUT': '86400', 03:50:36 INFO - 'USER': 'cltbld', 03:50:36 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', 03:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:36 INFO - '_': '/tools/buildbot/bin/python'} 03:50:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:50:37 INFO - Running setup.py (path:/tmp/pip-5xs_30-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:50:37 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)) 03:50:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:50:37 INFO - Running setup.py (path:/tmp/pip-c4kjxm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:50:37 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)) 03:50:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:50:37 INFO - Running setup.py (path:/tmp/pip-y78kVB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:50:37 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)) 03:50:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:50:37 INFO - Running setup.py (path:/tmp/pip-3VOYY4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:50:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:50:37 INFO - Running setup.py (path:/tmp/pip-L64vBb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:50:37 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)) 03:50:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:50:37 INFO - Running setup.py (path:/tmp/pip-nJofu4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:50:37 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)) 03:50:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:50:37 INFO - Running setup.py (path:/tmp/pip-Ik0Cu5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:50:37 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)) 03:50:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:50:37 INFO - Running setup.py (path:/tmp/pip-4ZfrD5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:50:37 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)) 03:50:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:50:37 INFO - Running setup.py (path:/tmp/pip-4YDTnq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:50:37 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)) 03:50:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:50:37 INFO - Running setup.py (path:/tmp/pip-cKWVyj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:50:37 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)) 03:50:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:50:37 INFO - Running setup.py (path:/tmp/pip-D1CkAn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:50:37 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)) 03:50:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:50:37 INFO - Running setup.py (path:/tmp/pip-E1qmoi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:50:37 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)) 03:50:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:50:37 INFO - Running setup.py (path:/tmp/pip-uSqa0I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 03:50:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:50:37 INFO - Running setup.py (path:/tmp/pip-yxTm39-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:50:38 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)) 03:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:50:38 INFO - Running setup.py (path:/tmp/pip-Wv7lrv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:50:38 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)) 03:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:50:38 INFO - Running setup.py (path:/tmp/pip-ImV_Co-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:50:38 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)) 03:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:50:38 INFO - Running setup.py (path:/tmp/pip-nzs3tq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:50:38 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)) 03:50:38 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)) 03:50:38 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)) 03:50:38 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)) 03:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:50:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:39 INFO - Downloading blessings-1.5.1.tar.gz 03:50:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:50:40 INFO - Installing collected packages: blessings 03:50:40 INFO - Running setup.py install for blessings 03:50:40 INFO - Successfully installed blessings 03:50:40 INFO - Cleaning up... 03:50:40 INFO - Return code: 0 03:50:40 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:50:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:50:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:50:40 INFO - Reading from file tmpfile_stdout 03:50:40 INFO - Current package versions: 03:50:40 INFO - argparse == 1.2.1 03:50:40 INFO - blessings == 1.5.1 03:50:40 INFO - blobuploader == 1.2.4 03:50:40 INFO - docopt == 0.6.1 03:50:40 INFO - manifestparser == 1.1 03:50:40 INFO - mozInstall == 1.12 03:50:40 INFO - mozcrash == 0.16 03:50:40 INFO - mozdebug == 0.1 03:50:40 INFO - mozdevice == 0.47 03:50:40 INFO - mozfile == 1.2 03:50:40 INFO - mozhttpd == 0.7 03:50:40 INFO - mozinfo == 0.9 03:50:40 INFO - mozleak == 0.1 03:50:40 INFO - mozlog == 3.1 03:50:40 INFO - moznetwork == 0.27 03:50:40 INFO - mozprocess == 0.22 03:50:40 INFO - mozprofile == 0.27 03:50:40 INFO - mozrunner == 6.11 03:50:40 INFO - mozscreenshot == 0.1 03:50:40 INFO - mozsystemmonitor == 0.0 03:50:40 INFO - moztest == 0.7 03:50:40 INFO - mozversion == 1.4 03:50:40 INFO - psutil == 3.1.1 03:50:40 INFO - requests == 1.2.3 03:50:40 INFO - wsgiref == 0.1.2 03:50:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:50:40 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')]} 03:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:40 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')]} 03:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f133460af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139fa50>, '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 0x130b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130b9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', '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 03:50:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:50:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:50:40 INFO - Using env: {'DISPLAY': ':0', 03:50:40 INFO - 'HOME': '/home/cltbld', 03:50:40 INFO - 'LANG': 'en_US.UTF-8', 03:50:40 INFO - 'LANGUAGE': 'en_US:en', 03:50:40 INFO - 'LOGNAME': 'cltbld', 03:50:40 INFO - 'MAIL': '/var/mail/cltbld', 03:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:40 INFO - 'MOZ_NO_REMOTE': '1', 03:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:40 INFO - 'NO_EM_RESTART': '1', 03:50:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:40 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:40 INFO - 'SHELL': '/bin/bash', 03:50:40 INFO - 'SHLVL': '1', 03:50:40 INFO - 'TERM': 'linux', 03:50:40 INFO - 'TMOUT': '86400', 03:50:40 INFO - 'USER': 'cltbld', 03:50:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', 03:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:40 INFO - '_': '/tools/buildbot/bin/python'} 03:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:40 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 1)) 03:50:40 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 2)) 03:50:40 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 3)) 03:50:40 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 4)) 03:50:40 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 5)) 03:50:40 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 6)) 03:50:40 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 7)) 03:50:40 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 8)) 03:50: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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:50: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:50:40 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:50:40 INFO - Cleaning up... 03:50:40 INFO - Return code: 0 03:50:40 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:50:40 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')]} 03:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:40 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')]} 03:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f133460af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139fa50>, '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 0x130b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130b9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', '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 03:50:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:50:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:50:40 INFO - Using env: {'DISPLAY': ':0', 03:50:40 INFO - 'HOME': '/home/cltbld', 03:50:40 INFO - 'LANG': 'en_US.UTF-8', 03:50:40 INFO - 'LANGUAGE': 'en_US:en', 03:50:40 INFO - 'LOGNAME': 'cltbld', 03:50:40 INFO - 'MAIL': '/var/mail/cltbld', 03:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:40 INFO - 'MOZ_NO_REMOTE': '1', 03:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:40 INFO - 'NO_EM_RESTART': '1', 03:50:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:40 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:40 INFO - 'SHELL': '/bin/bash', 03:50:40 INFO - 'SHLVL': '1', 03:50:40 INFO - 'TERM': 'linux', 03:50:40 INFO - 'TMOUT': '86400', 03:50:40 INFO - 'USER': 'cltbld', 03:50:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', 03:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:40 INFO - '_': '/tools/buildbot/bin/python'} 03:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:40 INFO - Downloading/unpacking jsonschema 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:50:42 INFO - Downloading/unpacking functools32 (from jsonschema) 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50:42 INFO - Downloading functools32-3.2.3-2.tar.gz 03:50:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:50:42 INFO - warning: no files found matching '*.txt' 03:50:42 INFO - no previously-included directories found matching 'build' 03:50:42 INFO - no previously-included directories found matching 'dist' 03:50:42 INFO - no previously-included directories found matching '.git*' 03:50:42 INFO - Installing collected packages: jsonschema, functools32 03:50:42 INFO - Running setup.py install for functools32 03:50:43 INFO - warning: no files found matching '*.txt' 03:50:43 INFO - no previously-included directories found matching 'build' 03:50:43 INFO - no previously-included directories found matching 'dist' 03:50:43 INFO - no previously-included directories found matching '.git*' 03:50:43 INFO - Successfully installed jsonschema functools32 03:50:43 INFO - Cleaning up... 03:50:43 INFO - Return code: 0 03:50:43 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f133460af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139fa50>, '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 0x130b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130b9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', '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 03:50:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:50:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:50:43 INFO - Using env: {'DISPLAY': ':0', 03:50:43 INFO - 'HOME': '/home/cltbld', 03:50:43 INFO - 'LANG': 'en_US.UTF-8', 03:50:43 INFO - 'LANGUAGE': 'en_US:en', 03:50:43 INFO - 'LOGNAME': 'cltbld', 03:50:43 INFO - 'MAIL': '/var/mail/cltbld', 03:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:43 INFO - 'MOZ_NO_REMOTE': '1', 03:50:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:43 INFO - 'NO_EM_RESTART': '1', 03:50:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:43 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:43 INFO - 'SHELL': '/bin/bash', 03:50:43 INFO - 'SHLVL': '1', 03:50:43 INFO - 'TERM': 'linux', 03:50:43 INFO - 'TMOUT': '86400', 03:50:43 INFO - 'USER': 'cltbld', 03:50:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', 03:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:43 INFO - '_': '/tools/buildbot/bin/python'} 03:50:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:43 INFO - Downloading/unpacking flake8 03:50:43 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 03:50:43 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 03:50:43 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 03:50:43 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 03:50:43 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 03:50:43 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 03:50:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:50:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:50:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:50:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:50:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:50:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:50:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:50:45 INFO - no previously-included directories found matching 'docs/_build' 03:50:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:50:45 INFO - Running setup.py install for pep8 03:50:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:50:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:50:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:50:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:50:45 INFO - no previously-included directories found matching 'docs/_build' 03:50:45 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:50:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:50:45 INFO - Cleaning up... 03:50:45 INFO - Return code: 0 03:50:45 INFO - Running post-action listener: _resource_record_post_action 03:50:45 INFO - Running post-action listener: _start_resource_monitoring 03:50:45 INFO - Starting resource monitoring. 03:50:45 INFO - ##### 03:50:45 INFO - ##### Running install step. 03:50:45 INFO - ##### 03:50:45 INFO - Running pre-action listener: _resource_record_pre_action 03:50:45 INFO - Running main action method: install 03:50:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:50:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:50:46 INFO - Reading from file tmpfile_stdout 03:50:46 INFO - Detecting whether we're running mozinstall >=1.0... 03:50:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:50:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:50:46 INFO - Reading from file tmpfile_stdout 03:50:46 INFO - Output received: 03:50:46 INFO - Usage: mozinstall [options] installer 03:50:46 INFO - Options: 03:50:46 INFO - -h, --help show this help message and exit 03:50:46 INFO - -d DEST, --destination=DEST 03:50:46 INFO - Directory to install application into. [default: 03:50:46 INFO - "/builds/slave/test-pgo"] 03:50:46 INFO - --app=APP Application being installed. [default: firefox] 03:50:46 INFO - mkdir: /builds/slave/test-pgo/build/application 03:50:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:50:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:51:01 INFO - Reading from file tmpfile_stdout 03:51:01 INFO - Output received: 03:51:01 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:51:01 INFO - Running post-action listener: _resource_record_post_action 03:51:01 INFO - ##### 03:51:01 INFO - ##### Running run-tests step. 03:51:01 INFO - ##### 03:51:01 INFO - Running pre-action listener: _resource_record_pre_action 03:51:01 INFO - Running main action method: run_tests 03:51:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:51:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:51:01 INFO - Python 2.7.3 03:51:01 INFO - Return code: 0 03:51:01 INFO - grabbing minidump binary from tooltool 03:51:01 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')]} 03:51:01 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 0x139fa50>, '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 0x130b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130b9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:51:01 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 03:51:01 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 03:51:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:51:01 INFO - Return code: 0 03:51:01 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:51:01 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:51:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:51:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:51:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:51:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:51:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:51:02 INFO - Return code: 0 03:51:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:51:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost 03:51:02 INFO - Using env: {'DISPLAY': ':0', 03:51:02 INFO - 'HOME': '/home/cltbld', 03:51:02 INFO - 'LANG': 'en_US.UTF-8', 03:51:02 INFO - 'LANGUAGE': 'en_US:en', 03:51:02 INFO - 'LOGNAME': 'cltbld', 03:51:02 INFO - 'MAIL': '/var/mail/cltbld', 03:51:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:51:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:02 INFO - 'MOZ_NO_REMOTE': '1', 03:51:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:02 INFO - 'NO_EM_RESTART': '1', 03:51:02 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:51:02 INFO - 'PWD': '/builds/slave/test-pgo', 03:51:02 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:51:02 INFO - 'SHELL': '/bin/bash', 03:51:02 INFO - 'SHLVL': '1', 03:51:02 INFO - 'TERM': 'linux', 03:51:02 INFO - 'TMOUT': '86400', 03:51:02 INFO - 'USER': 'cltbld', 03:51:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267', 03:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:02 INFO - '_': '/tools/buildbot/bin/python'} 03:51:02 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost'] with output_timeout 3600 03:51:02 INFO - mozversion INFO | application_buildid: 20160120011919 03:51:02 INFO - mozversion INFO | application_changeset: 64ec448f156d99870a0f27b039a63f0cb488b17d 03:51:02 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:51:02 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:51:02 INFO - mozversion INFO | application_name: Firefox 03:51:02 INFO - mozversion INFO | application_remotingname: firefox-dev 03:51:02 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:51:02 INFO - mozversion INFO | application_vendor: Mozilla 03:51:02 INFO - mozversion INFO | application_version: 45.0a2 03:51:02 INFO - mozversion INFO | platform_buildid: 20160120011919 03:51:02 INFO - mozversion INFO | platform_changeset: 64ec448f156d99870a0f27b039a63f0cb488b17d 03:51:02 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:51:02 INFO - mozversion INFO | platform_version: 45.0a2 03:51:02 INFO - 2016-01-20 03:51:02,787 DEBUG : using testdate: 1453290662 03:51:02 INFO - 2016-01-20 03:51:02,787 DEBUG : actual date: 1453290662 03:51:02 INFO - 2016-01-20 03:51:02,795 INFO : starting webserver on 'localhost:33422' 03:51:02 INFO - 2016-01-20 03:51:02,796 INFO : Starting test suite talos-linux64-ix-021.e 03:51:02 INFO - 2016-01-20 03:51:02,796 INFO : Starting test dromaeo_css 03:51:02 INFO - 2016-01-20 03:51:02,796 DEBUG : operating with platform_type : linux_ 03:51:02 INFO - 2016-01-20 03:51:02,797 INFO : Initialising browser for dromaeo_css test... 03:51:02 INFO - 2016-01-20 03:51:02,811 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUm_X3t/profile http://localhost:33422/getInfo.html 03:51:06 INFO - 2016-01-20 03:51:06,876 DEBUG : BROWSER_OUTPUT: 03:51:06 INFO - 2016-01-20 03:51:06,876 DEBUG : BROWSER_OUTPUT: (process:30318): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:51:07 INFO - 2016-01-20 03:51:07,881 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:51:07 INFO - 2016-01-20 03:51:07,881 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:51:07 INFO - 2016-01-20 03:51:07,881 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:51:07 INFO - 2016-01-20 03:51:07,881 DEBUG : BROWSER_OUTPUT: __metrics 03:51:08 INFO - 2016-01-20 03:51:08,981 INFO : Browser initialized. 03:51:08 INFO - 2016-01-20 03:51:08,982 INFO : Running cycle 1/1 for dromaeo_css test... 03:51:08 INFO - 2016-01-20 03:51:08,982 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUm_X3t/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:51:10 INFO - 2016-01-20 03:51:10,313 DEBUG : BROWSER_OUTPUT: 03:51:10 INFO - 2016-01-20 03:51:10,313 DEBUG : BROWSER_OUTPUT: (process:30432): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:51:20 INFO - 2016-01-20 03:51:20,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 136151040 03:51:20 INFO - 2016-01-20 03:51:20,819 DEBUG : BROWSER_OUTPUT: 03:52:10 INFO - 2016-01-20 03:52:10,462 DEBUG : BROWSER_OUTPUT: 1453290730455 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] 03:54:18 INFO - 2016-01-20 03:54:18,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33422/tests/dromaeo/cssquery-ext.html) 03:54:19 INFO - 2016-01-20 03:54:19,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 141549568 03:54:19 INFO - 2016-01-20 03:54:19,629 DEBUG : BROWSER_OUTPUT: 03:57:21 INFO - 2016-01-20 03:57:21,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/dromaeo/cssquery-ext.html (next: http://localhost:33422/tests/dromaeo/cssquery-jquery.html) 03:57:22 INFO - 2016-01-20 03:57:22,027 DEBUG : BROWSER_OUTPUT: RSS: Main: 140124160 03:57:22 INFO - 2016-01-20 03:57:22,027 DEBUG : BROWSER_OUTPUT: 04:00:23 INFO - 2016-01-20 04:00:23,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33422/tests/dromaeo/cssquery-mootools.html) 04:00:24 INFO - 2016-01-20 04:00:24,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 138493952 04:00:24 INFO - 2016-01-20 04:00:24,142 DEBUG : BROWSER_OUTPUT: 04:03:25 INFO - 2016-01-20 04:03:25,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33422/tests/dromaeo/cssquery-prototype.html) 04:03:26 INFO - 2016-01-20 04:03:26,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 139382784 04:03:26 INFO - 2016-01-20 04:03:26,336 DEBUG : BROWSER_OUTPUT: 04:06:28 INFO - 2016-01-20 04:06:28,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33422/tests/dromaeo/cssquery-yui.html) 04:06:29 INFO - 2016-01-20 04:06:29,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 140001280 04:06:29 INFO - 2016-01-20 04:06:29,131 DEBUG : BROWSER_OUTPUT: 04:09:31 INFO - 2016-01-20 04:09:31,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/dromaeo/cssquery-yui.html (next: http://localhost:33422/tests/dromaeo/cssquery-dojo.html) 04:09:31 INFO - 2016-01-20 04:09:31,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 141701120 04:09:31 INFO - 2016-01-20 04:09:31,479 DEBUG : BROWSER_OUTPUT: 04:09:31 INFO - 2016-01-20 04:09:31,479 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:09:31 INFO - 2016-01-20 04:09:31,479 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:09:31 INFO - 2016-01-20 04:09:31,479 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:09:31 INFO - 2016-01-20 04:09:31,479 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:09:31 INFO - 2016-01-20 04:09:31,480 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3288.1615188127025;3318.5851768528933;3329.800211987281;3356.2784001439686;3361.462166053432;5481.4518548145215;5508.807191748285;5517.062099443095;5519.613627046108;5526.944730552698;5536.916946245809;5619.943800562003;5642.492175704186;5658.943410565893;5665.518430933375;5108.055009823185;5168.0180765654595;5201.55786758126;5204.895902081975;5227.79088836446;4978.87552811179;5062.190049592066;5070.062038522867;5073.771680274396;5075.441701412841;5102.1836506159025;5165.070287348276;5165.509276618715;5201.0378080055125;5255.343082114736;5110.565601923841;5131.435542090367;5135.435102138762;5145.382554093533;5172.974135129338;4955.578775804061;4994.87512812179;5052.216906379517;5063.873403164914;5119.488051194888;5302.973485132588;5351.57187425005;5379.38137114233;5422;5426.104692725696;5884.382139875294;5925.585209035369;5970.611910225822;5972.25346831646;5997.610155339889;5894.705264736746;5983.491403230731;6035.30593981689;6039.54703397247;6057.30341010785;5683.318001839764;5695.316562012544;5698.943010569883;5714.399988001283;5715.942840571583;6150.907736383958;6158.784442544579;6168.660723660152;6195.380461953859;6204;5771.134329850472;5797.855053623609;5932.228810254725;5958.7914422995855;6075.027995520695;6051.092336149525;6061.909071363933;6073.848153796102;6083.543734219951;6098.75604975796;6010.789622363196;6016.338202797689;6047.0627052806885;6049.78825741097;6051.727672254759;5720.799772007959;5815.331236907725;6032.939670603238;6121.54443000217;6125.082842094198;4607.262837945913;4612.53874612536;4626.953730462719;4629.120467111238;4640.79116439761;4075.3071977763852;4133.565975572522;4137.338025915839;4141.461609990682;4147.19129769692;5695;5713.257276554022;5718.714064296769;5823.184754134425;5845.532357411397;5941.31674857397;5943.5839491236065;5968.1644569760265;5971.253593300838;5992.43071908168;5569.860753481114;5622.8754249149515;5729.48434640876;5735.2257445245195;5746.683932383676;5264.526192642604;5283.049051170826;5305.257263983045;5313;5381.48875856793;6153.84615384619;6187;6192.907106393408;6196.411340922605;6217.440430361199;5837.3870743571315;5943.227380440515;5978.222831031938;6005.549583781321;6010.579259451883;6253.749850005949;6303.212098487689;6304.65324407162;6305.873882522415;6306.84232894163;5966.552508561962;6018.277806663228;6018.398160183947;6024.33732289439;6024.87950240984;5800.4489573490455;5903.940960590511;5953.7916172935475;6064.326784858592;6124.89972046314;5948.048312270016;5966.791162309299;5969.641821490724;5975.37258587842;5978.282606087298;5893.499052580579;5936.554758393224;5960.314563825043;5970.910436343545;5973.223480947623;5607.383187849415;5731.942680573141;5780.421957804186;5876.970615147068;5903.350631430453;5749.885002300014;5807.477327040587;5837.708114594338;5885.352611212677;5988.910166347596;5583.330000399816;5761.91357129635;5763.855903602276;5765.5675824314185;5794.681292528951 04:09:31 INFO - 2016-01-20 04:09:31,480 DEBUG : BROWSER_OUTPUT: |1;ext.html;577.2841676321362;623.706857776845;639.8144538083956;652.1554586810081;678.5080816408108;32649.67350326496;33245.33509329812;37417.43873841895;37699.62300376996;37858.24283514331;41874.162516749646;42476.36285455713;42528;42545.14909701812;42570.14859702804;9026.097390260971;9179.678711245107;9198.356115071947;9206.171444569987;9226.67706630268;9026.413283136608;9095.636174553043;9143.451392916446;9177.219936305422;9203.355765096447;9060.728178154666;9061.184493395593;9112.8633070504;9159.038300978402;9180.8622870657;9062.275017998545;9083.45499270046;9170.724878253663;9172.724818255463;9175.724728258163;8984.46093234408;9163.908360916372;9164.633414663405;9166.724998250063;9178.541072946326;40523.59476405228;40581;40859;41246.793766031275;41347.173056538704;3600.4419315006216;3628.9455658165148;3716.349638813224;3800.3919372900205;4115.8971025724595;31002.534961975587;31384.529232061537;31405.685943140732;31664;32077.03768886937;4300.290452075404;4327.6105150536605;4331.415258940035;4337.804798784031;4406.801693923749;277300;277945.6102719494;278241;278518;279782;44371.556284436745;45655.77172114118;45733.54266457359;45805.54194458079;57878;46271.5372846274;46331.30503042457;46450.303245451345;46506;46738.29892551546;15717.21413929299;15772.211389430482;15942.60143496422;15960;15965.760513592306;12944.611661650166;12991.28547929854;13104.80342794859;13165.078444508985;13194.604161875159;14498.85501144975;14502.927485362507;14512.346944387527;14543.490977815938;14788;6071.7571297147615;6131.050837999949;6131.417515336036;6160.815175544741;6187.16473276111;965.3194497878978;974.9122578967786;1088.6516314779194;1096.4846522134585;1103.9448027598748;27072.187834365002;27263.72736272612;27295.986938385384;27816.443671126868;27940.161795146178;1010.6210171185805;1016.8220561401725;1034.2088302448633;1045.362328979322;1088.472091035847;14788.482403116055;14878.776818347733;15048.699026019418;15103.622409439633;15173.393064277305;684916;686682;688201;690634;726663;55406;55628.16557751637;55745.721271393384;55752;55920;1499.9850001500063;1507.8869084818464;1508.4117194294233;1516.924153792328;1521.4218596933094;29395.412091758473;30364.089077327717;33219.16952076121;33663.3267334647;33902.8304858484;52342;52664;52881.20678189907;53150.734246328524;53258.73370633122;303419;307306;307398;307897;308282;42129.36805947852;42425.36361954635;43120.35319470148;43209.3518597215;43483.56516434922;45670.54329456663;46350.30474542817;47020.529794701615;47296;47480.2877956824;39284;39346.213075738895;39858;40583.7970810144;40855.59144408518;41167.1766564673;41492.377614336416;41521.37717934294;42624.786876065424;43503.56496434995;36945.26109477849;37340;37533.43699844559;37639.81180094082;37653;33416.498752518244;33926.49110263299;34036.97889063332;37100;37885.81057094697;26202.606960895984;26453.92230770423;26628.866855665598;26680;27071.323216919736 04:09:31 INFO - 2016-01-20 04:09:31,480 DEBUG : BROWSER_OUTPUT: |2;jquery.html;391.5868758459824;397.8448405122001;398.8085718854949;402.1013035864842;405.2887182993845;15527.378904843792;15590.45433409831;17101.401450949204;17514;17588.472345829614;11382.658520244406;11470.942645286783;11533;11671.41642917855;11788.7642247155;4874.829380971667;4880.389951256093;4975.7263350515705;4976.676516026447;4981.928885289662;4961.305417241589;5143.614228932826;5290.312259406272;5292.10034294169;5293.86765330866;5198.428172900978;5206.271122042917;5228.424873263938;5253.212018197282;5464.535514481274;5408.891822163554;5413;5420.4850539198715;5428.45715428456;5457.263269458612;5224.138017227153;5229.1633338666015;5253.921191182136;5262.02652509287;5502.8349149525575;13039.413226404835;13216.537421190309;13301.467941282433;14563.490277840225;20977.056032478577;2147.795959383856;2162.5782972320403;2213.2032468311395;2259.243153543565;2326.6161083421216;10003.949980250125;10113.039261270167;10195.541200645988;12324.32216228107;13302.733945321137;1846.9933886032145;1865.9440216793382;1899.7815251246145;1935.5064458563118;2031.5530583271657;63157.68421157911;63239;65487.3451265486;65833;65954.67022664857;10929.56281748721;10953.521274627983;10956.616518421817;10990.725231869108;11076.944615277032;14033.578992630237;14089.43642254319;14169.78745318821;14176.787348189786;14198.858011419754;7695.153533111354;7747.457677962489;7825.334846537994;8107.067687215927;8128.715494957648;7546.20764819697;7593.506422082547;7629.847403051908;7679.232076792276;7689.50018248812;4595.862124136282;4612.561806628365;4623.976880115645;4684.203685373494;4706.176419126639;1915.3281172764196;1971.1327016112864;1990.2536548794203;1998.3505360757813;2000.9399718008483;862.6721845698594;910.7996240827008;995.2237254941158;1023.3655133817081;1027.6505987963978;14692.559223223321;16623.168841557872;17077.231524581424;17756.822431775516;17778.822211777977;944.2776276148752;972.2659392159017;990.4453506036642;1010.2625083688802;1013.9493025348703;9550.522473876417;9831.1643510301;9919.553620087114;9971.650992215238;10381.325213861075;565704;570082;573357;583135;588621;78009.60995194988;80175.59912200402;80557;81024;81578.18421815825;1116.7264020315074;1137.2721458266717;1142.8857114288671;1144.4392247798519;1145.564685419552;15234.771478428054;15345.23273836326;15428.768568471258;15524.534263972098;15624.765628515808;35899.641003590674;36912.81543592265;36955.6304436963;36986.8150659245;37085.25829483449;48626;48920.5107948916;50808;51091.489085108675;51097.23354149616;10115.342502737298;10234;10257.846132307872;10343.94828025855;10431.68704938853;12452.813207802072;17283.65432691314;17822.821771782634;17881;18123.728144077584;15408.075515469107;15466.14936178521;15585.76621350658;15761.448349307719;15782.447614333443;14990.700185996437;15388.769168462706;15460.768088478457;15688.686226275182;15764.290606922486;16140.596485087966;16191.433299834449;16214.432494862624;16339.59151021234;16556.337746490004;9595.376300540442;9976.950115249378;10094.293399461967;10235.795284094425;10296.279260451696;14744.115353078849;14902.850971490147;15075.396984120513;15632;15700 04:09:31 INFO - 2016-01-20 04:09:31,480 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1546.1109861829436;1633.869290456763;1707.6584683063386;1834.3488061738083;1879.5489082620168;7651.770446886595;7855.842883142341;7867.134615192324;7935.246151615602;8281.585920703956;8205.097439281673;8212.548309842956;8215.794605134875;8257.42198046137;8260.793480162998;2250.2124256510256;2292.4612716011725;2292.8165746740306;2306.9884650576723;2307.284741730061;2348.8825558722083;2351.6825228594093;2421.0315873650507;2422.39440139965;2428.429319110008;2329.860208387494;2341.555104530142;2363.8463499872455;2382.4520360317138;2386.6658667786523;2218.0462401167492;2364.196173301077;2385.236724248233;2395.401149712572;2396.6165413533836;2384.594618914771;2391.8564886106888;2397.5444665513496;2404.663347131403;2421.624648179535;8057.838843223103;8168.714095006646;8216.548089855056;8226.341892648574;8246.628901699438;4843.612510999147;4947.529984651453;4956.8760780980765;4966.329545511346;4970.776315065831;3287.3918325109694;3297.505374193866;3325.983370083158;3328.4341661917533;3364.52896594477;1019.5819713917332;1027.085893554737;1029.4132344563602;1046.0428707732415;1062.5112448273726;10995.230333876632;10999.505022273937;11085.113190944705;11086.057685096777;11093.778124437466;4223.619874211336;4302.483701955723;4317.028668549551;4339.631131353807;4396.956030439718;9000.549972501349;9028.413153145024;9041.18629323364;9053.59258833354;9068.773280667903;4767.713937163712;4792.329073929653;4827.106985207748;4829.517048295213;4849.393825771778;4420.248557745127;4437.134758722018;4460.264056430653;4463.04044630406;4471.776411179428;3447.345004449197;3451.4995325677637;3462.9826850865584;3463.9653603463644;3502.6322236165347;1017.6590842067842;1092.918031147667;1113.04834366617;1117.0281854786388;1119.8936101070385;1020.0768304684273;1114.453917580396;1206.221986818497;1294.5533790842144;1359.4358341288453;7136.857262854714;7146.428285737128;7193;7224.963875180591;7249.891251631229;588.3821986913723;596.3827438601027;622.862970146567;631.4127861089139;752.8406254368211;5596.160575913564;5617.915731264035;5653.632513886584;5666.801661941812;5701.71491425427;9868.161206297546;9878.407295562289;9970.351927124713;9983.301168918251;10079.143272821746;9735.951320243496;9815.2147828175;9834.852477212848;9905.405675659484;9961.601535938626;7643.770686879402;7683.462157649023;7685.42359323053;7693.961530192425;7758.689652413953;7128.251533588898;7139.32176443237;7193.064901562972;7214.422846172189;7310.488265821342;8643.783905402415;8812.471251724917;8839.292856571588;8932.642694292155;8974.641014359613;8983.236424903957;8997.100289971213;9046.773830654287;9107.271418286653;9126.45241285525;6898.344657257552;6912.27421120775;6939.89590156138;6951.652417379009;6974.197967233833;7854.096778870503;7872.881906771288;7963.482373645927;7975.840483190188;8018.518888866687;7033.191183013814;7272.309130632581;7298.489105762758;7396.186419493959;7596.468247222641;7120.465965052538;7152.105986751656;7153.928460715326;7215.062041934515;7299.927000729925;7169.318914703095;7207.243239459781;7218.530795498275;7227.566346019255;7236.34872861445;6553;6608.074869518367;6627.072209890523;6629.900551491828;6632.071509988509;6618.90071648916;6769.3907548320885;6797.796066118024;6842.178938527409;6872.244053154049 04:09:31 INFO - 2016-01-20 04:09:31,481 DEBUG : BROWSER_OUTPUT: |4;prototype.html;362.7533277371387;366.6681653103939;374.33929115111835;374.3561074951084;380.77343980331693;6245.687715614224;6332;6333.651649159295;6393.488520918327;6411.679416029203;6164.7534098636115;6235.25176978762;6302.180716506859;6307.968460157705;6323.30443651198;4846.733429661376;4848.7575621218975;4861.246506791453;4862.14912390332;4863.14894893394;4859;4864.075825593143;4865.440474345442;4866.951330486685;4873;4749.335093086971;4841.878953026185;4848.175810112271;4854.029194161164;4858.368412106439;4789;4830.661853670244;4834.661573689843;4834.734089625069;4846.36997190363;4229.429027081335;4238.660907127422;4252.192083504125;4256.297710877701;4277.8288868445225;5887.470127688486;5993.101034844764;6000.459958603747;6011.549133814981;6014.699265036731;5626.1842032905;5637.943620563824;5648.548116150698;5658.830235092953;5664.2636457260705;6685.699143538553;6702.597844129368;6706.798796036127;6710.597364158166;6729.663516824139;4707.317438971364;4732.124556956974;4732.337472753818;4732.621390288768;4746.881327966794;6881.518293719441;6971.442284617218;6990.405815505688;6998.580085194904;7008.334208250208;4832.1543729847135;4835.564799168092;4838.032393521239;4845.6123510119105;4851.029794041206;4901.387326584177;4914.926276105862;4916.385451818523;4919.950800492021;4939.234418665041;5522.420145884625;5620.49415552594;5624.887502250014;5624.91562626561;5626.859328516738;6779.966100169566;6780.762673306411;6783.389494945479;6785;6790.11728475305;1623.1884057971015;1653.8346165383607;1654.346533119411;1656.7349224124082;1692.8814982951321;1098.3300186885992;1120.708615759892;1142.9828552571719;1143.5025763792776;1154.4516354731436;6481.902771458432;6559.540832141704;6575.638339891352;6583.506237032242;6608.537402381787;6929.618870962045;6939.548929319578;6943.166819981533;6971.790846274518;6975.093237879043;6506.544541882023;6573.276939536647;6580.605163690194;6588.945768677085;6607.80176594703;3757.793321367351;3774.75464094833;3783.281176576442;3783.659470647655;3788.6969042476535;7111.1466624004415;7199.964000179965;7202.0637317149485;7202.315780000891;7209.639518024078;6980.860382792316;7127.073480447509;7128.857422851514;7129.750458733919;7137.072180616487;7139.535930164627;7156.427485801123;7199.244079371695;7208.603526805971;7214.134303883463;6824.4199243064895;6897;6927.515073944775;6942;6967.477439191979;6736.461083113437;6801.625910574768;6805.693743781443;6839.384455399038;6855.040294358893;7093.432525397852;7167.534110282815;7168.964155179399;7187.425005999612;7190.96404517974;4678.53214678543;4682.321063445713;4682.461516925461;4690.718556886598;4694.014257006067;6789.1852977643;6859.622720750406;6863.588184708933;6866.210385805696;6872.759453419107;6665;6699.866002680016;6712.798616041527;6766.627835468899;6781.830454238683;6750.729970801113;6751.324867513209;6753.729850805913;6754.223264324665;6771.93228067713;6520.021996700533;6608.570442921195;6630;6638.734450622114;6641.33586641332;6775.220849602359;6780.32196780318;6780.38976492118;6785.592864427953;6794.388505034571;6584.242812076673;6602.1747281589805;6616.603003819786;6624.536282460374;6630.237522684953 04:09:31 INFO - 2016-01-20 04:09:31,481 DEBUG : BROWSER_OUTPUT: |5;yui.html;785.7564155111912;788.3614272439324;941.5527624378417;951.3911096897987;952.8007091531264;14321.355539000744;14415.567532974;14493.275336233186;14503.709925801477;14541;13611;13856.653583660414;13936.79094813576;13938.372773225205;13946.511872084478;766.8734658781294;770.4837758701656;889.7241855024947;903.8644203369481;909.5361365703505;888.626776753765;888.6489836514573;890.4879694175843;893.5219657483248;899.0874262623443;949.2500924269818;958.4057884111826;959.2086528613886;959.4866746290736;959.7360725800426;950.9809803803954;952.2619969523605;953.1850268020846;955.2883102088954;956.4882787708613;693.8230751158472;695.4992405468055;696.6551556979277;696.7735485967081;698.0855079845368;14040.719185616332;14108.717825643533;14188.290585470788;14223.786643200361;14280.214588197645;12500.124991250615;12657;12760.361981900867;13201.60395188146;13301.201927884358;11112.666620001413;11177.017506351685;11277.436128193558;11455.96896279339;11481.253718508271;3840.2319536092614;3904.863329783472;3918.902027449308;3958.604139586047;3968.9801550992347;49235;49350.76623084416;49514.50485495135;49572.256416153425;49645.25532117021;10507;10849.945750271198;11149.21955463126;11162;11231.71920701989;18824.7176292353;18885.716714249298;18891.716624250646;18939.81060189408;18967.62064758697;7437.628118594049;7536.171021187665;7543.547387156788;7657.731979380695;7812.648430820626;4583.977080114578;4671.579557839811;4740.95259047412;4786.904261914742;4792.448868380111;3239.6598357172156;3275.7051865332232;3276.819774912403;3279.868805247811;3283.507473878937;601.1913975702673;604.5465900574569;607.4229481992126;607.9179310793074;612.4549151255386;707.8690442268094;737.303248430239;739.8187444076128;740.5826380030063;746.8020974441778;9216.170544651013;9771.267154963407;9933.503324833873;9954.904960454343;9957.800843983225;642.2004604267623;685.0580451878667;729.2379463460696;755.6221889055472;762.6453699029978;4301.956980430155;4368.126374725004;4396.054848207651;4416.977915110404;4661.790219440133;57913.13130303049;58317;58432.41567584355;58655.41344586585;58676.7066164675;51271.74364128155;51274.743626281626;51586;51979.740101300005;52152.73923630433;48521;48948.510514895104;48979.26531102036;49432;49519.25721114114;9210.861837072584;9240.815183696153;9252.676156334765;9352.802091508354;9386.530673466435;35097;35168.472472912414;35291.647083528835;35570;35618.10954726049;43695.34456983084;44137.33793993029;46572;46926.29610555776;46955.53044469511;10786.622468213574;10985.395803230898;11084.279521831055;11396.715082123013;11522.42387880586;12606.747865042464;12651.177673451197;12660.240385576895;12685.746285074432;12923.806142908052;12485.375731213584;12525.123241373016;12681.746365072831;12787.424565894371;12924.612261632166;12084.45619947087;12096.818547721616;12097.637070887888;12154.574589889311;12463.875361246633;12306.75386492283;12598.55905043319;12640;12664.936675316565;13114.60656180316;10541.894581054092;10644.680659580225;10825.945870270598;10905.34567925927;10976.341419514854;10489.47552622381;10495.737606559896;10651.57393704243;10677.519511622151;10790.244682872124 04:09:31 INFO - 2016-01-20 04:09:31,481 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:09:31 INFO - 2016-01-20 04:09:31,481 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:09:31 INFO - 2016-01-20 04:09:31,481 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,303 04:09:31 INFO - 2016-01-20 04:09:31,481 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:09:31 INFO - 2016-01-20 04:09:31,482 DEBUG : BROWSER_OUTPUT: __startTimestamp1453291771473__endTimestamp 04:09:31 INFO - 2016-01-20 04:09:31,482 DEBUG : BROWSER_OUTPUT: 04:09:31 INFO - 2016-01-20 04:09:31,482 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:09:31 INFO - 2016-01-20 04:09:31,482 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:09:31 INFO - 2016-01-20 04:09:31,482 DEBUG : BROWSER_OUTPUT: 04:09:31 INFO - 2016-01-20 04:09:31,482 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5588.01 Median:5780.42 stddev:623.96 (10.8%) stddev-sans-first:599.23 04:09:31 INFO - 2016-01-20 04:09:31,483 DEBUG : BROWSER_OUTPUT: Values: 3288.2 3318.6 3329.8 3356.3 3361.5 5481.5 5508.8 5517.1 5519.6 5526.9 5536.9 5619.9 5642.5 5658.9 5665.5 5108.1 5168.0 5201.6 5204.9 5227.8 4978.9 5062.2 5070.1 5073.8 5075.4 5102.2 5165.1 5165.5 5201.0 5255.3 5110.6 5131.4 5135.4 5145.4 5173.0 4955.6 4994.9 5052.2 5063.9 5119.5 5303.0 5351.6 5379.4 5422.0 5426.1 5884.4 5925.6 5970.6 5972.3 5997.6 5894.7 5983.5 6035.3 6039.5 6057.3 5683.3 5695.3 5698.9 5714.4 5715.9 6150.9 6158.8 6168.7 6195.4 6204.0 5771.1 5797.9 5932.2 5958.8 6075.0 6051.1 6061.9 6073.8 6083.5 6098.8 6010.8 6016.3 6047.1 6049.8 6051.7 5720.8 5815.3 6032.9 6121.5 6125.1 4607.3 4612.5 4627.0 4629.1 4640.8 4075.3 4133.6 4137.3 4141.5 4147.2 5695.0 5713.3 5718.7 5823.2 5845.5 5941.3 5943.6 5968.2 5971.3 5992.4 5569.9 5622.9 5729.5 5735.2 5746.7 5264.5 5283.0 5305.3 5313.0 5381.5 6153.8 6187.0 6192.9 6196.4 6217.4 5837.4 5943.2 5978.2 6005.5 6010.6 6253.7 6303.2 6304.7 6305.9 6306.8 5966.6 6018.3 6018.4 6024.3 6024.9 5800.4 5903.9 5953.8 6064.3 6124.9 5948.0 5966.8 5969.6 5975.4 5978.3 5893.5 5936.6 5960.3 5970.9 5973.2 5607.4 5731.9 5780.4 5877.0 5903.4 5749.9 5807.5 5837.7 5885.4 5988.9 5583.3 5761.9 5763.9 5765.6 5794.7 04:09:31 INFO - 2016-01-20 04:09:31,483 DEBUG : BROWSER_OUTPUT: 04:09:31 INFO - 2016-01-20 04:09:31,483 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:57982.65 Median:22641.54 stddev:125570.19 (554.6%) stddev-sans-first:125848.47 04:09:31 INFO - 2016-01-20 04:09:31,483 DEBUG : BROWSER_OUTPUT: Values: 577.3 623.7 639.8 652.2 678.5 32649.7 33245.3 37417.4 37699.6 37858.2 41874.2 42476.4 42528.0 42545.1 42570.1 9026.1 9179.7 9198.4 9206.2 9226.7 9026.4 9095.6 9143.5 9177.2 9203.4 9060.7 9061.2 9112.9 9159.0 9180.9 9062.3 9083.5 9170.7 9172.7 9175.7 8984.5 9163.9 9164.6 9166.7 9178.5 40523.6 40581.0 40859.0 41246.8 41347.2 3600.4 3628.9 3716.3 3800.4 4115.9 31002.5 31384.5 31405.7 31664.0 32077.0 4300.3 4327.6 4331.4 4337.8 4406.8 277300.0 277945.6 278241.0 278518.0 279782.0 44371.6 45655.8 45733.5 45805.5 57878.0 46271.5 46331.3 46450.3 46506.0 46738.3 15717.2 15772.2 15942.6 15960.0 15965.8 12944.6 12991.3 13104.8 13165.1 13194.6 14498.9 14502.9 14512.3 14543.5 14788.0 6071.8 6131.1 6131.4 6160.8 6187.2 965.3 974.9 1088.7 1096.5 1103.9 27072.2 27263.7 27296.0 27816.4 27940.2 1010.6 1016.8 1034.2 1045.4 1088.5 14788.5 14878.8 15048.7 15103.6 15173.4 684916.0 686682.0 688201.0 690634.0 726663.0 55406.0 55628.2 55745.7 55752.0 55920.0 1500.0 1507.9 1508.4 1516.9 1521.4 29395.4 30364.1 33219.2 33663.3 33902.8 52342.0 52664.0 52881.2 53150.7 53258.7 303419.0 307306.0 307398.0 307897.0 308282.0 42129.4 42425.4 43120.4 43209.4 43483.6 45670.5 46350.3 47020.5 47296.0 47480.3 39284.0 39346.2 39858.0 40583.8 40855.6 41167.2 41492.4 41521.4 42624.8 43503.6 36945.3 37340.0 37533.4 37639.8 37653.0 33416.5 33926.5 34037.0 37100.0 37885.8 26202.6 26453.9 26628.9 26680.0 27071.3 04:09:31 INFO - 2016-01-20 04:09:31,484 DEBUG : BROWSER_OUTPUT: 04:09:31 INFO - 2016-01-20 04:09:31,484 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30145.81 Median:2016.25 stddev:94146.99 (4669.4%) stddev-sans-first:94384.58 04:09:31 INFO - 2016-01-20 04:09:31,484 DEBUG : BROWSER_OUTPUT: Values: 391.6 397.8 398.8 402.1 405.3 15527.4 15590.5 17101.4 17514.0 17588.5 11382.7 11470.9 11533.0 11671.4 11788.8 4874.8 4880.4 4975.7 4976.7 4981.9 4961.3 5143.6 5290.3 5292.1 5293.9 5198.4 5206.3 5228.4 5253.2 5464.5 5408.9 5413.0 5420.5 5428.5 5457.3 5224.1 5229.2 5253.9 5262.0 5502.8 13039.4 13216.5 13301.5 14563.5 20977.1 2147.8 2162.6 2213.2 2259.2 2326.6 10003.9 10113.0 10195.5 12324.3 13302.7 1847.0 1865.9 1899.8 1935.5 2031.6 63157.7 63239.0 65487.3 65833.0 65954.7 10929.6 10953.5 10956.6 10990.7 11076.9 14033.6 14089.4 14169.8 14176.8 14198.9 7695.2 7747.5 7825.3 8107.1 8128.7 7546.2 7593.5 7629.8 7679.2 7689.5 4595.9 4612.6 4624.0 4684.2 4706.2 1915.3 1971.1 1990.3 1998.4 2000.9 862.7 910.8 995.2 1023.4 1027.7 14692.6 16623.2 17077.2 17756.8 17778.8 944.3 972.3 990.4 1010.3 1013.9 9550.5 9831.2 9919.6 9971.7 10381.3 565704.0 570082.0 573357.0 583135.0 588621.0 78009.6 80175.6 80557.0 81024.0 81578.2 1116.7 1137.3 1142.9 1144.4 1145.6 15234.8 15345.2 15428.8 15524.5 15624.8 35899.6 36912.8 36955.6 36986.8 37085.3 48626.0 48920.5 50808.0 51091.5 51097.2 10115.3 10234.0 10257.8 10343.9 10431.7 12452.8 17283.7 17822.8 17881.0 18123.7 15408.1 15466.1 15585.8 15761.4 15782.4 14990.7 15388.8 15460.8 15688.7 15764.3 16140.6 16191.4 16214.4 16339.6 16556.3 9595.4 9977.0 10094.3 10235.8 10296.3 14744.1 14902.9 15075.4 15632.0 15700.0 04:09:31 INFO - 2016-01-20 04:09:31,484 DEBUG : BROWSER_OUTPUT: 04:09:31 INFO - 2016-01-20 04:09:31,484 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5628.28 Median:6580.54 stddev:2960.65 (45.0%) stddev-sans-first:2953.06 04:09:31 INFO - 2016-01-20 04:09:31,485 DEBUG : BROWSER_OUTPUT: Values: 1546.1 1633.9 1707.7 1834.3 1879.5 7651.8 7855.8 7867.1 7935.2 8281.6 8205.1 8212.5 8215.8 8257.4 8260.8 2250.2 2292.5 2292.8 2307.0 2307.3 2348.9 2351.7 2421.0 2422.4 2428.4 2329.9 2341.6 2363.8 2382.5 2386.7 2218.0 2364.2 2385.2 2395.4 2396.6 2384.6 2391.9 2397.5 2404.7 2421.6 8057.8 8168.7 8216.5 8226.3 8246.6 4843.6 4947.5 4956.9 4966.3 4970.8 3287.4 3297.5 3326.0 3328.4 3364.5 1019.6 1027.1 1029.4 1046.0 1062.5 10995.2 10999.5 11085.1 11086.1 11093.8 4223.6 4302.5 4317.0 4339.6 4397.0 9000.5 9028.4 9041.2 9053.6 9068.8 4767.7 4792.3 4827.1 4829.5 4849.4 4420.2 4437.1 4460.3 4463.0 4471.8 3447.3 3451.5 3463.0 3464.0 3502.6 1017.7 1092.9 1113.0 1117.0 1119.9 1020.1 1114.5 1206.2 1294.6 1359.4 7136.9 7146.4 7193.0 7225.0 7249.9 588.4 596.4 622.9 631.4 752.8 5596.2 5617.9 5653.6 5666.8 5701.7 9868.2 9878.4 9970.4 9983.3 10079.1 9736.0 9815.2 9834.9 9905.4 9961.6 7643.8 7683.5 7685.4 7694.0 7758.7 7128.3 7139.3 7193.1 7214.4 7310.5 8643.8 8812.5 8839.3 8932.6 8974.6 8983.2 8997.1 9046.8 9107.3 9126.5 6898.3 6912.3 6939.9 6951.7 6974.2 7854.1 7872.9 7963.5 7975.8 8018.5 7033.2 7272.3 7298.5 7396.2 7596.5 7120.5 7152.1 7153.9 7215.1 7299.9 7169.3 7207.2 7218.5 7227.6 7236.3 6553.0 6608.1 6627.1 6629.9 6632.1 6618.9 6769.4 6797.8 6842.2 6872.2 04:09:31 INFO - 2016-01-20 04:09:31,485 DEBUG : BROWSER_OUTPUT: 04:09:31 INFO - 2016-01-20 04:09:31,486 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5633.78 Median:6494.22 stddev:1694.09 (26.1%) stddev-sans-first:1652.00 04:09:31 INFO - 2016-01-20 04:09:31,487 DEBUG : BROWSER_OUTPUT: Values: 362.8 366.7 374.3 374.4 380.8 6245.7 6332.0 6333.7 6393.5 6411.7 6164.8 6235.3 6302.2 6308.0 6323.3 4846.7 4848.8 4861.2 4862.1 4863.1 4859.0 4864.1 4865.4 4867.0 4873.0 4749.3 4841.9 4848.2 4854.0 4858.4 4789.0 4830.7 4834.7 4834.7 4846.4 4229.4 4238.7 4252.2 4256.3 4277.8 5887.5 5993.1 6000.5 6011.5 6014.7 5626.2 5637.9 5648.5 5658.8 5664.3 6685.7 6702.6 6706.8 6710.6 6729.7 4707.3 4732.1 4732.3 4732.6 4746.9 6881.5 6971.4 6990.4 6998.6 7008.3 4832.2 4835.6 4838.0 4845.6 4851.0 4901.4 4914.9 4916.4 4920.0 4939.2 5522.4 5620.5 5624.9 5624.9 5626.9 6780.0 6780.8 6783.4 6785.0 6790.1 1623.2 1653.8 1654.3 1656.7 1692.9 1098.3 1120.7 1143.0 1143.5 1154.5 6481.9 6559.5 6575.6 6583.5 6608.5 6929.6 6939.5 6943.2 6971.8 6975.1 6506.5 6573.3 6580.6 6588.9 6607.8 3757.8 3774.8 3783.3 3783.7 3788.7 7111.1 7200.0 7202.1 7202.3 7209.6 6980.9 7127.1 7128.9 7129.8 7137.1 7139.5 7156.4 7199.2 7208.6 7214.1 6824.4 6897.0 6927.5 6942.0 6967.5 6736.5 6801.6 6805.7 6839.4 6855.0 7093.4 7167.5 7169.0 7187.4 7191.0 4678.5 4682.3 4682.5 4690.7 4694.0 6789.2 6859.6 6863.6 6866.2 6872.8 6665.0 6699.9 6712.8 6766.6 6781.8 6750.7 6751.3 6753.7 6754.2 6771.9 6520.0 6608.6 6630.0 6638.7 6641.3 6775.2 6780.3 6780.4 6785.6 6794.4 6584.2 6602.2 6616.6 6624.5 6630.2 04:09:31 INFO - 2016-01-20 04:09:31,487 DEBUG : BROWSER_OUTPUT: 04:09:31 INFO - 2016-01-20 04:09:31,487 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14422.48 Median:4500.48 stddev:16250.38 (361.1%) stddev-sans-first:16263.69 04:09:31 INFO - 2016-01-20 04:09:31,488 DEBUG : BROWSER_OUTPUT: Values: 785.8 788.4 941.6 951.4 952.8 14321.4 14415.6 14493.3 14503.7 14541.0 13611.0 13856.7 13936.8 13938.4 13946.5 766.9 770.5 889.7 903.9 909.5 888.6 888.6 890.5 893.5 899.1 949.3 958.4 959.2 959.5 959.7 951.0 952.3 953.2 955.3 956.5 693.8 695.5 696.7 696.8 698.1 14040.7 14108.7 14188.3 14223.8 14280.2 12500.1 12657.0 12760.4 13201.6 13301.2 11112.7 11177.0 11277.4 11456.0 11481.3 3840.2 3904.9 3918.9 3958.6 3969.0 49235.0 49350.8 49514.5 49572.3 49645.3 10507.0 10849.9 11149.2 11162.0 11231.7 18824.7 18885.7 18891.7 18939.8 18967.6 7437.6 7536.2 7543.5 7657.7 7812.6 4584.0 4671.6 4741.0 4786.9 4792.4 3239.7 3275.7 3276.8 3279.9 3283.5 601.2 604.5 607.4 607.9 612.5 707.9 737.3 739.8 740.6 746.8 9216.2 9771.3 9933.5 9954.9 9957.8 642.2 685.1 729.2 755.6 762.6 4302.0 4368.1 4396.1 4417.0 4661.8 57913.1 58317.0 58432.4 58655.4 58676.7 51271.7 51274.7 51586.0 51979.7 52152.7 48521.0 48948.5 48979.3 49432.0 49519.3 9210.9 9240.8 9252.7 9352.8 9386.5 35097.0 35168.5 35291.6 35570.0 35618.1 43695.3 44137.3 46572.0 46926.3 46955.5 10786.6 10985.4 11084.3 11396.7 11522.4 12606.7 12651.2 12660.2 12685.7 12923.8 12485.4 12525.1 12681.7 12787.4 12924.6 12084.5 12096.8 12097.6 12154.6 12463.9 12306.8 12598.6 12640.0 12664.9 13114.6 10541.9 10644.7 10825.9 10905.3 10976.3 10489.5 10495.7 10651.6 10677.5 10790.2 04:09:31 INFO - 2016-01-20 04:09:31,488 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:09:31 INFO - 2016-01-20 04:09:31,488 DEBUG : BROWSER_OUTPUT: 04:09:32 INFO - 2016-01-20 04:09:32,237 INFO : Browser exited with error code: 0 04:09:32 INFO - 2016-01-20 04:09:32,256 INFO : Completed test dromaeo_css (00:18:29) 04:09:32 INFO - 2016-01-20 04:09:32,256 INFO : Starting test kraken 04:09:32 INFO - 2016-01-20 04:09:32,256 DEBUG : operating with platform_type : linux_ 04:09:32 INFO - 2016-01-20 04:09:32,256 INFO : Initialising browser for kraken test... 04:09:32 INFO - 2016-01-20 04:09:32,262 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp08_nFt/profile http://localhost:33422/getInfo.html 04:09:36 INFO - 2016-01-20 04:09:36,481 DEBUG : BROWSER_OUTPUT: 04:09:36 INFO - 2016-01-20 04:09:36,481 DEBUG : BROWSER_OUTPUT: (process:30691): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:09:37 INFO - 2016-01-20 04:09:37,505 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:09:37 INFO - 2016-01-20 04:09:37,505 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:09:37 INFO - 2016-01-20 04:09:37,505 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:09:37 INFO - 2016-01-20 04:09:37,505 DEBUG : BROWSER_OUTPUT: __metrics 04:09:37 INFO - 2016-01-20 04:09:37,694 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:09:38 INFO - 2016-01-20 04:09:38,605 INFO : Browser initialized. 04:09:38 INFO - 2016-01-20 04:09:38,606 INFO : Running cycle 1/1 for kraken test... 04:09:38 INFO - 2016-01-20 04:09:38,606 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp08_nFt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:09:39 INFO - 2016-01-20 04:09:39,878 DEBUG : BROWSER_OUTPUT: 04:09:39 INFO - 2016-01-20 04:09:39,878 DEBUG : BROWSER_OUTPUT: (process:30806): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:09:50 INFO - 2016-01-20 04:09:50,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 136011776 04:09:50 INFO - 2016-01-20 04:09:50,382 DEBUG : BROWSER_OUTPUT: 04:09:52 INFO - 2016-01-20 04:09:52,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33422/tests/kraken/driver.html?testName=audio-beat-detection) 04:09:53 INFO - 2016-01-20 04:09:53,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 137490432 04:09:53 INFO - 2016-01-20 04:09:53,415 DEBUG : BROWSER_OUTPUT: 04:09:56 INFO - 2016-01-20 04:09:56,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33422/tests/kraken/driver.html?testName=audio-dft) 04:09:56 INFO - 2016-01-20 04:09:56,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 138563584 04:09:56 INFO - 2016-01-20 04:09:56,598 DEBUG : BROWSER_OUTPUT: 04:09:59 INFO - 2016-01-20 04:09:59,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33422/tests/kraken/driver.html?testName=audio-fft) 04:09:59 INFO - 2016-01-20 04:09:59,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 137728000 04:09:59 INFO - 2016-01-20 04:09:59,983 DEBUG : BROWSER_OUTPUT: 04:10:01 INFO - 2016-01-20 04:10:01,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33422/tests/kraken/driver.html?testName=audio-oscillator) 04:10:02 INFO - 2016-01-20 04:10:02,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 138899456 04:10:02 INFO - 2016-01-20 04:10:02,567 DEBUG : BROWSER_OUTPUT: 04:10:04 INFO - 2016-01-20 04:10:04,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33422/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:10:05 INFO - 2016-01-20 04:10:05,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 137584640 04:10:05 INFO - 2016-01-20 04:10:05,328 DEBUG : BROWSER_OUTPUT: 04:10:08 INFO - 2016-01-20 04:10:08,267 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33422/tests/kraken/driver.html?testName=imaging-darkroom) 04:10:08 INFO - 2016-01-20 04:10:08,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 138252288 04:10:08 INFO - 2016-01-20 04:10:08,868 DEBUG : BROWSER_OUTPUT: 04:10:12 INFO - 2016-01-20 04:10:12,202 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33422/tests/kraken/driver.html?testName=imaging-desaturate) 04:10:12 INFO - 2016-01-20 04:10:12,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 138637312 04:10:12 INFO - 2016-01-20 04:10:12,789 DEBUG : BROWSER_OUTPUT: 04:10:15 INFO - 2016-01-20 04:10:15,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33422/tests/kraken/driver.html?testName=json-parse-financial) 04:10:16 INFO - 2016-01-20 04:10:16,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 138321920 04:10:16 INFO - 2016-01-20 04:10:16,187 DEBUG : BROWSER_OUTPUT: 04:10:17 INFO - 2016-01-20 04:10:17,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33422/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:10:18 INFO - 2016-01-20 04:10:18,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 139255808 04:10:18 INFO - 2016-01-20 04:10:18,330 DEBUG : BROWSER_OUTPUT: 04:10:20 INFO - 2016-01-20 04:10:20,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33422/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:10:20 INFO - 2016-01-20 04:10:20,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 139763712 04:10:20 INFO - 2016-01-20 04:10:20,702 DEBUG : BROWSER_OUTPUT: 04:10:22 INFO - 2016-01-20 04:10:22,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33422/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:10:23 INFO - 2016-01-20 04:10:23,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 139493376 04:10:23 INFO - 2016-01-20 04:10:23,316 DEBUG : BROWSER_OUTPUT: 04:10:25 INFO - 2016-01-20 04:10:25,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33422/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:10:26 INFO - 2016-01-20 04:10:26,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 138326016 04:10:26 INFO - 2016-01-20 04:10:26,292 DEBUG : BROWSER_OUTPUT: 04:10:28 INFO - 2016-01-20 04:10:28,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33422/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:10:29 INFO - 2016-01-20 04:10:29,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 137908224 04:10:29 INFO - 2016-01-20 04:10:29,373 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,022 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33422/tests/kraken/driver.html?testName=ai-astar) 04:10:31 INFO - 2016-01-20 04:10:31,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 138702848 04:10:31 INFO - 2016-01-20 04:10:31,273 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,274 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:10:31 INFO - 2016-01-20 04:10:31,274 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:10:31 INFO - 2016-01-20 04:10:31,275 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:10:31 INFO - 2016-01-20 04:10:31,275 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:10:31 INFO - 2016-01-20 04:10:31,275 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;105;110;108;111;119;110;112;110;109 04:10:31 INFO - 2016-01-20 04:10:31,276 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;127;145;164;130;146;144;125;159;128 04:10:31 INFO - 2016-01-20 04:10:31,276 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;160;164;160;160;160;163;161 04:10:31 INFO - 2016-01-20 04:10:31,276 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;72;150;74;73;73;71;155;72 04:10:31 INFO - 2016-01-20 04:10:31,277 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;139;93;93;94;139;92;91;131 04:10:31 INFO - 2016-01-20 04:10:31,277 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;109;113;111;110;111;110 04:10:31 INFO - 2016-01-20 04:10:31,277 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;146;149;149;147;145;146;146;146 04:10:31 INFO - 2016-01-20 04:10:31,277 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;95;95;96;97;96;96 04:10:31 INFO - 2016-01-20 04:10:31,278 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;62;60;60;62;59;59;60;65;57 04:10:31 INFO - 2016-01-20 04:10:31,278 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;62;62;64;63;64;63;63;64 04:10:31 INFO - 2016-01-20 04:10:31,278 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;81;83;82;82;89;82;81;90;82 04:10:31 INFO - 2016-01-20 04:10:31,279 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;113;121;120;123;112;118;124;126;110 04:10:31 INFO - 2016-01-20 04:10:31,279 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;153;144;144;145;144;147;144;143;137 04:10:31 INFO - 2016-01-20 04:10:31,279 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;66;65;65;66;64;65;65;64 04:10:31 INFO - 2016-01-20 04:10:31,279 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:10:31 INFO - 2016-01-20 04:10:31,280 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:10:31 INFO - 2016-01-20 04:10:31,280 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,696 04:10:31 INFO - 2016-01-20 04:10:31,280 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:10:31 INFO - 2016-01-20 04:10:31,280 DEBUG : BROWSER_OUTPUT: __startTimestamp1453291831272__endTimestamp 04:10:31 INFO - 2016-01-20 04:10:31,281 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,281 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:10:31 INFO - 2016-01-20 04:10:31,281 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:10:31 INFO - 2016-01-20 04:10:31,281 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,282 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.40 Median:110.00 stddev:3.57 (3.2%) stddev-sans-first:3.78 04:10:31 INFO - 2016-01-20 04:10:31,282 DEBUG : BROWSER_OUTPUT: Values: 110.0 105.0 110.0 108.0 111.0 119.0 110.0 112.0 110.0 109.0 04:10:31 INFO - 2016-01-20 04:10:31,282 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,283 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.40 Median:145.50 stddev:14.34 (9.9%) stddev-sans-first:14.34 04:10:31 INFO - 2016-01-20 04:10:31,283 DEBUG : BROWSER_OUTPUT: Values: 156.0 127.0 145.0 164.0 130.0 146.0 144.0 125.0 159.0 128.0 04:10:31 INFO - 2016-01-20 04:10:31,283 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,283 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.90 Median:160.50 stddev:1.45 (0.9%) stddev-sans-first:1.54 04:10:31 INFO - 2016-01-20 04:10:31,284 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 160.0 164.0 160.0 160.0 160.0 163.0 161.0 04:10:31 INFO - 2016-01-20 04:10:31,284 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,284 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.60 Median:73.00 stddev:33.71 (46.2%) stddev-sans-first:35.28 04:10:31 INFO - 2016-01-20 04:10:31,284 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 72.0 150.0 74.0 73.0 73.0 71.0 155.0 72.0 04:10:31 INFO - 2016-01-20 04:10:31,285 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,285 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.70 Median:92.50 stddev:21.27 (23.0%) stddev-sans-first:21.97 04:10:31 INFO - 2016-01-20 04:10:31,286 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 139.0 93.0 93.0 94.0 139.0 92.0 91.0 131.0 04:10:31 INFO - 2016-01-20 04:10:31,286 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,286 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:1.16 (1.1%) stddev-sans-first:1.13 04:10:31 INFO - 2016-01-20 04:10:31,286 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 109.0 113.0 111.0 110.0 111.0 110.0 04:10:31 INFO - 2016-01-20 04:10:31,287 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,287 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.37 (0.9%) stddev-sans-first:1.45 04:10:31 INFO - 2016-01-20 04:10:31,287 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 146.0 149.0 149.0 147.0 145.0 146.0 146.0 146.0 04:10:31 INFO - 2016-01-20 04:10:31,287 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,287 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:10:31 INFO - 2016-01-20 04:10:31,287 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 95.0 95.0 96.0 97.0 96.0 96.0 04:10:31 INFO - 2016-01-20 04:10:31,287 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,287 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.00 stddev:2.30 (3.8%) stddev-sans-first:2.30 04:10:31 INFO - 2016-01-20 04:10:31,287 DEBUG : BROWSER_OUTPUT: Values: 58.0 62.0 60.0 60.0 62.0 59.0 59.0 60.0 65.0 57.0 04:10:31 INFO - 2016-01-20 04:10:31,288 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,288 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 04:10:31 INFO - 2016-01-20 04:10:31,288 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 62.0 62.0 64.0 63.0 64.0 63.0 63.0 64.0 04:10:31 INFO - 2016-01-20 04:10:31,288 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,288 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:82.00 stddev:3.43 (4.2%) stddev-sans-first:3.43 04:10:31 INFO - 2016-01-20 04:10:31,288 DEBUG : BROWSER_OUTPUT: Values: 80.0 81.0 83.0 82.0 82.0 89.0 82.0 81.0 90.0 82.0 04:10:31 INFO - 2016-01-20 04:10:31,288 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,288 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:120.50 stddev:5.44 (4.5%) stddev-sans-first:5.70 04:10:31 INFO - 2016-01-20 04:10:31,288 DEBUG : BROWSER_OUTPUT: Values: 116.0 113.0 121.0 120.0 123.0 112.0 118.0 124.0 126.0 110.0 04:10:31 INFO - 2016-01-20 04:10:31,288 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,289 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.50 Median:144.00 stddev:3.92 (2.7%) stddev-sans-first:4.16 04:10:31 INFO - 2016-01-20 04:10:31,289 DEBUG : BROWSER_OUTPUT: Values: 144.0 153.0 144.0 144.0 145.0 144.0 147.0 144.0 143.0 137.0 04:10:31 INFO - 2016-01-20 04:10:31,289 DEBUG : BROWSER_OUTPUT: 04:10:31 INFO - 2016-01-20 04:10:31,289 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 04:10:31 INFO - 2016-01-20 04:10:31,289 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 66.0 65.0 65.0 66.0 64.0 65.0 65.0 64.0 04:10:31 INFO - 2016-01-20 04:10:31,289 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:10:31 INFO - 2016-01-20 04:10:31,289 DEBUG : BROWSER_OUTPUT: 04:10:32 INFO - 2016-01-20 04:10:32,337 INFO : Browser exited with error code: 0 04:10:32 INFO - 2016-01-20 04:10:32,392 INFO : Completed test kraken (00:01:00) 04:10:32 INFO - 2016-01-20 04:10:32,392 INFO : Starting test v8_7 04:10:32 INFO - 2016-01-20 04:10:32,392 DEBUG : operating with platform_type : linux_ 04:10:32 INFO - 2016-01-20 04:10:32,392 INFO : Initialising browser for v8_7 test... 04:10:32 INFO - 2016-01-20 04:10:32,399 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps_NpHF/profile http://localhost:33422/getInfo.html 04:10:36 INFO - 2016-01-20 04:10:36,667 DEBUG : BROWSER_OUTPUT: 04:10:36 INFO - 2016-01-20 04:10:36,668 DEBUG : BROWSER_OUTPUT: (process:31113): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:10:37 INFO - 2016-01-20 04:10:37,612 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:10:37 INFO - 2016-01-20 04:10:37,612 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:10:37 INFO - 2016-01-20 04:10:37,612 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:10:37 INFO - 2016-01-20 04:10:37,612 DEBUG : BROWSER_OUTPUT: __metrics 04:10:38 INFO - 2016-01-20 04:10:38,593 INFO : Browser initialized. 04:10:38 INFO - 2016-01-20 04:10:38,594 INFO : Running cycle 1/1 for v8_7 test... 04:10:38 INFO - 2016-01-20 04:10:38,594 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps_NpHF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:10:39 INFO - 2016-01-20 04:10:39,885 DEBUG : BROWSER_OUTPUT: 04:10:39 INFO - 2016-01-20 04:10:39,885 DEBUG : BROWSER_OUTPUT: (process:31225): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:10:50 INFO - 2016-01-20 04:10:50,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 136531968 04:10:50 INFO - 2016-01-20 04:10:50,384 DEBUG : BROWSER_OUTPUT: 04:11:11 INFO - 2016-01-20 04:11:11,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33422/tests/v8_7/run.html (next: http://localhost:33422/tests/v8_7/run.html) 04:11:11 INFO - 2016-01-20 04:11:11,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 136286208 04:11:11 INFO - 2016-01-20 04:11:11,994 DEBUG : BROWSER_OUTPUT: 04:11:11 INFO - 2016-01-20 04:11:11,995 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:11:11 INFO - 2016-01-20 04:11:11,995 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:11:11 INFO - 2016-01-20 04:11:11,995 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:11:11 INFO - 2016-01-20 04:11:11,995 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:11:11 INFO - 2016-01-20 04:11:11,995 DEBUG : BROWSER_OUTPUT: |0;Richards;167.7008217340265 04:11:11 INFO - 2016-01-20 04:11:11,995 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.0843776106934 04:11:11 INFO - 2016-01-20 04:11:11,995 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.00945232137894 04:11:11 INFO - 2016-01-20 04:11:11,995 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 04:11:11 INFO - 2016-01-20 04:11:11,995 DEBUG : BROWSER_OUTPUT: |4;RayTrace;932.8358208955224 04:11:11 INFO - 2016-01-20 04:11:11,995 DEBUG : BROWSER_OUTPUT: |5;Earley;549.4505494505495 04:11:11 INFO - 2016-01-20 04:11:11,995 DEBUG : BROWSER_OUTPUT: |6;Boyer;11021.978021978022 04:11:11 INFO - 2016-01-20 04:11:11,995 DEBUG : BROWSER_OUTPUT: |7;RegExp;24707.317073170732 04:11:11 INFO - 2016-01-20 04:11:11,996 DEBUG : BROWSER_OUTPUT: |8;Splay;518.4033177812338 04:11:11 INFO - 2016-01-20 04:11:11,996 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 04:11:11 INFO - 2016-01-20 04:11:11,996 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:11:11 INFO - 2016-01-20 04:11:11,996 DEBUG : BROWSER_OUTPUT: __startTimestamp1453291871994__endTimestamp 04:11:11 INFO - 2016-01-20 04:11:11,996 DEBUG : BROWSER_OUTPUT: 04:11:11 INFO - 2016-01-20 04:11:11,996 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:11:11 INFO - 2016-01-20 04:11:11,996 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:11:11 INFO - 2016-01-20 04:11:11,996 DEBUG : BROWSER_OUTPUT: 04:11:11 INFO - 2016-01-20 04:11:11,996 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.70 Median:167.70 stddev:0.00 (0.0%) 04:11:12 INFO - 2016-01-20 04:11:11,996 DEBUG : BROWSER_OUTPUT: Values: 167.7 04:11:12 INFO - 2016-01-20 04:11:11,996 DEBUG : BROWSER_OUTPUT: 04:11:12 INFO - 2016-01-20 04:11:11,996 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.08 Median:167.08 stddev:0.00 (0.0%) 04:11:12 INFO - 2016-01-20 04:11:11,997 DEBUG : BROWSER_OUTPUT: Values: 167.1 04:11:12 INFO - 2016-01-20 04:11:11,997 DEBUG : BROWSER_OUTPUT: 04:11:12 INFO - 2016-01-20 04:11:11,997 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 04:11:12 INFO - 2016-01-20 04:11:11,997 DEBUG : BROWSER_OUTPUT: Values: 278.0 04:11:12 INFO - 2016-01-20 04:11:11,997 DEBUG : BROWSER_OUTPUT: 04:11:12 INFO - 2016-01-20 04:11:11,997 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 04:11:12 INFO - 2016-01-20 04:11:11,998 DEBUG : BROWSER_OUTPUT: Values: 5202.1 04:11:12 INFO - 2016-01-20 04:11:11,998 DEBUG : BROWSER_OUTPUT: 04:11:12 INFO - 2016-01-20 04:11:11,998 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:932.84 Median:932.84 stddev:0.00 (0.0%) 04:11:12 INFO - 2016-01-20 04:11:11,998 DEBUG : BROWSER_OUTPUT: Values: 932.8 04:11:12 INFO - 2016-01-20 04:11:11,998 DEBUG : BROWSER_OUTPUT: 04:11:12 INFO - 2016-01-20 04:11:11,999 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:549.45 Median:549.45 stddev:0.00 (0.0%) 04:11:12 INFO - 2016-01-20 04:11:11,999 DEBUG : BROWSER_OUTPUT: Values: 549.5 04:11:12 INFO - 2016-01-20 04:11:11,999 DEBUG : BROWSER_OUTPUT: 04:11:12 INFO - 2016-01-20 04:11:11,999 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11021.98 Median:11021.98 stddev:0.00 (0.0%) 04:11:12 INFO - 2016-01-20 04:11:11,999 DEBUG : BROWSER_OUTPUT: Values: 11022.0 04:11:12 INFO - 2016-01-20 04:11:11,999 DEBUG : BROWSER_OUTPUT: 04:11:12 INFO - 2016-01-20 04:11:12,000 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24707.32 Median:24707.32 stddev:0.00 (0.0%) 04:11:12 INFO - 2016-01-20 04:11:12,000 DEBUG : BROWSER_OUTPUT: Values: 24707.3 04:11:12 INFO - 2016-01-20 04:11:12,000 DEBUG : BROWSER_OUTPUT: 04:11:12 INFO - 2016-01-20 04:11:12,000 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:518.40 Median:518.40 stddev:0.00 (0.0%) 04:11:12 INFO - 2016-01-20 04:11:12,001 DEBUG : BROWSER_OUTPUT: Values: 518.4 04:11:12 INFO - 2016-01-20 04:11:12,001 DEBUG : BROWSER_OUTPUT: 04:11:12 INFO - 2016-01-20 04:11:12,001 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:11:12 INFO - 2016-01-20 04:11:12,001 DEBUG : BROWSER_OUTPUT: Values: 4840.6 04:11:12 INFO - 2016-01-20 04:11:12,002 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:11:12 INFO - 2016-01-20 04:11:12,002 DEBUG : BROWSER_OUTPUT: 04:11:12 INFO - 2016-01-20 04:11:12,889 INFO : Browser exited with error code: 0 04:11:12 INFO - 2016-01-20 04:11:12,904 INFO : Completed test v8_7 (00:00:40) 04:11:13 INFO - 2016-01-20 04:11:13,065 INFO : Completed test suite (00:20:10) 04:11:13 INFO - 2016-01-20 04:11:13,066 DEBUG : Working with test: dromaeo_css 04:11:13 INFO - 2016-01-20 04:11:13,066 DEBUG : Generating results file: dromaeo_css 04:11:13 INFO - 2016-01-20 04:11:13,067 DEBUG : Working with test: kraken 04:11:13 INFO - 2016-01-20 04:11:13,067 DEBUG : Generating results file: kraken 04:11:13 INFO - 2016-01-20 04:11:13,068 INFO : javascript benchmark 04:11:13 INFO - 2016-01-20 04:11:13,068 DEBUG : Working with test: v8_7 04:11:13 INFO - 2016-01-20 04:11:13,068 DEBUG : Generating results file: v8_7 04:11:13 INFO - 2016-01-20 04:11:13,068 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:11:13 INFO - 2016-01-20 04:11:13,127 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 04:11:13 INFO - 2016-01-20 04:11:13,127 DEBUG : process_Request line: dromaeo_css 7315.12 graph.html#tests=[[72,52,43]] 04:11:13 INFO - 2016-01-20 04:11:13,127 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:11:13 INFO - 2016-01-20 04:11:13,157 DEBUG : process_Request line: kraken 1495.40 graph.html#tests=[[232,52,43]] 04:11:13 INFO - 2016-01-20 04:11:13,157 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:11:13 INFO - 2016-01-20 04:11:13,193 DEBUG : process_Request line: v8_7 23132.96 graph.html#tests=[[230,52,43]] 04:11:13 INFO - 2016-01-20 04:11:13,194 INFO : javascript benchmark 04:11:13 INFO - 2016-01-20 04:11:13,198 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3288.1615188127025, 3318.5851768528933, 3329.800211987281, 3356.2784001439686, 3361.462166053432, 5481.4518548145215, 5508.807191748285, 5517.062099443095, 5519.613627046108, 5526.944730552698, 5536.916946245809, 5619.943800562003, 5642.492175704186, 5658.943410565893, 5665.518430933375, 5108.055009823185, 5168.0180765654595, 5201.55786758126, 5204.895902081975, 5227.79088836446, 4978.87552811179, 5062.190049592066, 5070.062038522867, 5073.771680274396, 5075.441701412841, 5102.1836506159025, 5165.070287348276, 5165.509276618715, 5201.0378080055125, 5255.343082114736, 5110.565601923841, 5131.435542090367, 5135.435102138762, 5145.382554093533, 5172.974135129338, 4955.578775804061, 4994.87512812179, 5052.216906379517, 5063.873403164914, 5119.488051194888, 5302.973485132588, 5351.57187425005, 5379.38137114233, 5422.0, 5426.104692725696, 5884.382139875294, 5925.585209035369, 5970.611910225822, 5972.25346831646, 5997.610155339889, 5894.705264736746, 5983.491403230731, 6035.30593981689, 6039.54703397247, 6057.30341010785, 5683.318001839764, 5695.316562012544, 5698.943010569883, 5714.399988001283, 5715.942840571583, 6150.907736383958, 6158.784442544579, 6168.660723660152, 6195.380461953859, 6204.0, 5771.134329850472, 5797.855053623609, 5932.228810254725, 5958.7914422995855, 6075.027995520695, 6051.092336149525, 6061.909071363933, 6073.848153796102, 6083.543734219951, 6098.75604975796, 6010.789622363196, 6016.338202797689, 6047.0627052806885, 6049.78825741097, 6051.727672254759, 5720.799772007959, 5815.331236907725, 6032.939670603238, 6121.54443000217, 6125.082842094198, 4607.262837945913, 4612.53874612536, 4626.953730462719, 4629.120467111238, 4640.79116439761, 4075.3071977763852, 4133.565975572522, 4137.338025915839, 4141.461609990682, 4147.19129769692, 5695.0, 5713.257276554022, 5718.714064296769, 5823.184754134425, 5845.532357411397, 5941.31674857397, 5943.5839491236065, 5968.1644569760265, 5971.253593300838, 5992.43071908168, 5569.860753481114, 5622.8754249149515, 5729.48434640876, 5735.2257445245195, 5746.683932383676, 5264.526192642604, 5283.049051170826, 5305.257263983045, 5313.0, 5381.48875856793, 6153.84615384619, 6187.0, 6192.907106393408, 6196.411340922605, 6217.440430361199, 5837.3870743571315, 5943.227380440515, 5978.222831031938, 6005.549583781321, 6010.579259451883, 6253.749850005949, 6303.212098487689, 6304.65324407162, 6305.873882522415, 6306.84232894163, 5966.552508561962, 6018.277806663228, 6018.398160183947, 6024.33732289439, 6024.87950240984, 5800.4489573490455, 5903.940960590511, 5953.7916172935475, 6064.326784858592, 6124.89972046314, 5948.048312270016, 5966.791162309299, 5969.641821490724, 5975.37258587842, 5978.282606087298, 5893.499052580579, 5936.554758393224, 5960.314563825043, 5970.910436343545, 5973.223480947623, 5607.383187849415, 5731.942680573141, 5780.421957804186, 5876.970615147068, 5903.350631430453, 5749.885002300014, 5807.477327040587, 5837.708114594338, 5885.352611212677, 5988.910166347596, 5583.330000399816, 5761.91357129635, 5763.855903602276, 5765.5675824314185, 5794.681292528951], "unit": "ms", "name": "dojo.html", "value": 5547.1308843576435}, {"lowerIsBetter": false, "replicates": [577.2841676321362, 623.706857776845, 639.8144538083956, 652.1554586810081, 678.5080816408108, 32649.67350326496, 33245.33509329812, 37417.43873841895, 37699.62300376996, 37858.24283514331, 41874.162516749646, 42476.36285455713, 42528.0, 42545.14909701812, 42570.14859702804, 9026.097390260971, 9179.678711245107, 9198.356115071947, 9206.171444569987, 9226.67706630268, 9026.413283136608, 9095.636174553043, 9143.451392916446, 9177.219936305422, 9203.355765096447, 9060.728178154666, 9061.184493395593, 9112.8633070504, 9159.038300978402, 9180.8622870657, 9062.275017998545, 9083.45499270046, 9170.724878253663, 9172.724818255463, 9175.724728258163, 8984.46093234408, 9163.908360916372, 9164.633414663405, 9166.724998250063, 9178.541072946326, 40523.59476405228, 40581.0, 40859.0, 41246.793766031275, 41347.173056538704, 3600.4419315006216, 3628.9455658165148, 3716.349638813224, 3800.3919372900205, 4115.8971025724595, 31002.534961975587, 31384.529232061537, 31405.685943140732, 31664.0, 32077.03768886937, 4300.290452075404, 4327.6105150536605, 4331.415258940035, 4337.804798784031, 4406.801693923749, 277300.0, 277945.6102719494, 278241.0, 278518.0, 279782.0, 44371.556284436745, 45655.77172114118, 45733.54266457359, 45805.54194458079, 57878.0, 46271.5372846274, 46331.30503042457, 46450.303245451345, 46506.0, 46738.29892551546, 15717.21413929299, 15772.211389430482, 15942.60143496422, 15960.0, 15965.760513592306, 12944.611661650166, 12991.28547929854, 13104.80342794859, 13165.078444508985, 13194.604161875159, 14498.85501144975, 14502.927485362507, 14512.346944387527, 14543.490977815938, 14788.0, 6071.7571297147615, 6131.050837999949, 6131.417515336036, 6160.815175544741, 6187.16473276111, 965.3194497878978, 974.9122578967786, 1088.6516314779194, 1096.4846522134585, 1103.9448027598748, 27072.187834365002, 27263.72736272612, 27295.986938385384, 27816.443671126868, 27940.161795146178, 1010.6210171185805, 1016.8220561401725, 1034.2088302448633, 1045.362328979322, 1088.472091035847, 14788.482403116055, 14878.776818347733, 15048.699026019418, 15103.622409439633, 15173.393064277305, 684916.0, 686682.0, 688201.0, 690634.0, 726663.0, 55406.0, 55628.16557751637, 55745.721271393384, 55752.0, 55920.0, 1499.9850001500063, 1507.8869084818464, 1508.4117194294233, 1516.924153792328, 1521.4218596933094, 29395.412091758473, 30364.089077327717, 33219.16952076121, 33663.3267334647, 33902.8304858484, 52342.0, 52664.0, 52881.20678189907, 53150.734246328524, 53258.73370633122, 303419.0, 307306.0, 307398.0, 307897.0, 308282.0, 42129.36805947852, 42425.36361954635, 43120.35319470148, 43209.3518597215, 43483.56516434922, 45670.54329456663, 46350.30474542817, 47020.529794701615, 47296.0, 47480.2877956824, 39284.0, 39346.213075738895, 39858.0, 40583.7970810144, 40855.59144408518, 41167.1766564673, 41492.377614336416, 41521.37717934294, 42624.786876065424, 43503.56496434995, 36945.26109477849, 37340.0, 37533.43699844559, 37639.81180094082, 37653.0, 33416.498752518244, 33926.49110263299, 34036.97889063332, 37100.0, 37885.81057094697, 26202.606960895984, 26453.92230770423, 26628.866855665598, 26680.0, 27071.323216919736], "unit": "ms", "name": "ext.html", "value": 19426.441642805705}, {"lowerIsBetter": false, "replicates": [391.5868758459824, 397.8448405122001, 398.8085718854949, 402.1013035864842, 405.2887182993845, 15527.378904843792, 15590.45433409831, 17101.401450949204, 17514.0, 17588.472345829614, 11382.658520244406, 11470.942645286783, 11533.0, 11671.41642917855, 11788.7642247155, 4874.829380971667, 4880.389951256093, 4975.7263350515705, 4976.676516026447, 4981.928885289662, 4961.305417241589, 5143.614228932826, 5290.312259406272, 5292.10034294169, 5293.86765330866, 5198.428172900978, 5206.271122042917, 5228.424873263938, 5253.212018197282, 5464.535514481274, 5408.891822163554, 5413.0, 5420.4850539198715, 5428.45715428456, 5457.263269458612, 5224.138017227153, 5229.1633338666015, 5253.921191182136, 5262.02652509287, 5502.8349149525575, 13039.413226404835, 13216.537421190309, 13301.467941282433, 14563.490277840225, 20977.056032478577, 2147.795959383856, 2162.5782972320403, 2213.2032468311395, 2259.243153543565, 2326.6161083421216, 10003.949980250125, 10113.039261270167, 10195.541200645988, 12324.32216228107, 13302.733945321137, 1846.9933886032145, 1865.9440216793382, 1899.7815251246145, 1935.5064458563118, 2031.5530583271657, 63157.68421157911, 63239.0, 65487.3451265486, 65833.0, 65954.67022664857, 10929.56281748721, 10953.521274627983, 10956.616518421817, 10990.725231869108, 11076.944615277032, 14033.578992630237, 14089.43642254319, 14169.78745318821, 14176.787348189786, 14198.858011419754, 7695.153533111354, 7747.457677962489, 7825.334846537994, 8107.067687215927, 8128.715494957648, 7546.20764819697, 7593.506422082547, 7629.847403051908, 7679.232076792276, 7689.50018248812, 4595.862124136282, 4612.561806628365, 4623.976880115645, 4684.203685373494, 4706.176419126639, 1915.3281172764196, 1971.1327016112864, 1990.2536548794203, 1998.3505360757813, 2000.9399718008483, 862.6721845698594, 910.7996240827008, 995.2237254941158, 1023.3655133817081, 1027.6505987963978, 14692.559223223321, 16623.168841557872, 17077.231524581424, 17756.822431775516, 17778.822211777977, 944.2776276148752, 972.2659392159017, 990.4453506036642, 1010.2625083688802, 1013.9493025348703, 9550.522473876417, 9831.1643510301, 9919.553620087114, 9971.650992215238, 10381.325213861075, 565704.0, 570082.0, 573357.0, 583135.0, 588621.0, 78009.60995194988, 80175.59912200402, 80557.0, 81024.0, 81578.18421815825, 1116.7264020315074, 1137.2721458266717, 1142.8857114288671, 1144.4392247798519, 1145.564685419552, 15234.771478428054, 15345.23273836326, 15428.768568471258, 15524.534263972098, 15624.765628515808, 35899.641003590674, 36912.81543592265, 36955.6304436963, 36986.8150659245, 37085.25829483449, 48626.0, 48920.5107948916, 50808.0, 51091.489085108675, 51097.23354149616, 10115.342502737298, 10234.0, 10257.846132307872, 10343.94828025855, 10431.68704938853, 12452.813207802072, 17283.65432691314, 17822.821771782634, 17881.0, 18123.728144077584, 15408.075515469107, 15466.14936178521, 15585.76621350658, 15761.448349307719, 15782.447614333443, 14990.700185996437, 15388.769168462706, 15460.768088478457, 15688.686226275182, 15764.290606922486, 16140.596485087966, 16191.433299834449, 16214.432494862624, 16339.59151021234, 16556.337746490004, 9595.376300540442, 9976.950115249378, 10094.293399461967, 10235.795284094425, 10296.279260451696, 14744.115353078849, 14902.850971490147, 15075.396984120513, 15632.0, 15700.0], "unit": "ms", "name": "jquery.html", "value": 9064.80329109623}, {"lowerIsBetter": false, "replicates": [1546.1109861829436, 1633.869290456763, 1707.6584683063386, 1834.3488061738083, 1879.5489082620168, 7651.770446886595, 7855.842883142341, 7867.134615192324, 7935.246151615602, 8281.585920703956, 8205.097439281673, 8212.548309842956, 8215.794605134875, 8257.42198046137, 8260.793480162998, 2250.2124256510256, 2292.4612716011725, 2292.8165746740306, 2306.9884650576723, 2307.284741730061, 2348.8825558722083, 2351.6825228594093, 2421.0315873650507, 2422.39440139965, 2428.429319110008, 2329.860208387494, 2341.555104530142, 2363.8463499872455, 2382.4520360317138, 2386.6658667786523, 2218.0462401167492, 2364.196173301077, 2385.236724248233, 2395.401149712572, 2396.6165413533836, 2384.594618914771, 2391.8564886106888, 2397.5444665513496, 2404.663347131403, 2421.624648179535, 8057.838843223103, 8168.714095006646, 8216.548089855056, 8226.341892648574, 8246.628901699438, 4843.612510999147, 4947.529984651453, 4956.8760780980765, 4966.329545511346, 4970.776315065831, 3287.3918325109694, 3297.505374193866, 3325.983370083158, 3328.4341661917533, 3364.52896594477, 1019.5819713917332, 1027.085893554737, 1029.4132344563602, 1046.0428707732415, 1062.5112448273726, 10995.230333876632, 10999.505022273937, 11085.113190944705, 11086.057685096777, 11093.778124437466, 4223.619874211336, 4302.483701955723, 4317.028668549551, 4339.631131353807, 4396.956030439718, 9000.549972501349, 9028.413153145024, 9041.18629323364, 9053.59258833354, 9068.773280667903, 4767.713937163712, 4792.329073929653, 4827.106985207748, 4829.517048295213, 4849.393825771778, 4420.248557745127, 4437.134758722018, 4460.264056430653, 4463.04044630406, 4471.776411179428, 3447.345004449197, 3451.4995325677637, 3462.9826850865584, 3463.9653603463644, 3502.6322236165347, 1017.6590842067842, 1092.918031147667, 1113.04834366617, 1117.0281854786388, 1119.8936101070385, 1020.0768304684273, 1114.453917580396, 1206.221986818497, 1294.5533790842144, 1359.4358341288453, 7136.857262854714, 7146.428285737128, 7193.0, 7224.963875180591, 7249.891251631229, 588.3821986913723, 596.3827438601027, 622.862970146567, 631.4127861089139, 752.8406254368211, 5596.160575913564, 5617.915731264035, 5653.632513886584, 5666.801661941812, 5701.71491425427, 9868.161206297546, 9878.407295562289, 9970.351927124713, 9983.301168918251, 10079.143272821746, 9735.951320243496, 9815.2147828175, 9834.852477212848, 9905.405675659484, 9961.601535938626, 7643.770686879402, 7683.462157649023, 7685.42359323053, 7693.961530192425, 7758.689652413953, 7128.251533588898, 7139.32176443237, 7193.064901562972, 7214.422846172189, 7310.488265821342, 8643.783905402415, 8812.471251724917, 8839.292856571588, 8932.642694292155, 8974.641014359613, 8983.236424903957, 8997.100289971213, 9046.773830654287, 9107.271418286653, 9126.45241285525, 6898.344657257552, 6912.27421120775, 6939.89590156138, 6951.652417379009, 6974.197967233833, 7854.096778870503, 7872.881906771288, 7963.482373645927, 7975.840483190188, 8018.518888866687, 7033.191183013814, 7272.309130632581, 7298.489105762758, 7396.186419493959, 7596.468247222641, 7120.465965052538, 7152.105986751656, 7153.928460715326, 7215.062041934515, 7299.927000729925, 7169.318914703095, 7207.243239459781, 7218.530795498275, 7227.566346019255, 7236.34872861445, 6553.0, 6608.074869518367, 6627.072209890523, 6629.900551491828, 6632.071509988509, 6618.90071648916, 6769.3907548320885, 6797.796066118024, 6842.178938527409, 6872.244053154049], "unit": "ms", "name": "mootools.html", "value": 4554.371659393796}, {"lowerIsBetter": false, "replicates": [362.7533277371387, 366.6681653103939, 374.33929115111835, 374.3561074951084, 380.77343980331693, 6245.687715614224, 6332.0, 6333.651649159295, 6393.488520918327, 6411.679416029203, 6164.7534098636115, 6235.25176978762, 6302.180716506859, 6307.968460157705, 6323.30443651198, 4846.733429661376, 4848.7575621218975, 4861.246506791453, 4862.14912390332, 4863.14894893394, 4859.0, 4864.075825593143, 4865.440474345442, 4866.951330486685, 4873.0, 4749.335093086971, 4841.878953026185, 4848.175810112271, 4854.029194161164, 4858.368412106439, 4789.0, 4830.661853670244, 4834.661573689843, 4834.734089625069, 4846.36997190363, 4229.429027081335, 4238.660907127422, 4252.192083504125, 4256.297710877701, 4277.8288868445225, 5887.470127688486, 5993.101034844764, 6000.459958603747, 6011.549133814981, 6014.699265036731, 5626.1842032905, 5637.943620563824, 5648.548116150698, 5658.830235092953, 5664.2636457260705, 6685.699143538553, 6702.597844129368, 6706.798796036127, 6710.597364158166, 6729.663516824139, 4707.317438971364, 4732.124556956974, 4732.337472753818, 4732.621390288768, 4746.881327966794, 6881.518293719441, 6971.442284617218, 6990.405815505688, 6998.580085194904, 7008.334208250208, 4832.1543729847135, 4835.564799168092, 4838.032393521239, 4845.6123510119105, 4851.029794041206, 4901.387326584177, 4914.926276105862, 4916.385451818523, 4919.950800492021, 4939.234418665041, 5522.420145884625, 5620.49415552594, 5624.887502250014, 5624.91562626561, 5626.859328516738, 6779.966100169566, 6780.762673306411, 6783.389494945479, 6785.0, 6790.11728475305, 1623.1884057971015, 1653.8346165383607, 1654.346533119411, 1656.7349224124082, 1692.8814982951321, 1098.3300186885992, 1120.708615759892, 1142.9828552571719, 1143.5025763792776, 1154.4516354731436, 6481.902771458432, 6559.540832141704, 6575.638339891352, 6583.506237032242, 6608.537402381787, 6929.618870962045, 6939.548929319578, 6943.166819981533, 6971.790846274518, 6975.093237879043, 6506.544541882023, 6573.276939536647, 6580.605163690194, 6588.945768677085, 6607.80176594703, 3757.793321367351, 3774.75464094833, 3783.281176576442, 3783.659470647655, 3788.6969042476535, 7111.1466624004415, 7199.964000179965, 7202.0637317149485, 7202.315780000891, 7209.639518024078, 6980.860382792316, 7127.073480447509, 7128.857422851514, 7129.750458733919, 7137.072180616487, 7139.535930164627, 7156.427485801123, 7199.244079371695, 7208.603526805971, 7214.134303883463, 6824.4199243064895, 6897.0, 6927.515073944775, 6942.0, 6967.477439191979, 6736.461083113437, 6801.625910574768, 6805.693743781443, 6839.384455399038, 6855.040294358893, 7093.432525397852, 7167.534110282815, 7168.964155179399, 7187.425005999612, 7190.96404517974, 4678.53214678543, 4682.321063445713, 4682.461516925461, 4690.718556886598, 4694.014257006067, 6789.1852977643, 6859.622720750406, 6863.588184708933, 6866.210385805696, 6872.759453419107, 6665.0, 6699.866002680016, 6712.798616041527, 6766.627835468899, 6781.830454238683, 6750.729970801113, 6751.324867513209, 6753.729850805913, 6754.223264324665, 6771.93228067713, 6520.021996700533, 6608.570442921195, 6630.0, 6638.734450622114, 6641.33586641332, 6775.220849602359, 6780.32196780318, 6780.38976492118, 6785.592864427953, 6794.388505034571, 6584.242812076673, 6602.1747281589805, 6616.603003819786, 6624.536282460374, 6630.237522684953], "unit": "ms", "name": "prototype.html", "value": 5084.424706554206}, {"lowerIsBetter": false, "replicates": [785.7564155111912, 788.3614272439324, 941.5527624378417, 951.3911096897987, 952.8007091531264, 14321.355539000744, 14415.567532974, 14493.275336233186, 14503.709925801477, 14541.0, 13611.0, 13856.653583660414, 13936.79094813576, 13938.372773225205, 13946.511872084478, 766.8734658781294, 770.4837758701656, 889.7241855024947, 903.8644203369481, 909.5361365703505, 888.626776753765, 888.6489836514573, 890.4879694175843, 893.5219657483248, 899.0874262623443, 949.2500924269818, 958.4057884111826, 959.2086528613886, 959.4866746290736, 959.7360725800426, 950.9809803803954, 952.2619969523605, 953.1850268020846, 955.2883102088954, 956.4882787708613, 693.8230751158472, 695.4992405468055, 696.6551556979277, 696.7735485967081, 698.0855079845368, 14040.719185616332, 14108.717825643533, 14188.290585470788, 14223.786643200361, 14280.214588197645, 12500.124991250615, 12657.0, 12760.361981900867, 13201.60395188146, 13301.201927884358, 11112.666620001413, 11177.017506351685, 11277.436128193558, 11455.96896279339, 11481.253718508271, 3840.2319536092614, 3904.863329783472, 3918.902027449308, 3958.604139586047, 3968.9801550992347, 49235.0, 49350.76623084416, 49514.50485495135, 49572.256416153425, 49645.25532117021, 10507.0, 10849.945750271198, 11149.21955463126, 11162.0, 11231.71920701989, 18824.7176292353, 18885.716714249298, 18891.716624250646, 18939.81060189408, 18967.62064758697, 7437.628118594049, 7536.171021187665, 7543.547387156788, 7657.731979380695, 7812.648430820626, 4583.977080114578, 4671.579557839811, 4740.95259047412, 4786.904261914742, 4792.448868380111, 3239.6598357172156, 3275.7051865332232, 3276.819774912403, 3279.868805247811, 3283.507473878937, 601.1913975702673, 604.5465900574569, 607.4229481992126, 607.9179310793074, 612.4549151255386, 707.8690442268094, 737.303248430239, 739.8187444076128, 740.5826380030063, 746.8020974441778, 9216.170544651013, 9771.267154963407, 9933.503324833873, 9954.904960454343, 9957.800843983225, 642.2004604267623, 685.0580451878667, 729.2379463460696, 755.6221889055472, 762.6453699029978, 4301.956980430155, 4368.126374725004, 4396.054848207651, 4416.977915110404, 4661.790219440133, 57913.13130303049, 58317.0, 58432.41567584355, 58655.41344586585, 58676.7066164675, 51271.74364128155, 51274.743626281626, 51586.0, 51979.740101300005, 52152.73923630433, 48521.0, 48948.510514895104, 48979.26531102036, 49432.0, 49519.25721114114, 9210.861837072584, 9240.815183696153, 9252.676156334765, 9352.802091508354, 9386.530673466435, 35097.0, 35168.472472912414, 35291.647083528835, 35570.0, 35618.10954726049, 43695.34456983084, 44137.33793993029, 46572.0, 46926.29610555776, 46955.53044469511, 10786.622468213574, 10985.395803230898, 11084.279521831055, 11396.715082123013, 11522.42387880586, 12606.747865042464, 12651.177673451197, 12660.240385576895, 12685.746285074432, 12923.806142908052, 12485.375731213584, 12525.123241373016, 12681.746365072831, 12787.424565894371, 12924.612261632166, 12084.45619947087, 12096.818547721616, 12097.637070887888, 12154.574589889311, 12463.875361246633, 12306.75386492283, 12598.55905043319, 12640.0, 12664.936675316565, 13114.60656180316, 10541.894581054092, 10644.680659580225, 10825.945870270598, 10905.34567925927, 10976.341419514854, 10489.47552622381, 10495.737606559896, 10651.57393704243, 10677.519511622151, 10790.244682872124], "unit": "ms", "name": "yui.html", "value": 6773.302287680954}], "name": "dromaeo_css", "value": 7315.118027581222}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 110.0, 108.0, 111.0, 119.0, 110.0, 112.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 145.0, 164.0, 130.0, 146.0, 144.0, 125.0, 159.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.4}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 160.0, 164.0, 160.0, 160.0, 160.0, 163.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 150.0, 74.0, 73.0, 73.0, 71.0, 155.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 88.6}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 139.0, 93.0, 93.0, 94.0, 139.0, 92.0, 91.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 113.0, 111.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 146.0, 149.0, 149.0, 147.0, 145.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [58.0, 62.0, 60.0, 60.0, 62.0, 59.0, 59.0, 60.0, 65.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 62.0, 62.0, 64.0, 63.0, 64.0, 63.0, 63.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.1}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 83.0, 82.0, 82.0, 89.0, 82.0, 81.0, 90.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [116.0, 113.0, 121.0, 120.0, 123.0, 112.0, 118.0, 124.0, 126.0, 110.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [144.0, 153.0, 144.0, 144.0, 145.0, 144.0, 147.0, 144.0, 143.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.5}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 64.0, 65.0, 65.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.2}], "name": "kraken", "value": 1495.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7008217340265], "unit": "score", "name": "Richards", "value": 210.50582599999998}, {"lowerIsBetter": false, "replicates": [167.0843776106934], "unit": "score", "name": "DeltaBlue", "value": 395.71623000000017}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [932.8358208955224], "unit": "score", "name": "RayTrace", "value": 793.2682079999998}, {"lowerIsBetter": false, "replicates": [549.4505494505495], "unit": "score", "name": "Earley", "value": 1212.96266}, {"lowerIsBetter": false, "replicates": [11021.978021978022], "unit": "score", "name": "Boyer", "value": 60.46673280159525}, {"lowerIsBetter": false, "replicates": [24707.317073170732], "unit": "score", "name": "RegExp", "value": 36.871061204343526}, {"lowerIsBetter": false, "replicates": [518.4033177812338], "unit": "score", "name": "Splay", "value": 157.19613900000004}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23132.964639900423}]} 04:11:13 INFO - RETURN: dromaeo_css: 7315.12 04:11:13 INFO - RETURN: kraken: 1495.40 04:11:13 INFO - RETURN: v8_7: 23132.96 04:11:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23132.96"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1495.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7315.12"}}} 04:11:13 INFO - Return code: 0 04:11:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:11:13 INFO - # TBPL SUCCESS # 04:11:13 INFO - Running post-action listener: _resource_record_post_action 04:11:13 INFO - Running post-run listener: _resource_record_post_run 04:11:14 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 299008; Write bytes: 512204800; Read time: 352; Write time: 1163932 04:11:14 INFO - install - Wall time: 16s; CPU: 19.0%; Read bytes: 4096; Write bytes: 237039616; Read time: 256; Write time: 890352 04:11:14 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 294912; Write bytes: 268259328; Read time: 96; Write time: 270956 04:11:14 INFO - Running post-run listener: _upload_blobber_files 04:11:14 INFO - Blob upload gear active. 04:11:14 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:11:14 INFO - Copying logs to upload dir... 04:11:14 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1261.833021 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-01-20 04:11:14.039057) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-20 04:11:14.042818) ========= 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=df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009768 build_url: 'https://queue.taskcluster.net/v1/task/GlXTPJ7MTCWTOaldnEKR7w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-20 04:11:14.096350) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:11:14.096688) ========= 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=df17445c3590ff7897617a0e00000225-1453290610.945091-1675499267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:11:14.146286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 04:11:14.146621) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 04:11:14.146947) ========= ========= Total master_lag: 0.23 =========