builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1456166217.08 results: success (0) buildid: 20160222074756 builduid: dc73c008278f4343a7027ead6f7b4cab revision: 7da232006437 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.079421) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.079801) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.080075) ========= 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=836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005947 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.103194) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.103740) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.122608) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.122860) ========= 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=836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004664 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.171598) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.171851) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.172171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.172448) ========= 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=836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-22 10:36:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-02-22 10:36:57 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097849 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.282310) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.282616) ========= 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=836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018639 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.331732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.332251) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7da232006437 --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-beta --rev 7da232006437 --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=836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-22 10:36:57,527 Setting DEBUG logging. 2016-02-22 10:36:57,527 attempt 1/10 2016-02-22 10:36:57,528 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7da232006437?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 10:36:57,775 unpacking tar archive at: mozilla-beta-7da232006437/testing/mozharness/ program finished with exit code 0 elapsedTime=0.522879 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.868200) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.868514) ========= echo 7da232006437 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7da232006437'] 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=836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7da232006437 program finished with exit code 0 elapsedTime=0.004696 script_repo_revision: '7da232006437' ========= master_lag: 0.08 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.955933) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.956280) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:57.965993) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-02-22 10:36:57.966322) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:36:58 INFO - MultiFileLogger online at 20160222 10:36:58 in /builds/slave/test-pgo 10:36:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:36:58 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:36:58 INFO - {'append_to_log': False, 10:36:58 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:36:58 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:36:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:36:58 INFO - 'branch': 'Mozilla-Beta', 10:36:58 INFO - 'buildbot_json_path': 'buildprops.json', 10:36:58 INFO - 'config_files': ('talos/linux_config.py',), 10:36:58 INFO - 'default_actions': ('clobber', 10:36:58 INFO - 'read-buildbot-config', 10:36:58 INFO - 'download-and-extract', 10:36:58 INFO - 'populate-webroot', 10:36:58 INFO - 'create-virtualenv', 10:36:58 INFO - 'install', 10:36:58 INFO - 'run-tests'), 10:36:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:36:58 INFO - 'download_minidump_stackwalk': True, 10:36:58 INFO - 'download_symbols': 'ondemand', 10:36:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:36:58 INFO - 'tooltool.py': '/tools/tooltool.py', 10:36:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:36:58 INFO - '/tools/misc-python/virtualenv.py')}, 10:36:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:36:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:36:58 INFO - 'installer_path': 'installer.exe', 10:36:58 INFO - 'log_level': 'info', 10:36:58 INFO - 'log_name': 'talos', 10:36:58 INFO - 'log_to_console': True, 10:36:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:36:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:36:58 INFO - 'opt_config_files': (), 10:36:58 INFO - 'pip_index': False, 10:36:58 INFO - 'sps_profile': False, 10:36:58 INFO - 'sps_profile_interval': 0, 10:36:58 INFO - 'suite': 'dromaeojs', 10:36:58 INFO - 'system_bits': '32', 10:36:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:36:58 INFO - 'title': 'talos-linux64-ix-028', 10:36:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:36:58 INFO - 'use_talos_json': True, 10:36:58 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:36:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:36:58 INFO - 'work_dir': 'build'} 10:36:58 INFO - ##### 10:36:58 INFO - ##### Running clobber step. 10:36:58 INFO - ##### 10:36:58 INFO - Running pre-action listener: _resource_record_pre_action 10:36:58 INFO - Running main action method: clobber 10:36:58 INFO - rmtree: /builds/slave/test-pgo/build 10:36:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:36:58 INFO - Running post-action listener: _resource_record_post_action 10:36:58 INFO - ##### 10:36:58 INFO - ##### Running read-buildbot-config step. 10:36:58 INFO - ##### 10:36:58 INFO - Running pre-action listener: _resource_record_pre_action 10:36:58 INFO - Running main action method: read_buildbot_config 10:36:58 INFO - Using buildbot properties: 10:36:58 INFO - { 10:36:58 INFO - "properties": { 10:36:58 INFO - "buildnumber": 93, 10:36:58 INFO - "product": "firefox", 10:36:58 INFO - "script_repo_revision": "production", 10:36:58 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:36:58 INFO - "repository": "", 10:36:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:36:58 INFO - "buildid": "20160222074756", 10:36:58 INFO - "slavename": "talos-linux64-ix-028", 10:36:58 INFO - "pgo_build": "True", 10:36:58 INFO - "basedir": "/builds/slave/test-pgo", 10:36:58 INFO - "project": "", 10:36:58 INFO - "platform": "ubuntu64_hw", 10:36:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:36:58 INFO - "slavebuilddir": "test", 10:36:58 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:36:58 INFO - "branch": "mozilla-beta", 10:36:58 INFO - "repo_path": "releases/mozilla-beta", 10:36:58 INFO - "stage_platform": "linux64-pgo", 10:36:58 INFO - "builduid": "dc73c008278f4343a7027ead6f7b4cab", 10:36:58 INFO - "revision": "7da232006437" 10:36:58 INFO - }, 10:36:58 INFO - "sourcestamp": { 10:36:58 INFO - "repository": "", 10:36:58 INFO - "hasPatch": false, 10:36:58 INFO - "project": "", 10:36:58 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:36:58 INFO - "changes": [ 10:36:58 INFO - { 10:36:58 INFO - "category": null, 10:36:58 INFO - "files": [ 10:36:58 INFO - { 10:36:58 INFO - "url": null, 10:36:58 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155208/firefox-45.0.en-US.linux-x86_64.tar.bz2" 10:36:58 INFO - } 10:36:58 INFO - ], 10:36:58 INFO - "repository": "", 10:36:58 INFO - "rev": "0a37bbe7d7ab", 10:36:58 INFO - "who": "sendchange", 10:36:58 INFO - "when": 1456164250, 10:36:58 INFO - "number": 7636216, 10:36:58 INFO - "comments": "Bug 1247041: [ffmpeg] Request YUVJ420P format explicitly. r=kentuckyfriedtakahe, a=sylvestre", 10:36:58 INFO - "project": "", 10:36:58 INFO - "at": "Mon 22 Feb 2016 10:04:10", 10:36:58 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:36:58 INFO - "revlink": "", 10:36:58 INFO - "properties": [ 10:36:58 INFO - [ 10:36:58 INFO - "buildid", 10:36:58 INFO - "20160222073328", 10:36:58 INFO - "Change" 10:36:58 INFO - ], 10:36:58 INFO - [ 10:36:58 INFO - "builduid", 10:36:58 INFO - "3a76a955002e4eaeb05125e59feff0d5", 10:36:58 INFO - "Change" 10:36:58 INFO - ], 10:36:58 INFO - [ 10:36:58 INFO - "pgo_build", 10:36:58 INFO - "True", 10:36:58 INFO - "Change" 10:36:58 INFO - ] 10:36:58 INFO - ], 10:36:58 INFO - "revision": "0a37bbe7d7ab" 10:36:58 INFO - }, 10:36:58 INFO - { 10:36:58 INFO - "category": null, 10:36:58 INFO - "files": [ 10:36:58 INFO - { 10:36:58 INFO - "url": null, 10:36:58 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.tar.bz2" 10:36:58 INFO - } 10:36:58 INFO - ], 10:36:58 INFO - "repository": "", 10:36:58 INFO - "rev": "7da232006437", 10:36:58 INFO - "who": "sendchange", 10:36:58 INFO - "when": 1456164465, 10:36:58 INFO - "number": 7636242, 10:36:58 INFO - "comments": "Bug 1248909: [MSE] P2. Simplify diagnostic. r=gerald, a=sylvestre", 10:36:58 INFO - "project": "", 10:36:58 INFO - "at": "Mon 22 Feb 2016 10:07:45", 10:36:58 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:36:58 INFO - "revlink": "", 10:36:58 INFO - "properties": [ 10:36:58 INFO - [ 10:36:58 INFO - "buildid", 10:36:58 INFO - "20160222074756", 10:36:58 INFO - "Change" 10:36:58 INFO - ], 10:36:58 INFO - [ 10:36:58 INFO - "builduid", 10:36:58 INFO - "dc73c008278f4343a7027ead6f7b4cab", 10:36:58 INFO - "Change" 10:36:58 INFO - ], 10:36:58 INFO - [ 10:36:58 INFO - "pgo_build", 10:36:58 INFO - "True", 10:36:58 INFO - "Change" 10:36:58 INFO - ] 10:36:58 INFO - ], 10:36:58 INFO - "revision": "7da232006437" 10:36:58 INFO - } 10:36:58 INFO - ], 10:36:58 INFO - "revision": "7da232006437" 10:36:58 INFO - } 10:36:58 INFO - } 10:36:58 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.tar.bz2. 10:36:58 INFO - Running post-action listener: _resource_record_post_action 10:36:58 INFO - ##### 10:36:58 INFO - ##### Running download-and-extract step. 10:36:58 INFO - ##### 10:36:58 INFO - Running pre-action listener: _resource_record_pre_action 10:36:58 INFO - Running main action method: download_and_extract 10:36:58 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:36:58 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')]} 10:36:58 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/test_packages.json 10:36:58 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:36:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:36:58 INFO - Downloaded 1270 bytes. 10:36:58 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:36:58 INFO - Using the following test package requirements: 10:36:58 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:36:58 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:36:58 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:36:58 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:36:58 INFO - u'jsshell-linux-x86_64.zip'], 10:36:58 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:36:58 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:36:58 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:36:58 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:36:58 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 10:36:58 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:36:58 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 10:36:58 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:36:58 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:36:58 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:36:58 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:36:58 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:36:58 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:36:58 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')]} 10:36:58 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:36:58 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:36:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:36:59 INFO - Downloaded 21582126 bytes. 10:36:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:36:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:36:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:37:00 INFO - Return code: 0 10:37:00 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:37:00 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')]} 10:37:00 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:37:00 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:37:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:37:00 INFO - Downloaded 21582126 bytes. 10:37:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:37:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:37:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:37:01 INFO - Return code: 0 10:37: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')]} 10:37:01 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:37:01 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:37:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:37:02 INFO - Downloaded 11132038 bytes. 10:37:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 10:37:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:37:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:37:02 INFO - Return code: 0 10:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:02 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:37:02 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:37:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:37:03 INFO - Downloaded 57945198 bytes. 10:37:03 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:37:03 INFO - mkdir: /builds/slave/test-pgo/properties 10:37:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:37:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:37:03 INFO - Contents: 10:37:03 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:37:03 INFO - Running post-action listener: _resource_record_post_action 10:37:03 INFO - Running post-action listener: set_extra_try_arguments 10:37:03 INFO - ##### 10:37:03 INFO - ##### Running populate-webroot step. 10:37:03 INFO - ##### 10:37:03 INFO - Running pre-action listener: _resource_record_pre_action 10:37:03 INFO - Running main action method: populate_webroot 10:37:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:37:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:37:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:37:03 INFO - '--tppagecycles', 10:37:03 INFO - '7'], 10:37:03 INFO - 'tests': ['tsvgm']}}, 10:37:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:37:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:37:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:37:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:37:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:37:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:37:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:37:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:03 INFO - 'talos_options': ['--e10s'], 10:37:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:37:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:03 INFO - 'tests': ['damp', 'tps']}, 10:37:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:03 INFO - 'talos_options': ['--e10s'], 10:37:03 INFO - 'tests': ['damp', 'tps']}, 10:37:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:37:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:37:03 INFO - 'other': {'tests': ['a11yr', 10:37:03 INFO - 'ts_paint', 10:37:03 INFO - 'tpaint', 10:37:03 INFO - 'sessionrestore', 10:37:03 INFO - 'sessionrestore_no_auto_restore']}, 10:37:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:37:03 INFO - 'tests': ['a11yr', 10:37:03 INFO - 'ts_paint', 10:37:03 INFO - 'tpaint', 10:37:03 INFO - 'sessionrestore', 10:37:03 INFO - 'sessionrestore_no_auto_restore']}, 10:37:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:37:03 INFO - 'tests': ['a11yr', 10:37:03 INFO - 'ts_paint', 10:37:03 INFO - 'tpaint', 10:37:03 INFO - 'sessionrestore', 10:37:03 INFO - 'sessionrestore_no_auto_restore']}, 10:37:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:37:03 INFO - 'tests': ['a11yr', 10:37:03 INFO - 'ts_paint', 10:37:03 INFO - 'tpaint', 10:37:03 INFO - 'sessionrestore', 10:37:03 INFO - 'sessionrestore_no_auto_restore']}, 10:37:03 INFO - 'other_l64': {'tests': ['a11yr', 10:37:03 INFO - 'ts_paint', 10:37:03 INFO - 'tpaint', 10:37:03 INFO - 'sessionrestore', 10:37:03 INFO - 'sessionrestore_no_auto_restore']}, 10:37:03 INFO - 'other_nol64': {'tests': ['a11yr', 10:37:03 INFO - 'ts_paint', 10:37:03 INFO - 'tpaint', 10:37:03 INFO - 'sessionrestore', 10:37:03 INFO - 'sessionrestore_no_auto_restore']}, 10:37:03 INFO - 'svgr': {'tests': ['tsvgx', 10:37:03 INFO - 'tsvgr_opacity', 10:37:03 INFO - 'tart', 10:37:03 INFO - 'tscrollx', 10:37:03 INFO - 'cart']}, 10:37:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:37:03 INFO - 'tests': ['tsvgx', 10:37:03 INFO - 'tsvgr_opacity', 10:37:03 INFO - 'tart', 10:37:03 INFO - 'tscrollx', 10:37:03 INFO - 'cart']}, 10:37:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:03 INFO - 'tests': ['tp5o']}, 10:37:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:03 INFO - 'talos_options': ['--e10s'], 10:37:03 INFO - 'tests': ['tp5o']}, 10:37:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:03 INFO - 'talos_options': ['--xperf_path', 10:37:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:37:03 INFO - 'tests': ['tp5n']}, 10:37:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:03 INFO - 'talos_options': ['--e10s', 10:37:03 INFO - '--xperf_path', 10:37:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:37:03 INFO - 'tests': ['tp5n']}}, 10:37:03 INFO - 'talos.zip': {'path': '', 10:37:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:37:03 INFO - Running post-action listener: _resource_record_post_action 10:37:03 INFO - ##### 10:37:03 INFO - ##### Running create-virtualenv step. 10:37:03 INFO - ##### 10:37:03 INFO - Running pre-action listener: _resource_record_pre_action 10:37:03 INFO - Running main action method: create_virtualenv 10:37:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:37:03 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 10:37:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:37:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:37:03 INFO - Using real prefix '/usr' 10:37:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:37:03 INFO - Installing distribute.............................................................................................................................................................................................done. 10:37:05 INFO - Installing pip.................done. 10:37:05 INFO - Return code: 0 10:37:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:05 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 0x7fc079aacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b350>, '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 0x278c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278c6e0>, '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': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', '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 10:37:05 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 10:37:05 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 10:37:05 INFO - Using env: {'DISPLAY': ':0', 10:37:05 INFO - 'HOME': '/home/cltbld', 10:37:05 INFO - 'LANG': 'en_US.UTF-8', 10:37:05 INFO - 'LANGUAGE': 'en_US:en', 10:37:05 INFO - 'LOGNAME': 'cltbld', 10:37:05 INFO - 'MAIL': '/var/mail/cltbld', 10:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:05 INFO - 'MOZ_NO_REMOTE': '1', 10:37:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:05 INFO - 'NO_EM_RESTART': '1', 10:37:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:05 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:05 INFO - 'SHELL': '/bin/bash', 10:37:05 INFO - 'SHLVL': '1', 10:37:05 INFO - 'TERM': 'linux', 10:37:05 INFO - 'TMOUT': '86400', 10:37:05 INFO - 'USER': 'cltbld', 10:37:05 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', 10:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:05 INFO - '_': '/tools/buildbot/bin/python'} 10:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:06 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 10:37:06 INFO - Cleaning up... 10:37:06 INFO - Return code: 0 10:37:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:06 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 0x7fc079aacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b350>, '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 0x278c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278c6e0>, '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': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', '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 10:37:06 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 10:37:06 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 10:37:06 INFO - Using env: {'DISPLAY': ':0', 10:37:06 INFO - 'HOME': '/home/cltbld', 10:37:06 INFO - 'LANG': 'en_US.UTF-8', 10:37:06 INFO - 'LANGUAGE': 'en_US:en', 10:37:06 INFO - 'LOGNAME': 'cltbld', 10:37:06 INFO - 'MAIL': '/var/mail/cltbld', 10:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:06 INFO - 'MOZ_NO_REMOTE': '1', 10:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:06 INFO - 'NO_EM_RESTART': '1', 10:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:06 INFO - 'SHELL': '/bin/bash', 10:37:06 INFO - 'SHLVL': '1', 10:37:06 INFO - 'TERM': 'linux', 10:37:06 INFO - 'TMOUT': '86400', 10:37:06 INFO - 'USER': 'cltbld', 10:37:06 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', 10:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:06 INFO - '_': '/tools/buildbot/bin/python'} 10:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:06 INFO - Downloading/unpacking psutil>=0.7.1 10:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:37:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:37:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:37:08 INFO - Installing collected packages: psutil 10:37:08 INFO - Running setup.py install for psutil 10:37:08 INFO - building 'psutil._psutil_linux' extension 10:37:08 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 10:37:08 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 10:37:08 INFO - building 'psutil._psutil_posix' extension 10:37:08 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 10:37:08 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 10:37:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:37:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:37:08 INFO - Successfully installed psutil 10:37:08 INFO - Cleaning up... 10:37:08 INFO - Return code: 0 10:37:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:08 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 0x7fc079aacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b350>, '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 0x278c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278c6e0>, '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': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', '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 10:37:08 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 10:37:08 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 10:37:08 INFO - Using env: {'DISPLAY': ':0', 10:37:08 INFO - 'HOME': '/home/cltbld', 10:37:08 INFO - 'LANG': 'en_US.UTF-8', 10:37:08 INFO - 'LANGUAGE': 'en_US:en', 10:37:08 INFO - 'LOGNAME': 'cltbld', 10:37:08 INFO - 'MAIL': '/var/mail/cltbld', 10:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:08 INFO - 'MOZ_NO_REMOTE': '1', 10:37:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:08 INFO - 'NO_EM_RESTART': '1', 10:37:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:08 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:08 INFO - 'SHELL': '/bin/bash', 10:37:08 INFO - 'SHLVL': '1', 10:37:08 INFO - 'TERM': 'linux', 10:37:08 INFO - 'TMOUT': '86400', 10:37:08 INFO - 'USER': 'cltbld', 10:37:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', 10:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:08 INFO - '_': '/tools/buildbot/bin/python'} 10:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:37:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:37:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:37:10 INFO - Installing collected packages: mozsystemmonitor 10:37:10 INFO - Running setup.py install for mozsystemmonitor 10:37:11 INFO - Successfully installed mozsystemmonitor 10:37:11 INFO - Cleaning up... 10:37:11 INFO - Return code: 0 10:37:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:37:11 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')]} 10:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:11 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')]} 10:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:11 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 0x7fc079aacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b350>, '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 0x278c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278c6e0>, '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': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', '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 10:37:11 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 10:37:11 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 10:37:11 INFO - Using env: {'DISPLAY': ':0', 10:37:11 INFO - 'HOME': '/home/cltbld', 10:37:11 INFO - 'LANG': 'en_US.UTF-8', 10:37:11 INFO - 'LANGUAGE': 'en_US:en', 10:37:11 INFO - 'LOGNAME': 'cltbld', 10:37:11 INFO - 'MAIL': '/var/mail/cltbld', 10:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:11 INFO - 'MOZ_NO_REMOTE': '1', 10:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:11 INFO - 'NO_EM_RESTART': '1', 10:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:11 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:11 INFO - 'SHELL': '/bin/bash', 10:37:11 INFO - 'SHLVL': '1', 10:37:11 INFO - 'TERM': 'linux', 10:37:11 INFO - 'TMOUT': '86400', 10:37:11 INFO - 'USER': 'cltbld', 10:37:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', 10:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:11 INFO - '_': '/tools/buildbot/bin/python'} 10:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:11 INFO - Downloading/unpacking blobuploader==1.2.4 10:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:13 INFO - Downloading blobuploader-1.2.4.tar.gz 10:37:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:37:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:37:13 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 10:37:13 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 10:37:13 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 10:37:13 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 10:37:13 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 10:37:13 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 10:37:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:37:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:37:13 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 10:37:13 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 10:37:13 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 10:37:13 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 10:37:13 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 10:37:13 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 10:37:13 INFO - Downloading docopt-0.6.1.tar.gz 10:37:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:37:13 INFO - Installing collected packages: blobuploader, requests, docopt 10:37:13 INFO - Running setup.py install for blobuploader 10:37:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:37:13 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:37:13 INFO - Running setup.py install for requests 10:37:14 INFO - Running setup.py install for docopt 10:37:14 INFO - Successfully installed blobuploader requests docopt 10:37:14 INFO - Cleaning up... 10:37:14 INFO - Return code: 0 10:37:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:37: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')]} 10:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37: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')]} 10:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:14 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 0x7fc079aacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b350>, '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 0x278c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278c6e0>, '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': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', '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 10:37:14 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 10:37:14 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 10:37:14 INFO - Using env: {'DISPLAY': ':0', 10:37:14 INFO - 'HOME': '/home/cltbld', 10:37:14 INFO - 'LANG': 'en_US.UTF-8', 10:37:14 INFO - 'LANGUAGE': 'en_US:en', 10:37:14 INFO - 'LOGNAME': 'cltbld', 10:37:14 INFO - 'MAIL': '/var/mail/cltbld', 10:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:14 INFO - 'MOZ_NO_REMOTE': '1', 10:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:14 INFO - 'NO_EM_RESTART': '1', 10:37:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:14 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:14 INFO - 'SHELL': '/bin/bash', 10:37:14 INFO - 'SHLVL': '1', 10:37:14 INFO - 'TERM': 'linux', 10:37:14 INFO - 'TMOUT': '86400', 10:37:14 INFO - 'USER': 'cltbld', 10:37:14 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', 10:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:14 INFO - '_': '/tools/buildbot/bin/python'} 10:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:37:14 INFO - Running setup.py (path:/tmp/pip-IRo0_m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:37:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:37:14 INFO - Running setup.py (path:/tmp/pip-KA7DBJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:37:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:37:14 INFO - Running setup.py (path:/tmp/pip-FkNRku-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:37:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:37:14 INFO - Running setup.py (path:/tmp/pip-YCkDQj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:37:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:37:14 INFO - Running setup.py (path:/tmp/pip-ThZZfE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:37:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:37:14 INFO - Running setup.py (path:/tmp/pip-YzVHaZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:37:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:37:15 INFO - Running setup.py (path:/tmp/pip-6UXvW1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:37:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:37:15 INFO - Running setup.py (path:/tmp/pip-x2NuQF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:37:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:37:15 INFO - Running setup.py (path:/tmp/pip-afBQnm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:37:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:37:15 INFO - Running setup.py (path:/tmp/pip-iwntGs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:37:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:37:15 INFO - Running setup.py (path:/tmp/pip-HW42ly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:37:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:37:15 INFO - Running setup.py (path:/tmp/pip-SfYJ_K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:37:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:37:15 INFO - Running setup.py (path:/tmp/pip-_tj_ED-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:37:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:37:15 INFO - Running setup.py (path:/tmp/pip-0fQN_y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:37:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:37:15 INFO - Running setup.py (path:/tmp/pip-UHjdx8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:37:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:37:15 INFO - Running setup.py (path:/tmp/pip-0DfvLM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:37:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:37:15 INFO - Running setup.py (path:/tmp/pip-DaRzlj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:37:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:37:15 INFO - Running setup.py install for manifestparser 10:37:15 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:37:15 INFO - Running setup.py install for mozcrash 10:37:16 INFO - Running setup.py install for mozdebug 10:37:16 INFO - Running setup.py install for mozdevice 10:37:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:37:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:37:16 INFO - Running setup.py install for mozfile 10:37:16 INFO - Running setup.py install for mozhttpd 10:37:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:37:16 INFO - Running setup.py install for mozinfo 10:37:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:37:16 INFO - Running setup.py install for mozInstall 10:37:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:37:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:37:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:37:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:37:16 INFO - Running setup.py install for mozleak 10:37:16 INFO - Running setup.py install for mozlog 10:37:16 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:37:16 INFO - Running setup.py install for moznetwork 10:37:16 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:37:16 INFO - Running setup.py install for mozprocess 10:37:17 INFO - Running setup.py install for mozprofile 10:37:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:37:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:37:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:37:17 INFO - Running setup.py install for mozrunner 10:37:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:37:17 INFO - Running setup.py install for mozscreenshot 10:37:17 INFO - Running setup.py install for moztest 10:37:17 INFO - Running setup.py install for mozversion 10:37:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:37:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:37:17 INFO - Cleaning up... 10:37:17 INFO - Return code: 0 10:37:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:37: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')]} 10:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37: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')]} 10:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:17 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 0x7fc079aacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b350>, '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 0x278c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278c6e0>, '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': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', '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 10:37:17 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 10:37:17 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 10:37:17 INFO - Using env: {'DISPLAY': ':0', 10:37:17 INFO - 'HOME': '/home/cltbld', 10:37:17 INFO - 'LANG': 'en_US.UTF-8', 10:37:17 INFO - 'LANGUAGE': 'en_US:en', 10:37:17 INFO - 'LOGNAME': 'cltbld', 10:37:17 INFO - 'MAIL': '/var/mail/cltbld', 10:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:17 INFO - 'MOZ_NO_REMOTE': '1', 10:37:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:17 INFO - 'NO_EM_RESTART': '1', 10:37:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:17 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:17 INFO - 'SHELL': '/bin/bash', 10:37:17 INFO - 'SHLVL': '1', 10:37:17 INFO - 'TERM': 'linux', 10:37:17 INFO - 'TMOUT': '86400', 10:37:17 INFO - 'USER': 'cltbld', 10:37:17 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', 10:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:17 INFO - '_': '/tools/buildbot/bin/python'} 10:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:37:17 INFO - Running setup.py (path:/tmp/pip-EP22u7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:37:17 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)) 10:37:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:37:17 INFO - Running setup.py (path:/tmp/pip-evjnP0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:37:17 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)) 10:37:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:37:17 INFO - Running setup.py (path:/tmp/pip-b3t1Yn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:37:18 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)) 10:37:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:37:18 INFO - Running setup.py (path:/tmp/pip-lcg9X4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:37:18 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)) 10:37:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:37:18 INFO - Running setup.py (path:/tmp/pip-jF7wWn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:37:18 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)) 10:37:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:37:18 INFO - Running setup.py (path:/tmp/pip-xUqYwV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:37:18 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)) 10:37:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:37:18 INFO - Running setup.py (path:/tmp/pip-mU5ehz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:37:18 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)) 10:37:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:37:18 INFO - Running setup.py (path:/tmp/pip-xVzv5a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:37:18 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)) 10:37:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:37:18 INFO - Running setup.py (path:/tmp/pip-Mur2Va-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:37:18 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)) 10:37:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:37:18 INFO - Running setup.py (path:/tmp/pip-PWHAsm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:37:18 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)) 10:37:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:37:18 INFO - Running setup.py (path:/tmp/pip-Ryx1I8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:37:18 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)) 10:37:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:37:18 INFO - Running setup.py (path:/tmp/pip-9mmLyh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:37:18 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)) 10:37:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:37:18 INFO - Running setup.py (path:/tmp/pip-UEqask-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:37:18 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)) 10:37:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:37:18 INFO - Running setup.py (path:/tmp/pip-p9LdBl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:37:18 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)) 10:37:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:37:18 INFO - Running setup.py (path:/tmp/pip-LbO48B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:37:18 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)) 10:37:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:37:18 INFO - Running setup.py (path:/tmp/pip-16Igs2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:37:19 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)) 10:37:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:37:19 INFO - Running setup.py (path:/tmp/pip-9iMCRa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:37:19 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)) 10:37:19 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)) 10:37:19 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)) 10:37:19 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)) 10:37:19 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)) 10:37:19 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)) 10:37:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:37:19 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 10:37:19 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 10:37:19 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 10:37:19 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 10:37:19 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 10:37:19 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 10:37:20 INFO - Downloading blessings-1.6.tar.gz 10:37:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:37:20 INFO - Installing collected packages: blessings 10:37:20 INFO - Running setup.py install for blessings 10:37:21 INFO - Successfully installed blessings 10:37:21 INFO - Cleaning up... 10:37:21 INFO - Return code: 0 10:37:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:37:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:37:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:37:21 INFO - Reading from file tmpfile_stdout 10:37:21 INFO - Current package versions: 10:37:21 INFO - argparse == 1.2.1 10:37:21 INFO - blessings == 1.6 10:37:21 INFO - blobuploader == 1.2.4 10:37:21 INFO - docopt == 0.6.1 10:37:21 INFO - manifestparser == 1.1 10:37:21 INFO - mozInstall == 1.12 10:37:21 INFO - mozcrash == 0.16 10:37:21 INFO - mozdebug == 0.1 10:37:21 INFO - mozdevice == 0.47 10:37:21 INFO - mozfile == 1.2 10:37:21 INFO - mozhttpd == 0.7 10:37:21 INFO - mozinfo == 0.9 10:37:21 INFO - mozleak == 0.1 10:37:21 INFO - mozlog == 3.1 10:37:21 INFO - moznetwork == 0.27 10:37:21 INFO - mozprocess == 0.22 10:37:21 INFO - mozprofile == 0.27 10:37:21 INFO - mozrunner == 6.11 10:37:21 INFO - mozscreenshot == 0.1 10:37:21 INFO - mozsystemmonitor == 0.0 10:37:21 INFO - moztest == 0.7 10:37:21 INFO - mozversion == 1.4 10:37:21 INFO - psutil == 3.1.1 10:37:21 INFO - requests == 1.2.3 10:37:21 INFO - wsgiref == 0.1.2 10:37:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:37: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')]} 10:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37: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')]} 10:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:21 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 0x7fc079aacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b350>, '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 0x278c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278c6e0>, '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': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', '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 10:37:21 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 10:37:21 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 10:37:21 INFO - Using env: {'DISPLAY': ':0', 10:37:21 INFO - 'HOME': '/home/cltbld', 10:37:21 INFO - 'LANG': 'en_US.UTF-8', 10:37:21 INFO - 'LANGUAGE': 'en_US:en', 10:37:21 INFO - 'LOGNAME': 'cltbld', 10:37:21 INFO - 'MAIL': '/var/mail/cltbld', 10:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:21 INFO - 'MOZ_NO_REMOTE': '1', 10:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:21 INFO - 'NO_EM_RESTART': '1', 10:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:21 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:21 INFO - 'SHELL': '/bin/bash', 10:37:21 INFO - 'SHLVL': '1', 10:37:21 INFO - 'TERM': 'linux', 10:37:21 INFO - 'TMOUT': '86400', 10:37:21 INFO - 'USER': 'cltbld', 10:37:21 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', 10:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:21 INFO - '_': '/tools/buildbot/bin/python'} 10:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:21 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)) 10:37:21 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)) 10:37:21 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)) 10:37:21 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)) 10:37:21 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)) 10:37:21 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)) 10:37:21 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)) 10:37:21 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)) 10:37:21 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)) 10:37:21 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)) 10:37:21 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)) 10:37:21 INFO - Cleaning up... 10:37:21 INFO - Return code: 0 10:37:21 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:37: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')]} 10:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37: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')]} 10:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:21 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 0x7fc079aacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b350>, '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 0x278c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278c6e0>, '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': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', '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 10:37:21 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 10:37:21 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 10:37:21 INFO - Using env: {'DISPLAY': ':0', 10:37:21 INFO - 'HOME': '/home/cltbld', 10:37:21 INFO - 'LANG': 'en_US.UTF-8', 10:37:21 INFO - 'LANGUAGE': 'en_US:en', 10:37:21 INFO - 'LOGNAME': 'cltbld', 10:37:21 INFO - 'MAIL': '/var/mail/cltbld', 10:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:21 INFO - 'MOZ_NO_REMOTE': '1', 10:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:21 INFO - 'NO_EM_RESTART': '1', 10:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:21 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:21 INFO - 'SHELL': '/bin/bash', 10:37:21 INFO - 'SHLVL': '1', 10:37:21 INFO - 'TERM': 'linux', 10:37:21 INFO - 'TMOUT': '86400', 10:37:21 INFO - 'USER': 'cltbld', 10:37:21 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', 10:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:21 INFO - '_': '/tools/buildbot/bin/python'} 10:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:21 INFO - Downloading/unpacking jsonschema 10:37:21 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 10:37:21 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 10:37:21 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 10:37:21 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 10:37:21 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 10:37:21 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 10:37:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:37:23 INFO - Downloading/unpacking functools32 (from jsonschema) 10:37:23 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 10:37:23 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 10:37:23 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 10:37:23 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 10:37:23 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 10:37:23 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 10:37:23 INFO - Downloading functools32-3.2.3-2.tar.gz 10:37:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:37:23 INFO - warning: no files found matching '*.txt' 10:37:23 INFO - no previously-included directories found matching 'build' 10:37:23 INFO - no previously-included directories found matching 'dist' 10:37:23 INFO - no previously-included directories found matching '.git*' 10:37:23 INFO - Installing collected packages: jsonschema, functools32 10:37:24 INFO - Running setup.py install for functools32 10:37:24 INFO - warning: no files found matching '*.txt' 10:37:24 INFO - no previously-included directories found matching 'build' 10:37:24 INFO - no previously-included directories found matching 'dist' 10:37:24 INFO - no previously-included directories found matching '.git*' 10:37:24 INFO - Successfully installed jsonschema functools32 10:37:24 INFO - Cleaning up... 10:37:24 INFO - Return code: 0 10:37:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:24 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 0x7fc079aacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278b350>, '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 0x278c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278c6e0>, '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': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', '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 10:37:24 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 10:37:24 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 10:37:24 INFO - Using env: {'DISPLAY': ':0', 10:37:24 INFO - 'HOME': '/home/cltbld', 10:37:24 INFO - 'LANG': 'en_US.UTF-8', 10:37:24 INFO - 'LANGUAGE': 'en_US:en', 10:37:24 INFO - 'LOGNAME': 'cltbld', 10:37:24 INFO - 'MAIL': '/var/mail/cltbld', 10:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:24 INFO - 'MOZ_NO_REMOTE': '1', 10:37:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:24 INFO - 'NO_EM_RESTART': '1', 10:37:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:24 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:24 INFO - 'SHELL': '/bin/bash', 10:37:24 INFO - 'SHLVL': '1', 10:37:24 INFO - 'TERM': 'linux', 10:37:24 INFO - 'TMOUT': '86400', 10:37:24 INFO - 'USER': 'cltbld', 10:37:24 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', 10:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:24 INFO - '_': '/tools/buildbot/bin/python'} 10:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:24 INFO - Downloading/unpacking flake8 10:37:24 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 10:37:24 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 10:37:24 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 10:37:24 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 10:37:24 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 10:37:24 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 10:37:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:37:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:37:26 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 10:37:26 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 10:37:26 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 10:37:26 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 10:37:26 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 10:37:26 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 10:37:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:37:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:37:26 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 10:37:26 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 10:37:26 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 10:37:26 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 10:37:26 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 10:37:26 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 10:37:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:37:26 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 10:37:26 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 10:37:26 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 10:37:26 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 10:37:26 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 10:37:26 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 10:37:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:37:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:37:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:37:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:37:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:37:26 INFO - no previously-included directories found matching 'docs/_build' 10:37:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:37:26 INFO - Running setup.py install for pep8 10:37:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:37:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:37:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:37:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:37:27 INFO - no previously-included directories found matching 'docs/_build' 10:37:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:37:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:37:27 INFO - Cleaning up... 10:37:27 INFO - Return code: 0 10:37:27 INFO - Running post-action listener: _resource_record_post_action 10:37:27 INFO - Running post-action listener: _start_resource_monitoring 10:37:27 INFO - Starting resource monitoring. 10:37:27 INFO - ##### 10:37:27 INFO - ##### Running install step. 10:37:27 INFO - ##### 10:37:27 INFO - Running pre-action listener: _resource_record_pre_action 10:37:27 INFO - Running main action method: install 10:37:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:37:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:37:27 INFO - Reading from file tmpfile_stdout 10:37:27 INFO - Detecting whether we're running mozinstall >=1.0... 10:37:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:37:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:37:27 INFO - Reading from file tmpfile_stdout 10:37:27 INFO - Output received: 10:37:27 INFO - Usage: mozinstall [options] installer 10:37:27 INFO - Options: 10:37:27 INFO - -h, --help show this help message and exit 10:37:27 INFO - -d DEST, --destination=DEST 10:37:27 INFO - Directory to install application into. [default: 10:37:27 INFO - "/builds/slave/test-pgo"] 10:37:27 INFO - --app=APP Application being installed. [default: firefox] 10:37:27 INFO - mkdir: /builds/slave/test-pgo/build/application 10:37:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:37:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:37:41 INFO - Reading from file tmpfile_stdout 10:37:41 INFO - Output received: 10:37:41 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:37:41 INFO - Running post-action listener: _resource_record_post_action 10:37:41 INFO - ##### 10:37:41 INFO - ##### Running run-tests step. 10:37:41 INFO - ##### 10:37:41 INFO - Running pre-action listener: _resource_record_pre_action 10:37:41 INFO - Running main action method: run_tests 10:37:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:37:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:37:41 INFO - Python 2.7.3 10:37:41 INFO - Return code: 0 10:37:41 INFO - grabbing minidump binary from tooltool 10:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:41 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 0x278b350>, '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 0x278c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278c6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:37:41 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 10:37:41 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 10:37:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:37:42 INFO - Return code: 0 10:37:42 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:37:42 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:37:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:37:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:37:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:37:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:37:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:37:43 INFO - Return code: 0 10:37:43 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-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:37:43 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-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost 10:37:43 INFO - Using env: {'DISPLAY': ':0', 10:37:43 INFO - 'HOME': '/home/cltbld', 10:37:43 INFO - 'LANG': 'en_US.UTF-8', 10:37:43 INFO - 'LANGUAGE': 'en_US:en', 10:37:43 INFO - 'LOGNAME': 'cltbld', 10:37:43 INFO - 'MAIL': '/var/mail/cltbld', 10:37:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:37:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:43 INFO - 'MOZ_NO_REMOTE': '1', 10:37:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:43 INFO - 'NO_EM_RESTART': '1', 10:37:43 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:43 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:43 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:37:43 INFO - 'SHELL': '/bin/bash', 10:37:43 INFO - 'SHLVL': '1', 10:37:43 INFO - 'TERM': 'linux', 10:37:43 INFO - 'TMOUT': '86400', 10:37:43 INFO - 'USER': 'cltbld', 10:37:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251', 10:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:43 INFO - '_': '/tools/buildbot/bin/python'} 10:37:43 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] with output_timeout 3600 10:37:43 INFO - mozversion INFO | application_buildid: 20160222074756 10:37:43 INFO - mozversion INFO | application_changeset: 7da232006437a6e23eae84ac9884ef05a113814c 10:37:43 INFO - mozversion INFO | application_display_name: Nightly 10:37:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:37:43 INFO - mozversion INFO | application_name: Firefox 10:37:43 INFO - mozversion INFO | application_remotingname: firefox 10:37:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:37:43 INFO - mozversion INFO | application_vendor: Mozilla 10:37:43 INFO - mozversion INFO | application_version: 45.0 10:37:43 INFO - mozversion INFO | platform_buildid: 20160222074756 10:37:43 INFO - mozversion INFO | platform_changeset: 7da232006437a6e23eae84ac9884ef05a113814c 10:37:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:37:43 INFO - mozversion INFO | platform_version: 45.0 10:37:43 INFO - 2016-02-22 10:37:43,298 DEBUG : using testdate: 1456166263 10:37:43 INFO - 2016-02-22 10:37:43,298 DEBUG : actual date: 1456166263 10:37:43 INFO - 2016-02-22 10:37:43,344 INFO : starting webserver on 'localhost:48429' 10:37:43 INFO - 2016-02-22 10:37:43,345 INFO : Starting test suite talos-linux64-ix-028 10:37:43 INFO - 2016-02-22 10:37:43,346 INFO : Starting test dromaeo_css 10:37:43 INFO - 2016-02-22 10:37:43,346 DEBUG : operating with platform_type : linux_ 10:37:43 INFO - 2016-02-22 10:37:43,346 INFO : Initialising browser for dromaeo_css test... 10:37:43 INFO - 2016-02-22 10:37:43,359 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZyDTBc/profile http://localhost:48429/getInfo.html 10:37:47 INFO - 2016-02-22 10:37:47,518 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:37:47 INFO - 2016-02-22 10:37:47,518 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:37:47 INFO - 2016-02-22 10:37:47,518 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:37:47 INFO - 2016-02-22 10:37:47,519 DEBUG : BROWSER_OUTPUT: __metrics 10:37:47 INFO - 2016-02-22 10:37:47,667 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:37:48 INFO - 2016-02-22 10:37:48,562 INFO : Browser initialized. 10:37:48 INFO - 2016-02-22 10:37:48,562 INFO : Running cycle 1/1 for dromaeo_css test... 10:37:48 INFO - 2016-02-22 10:37:48,563 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZyDTBc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:38:00 INFO - 2016-02-22 10:38:00,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 132517888 10:38:00 INFO - 2016-02-22 10:38:00,225 DEBUG : BROWSER_OUTPUT: 10:38:51 INFO - 2016-02-22 10:38:51,177 DEBUG : BROWSER_OUTPUT: 1456166331174 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] 10:40:59 INFO - 2016-02-22 10:40:59,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48429/tests/dromaeo/cssquery-ext.html) 10:41:00 INFO - 2016-02-22 10:41:00,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 212205568 10:41:00 INFO - 2016-02-22 10:41:00,667 DEBUG : BROWSER_OUTPUT: 10:44:02 INFO - 2016-02-22 10:44:02,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/dromaeo/cssquery-ext.html (next: http://localhost:48429/tests/dromaeo/cssquery-jquery.html) 10:44:03 INFO - 2016-02-22 10:44:03,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 214839296 10:44:03 INFO - 2016-02-22 10:44:03,310 DEBUG : BROWSER_OUTPUT: 10:47:05 INFO - 2016-02-22 10:47:05,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48429/tests/dromaeo/cssquery-mootools.html) 10:47:05 INFO - 2016-02-22 10:47:05,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 212549632 10:47:05 INFO - 2016-02-22 10:47:05,692 DEBUG : BROWSER_OUTPUT: 10:50:07 INFO - 2016-02-22 10:50:07,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48429/tests/dromaeo/cssquery-prototype.html) 10:50:08 INFO - 2016-02-22 10:50:08,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 193728512 10:50:08 INFO - 2016-02-22 10:50:08,028 DEBUG : BROWSER_OUTPUT: 10:53:10 INFO - 2016-02-22 10:53:10,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48429/tests/dromaeo/cssquery-yui.html) 10:53:10 INFO - 2016-02-22 10:53:10,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 196354048 10:53:10 INFO - 2016-02-22 10:53:10,923 DEBUG : BROWSER_OUTPUT: 10:56:13 INFO - 2016-02-22 10:56:13,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/dromaeo/cssquery-yui.html (next: http://localhost:48429/tests/dromaeo/cssquery-dojo.html) 10:56:13 INFO - 2016-02-22 10:56:13,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 243707904 10:56:13 INFO - 2016-02-22 10:56:13,334 DEBUG : BROWSER_OUTPUT: 10:56:13 INFO - 2016-02-22 10:56:13,336 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:56:13 INFO - 2016-02-22 10:56:13,336 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:56:13 INFO - 2016-02-22 10:56:13,336 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:56:13 INFO - 2016-02-22 10:56:13,336 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:56:13 INFO - 2016-02-22 10:56:13,340 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3302.290007648356;3371.6628337166303;3397.473391624299;3403.778754380965;3414.470757032659;5497.285352904117;5515.448455154483;5515.751791169397;5520.254765606642;5533.916991245134;5473.945260547393;5498.972505137479;5511.338639363272;5521.806736764214;5522.585806064541;4968.378952630921;5006.874828129289;5027.673201241908;5062.645614806965;5108.872278193056;5046.3187469691675;5097.515736005093;5111.258867464216;5113.565346945514;5119.7696103675235;4991.900161996758;5033.446320904697;5097.413797413289;5097.872553186182;5099.923501147486;5043;5126.051680439112;5129.948700512984;5133.204353325241;5135.563477104451;5033.79864805411;5117.181250999859;5134.743262836881;5141.485851414866;5157.922631160535;5245.449227831061;5319.521243088141;5339.305890234284;5457.154141108134;5460.590455715797;5959.553033522459;5993.670348130851;6004;6006.189164462785;6008.939910600881;5948.494377977877;6039.63762174271;6045.33501314855;6046.2744470663365;6046.516278697738;5380.3274590676165;5496.258005169331;5509.449055094458;5585.385607583163;5621.80323688669;5985.700714964234;6087;6105.542084343692;6113.786017489456;6121.693915304217;5642.322921249476;5856.502197313191;5865.266841644794;5870.178175055496;5879.5002424794375;5791.189233507313;5795.33353664334;5892.528597712173;5948.405159484104;5969.970150149222;5902.940970590239;5928.4960778334325;5950.732217050243;5957.672328022;5957.821265362046;5936.1392598073035;5936.465718085393;5939.465448109604;5941.287045554561;5942.970285148633;4397.164538737629;4446.62203712688;4478.2386994211065;4545.499995000548;4570.977145114253;4081.2653722329674;4100.17996400721;4102.179564087194;4128.174365126986;4134.586541345841;5448.346198456132;5691.715414229355;5700.201971723962;5701.116326969326;5705.743241554057;5846.473817356458;5904.380040095728;5928.911066334009;5954.166416701665;5993.640381577119;5683.403242659461;5725.541956643458;5730.169125476783;5734.16854556087;5738.5982981191755;5066.16408292635;5155.9742201288755;5216.321878155815;5222.529972302511;5225.111731005738;6138.388398386059;6244.063390491463;6244.219472565929;6247.125402443661;6275.6862156892885;5991.7603295867675;5995.670238136944;6003.369646187088;6019.127226552037;6036.607620504653;5954.07711804671;6126.111713801563;6139.3553676863285;6165.84585385369;6184.474319682698;6002.489788367863;6003;6015.037593984942;6016.669083200466;6018.976773948351;6022.939770602413;6083.391660834058;6083.574149809471;6085.878282434415;6120.479759220338;5682.346530149086;5774.133879918046;5781.075027995501;5883.0881213411985;5927.9703601481715;5858.091995740667;5858.648481091148;5861.413858614275;5864;5866.735996880066;5790;5792.94207057924;5794.884102318014;5795;5795.536357091507;5687.829365119053;5704.885902282014;5766.682832444256;5859.58982871212;5887.882242355044;5770.394108618535;5837.124431335334;5837.387074357302;5841.065429531254;5848.181254624441 10:56:13 INFO - 2016-02-22 10:56:13,340 DEBUG : BROWSER_OUTPUT: |1;ext.html;594.5154698920383;632.9651869147197;640.174175313845;651.6839332923531;651.882022331701;33536.496952545735;34632;34638.65361346389;41008.58991410085;41608.167836643246;48011;48530.75734621331;48752.756236218855;48776.75611621946;48859;9161.908380916206;9340.3461757677;9341.76645583859;9346.719598412059;9347;8229.876551851727;8408.411411201188;10934.398608076554;11179.441027948611;11191.720206994849;10918.01737843594;10980.890191098106;10998.835017474705;11010;11030.779384412306;10885.727856803564;10976.835347469794;11000.954909283646;11007.61473348429;11007.944960275227;10635.468226588717;10749.301295415773;10759.83860242097;10765.084967777748;10766.892331076746;43085.78457107695;43211.56788432138;43638.78180609077;43692.3446148308;43728.781356093335;3810.961890381116;4099.139180772041;4124.6906482013665;4287.978560107211;4337.544557821415;32516.18709532257;32866.83566582176;33128.83435582831;33159.33681326384;33493.162670933176;3488.720902327808;3610.891673249807;3631.2737452509605;4152.771597562133;4223.092035212444;289725;289923.5503822488;290788;292237;294203;62060;62850.685746570976;67325.66337168282;67722.66138669275;76370.61814691003;69771.30228697648;70073.64963175151;70237;70356.6482167586;70421.2957870425;16732.91633541849;16740.41408550695;16804.83195168057;16819.579510512336;16901;12700.364981750876;12777.616671499869;12794.808077878839;12802.743945121045;12802.871971280169;22816.087356505886;23272.95271712777;23278.767212328;23298.883505582362;23425.180118695764;8344.374171937008;8775.648974040967;8850.822983540293;8853.114688531225;8860.64557417709;1021.7701017271203;1023.1558963854701;1145.587588468151;1179.4633441783967;1222.7860124478182;29065.7093429063;29568.704312957027;29768.809247630285;30077.248068798017;30081.849590751906;1093.781243751237;1103.87857335693;1171.7949358862165;1186.5372504723166;1193.9223950443193;15252.466163684217;15646.9217653911;16023.038617682743;18397.54006149857;18454.26182952694;427468;431406;432104;432215;432283;61139.694301529096;61569.38430615726;62061;62094.68952655298;62207.6889615549;1362.1963041805382;1377.407714682676;1399.734050530396;1464.1946929188903;1467.3470305714068;30799.53800693036;32550.83724581362;34879.302413952086;35011.47482787709;35061.82469087638;55819.72090139523;56697.71651141883;56742;56775.43224567702;56828;338184;338605;341085;341482;342094;31279.687203127676;31328.53007204848;35107.82446087855;35558.822205888806;36320.81839590891;41126.38310425286;41274.58725412827;41486.377704333856;42287.1542569153;42408;35120.47319290161;35547.11132221715;35711.46432803458;37382;45777.313340300585;35777.82111089428;39207;44179.55820441883;44329.55670443254;45434.77282613566;39914.40128398018;40002.399964001146;40641;40766.59233407628;43017.139657207306;34584.48123278103;40045.1990960185;40370.394444082776;40433;41225.38161927513;26963.460730785668;27463;27883;28019.719802801712;28051.859740701166 10:56:13 INFO - 2016-02-22 10:56:13,344 DEBUG : BROWSER_OUTPUT: |2;jquery.html;385.5585354768792;391.631866045917;397.0867005886461;397.4277041060872;401.3277759752415;15453.536393908173;15839.940807694984;17783.37758178464;18207.54481137972;18216.90891545542;19242;19451.90274048628;19488;19502.317418890343;19650.312239071634;6269.968650156754;6416.101745755598;6434.806955791334;6437.5815571987905;6440.420362167404;4641.25739881619;4770.7376094314795;6231.189945307126;7054.823629409255;7247.420206383503;7134.75028374007;7213.711451541932;7220.350168484835;7228.674709638052;7237.710491580357;7199.316064973819;7212.891806622905;7238.674259658328;7243.167035790899;7254.238304977954;6807.183138023469;6960.269171736945;6977.79066628002;6980.47646426515;6991.545549539263;24732.876335618388;24977.750222497907;25513.362165945815;25563.23310300694;26103.869480652476;2435.342457536473;2455.7789798918006;2463.285647162321;2497.300755788382;2502.0117053763843;15273.312700928485;15641.374345026185;15699.764503532342;15752.606184845356;16092.275847586887;2029.3810387831707;2102.894855257231;2116.968245476319;2148.34475484977;2204.548067646129;75737.62131189364;79449;81519;81947.59026204831;82096.58951705204;16978.660426791394;17001;17010.57473563146;17016.489505314614;17064.914675426542;27784.58323125155;27873.44253114967;28190.71809281922;28287.15138545847;28300.575491367646;7455.962720186473;7674.347680447225;7921.841563168704;7981.1220765715725;7993.360531157494;7579.090509138939;7583.734569290159;7606.087269527692;7616.276453736886;7627.5042122261875;4185.455890734185;4276.850310239189;4767.952320476751;4796.5203479651755;4827.517248275144;1913.9712904306446;1964.62672092302;1997.021459484842;2001.699745038256;2010.4672261850621;852.8464876322322;867.0852250875387;899.0425197164998;912.6531917871299;983.5082458770614;16004.114116813069;18017.459476215736;18388.724169137473;18634.906825465787;18810;982.7101005203482;1005.4218824176128;1042.593388578455;1062.5431064642278;1070.6466865934224;8370.372222083368;8497.830043399097;9816.165625921734;10377.792444151226;10397.532111055021;642006;645173;660813;664858;667026;80416.99999999884;81119;91096;91721.08278917125;92822.53588732149;1187.8990285825628;1188.0258188285522;1232.5686009896644;1252.1798222164498;1257.4655771297162;16632.916835415745;16683.83213175066;16822.915885420494;16861.578460538585;17049.573760656083;36451;36796.080097997765;36831.07922301857;36971.815140924125;40157.19685606213;52404.73797630987;52585.21122183247;55275.44724552864;55765.442345576026;60248.39751602428;10272.22958278147;10292.330998485075;10412.791744165226;10509.684709458728;10538.525766340686;18695.345662901735;19062.7140592894;19077.332293369665;19256.518587035436;19403.223871045;14528.63678408006;15053;15655.608609784846;15888;15932;13315.733685326433;13388.397522111334;13621.114627549177;14139.717205656036;15794.842051579797;15052.096874187584;15305.234738263265;16285.511434656979;16565.83434165691;16647.667046658757;9215.539223038688;10357.9482102589;10752.247342686249;10774.46127693628;10901.836472453078;12471.251724896536;14737.115773053221;15257.6185595361;15533.611659708145;15644.374225030871 10:56:13 INFO - 2016-02-22 10:56:13,345 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1540.4223416218917;1541.6223025358788;1751.2819743905002;1802.3691707902235;1834.6147309065095;7329.780106596811;7434;7956.124826269113;8171.10117887032;8188.91811081889;7724.536527808335;7898.249666281708;7974.800629984254;7993.720219792309;8004.239597238267;2312.814974802012;2347.166755801683;2348.1194552042984;2348.4481146930457;2349.518348738513;2037.3378651938106;2076.5431605046942;2080.1887263967064;2338.6608941703444;2364.858108513486;2351;2354.705661792276;2360.280114565057;2362.456634973957;2362.870042147681;2260.525289689167;2326.9883650581637;2328.569214695287;2330.3707998840305;2332.300309907021;2346.917857874966;2350.659154422599;2392.2823153054187;2392.988035059831;2395;7977.242161994601;8130.471519351282;8146.959265203695;8150.75547733569;8162.224588664068;4902.534259245366;4998.325226094467;5016.924746128811;5019.196928491424;5019.498050194988;3021.773366997484;3022.153796936861;3118.3451475190236;3120.469520181575;3125.0312403155094;983.6458874805136;991.8660980767576;1005.261133067195;1027.3835698580792;1035.8342665173611;10966.780664386668;11174.553017879274;11177.66467005991;11197.720056998558;11198.888011119867;4403.361512580658;4441.533638967927;4454.710443821141;4459.955400446019;4487.371767952489;9523.380980236263;9524.95237523808;9537.14165725088;9559.952200238955;9572.952135239279;5007.198848184273;5012.749362531932;5041.067402530543;5044.646874718808;5048.570871475966;4570.588647021717;4585.060062687141;4601.815927362935;4609.654275929319;4632.60622847055;3863.459115723801;3929.0373858404873;3950.486436763202;3952.6245006724316;3961.8217180226957;1174.8413964114734;1185.2888267039707;1229.3791635224334;1269.6000759760645;1272.6945533071996;1080.8216644253766;1084.8806631270554;1122.2144498850673;1275.5535562553032;1435.1604311477693;7256.092988376453;7296.416286697052;7309.817254568572;7453.85092298151;7712.113106992655;1189.4766302826729;1194.4804010255393;1198.8741182175745;1201.6034708546158;1214.7995580729257;5944.821655350346;6047.3045599755715;6060.454559089703;6082.817515474543;6086.391360863967;9358.57886395114;9848.507574621384;9947.850782238273;9951.900480995097;9956.502174891226;9666.371685840399;9811.852822207673;9815.411075335503;9821.508924553744;9843.261755368232;7263.382612477999;7407.407407407394;7435.1449583297535;7481.21447248042;7488.925110748932;7401.481896267425;7607.049118860143;7636.31273185416;7663.233676632292;7680.654370553227;8482.491050536988;8682.609282582172;8724.083971182934;8810.955945220232;8843.159899809765;8787.428817126865;8795.956020219857;8916.86624700643;9028.59371328305;9118.95440522793;7787.143414224544;7792.727254546064;7798.610069496616;7864.213578642319;7870.763877083697;6929.133858267716;7792.922070779219;7956;7981.960090199512;7982.720604778805;6745.696443660146;6778.593284402951;7189.7483588074165;7242.420606351374;7390.889136662847;7245.746398876014;7319.268073192638;7340.009098771598;7367.189609143097;7455.478116531791;7428.405727541892;7467.477276590586;7489.812754681177;7514.398848092249;7521.172671006076;6584.539082264196;6862.073620061228;6869.072675188786;6904.930950690429;6905.482088843457;6757.594544327356;6835.487338449736;6836.863262734817;6842.0079088532875;6844.760433384808 10:56:13 INFO - 2016-02-22 10:56:13,346 DEBUG : BROWSER_OUTPUT: |4;prototype.html;376.4503824416352;384.9307124717553;386.39722033627544;388.1906225519791;391.41874316639786;6037.849053773658;6038.758449662019;6049.969750151254;6060.8484787880325;6113.480354169889;5785.913211301834;5848.1520179574045;5943.049112142058;6010.489108425789;6019.247594050744;4671.813127474897;4689.085628302465;4745.145873742725;4751.762411879409;4752.881177970561;4686.578207961283;4700.224462963624;4700.365450664151;4717.716936983775;4745.928811067837;4500;4564.790330562404;4573.245414506602;4628.652851036169;4689.742064186468;4668.253079507263;4670.906581868344;4671.3226582145735;4682.2274324736545;4694.530546945312;4179.644730197937;4187.350960601112;4188.5811418858175;4191.580841915784;4194.203101410752;5649.92632919609;5754.510866576346;5754.827355179351;5756;5763.366029736726;5492.780288788444;5498.917516237259;5503.972480137573;5505.201745746885;5505.807296744635;6351.8412039698915;6356.555041147121;6368.395002474757;6385.169927909388;6390.297067322591;4579.862604121881;4606.493285738566;4614.584687378152;4626.699264547794;4647.86056418308;6406.967965160191;6587.868242635121;6597.670116494204;6610.7355705771715;6610.966945165292;4662.580367766917;4680.789364478606;4685.648576356787;4687.179743544866;4690.6012988895645;4728.739919304471;4750.263709125022;4750.548697873696;4758.048390321949;4759.428868535798;5422.457754224625;5429.267048948342;5430.8913821723345;5434.049041417736;5436.266104075979;6321.810345689637;6445.1621289233035;6452.35476452351;6457.225132983978;6462.838429039311;1657.593889497081;1681.277050868114;1681.4199101310273;1681.6972944869797;1682.3270691723164;1127.3968426891574;1141.132739118276;1143.6226045404997;1163.6101905861462;1167.9474423650956;6273.404026617464;6284.842878928063;6287.276963149205;6288.276848162428;6295.307516173218;6649.833754156088;6657.933420665731;6660.400563949171;6661.566998145105;6662.400383965466;6109.2974307955155;6126.6017708848785;6230.968845155745;6255.24937007562;6266;3541.6812486876306;3566.28674265148;3584.0502266899293;3588.802615856153;3590.8743193988084;6817;6856.862862742717;6865.485088618374;6867.519273650896;6873.20958089816;6699.062131301622;6837.9658101710165;6848.897266541006;6853.862922741518;6857;6826.658667066627;6863.176418829772;6869.587824730532;6875.5530890491955;6879.277675843964;6543.345665433419;6659.800205993828;6662.500312476681;6663.633500157538;6671.299513551007;6589.27517973013;6589.505787065893;6590.47276217911;6594.340565943367;6609.4712423005085;6854.211765646815;6859.279775623687;6863.519553631398;6870.141232345957;6871.209810871814;4782.95217047839;4812.1578723722505;4819.084373968934;4821.349117869043;4823.059503396804;6492.448141907991;6634.502412318999;6641.900371494528;6646.302138275411;6648.301928297459;6420.807375778734;6436.356364363526;6439.613623182624;6441.066045423481;6452.322506136788;6343.207099112611;6422.550421470452;6427.614343139427;6433.742650293936;6433.774817881352;6303.1175635412;6334.239891212899;6334.746610135543;6343.682815859281;6350.936490635035;6373.6175829450385;6397.6481293529305;6398.680065996775;6430.935690643221;6464.967675161594;6178.783742568989;6308.306086330592;6309.022101574264;6310.842228944313;6324.272708638566 10:56:13 INFO - 2016-02-22 10:56:13,347 DEBUG : BROWSER_OUTPUT: |5;yui.html;765.5712800831532;860.8751730999005;909.0545832334373;918.2883265469259;927.0775578299593;13802.447902083917;14224.288785560706;14231.359588818503;14237.71524569508;14251.78622320666;12846.229226246433;12854.871451285508;12967.416466259017;13037.02222333324;13319.933400332984;755.0222461911837;762.7368557847534;903.6159632156324;912.0605776050645;919.7608621758324;915.4370062411602;928.4893308680232;933.1508327422048;935.4480856294784;935.550935550936;961.9711408657752;973.5132433783108;976.5019839881676;976.7802244494967;977.0376179463223;803.6423791412824;815.384384789486;951.6859436385976;964.4358050540442;966.9274804389629;713.9500234983553;717.9605121718304;719.481972979454;720.0926832191424;720.5136532840312;13062.608121756362;13287.069905106646;13375;13377.531786387526;13384.196948183042;12725.872741272655;13385.598432047054;13403.731925361535;13411.46354145833;13664.795028074586;10641.220992680992;10730.22504985282;10737.78524429507;10852.945735271353;10907.072898803532;3774.7735135891935;3795.6583907448185;3798.5631652360057;3800.3539398302355;3844.058205739612;46696.533034669555;46959.29561056587;46987.060258794976;48039.519604803856;48771.512284877404;10174.694759157237;10481.161507079416;10505.632302869362;10807.189460790472;11011.394373309384;19403.708944365844;19655.50861228452;19662.213511459668;19671.21315147378;19698.113584888713;7852.685892564347;7913.604319784103;7918.564478953713;8064.556449395222;8260.215279548433;4556.544345565483;4628.606568441653;4727.314539391838;4739.715617062987;4763.428388593322;3247.626522949891;3248.1067706380936;3250.9837450813066;3251.9187020324207;3255.8860439884966;575.1085816983742;582.912563115536;583.4777873803007;587.0079565534234;596.60325883288;679.813051410866;681.9590824550543;712.0458585495461;718.5688586847849;720.3408880874047;8653.17794809492;8858.247049000778;9018.59416326267;9021.32340074497;9033.77415564603;635.3773302163813;638.6998110887876;690.7685925215109;697.1703672629656;747.4805010517638;3847.3844184930276;4175.206710724952;4294.592013758688;4345.782710864444;4434.733915965053;62258.688706557085;63885;64176;64358.356416436174;64477;56917.43082569204;57206.42793572011;57832;58144.418555814744;58327;51008.48991510038;51445.742771285906;51484.74257628688;51549.48450515447;51904.22143667848;8532.104129066358;8583.227509524173;8597.398182127192;8722.215000649972;8787.340949428946;36897.63102368942;36996.44505332476;37920.620793791706;38008.38920302567;38283;45020.54979450163;49591.75204124101;49838.50161498484;50599.241011385595;50763.74618127033;10261.384316941007;11707.765844683228;11719.531218751154;11720.589779357682;11772.70568235801;12218.327991960528;12532.373381330715;13467.32663366808;13595.660108497366;13895.72208555803;11757.647270581896;11779.116566257737;11807.468663909973;11842.585509507471;12191.75616487683;11100.389478578756;11254.94372528132;11650.88349116498;11741.589044383405;11765.941170294094;10270.33242839213;10507.15942724565;10514.526846292089;12150.270983741004;12311.138220324492;9978.201743860329;10308.793824123626;10324.122449591869;10442;10543.103836173705;9209;9349.532523373668;9355.906440935503;9463.432194068379;9622.566984485575 10:56:13 INFO - 2016-02-22 10:56:13,348 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:56:13 INFO - 2016-02-22 10:56:13,348 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:56:13 INFO - 2016-02-22 10:56:13,348 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,846 10:56:13 INFO - 2016-02-22 10:56:13,348 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:56:13 INFO - 2016-02-22 10:56:13,348 DEBUG : BROWSER_OUTPUT: __startTimestamp1456167373335__endTimestamp 10:56:13 INFO - 2016-02-22 10:56:13,348 DEBUG : BROWSER_OUTPUT: 10:56:13 INFO - 2016-02-22 10:56:13,349 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:56:13 INFO - 2016-02-22 10:56:13,349 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:56:13 INFO - 2016-02-22 10:56:13,349 DEBUG : BROWSER_OUTPUT: 10:56:13 INFO - 2016-02-22 10:56:13,349 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5544.93 Median:5781.08 stddev:616.93 (10.7%) stddev-sans-first:593.21 10:56:13 INFO - 2016-02-22 10:56:13,349 DEBUG : BROWSER_OUTPUT: Values: 3302.3 3371.7 3397.5 3403.8 3414.5 5497.3 5515.4 5515.8 5520.3 5533.9 5473.9 5499.0 5511.3 5521.8 5522.6 4968.4 5006.9 5027.7 5062.6 5108.9 5046.3 5097.5 5111.3 5113.6 5119.8 4991.9 5033.4 5097.4 5097.9 5099.9 5043.0 5126.1 5129.9 5133.2 5135.6 5033.8 5117.2 5134.7 5141.5 5157.9 5245.4 5319.5 5339.3 5457.2 5460.6 5959.6 5993.7 6004.0 6006.2 6008.9 5948.5 6039.6 6045.3 6046.3 6046.5 5380.3 5496.3 5509.4 5585.4 5621.8 5985.7 6087.0 6105.5 6113.8 6121.7 5642.3 5856.5 5865.3 5870.2 5879.5 5791.2 5795.3 5892.5 5948.4 5970.0 5902.9 5928.5 5950.7 5957.7 5957.8 5936.1 5936.5 5939.5 5941.3 5943.0 4397.2 4446.6 4478.2 4545.5 4571.0 4081.3 4100.2 4102.2 4128.2 4134.6 5448.3 5691.7 5700.2 5701.1 5705.7 5846.5 5904.4 5928.9 5954.2 5993.6 5683.4 5725.5 5730.2 5734.2 5738.6 5066.2 5156.0 5216.3 5222.5 5225.1 6138.4 6244.1 6244.2 6247.1 6275.7 5991.8 5995.7 6003.4 6019.1 6036.6 5954.1 6126.1 6139.4 6165.8 6184.5 6002.5 6003.0 6015.0 6016.7 6019.0 6022.9 6083.4 6083.6 6085.9 6120.5 5682.3 5774.1 5781.1 5883.1 5928.0 5858.1 5858.6 5861.4 5864.0 5866.7 5790.0 5792.9 5794.9 5795.0 5795.5 5687.8 5704.9 5766.7 5859.6 5887.9 5770.4 5837.1 5837.4 5841.1 5848.2 10:56:13 INFO - 2016-02-22 10:56:13,349 DEBUG : BROWSER_OUTPUT: 10:56:13 INFO - 2016-02-22 10:56:13,349 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:54163.61 Median:35114.15 stddev:94278.25 (268.5%) stddev-sans-first:94456.93 10:56:13 INFO - 2016-02-22 10:56:13,349 DEBUG : BROWSER_OUTPUT: Values: 594.5 633.0 640.2 651.7 651.9 33536.5 34632.0 34638.7 41008.6 41608.2 48011.0 48530.8 48752.8 48776.8 48859.0 9161.9 9340.3 9341.8 9346.7 9347.0 8229.9 8408.4 10934.4 11179.4 11191.7 10918.0 10980.9 10998.8 11010.0 11030.8 10885.7 10976.8 11001.0 11007.6 11007.9 10635.5 10749.3 10759.8 10765.1 10766.9 43085.8 43211.6 43638.8 43692.3 43728.8 3811.0 4099.1 4124.7 4288.0 4337.5 32516.2 32866.8 33128.8 33159.3 33493.2 3488.7 3610.9 3631.3 4152.8 4223.1 289725.0 289923.6 290788.0 292237.0 294203.0 62060.0 62850.7 67325.7 67722.7 76370.6 69771.3 70073.6 70237.0 70356.6 70421.3 16732.9 16740.4 16804.8 16819.6 16901.0 12700.4 12777.6 12794.8 12802.7 12802.9 22816.1 23273.0 23278.8 23298.9 23425.2 8344.4 8775.6 8850.8 8853.1 8860.6 1021.8 1023.2 1145.6 1179.5 1222.8 29065.7 29568.7 29768.8 30077.2 30081.8 1093.8 1103.9 1171.8 1186.5 1193.9 15252.5 15646.9 16023.0 18397.5 18454.3 427468.0 431406.0 432104.0 432215.0 432283.0 61139.7 61569.4 62061.0 62094.7 62207.7 1362.2 1377.4 1399.7 1464.2 1467.3 30799.5 32550.8 34879.3 35011.5 35061.8 55819.7 56697.7 56742.0 56775.4 56828.0 338184.0 338605.0 341085.0 341482.0 342094.0 31279.7 31328.5 35107.8 35558.8 36320.8 41126.4 41274.6 41486.4 42287.2 42408.0 35120.5 35547.1 35711.5 37382.0 45777.3 35777.8 39207.0 44179.6 44329.6 45434.8 39914.4 40002.4 40641.0 40766.6 43017.1 34584.5 40045.2 40370.4 40433.0 41225.4 26963.5 27463.0 27883.0 28019.7 28051.9 10:56:13 INFO - 2016-02-22 10:56:13,350 DEBUG : BROWSER_OUTPUT: 10:56:13 INFO - 2016-02-22 10:56:13,350 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:34644.67 Median:13739.88 stddev:107145.61 (779.8%) stddev-sans-first:107415.30 10:56:13 INFO - 2016-02-22 10:56:13,350 DEBUG : BROWSER_OUTPUT: Values: 385.6 391.6 397.1 397.4 401.3 15453.5 15839.9 17783.4 18207.5 18216.9 19242.0 19451.9 19488.0 19502.3 19650.3 6270.0 6416.1 6434.8 6437.6 6440.4 4641.3 4770.7 6231.2 7054.8 7247.4 7134.8 7213.7 7220.4 7228.7 7237.7 7199.3 7212.9 7238.7 7243.2 7254.2 6807.2 6960.3 6977.8 6980.5 6991.5 24732.9 24977.8 25513.4 25563.2 26103.9 2435.3 2455.8 2463.3 2497.3 2502.0 15273.3 15641.4 15699.8 15752.6 16092.3 2029.4 2102.9 2117.0 2148.3 2204.5 75737.6 79449.0 81519.0 81947.6 82096.6 16978.7 17001.0 17010.6 17016.5 17064.9 27784.6 27873.4 28190.7 28287.2 28300.6 7456.0 7674.3 7921.8 7981.1 7993.4 7579.1 7583.7 7606.1 7616.3 7627.5 4185.5 4276.9 4768.0 4796.5 4827.5 1914.0 1964.6 1997.0 2001.7 2010.5 852.8 867.1 899.0 912.7 983.5 16004.1 18017.5 18388.7 18634.9 18810.0 982.7 1005.4 1042.6 1062.5 1070.6 8370.4 8497.8 9816.2 10377.8 10397.5 642006.0 645173.0 660813.0 664858.0 667026.0 80417.0 81119.0 91096.0 91721.1 92822.5 1187.9 1188.0 1232.6 1252.2 1257.5 16632.9 16683.8 16822.9 16861.6 17049.6 36451.0 36796.1 36831.1 36971.8 40157.2 52404.7 52585.2 55275.4 55765.4 60248.4 10272.2 10292.3 10412.8 10509.7 10538.5 18695.3 19062.7 19077.3 19256.5 19403.2 14528.6 15053.0 15655.6 15888.0 15932.0 13315.7 13388.4 13621.1 14139.7 15794.8 15052.1 15305.2 16285.5 16565.8 16647.7 9215.5 10357.9 10752.2 10774.5 10901.8 12471.3 14737.1 15257.6 15533.6 15644.4 10:56:13 INFO - 2016-02-22 10:56:13,350 DEBUG : BROWSER_OUTPUT: 10:56:13 INFO - 2016-02-22 10:56:13,352 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5703.43 Median:6768.09 stddev:2949.75 (43.6%) stddev-sans-first:2941.43 10:56:13 INFO - 2016-02-22 10:56:13,352 DEBUG : BROWSER_OUTPUT: Values: 1540.4 1541.6 1751.3 1802.4 1834.6 7329.8 7434.0 7956.1 8171.1 8188.9 7724.5 7898.2 7974.8 7993.7 8004.2 2312.8 2347.2 2348.1 2348.4 2349.5 2037.3 2076.5 2080.2 2338.7 2364.9 2351.0 2354.7 2360.3 2362.5 2362.9 2260.5 2327.0 2328.6 2330.4 2332.3 2346.9 2350.7 2392.3 2393.0 2395.0 7977.2 8130.5 8147.0 8150.8 8162.2 4902.5 4998.3 5016.9 5019.2 5019.5 3021.8 3022.2 3118.3 3120.5 3125.0 983.6 991.9 1005.3 1027.4 1035.8 10966.8 11174.6 11177.7 11197.7 11198.9 4403.4 4441.5 4454.7 4460.0 4487.4 9523.4 9525.0 9537.1 9560.0 9573.0 5007.2 5012.7 5041.1 5044.6 5048.6 4570.6 4585.1 4601.8 4609.7 4632.6 3863.5 3929.0 3950.5 3952.6 3961.8 1174.8 1185.3 1229.4 1269.6 1272.7 1080.8 1084.9 1122.2 1275.6 1435.2 7256.1 7296.4 7309.8 7453.9 7712.1 1189.5 1194.5 1198.9 1201.6 1214.8 5944.8 6047.3 6060.5 6082.8 6086.4 9358.6 9848.5 9947.9 9951.9 9956.5 9666.4 9811.9 9815.4 9821.5 9843.3 7263.4 7407.4 7435.1 7481.2 7488.9 7401.5 7607.0 7636.3 7663.2 7680.7 8482.5 8682.6 8724.1 8811.0 8843.2 8787.4 8796.0 8916.9 9028.6 9119.0 7787.1 7792.7 7798.6 7864.2 7870.8 6929.1 7792.9 7956.0 7982.0 7982.7 6745.7 6778.6 7189.7 7242.4 7390.9 7245.7 7319.3 7340.0 7367.2 7455.5 7428.4 7467.5 7489.8 7514.4 7521.2 6584.5 6862.1 6869.1 6904.9 6905.5 6757.6 6835.5 6836.9 6842.0 6844.8 10:56:13 INFO - 2016-02-22 10:56:13,352 DEBUG : BROWSER_OUTPUT: 10:56:13 INFO - 2016-02-22 10:56:13,352 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5411.58 Median:6120.04 stddev:1592.25 (26.0%) stddev-sans-first:1551.22 10:56:13 INFO - 2016-02-22 10:56:13,352 DEBUG : BROWSER_OUTPUT: Values: 376.5 384.9 386.4 388.2 391.4 6037.8 6038.8 6050.0 6060.8 6113.5 5785.9 5848.2 5943.0 6010.5 6019.2 4671.8 4689.1 4745.1 4751.8 4752.9 4686.6 4700.2 4700.4 4717.7 4745.9 4500.0 4564.8 4573.2 4628.7 4689.7 4668.3 4670.9 4671.3 4682.2 4694.5 4179.6 4187.4 4188.6 4191.6 4194.2 5649.9 5754.5 5754.8 5756.0 5763.4 5492.8 5498.9 5504.0 5505.2 5505.8 6351.8 6356.6 6368.4 6385.2 6390.3 4579.9 4606.5 4614.6 4626.7 4647.9 6407.0 6587.9 6597.7 6610.7 6611.0 4662.6 4680.8 4685.6 4687.2 4690.6 4728.7 4750.3 4750.5 4758.0 4759.4 5422.5 5429.3 5430.9 5434.0 5436.3 6321.8 6445.2 6452.4 6457.2 6462.8 1657.6 1681.3 1681.4 1681.7 1682.3 1127.4 1141.1 1143.6 1163.6 1167.9 6273.4 6284.8 6287.3 6288.3 6295.3 6649.8 6657.9 6660.4 6661.6 6662.4 6109.3 6126.6 6231.0 6255.2 6266.0 3541.7 3566.3 3584.1 3588.8 3590.9 6817.0 6856.9 6865.5 6867.5 6873.2 6699.1 6838.0 6848.9 6853.9 6857.0 6826.7 6863.2 6869.6 6875.6 6879.3 6543.3 6659.8 6662.5 6663.6 6671.3 6589.3 6589.5 6590.5 6594.3 6609.5 6854.2 6859.3 6863.5 6870.1 6871.2 4783.0 4812.2 4819.1 4821.3 4823.1 6492.4 6634.5 6641.9 6646.3 6648.3 6420.8 6436.4 6439.6 6441.1 6452.3 6343.2 6422.6 6427.6 6433.7 6433.8 6303.1 6334.2 6334.7 6343.7 6350.9 6373.6 6397.6 6398.7 6430.9 6465.0 6178.8 6308.3 6309.0 6310.8 6324.3 10:56:13 INFO - 2016-02-22 10:56:13,352 DEBUG : BROWSER_OUTPUT: 10:56:13 INFO - 2016-02-22 10:56:13,352 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14710.90 Median:4733.52 stddev:17432.47 (368.3%) stddev-sans-first:17449.92 10:56:13 INFO - 2016-02-22 10:56:13,352 DEBUG : BROWSER_OUTPUT: Values: 765.6 860.9 909.1 918.3 927.1 13802.4 14224.3 14231.4 14237.7 14251.8 12846.2 12854.9 12967.4 13037.0 13319.9 755.0 762.7 903.6 912.1 919.8 915.4 928.5 933.2 935.4 935.6 962.0 973.5 976.5 976.8 977.0 803.6 815.4 951.7 964.4 966.9 714.0 718.0 719.5 720.1 720.5 13062.6 13287.1 13375.0 13377.5 13384.2 12725.9 13385.6 13403.7 13411.5 13664.8 10641.2 10730.2 10737.8 10852.9 10907.1 3774.8 3795.7 3798.6 3800.4 3844.1 46696.5 46959.3 46987.1 48039.5 48771.5 10174.7 10481.2 10505.6 10807.2 11011.4 19403.7 19655.5 19662.2 19671.2 19698.1 7852.7 7913.6 7918.6 8064.6 8260.2 4556.5 4628.6 4727.3 4739.7 4763.4 3247.6 3248.1 3251.0 3251.9 3255.9 575.1 582.9 583.5 587.0 596.6 679.8 682.0 712.0 718.6 720.3 8653.2 8858.2 9018.6 9021.3 9033.8 635.4 638.7 690.8 697.2 747.5 3847.4 4175.2 4294.6 4345.8 4434.7 62258.7 63885.0 64176.0 64358.4 64477.0 56917.4 57206.4 57832.0 58144.4 58327.0 51008.5 51445.7 51484.7 51549.5 51904.2 8532.1 8583.2 8597.4 8722.2 8787.3 36897.6 36996.4 37920.6 38008.4 38283.0 45020.5 49591.8 49838.5 50599.2 50763.7 10261.4 11707.8 11719.5 11720.6 11772.7 12218.3 12532.4 13467.3 13595.7 13895.7 11757.6 11779.1 11807.5 11842.6 12191.8 11100.4 11254.9 11650.9 11741.6 11765.9 10270.3 10507.2 10514.5 12150.3 12311.1 9978.2 10308.8 10324.1 10442.0 10543.1 9209.0 9349.5 9355.9 9463.4 9622.6 10:56:13 INFO - 2016-02-22 10:56:13,353 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:56:13 INFO - 2016-02-22 10:56:13,353 DEBUG : BROWSER_OUTPUT: 10:56:13 INFO - 2016-02-22 10:56:13,929 INFO : Browser exited with error code: 0 10:56:13 INFO - 2016-02-22 10:56:13,950 INFO : Completed test dromaeo_css (00:18:30) 10:56:13 INFO - 2016-02-22 10:56:13,951 INFO : Starting test kraken 10:56:13 INFO - 2016-02-22 10:56:13,951 DEBUG : operating with platform_type : linux_ 10:56:13 INFO - 2016-02-22 10:56:13,951 INFO : Initialising browser for kraken test... 10:56:13 INFO - 2016-02-22 10:56:13,957 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGdUg8E/profile http://localhost:48429/getInfo.html 10:56:17 INFO - 2016-02-22 10:56:17,616 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:56:17 INFO - 2016-02-22 10:56:17,616 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:56:17 INFO - 2016-02-22 10:56:17,617 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:56:17 INFO - 2016-02-22 10:56:17,617 DEBUG : BROWSER_OUTPUT: __metrics 10:56:17 INFO - 2016-02-22 10:56:17,745 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:56:18 INFO - 2016-02-22 10:56:18,810 INFO : Browser initialized. 10:56:18 INFO - 2016-02-22 10:56:18,810 INFO : Running cycle 1/1 for kraken test... 10:56:18 INFO - 2016-02-22 10:56:18,811 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGdUg8E/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:56:30 INFO - 2016-02-22 10:56:30,513 DEBUG : BROWSER_OUTPUT: RSS: Main: 132853760 10:56:30 INFO - 2016-02-22 10:56:30,513 DEBUG : BROWSER_OUTPUT: 10:56:32 INFO - 2016-02-22 10:56:32,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48429/tests/kraken/driver.html?testName=audio-beat-detection) 10:56:33 INFO - 2016-02-22 10:56:33,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 166072320 10:56:33 INFO - 2016-02-22 10:56:33,521 DEBUG : BROWSER_OUTPUT: 10:56:36 INFO - 2016-02-22 10:56:36,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48429/tests/kraken/driver.html?testName=audio-dft) 10:56:36 INFO - 2016-02-22 10:56:36,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 163708928 10:56:36 INFO - 2016-02-22 10:56:36,660 DEBUG : BROWSER_OUTPUT: 10:56:39 INFO - 2016-02-22 10:56:39,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48429/tests/kraken/driver.html?testName=audio-fft) 10:56:40 INFO - 2016-02-22 10:56:40,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 161161216 10:56:40 INFO - 2016-02-22 10:56:40,002 DEBUG : BROWSER_OUTPUT: 10:56:42 INFO - 2016-02-22 10:56:41,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48429/tests/kraken/driver.html?testName=audio-oscillator) 10:56:42 INFO - 2016-02-22 10:56:42,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 160796672 10:56:42 INFO - 2016-02-22 10:56:42,566 DEBUG : BROWSER_OUTPUT: 10:56:44 INFO - 2016-02-22 10:56:44,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48429/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:56:45 INFO - 2016-02-22 10:56:45,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 161325056 10:56:45 INFO - 2016-02-22 10:56:45,339 DEBUG : BROWSER_OUTPUT: 10:56:48 INFO - 2016-02-22 10:56:48,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48429/tests/kraken/driver.html?testName=imaging-darkroom) 10:56:48 INFO - 2016-02-22 10:56:48,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 161402880 10:56:48 INFO - 2016-02-22 10:56:48,741 DEBUG : BROWSER_OUTPUT: 10:56:52 INFO - 2016-02-22 10:56:52,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48429/tests/kraken/driver.html?testName=imaging-desaturate) 10:56:52 INFO - 2016-02-22 10:56:52,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 161361920 10:56:52 INFO - 2016-02-22 10:56:52,659 DEBUG : BROWSER_OUTPUT: 10:56:55 INFO - 2016-02-22 10:56:55,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48429/tests/kraken/driver.html?testName=json-parse-financial) 10:56:55 INFO - 2016-02-22 10:56:55,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 162111488 10:56:55 INFO - 2016-02-22 10:56:55,923 DEBUG : BROWSER_OUTPUT: 10:56:57 INFO - 2016-02-22 10:56:57,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48429/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:56:58 INFO - 2016-02-22 10:56:58,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 169160704 10:56:58 INFO - 2016-02-22 10:56:58,019 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48429/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:57:00 INFO - 2016-02-22 10:57:00,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 166137856 10:57:00 INFO - 2016-02-22 10:57:00,380 DEBUG : BROWSER_OUTPUT: 10:57:02 INFO - 2016-02-22 10:57:02,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48429/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:57:02 INFO - 2016-02-22 10:57:02,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 171233280 10:57:02 INFO - 2016-02-22 10:57:02,879 DEBUG : BROWSER_OUTPUT: 10:57:05 INFO - 2016-02-22 10:57:05,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48429/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:57:05 INFO - 2016-02-22 10:57:05,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 177524736 10:57:05 INFO - 2016-02-22 10:57:05,807 DEBUG : BROWSER_OUTPUT: 10:57:08 INFO - 2016-02-22 10:57:08,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48429/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:57:08 INFO - 2016-02-22 10:57:08,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 174600192 10:57:08 INFO - 2016-02-22 10:57:08,843 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48429/tests/kraken/driver.html?testName=ai-astar) 10:57:10 INFO - 2016-02-22 10:57:10,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 233496576 10:57:10 INFO - 2016-02-22 10:57:10,731 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,731 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:57:10 INFO - 2016-02-22 10:57:10,731 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:57:10 INFO - 2016-02-22 10:57:10,731 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:57:10 INFO - 2016-02-22 10:57:10,731 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:57:10 INFO - 2016-02-22 10:57:10,731 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;103;107;108;109;98;109;109;108 10:57:10 INFO - 2016-02-22 10:57:10,731 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;121;151;153;122;151;146;129;160;127 10:57:10 INFO - 2016-02-22 10:57:10,731 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;159;160;159;159;162;160;162;163;159 10:57:10 INFO - 2016-02-22 10:57:10,731 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;74;155;73;70;72;71;152;73 10:57:10 INFO - 2016-02-22 10:57:10,731 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;143;92;92;92;134;92;93;144 10:57:10 INFO - 2016-02-22 10:57:10,731 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;111;108;109;109;109;109 10:57:10 INFO - 2016-02-22 10:57:10,732 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;154;145;146;146;145;146;145;145 10:57:10 INFO - 2016-02-22 10:57:10,732 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 10:57:10 INFO - 2016-02-22 10:57:10,732 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;54;56;56;55;56;56;58;56;54;55 10:57:10 INFO - 2016-02-22 10:57:10,732 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;64;65;65;65;66;65;73;64 10:57:10 INFO - 2016-02-22 10:57:10,732 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;76;75;78;78;79;78;78;78;77;78 10:57:10 INFO - 2016-02-22 10:57:10,732 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;119;111;115;117;113;114;111;115;115 10:57:10 INFO - 2016-02-22 10:57:10,732 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;147;140;142;140;130;140;142;141;137 10:57:10 INFO - 2016-02-22 10:57:10,732 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;66;62;62;62;63;64;63;64;64 10:57:10 INFO - 2016-02-22 10:57:10,732 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:57:10 INFO - 2016-02-22 10:57:10,732 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:57:10 INFO - 2016-02-22 10:57:10,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,871 10:57:10 INFO - 2016-02-22 10:57:10,733 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:57:10 INFO - 2016-02-22 10:57:10,733 DEBUG : BROWSER_OUTPUT: __startTimestamp1456167430725__endTimestamp 10:57:10 INFO - 2016-02-22 10:57:10,733 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,733 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:57:10 INFO - 2016-02-22 10:57:10,734 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:57:10 INFO - 2016-02-22 10:57:10,734 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,734 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.80 Median:109.00 stddev:3.58 (3.3%) stddev-sans-first:3.77 10:57:10 INFO - 2016-02-22 10:57:10,734 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 103.0 107.0 108.0 109.0 98.0 109.0 109.0 108.0 10:57:10 INFO - 2016-02-22 10:57:10,734 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,735 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.20 Median:151.00 stddev:15.84 (10.5%) stddev-sans-first:15.09 10:57:10 INFO - 2016-02-22 10:57:10,735 DEBUG : BROWSER_OUTPUT: Values: 162.0 121.0 151.0 153.0 122.0 151.0 146.0 129.0 160.0 127.0 10:57:10 INFO - 2016-02-22 10:57:10,735 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,735 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:1.55 (1.0%) stddev-sans-first:1.58 10:57:10 INFO - 2016-02-22 10:57:10,735 DEBUG : BROWSER_OUTPUT: Values: 159.0 159.0 160.0 159.0 159.0 162.0 160.0 162.0 163.0 159.0 10:57:10 INFO - 2016-02-22 10:57:10,736 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,736 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.40 Median:72.50 stddev:34.34 (47.4%) stddev-sans-first:35.84 10:57:10 INFO - 2016-02-22 10:57:10,736 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 74.0 155.0 73.0 70.0 72.0 71.0 152.0 73.0 10:57:10 INFO - 2016-02-22 10:57:10,736 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,737 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:92.00 stddev:23.50 (25.5%) stddev-sans-first:24.24 10:57:10 INFO - 2016-02-22 10:57:10,737 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 143.0 92.0 92.0 92.0 134.0 92.0 93.0 144.0 10:57:10 INFO - 2016-02-22 10:57:10,737 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,737 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 10:57:10 INFO - 2016-02-22 10:57:10,737 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 111.0 108.0 109.0 109.0 109.0 109.0 10:57:10 INFO - 2016-02-22 10:57:10,738 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,738 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:2.72 (1.9%) stddev-sans-first:2.88 10:57:10 INFO - 2016-02-22 10:57:10,738 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 154.0 145.0 146.0 146.0 145.0 146.0 145.0 145.0 10:57:10 INFO - 2016-02-22 10:57:10,738 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,738 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:57:10 INFO - 2016-02-22 10:57:10,738 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 10:57:10 INFO - 2016-02-22 10:57:10,738 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,738 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.17 (2.1%) stddev-sans-first:1.09 10:57:10 INFO - 2016-02-22 10:57:10,738 DEBUG : BROWSER_OUTPUT: Values: 54.0 56.0 56.0 55.0 56.0 56.0 58.0 56.0 54.0 55.0 10:57:10 INFO - 2016-02-22 10:57:10,739 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,739 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:2.72 (4.2%) stddev-sans-first:2.83 10:57:10 INFO - 2016-02-22 10:57:10,739 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 65.0 65.0 65.0 66.0 65.0 73.0 64.0 10:57:10 INFO - 2016-02-22 10:57:10,739 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,739 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:78.00 stddev:1.18 (1.5%) stddev-sans-first:1.12 10:57:10 INFO - 2016-02-22 10:57:10,739 DEBUG : BROWSER_OUTPUT: Values: 76.0 75.0 78.0 78.0 79.0 78.0 78.0 78.0 77.0 78.0 10:57:10 INFO - 2016-02-22 10:57:10,739 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,739 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:114.20 Median:115.00 stddev:2.57 (2.2%) stddev-sans-first:2.60 10:57:10 INFO - 2016-02-22 10:57:10,739 DEBUG : BROWSER_OUTPUT: Values: 112.0 119.0 111.0 115.0 117.0 113.0 114.0 111.0 115.0 115.0 10:57:10 INFO - 2016-02-22 10:57:10,739 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,739 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.00 Median:141.00 stddev:4.32 (3.1%) stddev-sans-first:4.57 10:57:10 INFO - 2016-02-22 10:57:10,739 DEBUG : BROWSER_OUTPUT: Values: 141.0 147.0 140.0 142.0 140.0 130.0 140.0 142.0 141.0 137.0 10:57:10 INFO - 2016-02-22 10:57:10,739 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2016-02-22 10:57:10,739 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.35 (2.1%) stddev-sans-first:1.32 10:57:10 INFO - 2016-02-22 10:57:10,739 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 62.0 62.0 62.0 63.0 64.0 63.0 64.0 64.0 10:57:10 INFO - 2016-02-22 10:57:10,739 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:57:10 INFO - 2016-02-22 10:57:10,740 DEBUG : BROWSER_OUTPUT: 10:57:11 INFO - 2016-02-22 10:57:11,398 INFO : Browser exited with error code: 0 10:57:11 INFO - 2016-02-22 10:57:11,453 INFO : Completed test kraken (00:00:57) 10:57:11 INFO - 2016-02-22 10:57:11,453 INFO : Starting test v8_7 10:57:11 INFO - 2016-02-22 10:57:11,453 DEBUG : operating with platform_type : linux_ 10:57:11 INFO - 2016-02-22 10:57:11,454 INFO : Initialising browser for v8_7 test... 10:57:11 INFO - 2016-02-22 10:57:11,460 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEi2V7w/profile http://localhost:48429/getInfo.html 10:57:15 INFO - 2016-02-22 10:57:15,138 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:57:15 INFO - 2016-02-22 10:57:15,138 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:57:15 INFO - 2016-02-22 10:57:15,138 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:57:15 INFO - 2016-02-22 10:57:15,138 DEBUG : BROWSER_OUTPUT: __metrics 10:57:15 INFO - 2016-02-22 10:57:15,315 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:57:16 INFO - 2016-02-22 10:57:16,466 INFO : Browser initialized. 10:57:16 INFO - 2016-02-22 10:57:16,466 INFO : Running cycle 1/1 for v8_7 test... 10:57:16 INFO - 2016-02-22 10:57:16,467 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEi2V7w/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:57:28 INFO - 2016-02-22 10:57:28,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 132300800 10:57:28 INFO - 2016-02-22 10:57:28,121 DEBUG : BROWSER_OUTPUT: 10:57:49 INFO - 2016-02-22 10:57:49,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48429/tests/v8_7/run.html (next: http://localhost:48429/tests/v8_7/run.html) 10:57:49 INFO - 2016-02-22 10:57:49,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 422383616 10:57:49 INFO - 2016-02-22 10:57:49,706 DEBUG : BROWSER_OUTPUT: 10:57:49 INFO - 2016-02-22 10:57:49,706 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:57:49 INFO - 2016-02-22 10:57:49,707 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:57:49 INFO - 2016-02-22 10:57:49,707 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:57:49 INFO - 2016-02-22 10:57:49,707 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:57:49 INFO - 2016-02-22 10:57:49,707 DEBUG : BROWSER_OUTPUT: |0;Richards;165.59032952475576 10:57:49 INFO - 2016-02-22 10:57:49,708 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.50074025333114 10:57:49 INFO - 2016-02-22 10:57:49,708 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.473962684489 10:57:49 INFO - 2016-02-22 10:57:49,708 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5143.589743589743 10:57:49 INFO - 2016-02-22 10:57:49,708 DEBUG : BROWSER_OUTPUT: |4;RayTrace;959.6928982725528 10:57:49 INFO - 2016-02-22 10:57:49,709 DEBUG : BROWSER_OUTPUT: |5;Earley;542.2993492407809 10:57:49 INFO - 2016-02-22 10:57:49,709 DEBUG : BROWSER_OUTPUT: |6;Boyer;10589.473684210527 10:57:49 INFO - 2016-02-22 10:57:49,709 DEBUG : BROWSER_OUTPUT: |7;RegExp;24023.809523809523 10:57:49 INFO - 2016-02-22 10:57:49,709 DEBUG : BROWSER_OUTPUT: |8;Splay;519.2107995846313 10:57:49 INFO - 2016-02-22 10:57:49,710 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 10:57:49 INFO - 2016-02-22 10:57:49,710 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:57:49 INFO - 2016-02-22 10:57:49,710 DEBUG : BROWSER_OUTPUT: __startTimestamp1456167469703__endTimestamp 10:57:49 INFO - 2016-02-22 10:57:49,710 DEBUG : BROWSER_OUTPUT: 10:57:49 INFO - 2016-02-22 10:57:49,711 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:57:49 INFO - 2016-02-22 10:57:49,711 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:57:49 INFO - 2016-02-22 10:57:49,711 DEBUG : BROWSER_OUTPUT: 10:57:49 INFO - 2016-02-22 10:57:49,711 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.59 Median:165.59 stddev:0.00 (0.0%) 10:57:49 INFO - 2016-02-22 10:57:49,712 DEBUG : BROWSER_OUTPUT: Values: 165.6 10:57:49 INFO - 2016-02-22 10:57:49,712 DEBUG : BROWSER_OUTPUT: 10:57:49 INFO - 2016-02-22 10:57:49,712 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.50 Median:164.50 stddev:0.00 (0.0%) 10:57:49 INFO - 2016-02-22 10:57:49,712 DEBUG : BROWSER_OUTPUT: Values: 164.5 10:57:49 INFO - 2016-02-22 10:57:49,712 DEBUG : BROWSER_OUTPUT: 10:57:49 INFO - 2016-02-22 10:57:49,713 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 10:57:49 INFO - 2016-02-22 10:57:49,713 DEBUG : BROWSER_OUTPUT: Values: 278.5 10:57:49 INFO - 2016-02-22 10:57:49,713 DEBUG : BROWSER_OUTPUT: 10:57:49 INFO - 2016-02-22 10:57:49,713 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5143.59 Median:5143.59 stddev:0.00 (0.0%) 10:57:49 INFO - 2016-02-22 10:57:49,714 DEBUG : BROWSER_OUTPUT: Values: 5143.6 10:57:49 INFO - 2016-02-22 10:57:49,714 DEBUG : BROWSER_OUTPUT: 10:57:49 INFO - 2016-02-22 10:57:49,714 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:959.69 Median:959.69 stddev:0.00 (0.0%) 10:57:49 INFO - 2016-02-22 10:57:49,714 DEBUG : BROWSER_OUTPUT: Values: 959.7 10:57:49 INFO - 2016-02-22 10:57:49,715 DEBUG : BROWSER_OUTPUT: 10:57:49 INFO - 2016-02-22 10:57:49,715 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:542.30 Median:542.30 stddev:0.00 (0.0%) 10:57:49 INFO - 2016-02-22 10:57:49,715 DEBUG : BROWSER_OUTPUT: Values: 542.3 10:57:49 INFO - 2016-02-22 10:57:49,715 DEBUG : BROWSER_OUTPUT: 10:57:49 INFO - 2016-02-22 10:57:49,715 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10589.47 Median:10589.47 stddev:0.00 (0.0%) 10:57:49 INFO - 2016-02-22 10:57:49,716 DEBUG : BROWSER_OUTPUT: Values: 10589.5 10:57:49 INFO - 2016-02-22 10:57:49,716 DEBUG : BROWSER_OUTPUT: 10:57:49 INFO - 2016-02-22 10:57:49,716 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24023.81 Median:24023.81 stddev:0.00 (0.0%) 10:57:49 INFO - 2016-02-22 10:57:49,716 DEBUG : BROWSER_OUTPUT: Values: 24023.8 10:57:49 INFO - 2016-02-22 10:57:49,717 DEBUG : BROWSER_OUTPUT: 10:57:49 INFO - 2016-02-22 10:57:49,717 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:519.21 Median:519.21 stddev:0.00 (0.0%) 10:57:49 INFO - 2016-02-22 10:57:49,717 DEBUG : BROWSER_OUTPUT: Values: 519.2 10:57:49 INFO - 2016-02-22 10:57:49,717 DEBUG : BROWSER_OUTPUT: 10:57:49 INFO - 2016-02-22 10:57:49,717 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 10:57:49 INFO - 2016-02-22 10:57:49,717 DEBUG : BROWSER_OUTPUT: Values: 4826.9 10:57:49 INFO - 2016-02-22 10:57:49,718 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:57:49 INFO - 2016-02-22 10:57:49,718 DEBUG : BROWSER_OUTPUT: 10:57:50 INFO - 2016-02-22 10:57:50,358 INFO : Browser exited with error code: 0 10:57:50 INFO - 2016-02-22 10:57:50,372 INFO : Completed test v8_7 (00:00:38) 10:57:50 INFO - 2016-02-22 10:57:50,785 INFO : Completed test suite (00:20:07) 10:57:50 INFO - 2016-02-22 10:57:50,785 DEBUG : Working with test: dromaeo_css 10:57:50 INFO - 2016-02-22 10:57:50,785 DEBUG : Generating results file: dromaeo_css 10:57:50 INFO - 2016-02-22 10:57:50,786 DEBUG : Working with test: kraken 10:57:50 INFO - 2016-02-22 10:57:50,786 DEBUG : Generating results file: kraken 10:57:50 INFO - 2016-02-22 10:57:50,787 INFO : javascript benchmark 10:57:50 INFO - 2016-02-22 10:57:50,787 DEBUG : Working with test: v8_7 10:57:50 INFO - 2016-02-22 10:57:50,787 DEBUG : Generating results file: v8_7 10:57:50 INFO - 2016-02-22 10:57:50,787 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:57:50 INFO - 2016-02-22 10:57:50,840 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 10:57:50 INFO - 2016-02-22 10:57:50,840 DEBUG : process_Request line: dromaeo_css 7527.65 graph.html#tests=[[72,53,35]] 10:57:50 INFO - 2016-02-22 10:57:50,840 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:57:50 INFO - 2016-02-22 10:57:50,868 DEBUG : process_Request line: kraken 1470.90 graph.html#tests=[[232,53,35]] 10:57:50 INFO - 2016-02-22 10:57:50,868 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:57:50 INFO - 2016-02-22 10:57:50,898 DEBUG : process_Request line: v8_7 23343.71 graph.html#tests=[[230,53,35]] 10:57:50 INFO - 2016-02-22 10:57:50,899 INFO : javascript benchmark 10:57:50 INFO - 2016-02-22 10:57:50,903 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3302.290007648356, 3371.6628337166303, 3397.473391624299, 3403.778754380965, 3414.470757032659, 5497.285352904117, 5515.448455154483, 5515.751791169397, 5520.254765606642, 5533.916991245134, 5473.945260547393, 5498.972505137479, 5511.338639363272, 5521.806736764214, 5522.585806064541, 4968.378952630921, 5006.874828129289, 5027.673201241908, 5062.645614806965, 5108.872278193056, 5046.3187469691675, 5097.515736005093, 5111.258867464216, 5113.565346945514, 5119.7696103675235, 4991.900161996758, 5033.446320904697, 5097.413797413289, 5097.872553186182, 5099.923501147486, 5043.0, 5126.051680439112, 5129.948700512984, 5133.204353325241, 5135.563477104451, 5033.79864805411, 5117.181250999859, 5134.743262836881, 5141.485851414866, 5157.922631160535, 5245.449227831061, 5319.521243088141, 5339.305890234284, 5457.154141108134, 5460.590455715797, 5959.553033522459, 5993.670348130851, 6004.0, 6006.189164462785, 6008.939910600881, 5948.494377977877, 6039.63762174271, 6045.33501314855, 6046.2744470663365, 6046.516278697738, 5380.3274590676165, 5496.258005169331, 5509.449055094458, 5585.385607583163, 5621.80323688669, 5985.700714964234, 6087.0, 6105.542084343692, 6113.786017489456, 6121.693915304217, 5642.322921249476, 5856.502197313191, 5865.266841644794, 5870.178175055496, 5879.5002424794375, 5791.189233507313, 5795.33353664334, 5892.528597712173, 5948.405159484104, 5969.970150149222, 5902.940970590239, 5928.4960778334325, 5950.732217050243, 5957.672328022, 5957.821265362046, 5936.1392598073035, 5936.465718085393, 5939.465448109604, 5941.287045554561, 5942.970285148633, 4397.164538737629, 4446.62203712688, 4478.2386994211065, 4545.499995000548, 4570.977145114253, 4081.2653722329674, 4100.17996400721, 4102.179564087194, 4128.174365126986, 4134.586541345841, 5448.346198456132, 5691.715414229355, 5700.201971723962, 5701.116326969326, 5705.743241554057, 5846.473817356458, 5904.380040095728, 5928.911066334009, 5954.166416701665, 5993.640381577119, 5683.403242659461, 5725.541956643458, 5730.169125476783, 5734.16854556087, 5738.5982981191755, 5066.16408292635, 5155.9742201288755, 5216.321878155815, 5222.529972302511, 5225.111731005738, 6138.388398386059, 6244.063390491463, 6244.219472565929, 6247.125402443661, 6275.6862156892885, 5991.7603295867675, 5995.670238136944, 6003.369646187088, 6019.127226552037, 6036.607620504653, 5954.07711804671, 6126.111713801563, 6139.3553676863285, 6165.84585385369, 6184.474319682698, 6002.489788367863, 6003.0, 6015.037593984942, 6016.669083200466, 6018.976773948351, 6022.939770602413, 6083.391660834058, 6083.574149809471, 6085.878282434415, 6120.479759220338, 5682.346530149086, 5774.133879918046, 5781.075027995501, 5883.0881213411985, 5927.9703601481715, 5858.091995740667, 5858.648481091148, 5861.413858614275, 5864.0, 5866.735996880066, 5790.0, 5792.94207057924, 5794.884102318014, 5795.0, 5795.536357091507, 5687.829365119053, 5704.885902282014, 5766.682832444256, 5859.58982871212, 5887.882242355044, 5770.394108618535, 5837.124431335334, 5837.387074357302, 5841.065429531254, 5848.181254624441], "unit": "ms", "name": "dojo.html", "value": 5505.053635959504}, {"lowerIsBetter": false, "replicates": [594.5154698920383, 632.9651869147197, 640.174175313845, 651.6839332923531, 651.882022331701, 33536.496952545735, 34632.0, 34638.65361346389, 41008.58991410085, 41608.167836643246, 48011.0, 48530.75734621331, 48752.756236218855, 48776.75611621946, 48859.0, 9161.908380916206, 9340.3461757677, 9341.76645583859, 9346.719598412059, 9347.0, 8229.876551851727, 8408.411411201188, 10934.398608076554, 11179.441027948611, 11191.720206994849, 10918.01737843594, 10980.890191098106, 10998.835017474705, 11010.0, 11030.779384412306, 10885.727856803564, 10976.835347469794, 11000.954909283646, 11007.61473348429, 11007.944960275227, 10635.468226588717, 10749.301295415773, 10759.83860242097, 10765.084967777748, 10766.892331076746, 43085.78457107695, 43211.56788432138, 43638.78180609077, 43692.3446148308, 43728.781356093335, 3810.961890381116, 4099.139180772041, 4124.6906482013665, 4287.978560107211, 4337.544557821415, 32516.18709532257, 32866.83566582176, 33128.83435582831, 33159.33681326384, 33493.162670933176, 3488.720902327808, 3610.891673249807, 3631.2737452509605, 4152.771597562133, 4223.092035212444, 289725.0, 289923.5503822488, 290788.0, 292237.0, 294203.0, 62060.0, 62850.685746570976, 67325.66337168282, 67722.66138669275, 76370.61814691003, 69771.30228697648, 70073.64963175151, 70237.0, 70356.6482167586, 70421.2957870425, 16732.91633541849, 16740.41408550695, 16804.83195168057, 16819.579510512336, 16901.0, 12700.364981750876, 12777.616671499869, 12794.808077878839, 12802.743945121045, 12802.871971280169, 22816.087356505886, 23272.95271712777, 23278.767212328, 23298.883505582362, 23425.180118695764, 8344.374171937008, 8775.648974040967, 8850.822983540293, 8853.114688531225, 8860.64557417709, 1021.7701017271203, 1023.1558963854701, 1145.587588468151, 1179.4633441783967, 1222.7860124478182, 29065.7093429063, 29568.704312957027, 29768.809247630285, 30077.248068798017, 30081.849590751906, 1093.781243751237, 1103.87857335693, 1171.7949358862165, 1186.5372504723166, 1193.9223950443193, 15252.466163684217, 15646.9217653911, 16023.038617682743, 18397.54006149857, 18454.26182952694, 427468.0, 431406.0, 432104.0, 432215.0, 432283.0, 61139.694301529096, 61569.38430615726, 62061.0, 62094.68952655298, 62207.6889615549, 1362.1963041805382, 1377.407714682676, 1399.734050530396, 1464.1946929188903, 1467.3470305714068, 30799.53800693036, 32550.83724581362, 34879.302413952086, 35011.47482787709, 35061.82469087638, 55819.72090139523, 56697.71651141883, 56742.0, 56775.43224567702, 56828.0, 338184.0, 338605.0, 341085.0, 341482.0, 342094.0, 31279.687203127676, 31328.53007204848, 35107.82446087855, 35558.822205888806, 36320.81839590891, 41126.38310425286, 41274.58725412827, 41486.377704333856, 42287.1542569153, 42408.0, 35120.47319290161, 35547.11132221715, 35711.46432803458, 37382.0, 45777.313340300585, 35777.82111089428, 39207.0, 44179.55820441883, 44329.55670443254, 45434.77282613566, 39914.40128398018, 40002.399964001146, 40641.0, 40766.59233407628, 43017.139657207306, 34584.48123278103, 40045.1990960185, 40370.394444082776, 40433.0, 41225.38161927513, 26963.460730785668, 27463.0, 27883.0, 28019.719802801712, 28051.859740701166], "unit": "ms", "name": "ext.html", "value": 20820.898004213785}, {"lowerIsBetter": false, "replicates": [385.5585354768792, 391.631866045917, 397.0867005886461, 397.4277041060872, 401.3277759752415, 15453.536393908173, 15839.940807694984, 17783.37758178464, 18207.54481137972, 18216.90891545542, 19242.0, 19451.90274048628, 19488.0, 19502.317418890343, 19650.312239071634, 6269.968650156754, 6416.101745755598, 6434.806955791334, 6437.5815571987905, 6440.420362167404, 4641.25739881619, 4770.7376094314795, 6231.189945307126, 7054.823629409255, 7247.420206383503, 7134.75028374007, 7213.711451541932, 7220.350168484835, 7228.674709638052, 7237.710491580357, 7199.316064973819, 7212.891806622905, 7238.674259658328, 7243.167035790899, 7254.238304977954, 6807.183138023469, 6960.269171736945, 6977.79066628002, 6980.47646426515, 6991.545549539263, 24732.876335618388, 24977.750222497907, 25513.362165945815, 25563.23310300694, 26103.869480652476, 2435.342457536473, 2455.7789798918006, 2463.285647162321, 2497.300755788382, 2502.0117053763843, 15273.312700928485, 15641.374345026185, 15699.764503532342, 15752.606184845356, 16092.275847586887, 2029.3810387831707, 2102.894855257231, 2116.968245476319, 2148.34475484977, 2204.548067646129, 75737.62131189364, 79449.0, 81519.0, 81947.59026204831, 82096.58951705204, 16978.660426791394, 17001.0, 17010.57473563146, 17016.489505314614, 17064.914675426542, 27784.58323125155, 27873.44253114967, 28190.71809281922, 28287.15138545847, 28300.575491367646, 7455.962720186473, 7674.347680447225, 7921.841563168704, 7981.1220765715725, 7993.360531157494, 7579.090509138939, 7583.734569290159, 7606.087269527692, 7616.276453736886, 7627.5042122261875, 4185.455890734185, 4276.850310239189, 4767.952320476751, 4796.5203479651755, 4827.517248275144, 1913.9712904306446, 1964.62672092302, 1997.021459484842, 2001.699745038256, 2010.4672261850621, 852.8464876322322, 867.0852250875387, 899.0425197164998, 912.6531917871299, 983.5082458770614, 16004.114116813069, 18017.459476215736, 18388.724169137473, 18634.906825465787, 18810.0, 982.7101005203482, 1005.4218824176128, 1042.593388578455, 1062.5431064642278, 1070.6466865934224, 8370.372222083368, 8497.830043399097, 9816.165625921734, 10377.792444151226, 10397.532111055021, 642006.0, 645173.0, 660813.0, 664858.0, 667026.0, 80416.99999999884, 81119.0, 91096.0, 91721.08278917125, 92822.53588732149, 1187.8990285825628, 1188.0258188285522, 1232.5686009896644, 1252.1798222164498, 1257.4655771297162, 16632.916835415745, 16683.83213175066, 16822.915885420494, 16861.578460538585, 17049.573760656083, 36451.0, 36796.080097997765, 36831.07922301857, 36971.815140924125, 40157.19685606213, 52404.73797630987, 52585.21122183247, 55275.44724552864, 55765.442345576026, 60248.39751602428, 10272.22958278147, 10292.330998485075, 10412.791744165226, 10509.684709458728, 10538.525766340686, 18695.345662901735, 19062.7140592894, 19077.332293369665, 19256.518587035436, 19403.223871045, 14528.63678408006, 15053.0, 15655.608609784846, 15888.0, 15932.0, 13315.733685326433, 13388.397522111334, 13621.114627549177, 14139.717205656036, 15794.842051579797, 15052.096874187584, 15305.234738263265, 16285.511434656979, 16565.83434165691, 16647.667046658757, 9215.539223038688, 10357.9482102589, 10752.247342686249, 10774.46127693628, 10901.836472453078, 12471.251724896536, 14737.115773053221, 15257.6185595361, 15533.611659708145, 15644.374225030871], "unit": "ms", "name": "jquery.html", "value": 10329.294544419981}, {"lowerIsBetter": false, "replicates": [1540.4223416218917, 1541.6223025358788, 1751.2819743905002, 1802.3691707902235, 1834.6147309065095, 7329.780106596811, 7434.0, 7956.124826269113, 8171.10117887032, 8188.91811081889, 7724.536527808335, 7898.249666281708, 7974.800629984254, 7993.720219792309, 8004.239597238267, 2312.814974802012, 2347.166755801683, 2348.1194552042984, 2348.4481146930457, 2349.518348738513, 2037.3378651938106, 2076.5431605046942, 2080.1887263967064, 2338.6608941703444, 2364.858108513486, 2351.0, 2354.705661792276, 2360.280114565057, 2362.456634973957, 2362.870042147681, 2260.525289689167, 2326.9883650581637, 2328.569214695287, 2330.3707998840305, 2332.300309907021, 2346.917857874966, 2350.659154422599, 2392.2823153054187, 2392.988035059831, 2395.0, 7977.242161994601, 8130.471519351282, 8146.959265203695, 8150.75547733569, 8162.224588664068, 4902.534259245366, 4998.325226094467, 5016.924746128811, 5019.196928491424, 5019.498050194988, 3021.773366997484, 3022.153796936861, 3118.3451475190236, 3120.469520181575, 3125.0312403155094, 983.6458874805136, 991.8660980767576, 1005.261133067195, 1027.3835698580792, 1035.8342665173611, 10966.780664386668, 11174.553017879274, 11177.66467005991, 11197.720056998558, 11198.888011119867, 4403.361512580658, 4441.533638967927, 4454.710443821141, 4459.955400446019, 4487.371767952489, 9523.380980236263, 9524.95237523808, 9537.14165725088, 9559.952200238955, 9572.952135239279, 5007.198848184273, 5012.749362531932, 5041.067402530543, 5044.646874718808, 5048.570871475966, 4570.588647021717, 4585.060062687141, 4601.815927362935, 4609.654275929319, 4632.60622847055, 3863.459115723801, 3929.0373858404873, 3950.486436763202, 3952.6245006724316, 3961.8217180226957, 1174.8413964114734, 1185.2888267039707, 1229.3791635224334, 1269.6000759760645, 1272.6945533071996, 1080.8216644253766, 1084.8806631270554, 1122.2144498850673, 1275.5535562553032, 1435.1604311477693, 7256.092988376453, 7296.416286697052, 7309.817254568572, 7453.85092298151, 7712.113106992655, 1189.4766302826729, 1194.4804010255393, 1198.8741182175745, 1201.6034708546158, 1214.7995580729257, 5944.821655350346, 6047.3045599755715, 6060.454559089703, 6082.817515474543, 6086.391360863967, 9358.57886395114, 9848.507574621384, 9947.850782238273, 9951.900480995097, 9956.502174891226, 9666.371685840399, 9811.852822207673, 9815.411075335503, 9821.508924553744, 9843.261755368232, 7263.382612477999, 7407.407407407394, 7435.1449583297535, 7481.21447248042, 7488.925110748932, 7401.481896267425, 7607.049118860143, 7636.31273185416, 7663.233676632292, 7680.654370553227, 8482.491050536988, 8682.609282582172, 8724.083971182934, 8810.955945220232, 8843.159899809765, 8787.428817126865, 8795.956020219857, 8916.86624700643, 9028.59371328305, 9118.95440522793, 7787.143414224544, 7792.727254546064, 7798.610069496616, 7864.213578642319, 7870.763877083697, 6929.133858267716, 7792.922070779219, 7956.0, 7981.960090199512, 7982.720604778805, 6745.696443660146, 6778.593284402951, 7189.7483588074165, 7242.420606351374, 7390.889136662847, 7245.746398876014, 7319.268073192638, 7340.009098771598, 7367.189609143097, 7455.478116531791, 7428.405727541892, 7467.477276590586, 7489.812754681177, 7514.398848092249, 7521.172671006076, 6584.539082264196, 6862.073620061228, 6869.072675188786, 6904.930950690429, 6905.482088843457, 6757.594544327356, 6835.487338449736, 6836.863262734817, 6842.0079088532875, 6844.760433384808], "unit": "ms", "name": "mootools.html", "value": 4682.618176059995}, {"lowerIsBetter": false, "replicates": [376.4503824416352, 384.9307124717553, 386.39722033627544, 388.1906225519791, 391.41874316639786, 6037.849053773658, 6038.758449662019, 6049.969750151254, 6060.8484787880325, 6113.480354169889, 5785.913211301834, 5848.1520179574045, 5943.049112142058, 6010.489108425789, 6019.247594050744, 4671.813127474897, 4689.085628302465, 4745.145873742725, 4751.762411879409, 4752.881177970561, 4686.578207961283, 4700.224462963624, 4700.365450664151, 4717.716936983775, 4745.928811067837, 4500.0, 4564.790330562404, 4573.245414506602, 4628.652851036169, 4689.742064186468, 4668.253079507263, 4670.906581868344, 4671.3226582145735, 4682.2274324736545, 4694.530546945312, 4179.644730197937, 4187.350960601112, 4188.5811418858175, 4191.580841915784, 4194.203101410752, 5649.92632919609, 5754.510866576346, 5754.827355179351, 5756.0, 5763.366029736726, 5492.780288788444, 5498.917516237259, 5503.972480137573, 5505.201745746885, 5505.807296744635, 6351.8412039698915, 6356.555041147121, 6368.395002474757, 6385.169927909388, 6390.297067322591, 4579.862604121881, 4606.493285738566, 4614.584687378152, 4626.699264547794, 4647.86056418308, 6406.967965160191, 6587.868242635121, 6597.670116494204, 6610.7355705771715, 6610.966945165292, 4662.580367766917, 4680.789364478606, 4685.648576356787, 4687.179743544866, 4690.6012988895645, 4728.739919304471, 4750.263709125022, 4750.548697873696, 4758.048390321949, 4759.428868535798, 5422.457754224625, 5429.267048948342, 5430.8913821723345, 5434.049041417736, 5436.266104075979, 6321.810345689637, 6445.1621289233035, 6452.35476452351, 6457.225132983978, 6462.838429039311, 1657.593889497081, 1681.277050868114, 1681.4199101310273, 1681.6972944869797, 1682.3270691723164, 1127.3968426891574, 1141.132739118276, 1143.6226045404997, 1163.6101905861462, 1167.9474423650956, 6273.404026617464, 6284.842878928063, 6287.276963149205, 6288.276848162428, 6295.307516173218, 6649.833754156088, 6657.933420665731, 6660.400563949171, 6661.566998145105, 6662.400383965466, 6109.2974307955155, 6126.6017708848785, 6230.968845155745, 6255.24937007562, 6266.0, 3541.6812486876306, 3566.28674265148, 3584.0502266899293, 3588.802615856153, 3590.8743193988084, 6817.0, 6856.862862742717, 6865.485088618374, 6867.519273650896, 6873.20958089816, 6699.062131301622, 6837.9658101710165, 6848.897266541006, 6853.862922741518, 6857.0, 6826.658667066627, 6863.176418829772, 6869.587824730532, 6875.5530890491955, 6879.277675843964, 6543.345665433419, 6659.800205993828, 6662.500312476681, 6663.633500157538, 6671.299513551007, 6589.27517973013, 6589.505787065893, 6590.47276217911, 6594.340565943367, 6609.4712423005085, 6854.211765646815, 6859.279775623687, 6863.519553631398, 6870.141232345957, 6871.209810871814, 4782.95217047839, 4812.1578723722505, 4819.084373968934, 4821.349117869043, 4823.059503396804, 6492.448141907991, 6634.502412318999, 6641.900371494528, 6646.302138275411, 6648.301928297459, 6420.807375778734, 6436.356364363526, 6439.613623182624, 6441.066045423481, 6452.322506136788, 6343.207099112611, 6422.550421470452, 6427.614343139427, 6433.742650293936, 6433.774817881352, 6303.1175635412, 6334.239891212899, 6334.746610135543, 6343.682815859281, 6350.936490635035, 6373.6175829450385, 6397.6481293529305, 6398.680065996775, 6430.935690643221, 6464.967675161594, 6178.783742568989, 6308.306086330592, 6309.022101574264, 6310.842228944313, 6324.272708638566], "unit": "ms", "name": "prototype.html", "value": 4910.101264334855}, {"lowerIsBetter": false, "replicates": [765.5712800831532, 860.8751730999005, 909.0545832334373, 918.2883265469259, 927.0775578299593, 13802.447902083917, 14224.288785560706, 14231.359588818503, 14237.71524569508, 14251.78622320666, 12846.229226246433, 12854.871451285508, 12967.416466259017, 13037.02222333324, 13319.933400332984, 755.0222461911837, 762.7368557847534, 903.6159632156324, 912.0605776050645, 919.7608621758324, 915.4370062411602, 928.4893308680232, 933.1508327422048, 935.4480856294784, 935.550935550936, 961.9711408657752, 973.5132433783108, 976.5019839881676, 976.7802244494967, 977.0376179463223, 803.6423791412824, 815.384384789486, 951.6859436385976, 964.4358050540442, 966.9274804389629, 713.9500234983553, 717.9605121718304, 719.481972979454, 720.0926832191424, 720.5136532840312, 13062.608121756362, 13287.069905106646, 13375.0, 13377.531786387526, 13384.196948183042, 12725.872741272655, 13385.598432047054, 13403.731925361535, 13411.46354145833, 13664.795028074586, 10641.220992680992, 10730.22504985282, 10737.78524429507, 10852.945735271353, 10907.072898803532, 3774.7735135891935, 3795.6583907448185, 3798.5631652360057, 3800.3539398302355, 3844.058205739612, 46696.533034669555, 46959.29561056587, 46987.060258794976, 48039.519604803856, 48771.512284877404, 10174.694759157237, 10481.161507079416, 10505.632302869362, 10807.189460790472, 11011.394373309384, 19403.708944365844, 19655.50861228452, 19662.213511459668, 19671.21315147378, 19698.113584888713, 7852.685892564347, 7913.604319784103, 7918.564478953713, 8064.556449395222, 8260.215279548433, 4556.544345565483, 4628.606568441653, 4727.314539391838, 4739.715617062987, 4763.428388593322, 3247.626522949891, 3248.1067706380936, 3250.9837450813066, 3251.9187020324207, 3255.8860439884966, 575.1085816983742, 582.912563115536, 583.4777873803007, 587.0079565534234, 596.60325883288, 679.813051410866, 681.9590824550543, 712.0458585495461, 718.5688586847849, 720.3408880874047, 8653.17794809492, 8858.247049000778, 9018.59416326267, 9021.32340074497, 9033.77415564603, 635.3773302163813, 638.6998110887876, 690.7685925215109, 697.1703672629656, 747.4805010517638, 3847.3844184930276, 4175.206710724952, 4294.592013758688, 4345.782710864444, 4434.733915965053, 62258.688706557085, 63885.0, 64176.0, 64358.356416436174, 64477.0, 56917.43082569204, 57206.42793572011, 57832.0, 58144.418555814744, 58327.0, 51008.48991510038, 51445.742771285906, 51484.74257628688, 51549.48450515447, 51904.22143667848, 8532.104129066358, 8583.227509524173, 8597.398182127192, 8722.215000649972, 8787.340949428946, 36897.63102368942, 36996.44505332476, 37920.620793791706, 38008.38920302567, 38283.0, 45020.54979450163, 49591.75204124101, 49838.50161498484, 50599.241011385595, 50763.74618127033, 10261.384316941007, 11707.765844683228, 11719.531218751154, 11720.589779357682, 11772.70568235801, 12218.327991960528, 12532.373381330715, 13467.32663366808, 13595.660108497366, 13895.72208555803, 11757.647270581896, 11779.116566257737, 11807.468663909973, 11842.585509507471, 12191.75616487683, 11100.389478578756, 11254.94372528132, 11650.88349116498, 11741.589044383405, 11765.941170294094, 10270.33242839213, 10507.15942724565, 10514.526846292089, 12150.270983741004, 12311.138220324492, 9978.201743860329, 10308.793824123626, 10324.122449591869, 10442.0, 10543.103836173705, 9209.0, 9349.532523373668, 9355.906440935503, 9463.432194068379, 9622.566984485575], "unit": "ms", "name": "yui.html", "value": 6683.52137148135}], "name": "dromaeo_css", "value": 7527.654331160699}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 103.0, 107.0, 108.0, 109.0, 98.0, 109.0, 109.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 106.8}, {"lowerIsBetter": true, "replicates": [162.0, 121.0, 151.0, 153.0, 122.0, 151.0, 146.0, 129.0, 160.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.2}, {"lowerIsBetter": true, "replicates": [159.0, 159.0, 160.0, 159.0, 159.0, 162.0, 160.0, 162.0, 163.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.2}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 74.0, 155.0, 73.0, 70.0, 72.0, 71.0, 152.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 88.4}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 143.0, 92.0, 92.0, 92.0, 134.0, 92.0, 93.0, 144.0], "unit": "ms", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 111.0, 108.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 154.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "unit": "ms", "name": "imaging-desaturate", "value": 94.9}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 56.0, 55.0, 56.0, 56.0, 58.0, 56.0, 54.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0, 73.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.5}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 78.0, 78.0, 79.0, 78.0, 78.0, 78.0, 77.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.5}, {"lowerIsBetter": true, "replicates": [112.0, 119.0, 111.0, 115.0, 117.0, 113.0, 114.0, 111.0, 115.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 114.2}, {"lowerIsBetter": true, "replicates": [141.0, 147.0, 140.0, 142.0, 140.0, 130.0, 140.0, 142.0, 141.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.0}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 62.0, 62.0, 62.0, 63.0, 64.0, 63.0, 64.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.5}], "name": "kraken", "value": 1470.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.59032952475576], "unit": "score", "name": "Richards", "value": 213.18877800000007}, {"lowerIsBetter": false, "replicates": [164.50074025333114], "unit": "score", "name": "DeltaBlue", "value": 401.93132199999985}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5143.589743589743], "unit": "score", "name": "Decrypt", "value": 51.75004486540379}, {"lowerIsBetter": false, "replicates": [959.6928982725528], "unit": "score", "name": "RayTrace", "value": 771.0685379999996}, {"lowerIsBetter": false, "replicates": [542.2993492407809], "unit": "score", "name": "Earley", "value": 1228.9577720000002}, {"lowerIsBetter": false, "replicates": [10589.473684210527], "unit": "score", "name": "Boyer", "value": 62.93636679920471}, {"lowerIsBetter": false, "replicates": [24023.809523809523], "unit": "score", "name": "RegExp", "value": 37.920089197225}, {"lowerIsBetter": false, "replicates": [519.2107995846313], "unit": "score", "name": "Splay", "value": 156.95166600000005}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23343.7079776252}]} 10:57:50 INFO - RETURN: dromaeo_css: 7527.65 10:57:50 INFO - RETURN: kraken: 1470.90 10:57:50 INFO - RETURN: v8_7: 23343.71 10:57:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23343.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1470.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7527.65"}}} 10:57:50 INFO - Return code: 0 10:57:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:57:51 INFO - # TBPL SUCCESS # 10:57:51 INFO - Running post-action listener: _resource_record_post_action 10:57:51 INFO - Running post-run listener: _resource_record_post_run 10:57:52 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 319488; Write bytes: 504336384; Read time: 68; Write time: 603644 10:57:52 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 239243264; Read time: 0; Write time: 369688 10:57:52 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 319488; Write bytes: 265093120; Read time: 68; Write time: 233956 10:57:52 INFO - Running post-run listener: _upload_blobber_files 10:57:52 INFO - Blob upload gear active. 10:57:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:57:52 INFO - Copying logs to upload dir... 10:57:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1253.999590 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-02-22 10:57:51.975702) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-22 10:57:51.979584) ========= 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=836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010045 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456156076/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-22 10:57:52.030482) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:57:52.030797) ========= 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=836cfdc75598d54cb747368e000001a9-1456166190.298034-1552497251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:57:52.079940) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 10:57:52.080254) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 10:57:52.080544) ========= ========= Total master_lag: 0.29 =========