builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1453568652.51 results: success (0) buildid: 20160123064329 builduid: 00521244bc5647c5ad2f6312d4c0867c revision: a4743600b7507c8e09c9e324aaf42c5928951249 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:12.509854) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:12.510225) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:12.510509) ========= 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=574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006412 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:12.546785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:12.547067) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:12.572230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:12.572502) ========= 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=574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:12.624099) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:12.624385) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:12.624730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:12.625011) ========= 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=574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-23 09:04:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 82.9M=0s 2016-01-23 09:04:14 (82.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.310895 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:12.948752) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:12.949047) ========= 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=574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017983 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:12.999001) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:12.999346) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a4743600b7507c8e09c9e324aaf42c5928951249 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a4743600b7507c8e09c9e324aaf42c5928951249 --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=574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-23 09:04:14,274 truncating revision to first 12 chars 2016-01-23 09:04:14,274 Setting DEBUG logging. 2016-01-23 09:04:14,274 attempt 1/10 2016-01-23 09:04:14,274 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a4743600b750?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-23 09:04:14,582 unpacking tar archive at: mozilla-aurora-a4743600b750/testing/mozharness/ program finished with exit code 0 elapsedTime=0.597713 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:13.614923) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:13.615266) ========= echo a4743600b7507c8e09c9e324aaf42c5928951249 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a4743600b7507c8e09c9e324aaf42c5928951249'] 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=574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a4743600b7507c8e09c9e324aaf42c5928951249 program finished with exit code 0 elapsedTime=0.004645 script_repo_revision: 'a4743600b7507c8e09c9e324aaf42c5928951249' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:13.666592) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:13.666925) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 09:04:13.688112) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-23 09:04:13.688381) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:04:15 INFO - MultiFileLogger online at 20160123 09:04:15 in /builds/slave/test-pgo 09:04:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:04:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:04:15 INFO - {'append_to_log': False, 09:04:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:04:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:04:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:04:15 INFO - 'branch': 'Mozilla-Aurora', 09:04:15 INFO - 'buildbot_json_path': 'buildprops.json', 09:04:15 INFO - 'config_files': ('talos/linux_config.py',), 09:04:15 INFO - 'default_actions': ('clobber', 09:04:15 INFO - 'read-buildbot-config', 09:04:15 INFO - 'download-and-extract', 09:04:15 INFO - 'populate-webroot', 09:04:15 INFO - 'create-virtualenv', 09:04:15 INFO - 'install', 09:04:15 INFO - 'run-tests'), 09:04:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:04:15 INFO - 'download_minidump_stackwalk': True, 09:04:15 INFO - 'download_symbols': 'ondemand', 09:04:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:04:15 INFO - 'tooltool.py': '/tools/tooltool.py', 09:04:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:04:15 INFO - '/tools/misc-python/virtualenv.py')}, 09:04:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:04:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:04:15 INFO - 'installer_path': 'installer.exe', 09:04:15 INFO - 'log_level': 'info', 09:04:15 INFO - 'log_name': 'talos', 09:04:15 INFO - 'log_to_console': True, 09:04:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:04:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:04:15 INFO - 'opt_config_files': (), 09:04:15 INFO - 'pip_index': False, 09:04:15 INFO - 'sps_profile': False, 09:04:15 INFO - 'sps_profile_interval': 0, 09:04:15 INFO - 'suite': 'dromaeojs-e10s', 09:04:15 INFO - 'system_bits': '32', 09:04:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:04:15 INFO - 'title': 'talos-linux64-ix-044', 09:04:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:04:15 INFO - 'use_talos_json': True, 09:04:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:04:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:04:15 INFO - 'work_dir': 'build'} 09:04:15 INFO - ##### 09:04:15 INFO - ##### Running clobber step. 09:04:15 INFO - ##### 09:04:15 INFO - Running pre-action listener: _resource_record_pre_action 09:04:15 INFO - Running main action method: clobber 09:04:15 INFO - rmtree: /builds/slave/test-pgo/build 09:04:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:04:16 INFO - Running post-action listener: _resource_record_post_action 09:04:16 INFO - ##### 09:04:16 INFO - ##### Running read-buildbot-config step. 09:04:16 INFO - ##### 09:04:16 INFO - Running pre-action listener: _resource_record_pre_action 09:04:16 INFO - Running main action method: read_buildbot_config 09:04:16 INFO - Using buildbot properties: 09:04:16 INFO - { 09:04:16 INFO - "properties": { 09:04:16 INFO - "buildnumber": 78, 09:04:16 INFO - "product": "firefox", 09:04:16 INFO - "script_repo_revision": "production", 09:04:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:04:16 INFO - "repository": "", 09:04:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:04:16 INFO - "buildid": "20160123064329", 09:04:16 INFO - "slavename": "talos-linux64-ix-044", 09:04:16 INFO - "pgo_build": "True", 09:04:16 INFO - "basedir": "/builds/slave/test-pgo", 09:04:16 INFO - "project": "", 09:04:16 INFO - "platform": "ubuntu64_hw", 09:04:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:04:16 INFO - "slavebuilddir": "test", 09:04:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:04:16 INFO - "branch": "mozilla-aurora", 09:04:16 INFO - "repo_path": "releases/mozilla-aurora", 09:04:16 INFO - "stage_platform": "linux64-pgo", 09:04:16 INFO - "builduid": "00521244bc5647c5ad2f6312d4c0867c", 09:04:16 INFO - "revision": "a4743600b7507c8e09c9e324aaf42c5928951249" 09:04:16 INFO - }, 09:04:16 INFO - "sourcestamp": { 09:04:16 INFO - "repository": "", 09:04:16 INFO - "hasPatch": false, 09:04:16 INFO - "project": "", 09:04:16 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:04:16 INFO - "changes": [ 09:04:16 INFO - { 09:04:16 INFO - "category": null, 09:04:16 INFO - "files": [ 09:04:16 INFO - { 09:04:16 INFO - "url": null, 09:04:16 INFO - "name": "https://queue.taskcluster.net/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 09:04:16 INFO - } 09:04:16 INFO - ], 09:04:16 INFO - "repository": "", 09:04:16 INFO - "rev": "a4743600b7507c8e09c9e324aaf42c5928951249", 09:04:16 INFO - "who": "ryanvm@gmail.com", 09:04:16 INFO - "when": 1453568630, 09:04:16 INFO - "number": 7505447, 09:04:16 INFO - "comments": "Bug 1240559 - Ship NewTabURL.jsm in 45. r=mconley, a=sylvestre", 09:04:16 INFO - "project": "", 09:04:16 INFO - "at": "Sat 23 Jan 2016 09:03:50", 09:04:16 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:04:16 INFO - "revlink": "", 09:04:16 INFO - "properties": [ 09:04:16 INFO - [ 09:04:16 INFO - "buildid", 09:04:16 INFO - "20160123064329", 09:04:16 INFO - "Change" 09:04:16 INFO - ], 09:04:16 INFO - [ 09:04:16 INFO - "builduid", 09:04:16 INFO - "00521244bc5647c5ad2f6312d4c0867c", 09:04:16 INFO - "Change" 09:04:16 INFO - ], 09:04:16 INFO - [ 09:04:16 INFO - "pgo_build", 09:04:16 INFO - "True", 09:04:16 INFO - "Change" 09:04:16 INFO - ] 09:04:16 INFO - ], 09:04:16 INFO - "revision": "a4743600b7507c8e09c9e324aaf42c5928951249" 09:04:16 INFO - } 09:04:16 INFO - ], 09:04:16 INFO - "revision": "a4743600b7507c8e09c9e324aaf42c5928951249" 09:04:16 INFO - } 09:04:16 INFO - } 09:04:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 09:04:16 INFO - Running post-action listener: _resource_record_post_action 09:04:16 INFO - ##### 09:04:16 INFO - ##### Running download-and-extract step. 09:04:16 INFO - ##### 09:04:16 INFO - Running pre-action listener: _resource_record_pre_action 09:04:16 INFO - Running main action method: download_and_extract 09:04:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:04:16 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')]} 09:04:16 INFO - https://queue.taskcluster.net/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:04:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/test_packages.json 09:04:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/test_packages.json 09:04:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:04:21 INFO - Downloaded 1302 bytes. 09:04:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:04:21 INFO - Using the following test package requirements: 09:04:21 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:04:21 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:04:21 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:04:21 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:04:21 INFO - u'jsshell-linux-x86_64.zip'], 09:04:21 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:04:21 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:04:21 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:04:21 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:04:21 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:04:21 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:04:21 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:04:21 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:04:21 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:04:21 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:04:21 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:04:21 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:04:21 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:04: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')]} 09:04:21 INFO - https://queue.taskcluster.net/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:04:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:04:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:04:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:04:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:04:24 INFO - Downloaded 23159143 bytes. 09:04:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:04:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:04:24 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:04:25 INFO - Return code: 0 09:04:25 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:04:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:25 INFO - https://queue.taskcluster.net/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:04:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:04:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:04:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:04:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:04:27 INFO - Downloaded 23159143 bytes. 09:04:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:04:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:04:27 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:04:28 INFO - Return code: 0 09:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:28 INFO - https://queue.taskcluster.net/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:04:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:04:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:04:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:04:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:04:30 INFO - Downloaded 11132038 bytes. 09:04:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 09:04:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:04:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:04:30 INFO - Return code: 0 09:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:30 INFO - https://queue.taskcluster.net/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:04:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:04:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:04:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:04:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:04:32 INFO - Downloaded 58032145 bytes. 09:04:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:04:32 INFO - mkdir: /builds/slave/test-pgo/properties 09:04:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:04:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:04:32 INFO - Contents: 09:04:32 INFO - build_url:https://queue.taskcluster.net/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:04:32 INFO - Running post-action listener: _resource_record_post_action 09:04:32 INFO - Running post-action listener: set_extra_try_arguments 09:04:32 INFO - ##### 09:04:32 INFO - ##### Running populate-webroot step. 09:04:32 INFO - ##### 09:04:32 INFO - Running pre-action listener: _resource_record_pre_action 09:04:32 INFO - Running main action method: populate_webroot 09:04:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:04:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:04:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:04:32 INFO - '--tppagecycles', 09:04:32 INFO - '7'], 09:04:32 INFO - 'tests': ['tsvgm']}}, 09:04:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:04:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:04:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:04:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:04:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:04:32 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:04:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:32 INFO - 'talos_options': ['--e10s'], 09:04:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:32 INFO - 'tests': ['damp', 'tps']}, 09:04:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:32 INFO - 'talos_options': ['--e10s'], 09:04:32 INFO - 'tests': ['damp', 'tps']}, 09:04:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:04:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:04:32 INFO - 'other': {'tests': ['a11yr', 09:04:32 INFO - 'ts_paint', 09:04:32 INFO - 'tpaint', 09:04:32 INFO - 'sessionrestore', 09:04:32 INFO - 'sessionrestore_no_auto_restore']}, 09:04:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:04:32 INFO - 'tests': ['a11yr', 09:04:32 INFO - 'ts_paint', 09:04:32 INFO - 'tpaint', 09:04:32 INFO - 'sessionrestore', 09:04:32 INFO - 'sessionrestore_no_auto_restore']}, 09:04:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:04:32 INFO - 'tests': ['a11yr', 09:04:32 INFO - 'ts_paint', 09:04:32 INFO - 'tpaint', 09:04:32 INFO - 'sessionrestore', 09:04:32 INFO - 'sessionrestore_no_auto_restore']}, 09:04:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:04:32 INFO - 'tests': ['a11yr', 09:04:32 INFO - 'ts_paint', 09:04:32 INFO - 'tpaint', 09:04:32 INFO - 'sessionrestore', 09:04:32 INFO - 'sessionrestore_no_auto_restore']}, 09:04:32 INFO - 'other_l64': {'tests': ['a11yr', 09:04:32 INFO - 'ts_paint', 09:04:32 INFO - 'tpaint', 09:04:32 INFO - 'sessionrestore', 09:04:32 INFO - 'sessionrestore_no_auto_restore']}, 09:04:32 INFO - 'other_nol64': {'tests': ['a11yr', 09:04:32 INFO - 'ts_paint', 09:04:32 INFO - 'tpaint', 09:04:32 INFO - 'sessionrestore', 09:04:32 INFO - 'sessionrestore_no_auto_restore']}, 09:04:32 INFO - 'svgr': {'tests': ['tsvgx', 09:04:32 INFO - 'tsvgr_opacity', 09:04:32 INFO - 'tart', 09:04:32 INFO - 'tscrollx', 09:04:32 INFO - 'cart']}, 09:04:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:04:32 INFO - 'tests': ['tsvgx', 09:04:32 INFO - 'tsvgr_opacity', 09:04:32 INFO - 'tart', 09:04:32 INFO - 'tscrollx', 09:04:32 INFO - 'cart']}, 09:04:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:32 INFO - 'tests': ['tp5o']}, 09:04:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:32 INFO - 'talos_options': ['--e10s'], 09:04:32 INFO - 'tests': ['tp5o']}, 09:04:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:32 INFO - 'talos_options': ['--xperf_path', 09:04:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:32 INFO - 'tests': ['tp5n']}, 09:04:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:32 INFO - 'talos_options': ['--e10s', 09:04:32 INFO - '--xperf_path', 09:04:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:32 INFO - 'tests': ['tp5n']}}, 09:04:32 INFO - 'talos.zip': {'path': '', 09:04:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:04:32 INFO - Running post-action listener: _resource_record_post_action 09:04:32 INFO - ##### 09:04:32 INFO - ##### Running create-virtualenv step. 09:04:32 INFO - ##### 09:04:32 INFO - Running pre-action listener: _resource_record_pre_action 09:04:32 INFO - Running main action method: create_virtualenv 09:04:32 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:04:32 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 09:04:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:04:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:04:32 INFO - Using real prefix '/usr' 09:04:32 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:04:32 INFO - Installing distribute.............................................................................................................................................................................................done. 09:04:34 INFO - Installing pip.................done. 09:04:34 INFO - Return code: 0 09:04:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:34 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 0x7f6fc0a61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da50>, '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 0x1dd9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd99e0>, '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': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', '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 09:04:34 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 09:04:34 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 09:04:34 INFO - Using env: {'DISPLAY': ':0', 09:04:34 INFO - 'HOME': '/home/cltbld', 09:04:34 INFO - 'LANG': 'en_US.UTF-8', 09:04:34 INFO - 'LANGUAGE': 'en_US:en', 09:04:34 INFO - 'LOGNAME': 'cltbld', 09:04:34 INFO - 'MAIL': '/var/mail/cltbld', 09:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:34 INFO - 'MOZ_NO_REMOTE': '1', 09:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:34 INFO - 'NO_EM_RESTART': '1', 09:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:34 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:34 INFO - 'SHELL': '/bin/bash', 09:04:34 INFO - 'SHLVL': '1', 09:04:34 INFO - 'TERM': 'linux', 09:04:34 INFO - 'TMOUT': '86400', 09:04:34 INFO - 'USER': 'cltbld', 09:04:34 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', 09:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:34 INFO - '_': '/tools/buildbot/bin/python'} 09:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:35 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 09:04:35 INFO - Cleaning up... 09:04:35 INFO - Return code: 0 09:04:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:35 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 0x7f6fc0a61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da50>, '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 0x1dd9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd99e0>, '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': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', '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 09:04:35 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 09:04:35 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 09:04:35 INFO - Using env: {'DISPLAY': ':0', 09:04:35 INFO - 'HOME': '/home/cltbld', 09:04:35 INFO - 'LANG': 'en_US.UTF-8', 09:04:35 INFO - 'LANGUAGE': 'en_US:en', 09:04:35 INFO - 'LOGNAME': 'cltbld', 09:04:35 INFO - 'MAIL': '/var/mail/cltbld', 09:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:35 INFO - 'MOZ_NO_REMOTE': '1', 09:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:35 INFO - 'NO_EM_RESTART': '1', 09:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:35 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:35 INFO - 'SHELL': '/bin/bash', 09:04:35 INFO - 'SHLVL': '1', 09:04:35 INFO - 'TERM': 'linux', 09:04:35 INFO - 'TMOUT': '86400', 09:04:35 INFO - 'USER': 'cltbld', 09:04:35 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', 09:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:35 INFO - '_': '/tools/buildbot/bin/python'} 09:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:35 INFO - Downloading/unpacking psutil>=0.7.1 09:04:35 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 09:04:35 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 09:04:35 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 09:04:35 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 09:04:35 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 09:04:35 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 09:04:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:04:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:37 INFO - Installing collected packages: psutil 09:04:37 INFO - Running setup.py install for psutil 09:04:37 INFO - building 'psutil._psutil_linux' extension 09:04:37 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 09:04:37 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 09:04:37 INFO - building 'psutil._psutil_posix' extension 09:04:37 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 09:04:37 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 09:04:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:37 INFO - Successfully installed psutil 09:04:37 INFO - Cleaning up... 09:04:37 INFO - Return code: 0 09:04:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:37 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 0x7f6fc0a61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da50>, '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 0x1dd9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd99e0>, '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': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', '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 09:04:37 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 09:04:37 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 09:04:37 INFO - Using env: {'DISPLAY': ':0', 09:04:37 INFO - 'HOME': '/home/cltbld', 09:04:37 INFO - 'LANG': 'en_US.UTF-8', 09:04:37 INFO - 'LANGUAGE': 'en_US:en', 09:04:37 INFO - 'LOGNAME': 'cltbld', 09:04:37 INFO - 'MAIL': '/var/mail/cltbld', 09:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:37 INFO - 'MOZ_NO_REMOTE': '1', 09:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:37 INFO - 'NO_EM_RESTART': '1', 09:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:37 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:37 INFO - 'SHELL': '/bin/bash', 09:04:37 INFO - 'SHLVL': '1', 09:04:37 INFO - 'TERM': 'linux', 09:04:37 INFO - 'TMOUT': '86400', 09:04:37 INFO - 'USER': 'cltbld', 09:04:37 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', 09:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:37 INFO - '_': '/tools/buildbot/bin/python'} 09:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:04:37 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 09:04:37 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 09:04:37 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 09:04:37 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 09:04:37 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 09:04:37 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 09:04:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:04:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:04:39 INFO - Installing collected packages: mozsystemmonitor 09:04:39 INFO - Running setup.py install for mozsystemmonitor 09:04:39 INFO - Successfully installed mozsystemmonitor 09:04:39 INFO - Cleaning up... 09:04:39 INFO - Return code: 0 09:04:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:39 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 0x7f6fc0a61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da50>, '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 0x1dd9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd99e0>, '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': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', '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 09:04:39 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 09:04:39 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 09:04:39 INFO - Using env: {'DISPLAY': ':0', 09:04:39 INFO - 'HOME': '/home/cltbld', 09:04:39 INFO - 'LANG': 'en_US.UTF-8', 09:04:39 INFO - 'LANGUAGE': 'en_US:en', 09:04:39 INFO - 'LOGNAME': 'cltbld', 09:04:39 INFO - 'MAIL': '/var/mail/cltbld', 09:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:39 INFO - 'MOZ_NO_REMOTE': '1', 09:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:39 INFO - 'NO_EM_RESTART': '1', 09:04:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:39 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:39 INFO - 'SHELL': '/bin/bash', 09:04:39 INFO - 'SHLVL': '1', 09:04:39 INFO - 'TERM': 'linux', 09:04:39 INFO - 'TMOUT': '86400', 09:04:39 INFO - 'USER': 'cltbld', 09:04:39 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', 09:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:39 INFO - '_': '/tools/buildbot/bin/python'} 09:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:40 INFO - Downloading/unpacking blobuploader==1.2.4 09:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:41 INFO - Downloading blobuploader-1.2.4.tar.gz 09:04:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:04:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:04:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:42 INFO - Downloading docopt-0.6.1.tar.gz 09:04:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:04:42 INFO - Installing collected packages: blobuploader, requests, docopt 09:04:42 INFO - Running setup.py install for blobuploader 09:04:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:04:42 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:04:42 INFO - Running setup.py install for requests 09:04:43 INFO - Running setup.py install for docopt 09:04:43 INFO - Successfully installed blobuploader requests docopt 09:04:43 INFO - Cleaning up... 09:04:43 INFO - Return code: 0 09:04:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:43 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 0x7f6fc0a61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da50>, '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 0x1dd9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd99e0>, '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': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', '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 09:04:43 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 09:04:43 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 09:04:43 INFO - Using env: {'DISPLAY': ':0', 09:04:43 INFO - 'HOME': '/home/cltbld', 09:04:43 INFO - 'LANG': 'en_US.UTF-8', 09:04:43 INFO - 'LANGUAGE': 'en_US:en', 09:04:43 INFO - 'LOGNAME': 'cltbld', 09:04:43 INFO - 'MAIL': '/var/mail/cltbld', 09:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:43 INFO - 'MOZ_NO_REMOTE': '1', 09:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:43 INFO - 'NO_EM_RESTART': '1', 09:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:43 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:43 INFO - 'SHELL': '/bin/bash', 09:04:43 INFO - 'SHLVL': '1', 09:04:43 INFO - 'TERM': 'linux', 09:04:43 INFO - 'TMOUT': '86400', 09:04:43 INFO - 'USER': 'cltbld', 09:04:43 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', 09:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:43 INFO - '_': '/tools/buildbot/bin/python'} 09:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:04:43 INFO - Running setup.py (path:/tmp/pip-_u1mK0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:04:43 INFO - Running setup.py (path:/tmp/pip-_x0Krt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:04:43 INFO - Running setup.py (path:/tmp/pip-Fq1lDq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:04:43 INFO - Running setup.py (path:/tmp/pip-TGpG6g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:04:43 INFO - Running setup.py (path:/tmp/pip-RkLctK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:04:44 INFO - Running setup.py (path:/tmp/pip-_6PpXp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:04:44 INFO - Running setup.py (path:/tmp/pip-_NR0Ct-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:04:44 INFO - Running setup.py (path:/tmp/pip-rxLEPC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:04:44 INFO - Running setup.py (path:/tmp/pip-KumveQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:04:44 INFO - Running setup.py (path:/tmp/pip-f8Qihr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:04:44 INFO - Running setup.py (path:/tmp/pip-Iw3jjy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:04:44 INFO - Running setup.py (path:/tmp/pip-7HiWvm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:04:44 INFO - Running setup.py (path:/tmp/pip-Pn5IWM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:04:44 INFO - Running setup.py (path:/tmp/pip-CTgr0a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:04:44 INFO - Running setup.py (path:/tmp/pip-SL4jQ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:04:44 INFO - Running setup.py (path:/tmp/pip-rT1CLV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:04:44 INFO - Running setup.py (path:/tmp/pip-4jZpbu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:04:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:04:44 INFO - Running setup.py install for manifestparser 09:04:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:04:45 INFO - Running setup.py install for mozcrash 09:04:45 INFO - Running setup.py install for mozdebug 09:04:45 INFO - Running setup.py install for mozdevice 09:04:45 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:04:45 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:04:45 INFO - Running setup.py install for mozfile 09:04:45 INFO - Running setup.py install for mozhttpd 09:04:45 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:04:45 INFO - Running setup.py install for mozinfo 09:04:45 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:04:45 INFO - Running setup.py install for mozInstall 09:04:45 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:04:45 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:04:45 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:04:45 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:04:45 INFO - Running setup.py install for mozleak 09:04:45 INFO - Running setup.py install for mozlog 09:04:45 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:04:45 INFO - Running setup.py install for moznetwork 09:04:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:04:46 INFO - Running setup.py install for mozprocess 09:04:46 INFO - Running setup.py install for mozprofile 09:04:46 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:04:46 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:04:46 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:04:46 INFO - Running setup.py install for mozrunner 09:04:46 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:04:46 INFO - Running setup.py install for mozscreenshot 09:04:46 INFO - Running setup.py install for moztest 09:04:46 INFO - Running setup.py install for mozversion 09:04:46 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:04:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:04:46 INFO - Cleaning up... 09:04:46 INFO - Return code: 0 09:04:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:46 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 0x7f6fc0a61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da50>, '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 0x1dd9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd99e0>, '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': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', '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 09:04:46 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 09:04:46 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 09:04:46 INFO - Using env: {'DISPLAY': ':0', 09:04:46 INFO - 'HOME': '/home/cltbld', 09:04:46 INFO - 'LANG': 'en_US.UTF-8', 09:04:46 INFO - 'LANGUAGE': 'en_US:en', 09:04:46 INFO - 'LOGNAME': 'cltbld', 09:04:46 INFO - 'MAIL': '/var/mail/cltbld', 09:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:46 INFO - 'MOZ_NO_REMOTE': '1', 09:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:46 INFO - 'NO_EM_RESTART': '1', 09:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:46 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:46 INFO - 'SHELL': '/bin/bash', 09:04:46 INFO - 'SHLVL': '1', 09:04:46 INFO - 'TERM': 'linux', 09:04:46 INFO - 'TMOUT': '86400', 09:04:46 INFO - 'USER': 'cltbld', 09:04:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', 09:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:46 INFO - '_': '/tools/buildbot/bin/python'} 09:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:04:46 INFO - Running setup.py (path:/tmp/pip-BLF3GS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:04:46 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)) 09:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:04:46 INFO - Running setup.py (path:/tmp/pip-VoBgVt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:04:47 INFO - Running setup.py (path:/tmp/pip-Xo6MEp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:04:47 INFO - Running setup.py (path:/tmp/pip-cBB12z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:04:47 INFO - Running setup.py (path:/tmp/pip-HI2Prk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:04:47 INFO - Running setup.py (path:/tmp/pip-rZtFg5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:04:47 INFO - Running setup.py (path:/tmp/pip-mvojNl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:04:47 INFO - Running setup.py (path:/tmp/pip-xiEGXG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:04:47 INFO - Running setup.py (path:/tmp/pip-PB0oTi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:04:47 INFO - Running setup.py (path:/tmp/pip-4PTZx5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:04:47 INFO - Running setup.py (path:/tmp/pip-JPeUi5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:04:47 INFO - Running setup.py (path:/tmp/pip-1KJyZv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:04:47 INFO - Running setup.py (path:/tmp/pip-LeKKH2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:04:47 INFO - Running setup.py (path:/tmp/pip-jaNILV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:04:47 INFO - Running setup.py (path:/tmp/pip-jUWcKK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:04:48 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)) 09:04:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:04:48 INFO - Running setup.py (path:/tmp/pip-2mBwle-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:04:48 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)) 09:04:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:04:48 INFO - Running setup.py (path:/tmp/pip-KjYeb9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:04:48 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)) 09:04:48 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)) 09:04:48 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)) 09:04:48 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)) 09:04:48 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)) 09:04:48 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)) 09:04:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:49 INFO - Downloading blessings-1.6.tar.gz 09:04:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:04:49 INFO - Installing collected packages: blessings 09:04:49 INFO - Running setup.py install for blessings 09:04:50 INFO - Successfully installed blessings 09:04:50 INFO - Cleaning up... 09:04:50 INFO - Return code: 0 09:04:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:04:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:04:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:04:50 INFO - Reading from file tmpfile_stdout 09:04:50 INFO - Current package versions: 09:04:50 INFO - argparse == 1.2.1 09:04:50 INFO - blessings == 1.6 09:04:50 INFO - blobuploader == 1.2.4 09:04:50 INFO - docopt == 0.6.1 09:04:50 INFO - manifestparser == 1.1 09:04:50 INFO - mozInstall == 1.12 09:04:50 INFO - mozcrash == 0.16 09:04:50 INFO - mozdebug == 0.1 09:04:50 INFO - mozdevice == 0.47 09:04:50 INFO - mozfile == 1.2 09:04:50 INFO - mozhttpd == 0.7 09:04:50 INFO - mozinfo == 0.9 09:04:50 INFO - mozleak == 0.1 09:04:50 INFO - mozlog == 3.1 09:04:50 INFO - moznetwork == 0.27 09:04:50 INFO - mozprocess == 0.22 09:04:50 INFO - mozprofile == 0.27 09:04:50 INFO - mozrunner == 6.11 09:04:50 INFO - mozscreenshot == 0.1 09:04:50 INFO - mozsystemmonitor == 0.0 09:04:50 INFO - moztest == 0.7 09:04:50 INFO - mozversion == 1.4 09:04:50 INFO - psutil == 3.1.1 09:04:50 INFO - requests == 1.2.3 09:04:50 INFO - wsgiref == 0.1.2 09:04:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:50 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 0x7f6fc0a61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da50>, '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 0x1dd9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd99e0>, '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': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', '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 09:04:50 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 09:04:50 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 09:04:50 INFO - Using env: {'DISPLAY': ':0', 09:04:50 INFO - 'HOME': '/home/cltbld', 09:04:50 INFO - 'LANG': 'en_US.UTF-8', 09:04:50 INFO - 'LANGUAGE': 'en_US:en', 09:04:50 INFO - 'LOGNAME': 'cltbld', 09:04:50 INFO - 'MAIL': '/var/mail/cltbld', 09:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:50 INFO - 'MOZ_NO_REMOTE': '1', 09:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:50 INFO - 'NO_EM_RESTART': '1', 09:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:50 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:50 INFO - 'SHELL': '/bin/bash', 09:04:50 INFO - 'SHLVL': '1', 09:04:50 INFO - 'TERM': 'linux', 09:04:50 INFO - 'TMOUT': '86400', 09:04:50 INFO - 'USER': 'cltbld', 09:04:50 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', 09:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:50 INFO - '_': '/tools/buildbot/bin/python'} 09:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:50 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)) 09:04:50 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)) 09:04:50 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)) 09:04:50 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)) 09:04:50 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)) 09:04:50 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)) 09:04:50 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)) 09:04:50 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)) 09:04:50 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)) 09:04:50 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)) 09:04:50 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)) 09:04:50 INFO - Cleaning up... 09:04:50 INFO - Return code: 0 09:04:50 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:50 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 0x7f6fc0a61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da50>, '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 0x1dd9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd99e0>, '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': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', '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 09:04:50 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 09:04:50 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 09:04:50 INFO - Using env: {'DISPLAY': ':0', 09:04:50 INFO - 'HOME': '/home/cltbld', 09:04:50 INFO - 'LANG': 'en_US.UTF-8', 09:04:50 INFO - 'LANGUAGE': 'en_US:en', 09:04:50 INFO - 'LOGNAME': 'cltbld', 09:04:50 INFO - 'MAIL': '/var/mail/cltbld', 09:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:50 INFO - 'MOZ_NO_REMOTE': '1', 09:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:50 INFO - 'NO_EM_RESTART': '1', 09:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:50 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:50 INFO - 'SHELL': '/bin/bash', 09:04:50 INFO - 'SHLVL': '1', 09:04:50 INFO - 'TERM': 'linux', 09:04:50 INFO - 'TMOUT': '86400', 09:04:50 INFO - 'USER': 'cltbld', 09:04:50 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', 09:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:50 INFO - '_': '/tools/buildbot/bin/python'} 09:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:50 INFO - Downloading/unpacking jsonschema 09:04:50 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 09:04:50 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 09:04:50 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 09:04:50 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 09:04:50 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 09:04:50 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 09:04:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:04:52 INFO - Downloading/unpacking functools32 (from jsonschema) 09:04:52 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 09:04:52 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 09:04:52 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 09:04:52 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 09:04:52 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 09:04:52 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 09:04:52 INFO - Downloading functools32-3.2.3-2.tar.gz 09:04:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:04:52 INFO - warning: no files found matching '*.txt' 09:04:52 INFO - no previously-included directories found matching 'build' 09:04:52 INFO - no previously-included directories found matching 'dist' 09:04:52 INFO - no previously-included directories found matching '.git*' 09:04:52 INFO - Installing collected packages: jsonschema, functools32 09:04:52 INFO - Running setup.py install for functools32 09:04:52 INFO - warning: no files found matching '*.txt' 09:04:52 INFO - no previously-included directories found matching 'build' 09:04:52 INFO - no previously-included directories found matching 'dist' 09:04:52 INFO - no previously-included directories found matching '.git*' 09:04:52 INFO - Successfully installed jsonschema functools32 09:04:52 INFO - Cleaning up... 09:04:53 INFO - Return code: 0 09:04:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:53 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 0x7f6fc0a61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da50>, '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 0x1dd9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd99e0>, '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': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', '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 09:04:53 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 09:04:53 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 09:04:53 INFO - Using env: {'DISPLAY': ':0', 09:04:53 INFO - 'HOME': '/home/cltbld', 09:04:53 INFO - 'LANG': 'en_US.UTF-8', 09:04:53 INFO - 'LANGUAGE': 'en_US:en', 09:04:53 INFO - 'LOGNAME': 'cltbld', 09:04:53 INFO - 'MAIL': '/var/mail/cltbld', 09:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:53 INFO - 'MOZ_NO_REMOTE': '1', 09:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:53 INFO - 'NO_EM_RESTART': '1', 09:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:53 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:53 INFO - 'SHELL': '/bin/bash', 09:04:53 INFO - 'SHLVL': '1', 09:04:53 INFO - 'TERM': 'linux', 09:04:53 INFO - 'TMOUT': '86400', 09:04:53 INFO - 'USER': 'cltbld', 09:04:53 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', 09:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:53 INFO - '_': '/tools/buildbot/bin/python'} 09:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:53 INFO - Downloading/unpacking flake8 09:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:04:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:04:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:04:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:04:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:04:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:04:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:04:55 INFO - no previously-included directories found matching 'docs/_build' 09:04:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:04:55 INFO - Running setup.py install for pep8 09:04:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:04:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:04:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:04:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:04:55 INFO - no previously-included directories found matching 'docs/_build' 09:04:55 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:04:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:04:55 INFO - Cleaning up... 09:04:55 INFO - Return code: 0 09:04:55 INFO - Running post-action listener: _resource_record_post_action 09:04:55 INFO - Running post-action listener: _start_resource_monitoring 09:04:55 INFO - Starting resource monitoring. 09:04:55 INFO - ##### 09:04:55 INFO - ##### Running install step. 09:04:55 INFO - ##### 09:04:55 INFO - Running pre-action listener: _resource_record_pre_action 09:04:55 INFO - Running main action method: install 09:04:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:04:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:04:56 INFO - Reading from file tmpfile_stdout 09:04:56 INFO - Detecting whether we're running mozinstall >=1.0... 09:04:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:04:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:04:56 INFO - Reading from file tmpfile_stdout 09:04:56 INFO - Output received: 09:04:56 INFO - Usage: mozinstall [options] installer 09:04:56 INFO - Options: 09:04:56 INFO - -h, --help show this help message and exit 09:04:56 INFO - -d DEST, --destination=DEST 09:04:56 INFO - Directory to install application into. [default: 09:04:56 INFO - "/builds/slave/test-pgo"] 09:04:56 INFO - --app=APP Application being installed. [default: firefox] 09:04:56 INFO - mkdir: /builds/slave/test-pgo/build/application 09:04:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:04:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:05:10 INFO - Reading from file tmpfile_stdout 09:05:10 INFO - Output received: 09:05:10 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:05:10 INFO - Running post-action listener: _resource_record_post_action 09:05:10 INFO - ##### 09:05:10 INFO - ##### Running run-tests step. 09:05:10 INFO - ##### 09:05:10 INFO - Running pre-action listener: _resource_record_pre_action 09:05:10 INFO - Running main action method: run_tests 09:05:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:05:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:05:10 INFO - Python 2.7.3 09:05:10 INFO - Return code: 0 09:05:10 INFO - grabbing minidump binary from tooltool 09:05:10 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')]} 09:05:10 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 0x1e6da50>, '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 0x1dd9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd99e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:05:10 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 09:05:10 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 09:05:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:05:10 INFO - Return code: 0 09:05:10 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:05:10 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:05:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:05:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:05:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:05:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:05:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:05:11 INFO - Return code: 0 09:05:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:05:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost 09:05:11 INFO - Using env: {'DISPLAY': ':0', 09:05:11 INFO - 'HOME': '/home/cltbld', 09:05:11 INFO - 'LANG': 'en_US.UTF-8', 09:05:11 INFO - 'LANGUAGE': 'en_US:en', 09:05:11 INFO - 'LOGNAME': 'cltbld', 09:05:11 INFO - 'MAIL': '/var/mail/cltbld', 09:05:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:05:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:11 INFO - 'MOZ_NO_REMOTE': '1', 09:05:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:11 INFO - 'NO_EM_RESTART': '1', 09:05:11 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:05:11 INFO - 'PWD': '/builds/slave/test-pgo', 09:05:11 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:05:11 INFO - 'SHELL': '/bin/bash', 09:05:11 INFO - 'SHLVL': '1', 09:05:11 INFO - 'TERM': 'linux', 09:05:11 INFO - 'TMOUT': '86400', 09:05:11 INFO - 'USER': 'cltbld', 09:05:11 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362', 09:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:11 INFO - '_': '/tools/buildbot/bin/python'} 09:05:11 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost'] with output_timeout 3600 09:05:12 INFO - mozversion INFO | application_buildid: 20160123064329 09:05:12 INFO - mozversion INFO | application_changeset: a4743600b7507c8e09c9e324aaf42c5928951249 09:05:12 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 09:05:12 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:05:12 INFO - mozversion INFO | application_name: Firefox 09:05:12 INFO - mozversion INFO | application_remotingname: firefox-dev 09:05:12 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:05:12 INFO - mozversion INFO | application_vendor: Mozilla 09:05:12 INFO - mozversion INFO | application_version: 45.0a2 09:05:12 INFO - mozversion INFO | platform_buildid: 20160123064329 09:05:12 INFO - mozversion INFO | platform_changeset: a4743600b7507c8e09c9e324aaf42c5928951249 09:05:12 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:05:12 INFO - mozversion INFO | platform_version: 45.0a2 09:05:12 INFO - 2016-01-23 09:05:12,155 DEBUG : using testdate: 1453568712 09:05:12 INFO - 2016-01-23 09:05:12,155 DEBUG : actual date: 1453568712 09:05:12 INFO - 2016-01-23 09:05:12,263 INFO : starting webserver on 'localhost:54883' 09:05:12 INFO - 2016-01-23 09:05:12,264 INFO : Starting test suite talos-linux64-ix-044.e 09:05:12 INFO - 2016-01-23 09:05:12,264 INFO : Starting test dromaeo_css 09:05:12 INFO - 2016-01-23 09:05:12,265 DEBUG : operating with platform_type : linux_ 09:05:12 INFO - 2016-01-23 09:05:12,265 INFO : Initialising browser for dromaeo_css test... 09:05:12 INFO - 2016-01-23 09:05:12,279 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb2357D/profile http://localhost:54883/getInfo.html 09:05:16 INFO - 2016-01-23 09:05:16,060 DEBUG : BROWSER_OUTPUT: 09:05:16 INFO - 2016-01-23 09:05:16,061 DEBUG : BROWSER_OUTPUT: (process:27616): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:05:16 INFO - 2016-01-23 09:05:16,863 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:05:16 INFO - 2016-01-23 09:05:16,863 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:05:16 INFO - 2016-01-23 09:05:16,864 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:05:16 INFO - 2016-01-23 09:05:16,864 DEBUG : BROWSER_OUTPUT: __metrics 09:05:17 INFO - 2016-01-23 09:05:17,797 INFO : Browser initialized. 09:05:17 INFO - 2016-01-23 09:05:17,798 INFO : Running cycle 1/1 for dromaeo_css test... 09:05:17 INFO - 2016-01-23 09:05:17,798 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb2357D/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:05:19 INFO - 2016-01-23 09:05:19,122 DEBUG : BROWSER_OUTPUT: 09:05:19 INFO - 2016-01-23 09:05:19,122 DEBUG : BROWSER_OUTPUT: (process:27728): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:05:29 INFO - 2016-01-23 09:05:29,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 135897088 09:05:29 INFO - 2016-01-23 09:05:29,628 DEBUG : BROWSER_OUTPUT: 09:06:19 INFO - 2016-01-23 09:06:19,247 DEBUG : BROWSER_OUTPUT: 1453568779244 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] 09:08:26 INFO - 2016-01-23 09:08:26,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54883/tests/dromaeo/cssquery-ext.html) 09:08:27 INFO - 2016-01-23 09:08:27,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 141320192 09:08:27 INFO - 2016-01-23 09:08:27,877 DEBUG : BROWSER_OUTPUT: 09:11:29 INFO - 2016-01-23 09:11:29,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/dromaeo/cssquery-ext.html (next: http://localhost:54883/tests/dromaeo/cssquery-jquery.html) 09:11:30 INFO - 2016-01-23 09:11:30,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 139948032 09:11:30 INFO - 2016-01-23 09:11:30,267 DEBUG : BROWSER_OUTPUT: 09:14:31 INFO - 2016-01-23 09:14:31,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54883/tests/dromaeo/cssquery-mootools.html) 09:14:32 INFO - 2016-01-23 09:14:32,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 138633216 09:14:32 INFO - 2016-01-23 09:14:32,415 DEBUG : BROWSER_OUTPUT: 09:17:34 INFO - 2016-01-23 09:17:34,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54883/tests/dromaeo/cssquery-prototype.html) 09:17:34 INFO - 2016-01-23 09:17:34,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 139436032 09:17:34 INFO - 2016-01-23 09:17:34,615 DEBUG : BROWSER_OUTPUT: 09:20:36 INFO - 2016-01-23 09:20:36,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54883/tests/dromaeo/cssquery-yui.html) 09:20:37 INFO - 2016-01-23 09:20:37,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 139874304 09:20:37 INFO - 2016-01-23 09:20:37,488 DEBUG : BROWSER_OUTPUT: 09:23:39 INFO - 2016-01-23 09:23:39,509 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/dromaeo/cssquery-yui.html (next: http://localhost:54883/tests/dromaeo/cssquery-dojo.html) 09:23:39 INFO - 2016-01-23 09:23:39,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 140775424 09:23:39 INFO - 2016-01-23 09:23:39,767 DEBUG : BROWSER_OUTPUT: 09:23:39 INFO - 2016-01-23 09:23:39,767 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:23:39 INFO - 2016-01-23 09:23:39,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:23:39 INFO - 2016-01-23 09:23:39,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:23:39 INFO - 2016-01-23 09:23:39,767 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:23:39 INFO - 2016-01-23 09:23:39,768 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3300.0759787259567;3344.816035118069;3351.597808263009;3374.1395944034266;3382.7124694400973;5289.788408463657;5322.467753224676;5327.627066105374;5330.493603107703;5354.812581559646;5390;5436.429174936634;5443.727813609324;5445.754941027653;5447.12845944649;4950.381202349698;4972.776225069862;5032.421271553763;5048.747562621854;5049.823256186034;4788.281757736333;4927.605791536668;4937.358143441347;4945.1098802215765;5075.873103172414;4946.134426475371;5024.145895197825;5028.069807085701;5030.874228144307;5046.09170349337;4917.114919314522;4956.826511072131;4978.303037574724;4991.850244492671;5080.618953578478;4740.810367585293;4810.134175848346;4816.927746083777;4844.63665225106;4912.533309335608;5106.948930510722;5180.818671346522;5222.190560463135;5264.236685680593;5276.762545685453;5815.331236907725;5821.67980761058;5857;5894.115882617599;5900.203472531196;5619.157126431027;5651.208830763697;5683.403242659502;5841;5922.200502932092;5450.264214331094;5515.117581186991;5517.034518959166;5517.310336207974;5533.6956467393875;5926.170336152942;5966.552508561876;5968.1644569760265;5973.701314934236;5974.133750606138;5690.374058853523;5697.202391665171;5709.371969083398;5775.509081728016;5829.038208695602;5855.180274761537;5856.267966504187;5872.148538461985;5874.618149820248;5893.941060589425;5639.971800141055;5804.9419505805245;5819.73811178498;5826.126081087786;5829.650220986754;5648.406917273709;5740.885182296331;5742.6554406734895;5822.650640961471;5854;4472.798724057425;4535;4555.863324100283;4568.451785785727;4594.035252596992;3934.842606295716;4037.515498140242;4081;4103.733257338264;4121.340585506305;5408.702521361363;5499.615026948155;5504.944950550524;5524.254225679562;5568.638038527563;5837.036888913367;5854.560907931922;5860.2381690380835;5862.648241105548;5884.882302354014;5364.30264065669;5394.91907621386;5402.864928376822;5569.610127291132;5601.8599535011135;5112.795488180505;5113.590912726973;5140.434552199255;5140.640155189101;5166.43169251382;5867.647941123546;5915.349311575723;5927.614705044159;5958.970205149033;5996.37038110992;5653.067243904709;5771.884562308815;5866.178734977021;5893.263342082154;5966;5991;5991.64050156992;6000.759969601341;6008.098785182257;6012.819615411545;5812.331581868139;5821.330546987151;5825.446582574648;5834.708264586839;5838.299404071538;5680.6591604503865;5744;5755.683437410982;5796.82609521715;5842.2405087338375;5634.74643641029;5761.56788240892;5764.654120752768;5780.132980053026;5783.190353350618;5695.686737229326;5763;5764.7405866736935;5765.279340082489;5768.480836724715;5391.4608539145775;5504.669719816824;5551.1673249011355;5563.970665426909;5627.718614069362;5678.233438485917;5701.714914254354;5728.828135155952;5735.913961290667;5782.074868021096;5497.065498865122;5605.887882242414;5606.467385598362;5611.80358687444;5617.859553511195 09:23:39 INFO - 2016-01-23 09:23:39,768 DEBUG : BROWSER_OUTPUT: |1;ext.html;571.702714588414;617.6448542088299;620.5314987184674;638.0716058135414;681.2506243132555;32490.18774530638;40222;41040.38439423411;41065;41281;44664.55335446653;45283;45287.77356113223;45373.54626453735;45382.773086134526;9083.636654533811;9196.310276729238;9200.723978280663;9211.401258918182;9216.723498295061;9001.684941027066;9140.63437462504;9146.359754817166;9154.816903661922;9157.725268241964;9092.772680683003;9164.725058248263;9187.173154416101;9192.494412807293;9200.355975081748;9159.129882661136;9180.770480737969;9235.307351948632;9237.722868313927;9259;9075.954620226923;9141.314401419853;9161.358704890661;9199.908000919972;9200.263978881674;42558;42597.36103958443;43201;43207.783961080306;43232.35151472731;3640.8179591020344;3741.8316175772156;4022.8390864365683;4049.8380064797375;4185.832566697329;32456.513152302734;32655.020349389557;32735.6726432735;32809.17977050569;32988.67011329904;3867.7099217558793;3904.3362628352966;3922.431247469101;3988.840446382141;4045.7977101144825;280600;281319;281350;281494;469728.99999999657;65821.34178658247;65865.67067164634;66196;66323.33676663268;66710.66644666746;70275.64862175759;71088.64455677688;71173.28826711666;71259.28740712526;71582;15663.68672626541;15845.762313565076;15880.285387157606;15909.284082216329;15931;12896.871031289755;13290.73418531624;13290.800637990438;13294.933525332312;13317.866821331663;22515.437114071952;22671.773282267295;22788.658170127463;22837.885810570842;22970.7702922972;8743.344249181337;9014.906577783531;9044.954775226082;9046.683366082287;9086.864586822092;968.4189486308159;1022.0494939706144;1093.6937657455926;1103.9558417663363;1161.5760247509597;29566.852165739034;29731.702682973326;29986.25034374158;30647;30652.693473064985;1131.3607811586592;1146.358039497884;1149.126663735567;1198.0415667465993;1210.842590463234;15715;15919.363225470852;15997.80016498744;16001.919990399974;16001.959872608477;326701;589088;765952;773082;775462.245377539;59070.40929590649;59828;59970;60160;60295.39704602986;1479.0534058202759;1482.577465422371;1491.0382803091945;1515.6210947263185;1516.5829396915935;30582.388352233276;31344.686553134175;31397.372052559276;31625.8418707905;32093.35813283768;49990;50395.49604503908;50527.74736126296;50570.2414463776;50797;321304;321924;322960;323055;323940;34686;34839.47740783941;34870.825645871606;35090.64909350976;35239.82380088186;45700.771496143636;45954.54045459503;46387;46517.76741116273;47091;39726.60273397345;39737.2052558953;40628.59371406248;40917.79541102275;41153.176936460506;45276.77361613171;46497.53502464932;47325.290120648904;47499.52500475089;48014.759926200146;37998.43002354912;38467.23065538618;38521.807390962866;38591.6140838588;38679;34274;34570;34723.30553388868;34811.47782783311;34993.65006349904;28189.43621127607;28799.42401152007;30761.538576921812;30891;31113 09:23:39 INFO - 2016-01-23 09:23:39,768 DEBUG : BROWSER_OUTPUT: |2;jquery.html;379.57866767887657;380.0479798105745;381.4012001158181;384.90878359849825;390.62890254258457;15978.520644380687;17466.825331746695;17918;19081.61836763264;19158.71261931072;17549.21028553715;17799.110044497756;18032.54918627035;18177.272909083622;18638.508919286458;4890.119778439888;5169.767360468788;5177;5193.428722840485;5196.246544251081;5090.694558326512;5275.472452754713;5412.431694672062;5414.187871819239;5416.729163541827;5387.24578559002;5403.918941215885;5432.320959880015;6351.110844481776;6369.4585960193435;6321.841953951142;6327.683615819191;6336.873262534747;6368.140301059344;6376.458001069915;5401.243825864382;5417.349918009864;5425.321834770653;5452.645578037414;5620.690862002588;15281.006734562217;21517.892410538003;21553.56892862134;21801.454963626034;21971.780282197135;2248.6177349850564;2295.1507942061376;2321.3848330192513;2472.950540989188;2482.9943872731574;9407.341486095977;9593.568289426992;9816.116549510578;12725.872741272562;14175.220362880038;2007.979920200794;2013.8590298679098;2022.7067075274003;2039.7246371739773;2083.14591017682;65438.3456165437;66006.66996665034;66969;68108;69282.65358673174;10795.352278863293;10934.234603577832;11097.44512774358;11110.277831941059;11135.665930022113;14543.85456145425;14600.488982885548;14614.488492902698;14663.853361466463;14671.413143474356;8485.618147183392;8501.362397820189;8513.148685131437;8566.27186689126;8620.094890036582;8424.28393586552;8504.829903401896;8507.319414446829;8545.359098067669;8551.957240213884;4636.11913736389;4712.552307530779;4754.667173297905;4762.78567464465;4837.129316723023;1964.184863281722;1979.7921218272163;1992.1135094882638;2018.2431588154443;2023.9089240983897;470.1419908666697;956.2159029595665;1022.749426390539;1022.8210063238903;1128.136975213962;10091.344062635904;10144.797104057878;10205.948970255102;10268.845967310497;10637;480.9903801923942;487.53927538476506;491.9950800492021;492.1706923833352;525.4220357606679;5712.200291959129;5734.340550836707;5796.594238403271;5831.241938547962;5836.416358364215;635317;644061;650247.4975250186;674650;676951;78488;79671.60164199142;80104;87765;91009.08990910139;1210.3403645013489;1215.7143071378396;1252.1110011891658;1260.5021016698354;1287.5429222626021;16402.343906243615;16435.91782041082;16596.309491731805;16631.66736665284;16785.832141678915;37464.62535374721;37875.24249514939;38320.23359532738;38449.6155038446;38663.806680966416;45247;47119;47864.521354786004;48253;49020.75489622672;9335.253179745469;9665.661701840401;9764.267679923893;9808.852867206855;9834.901650983398;13717.108387954751;17888.552786179927;18148.637027259643;18224.36214732531;18573.90713046426;14446.494372696905;14586.781198282246;15140.394384224508;15394.769078464056;15736;14790.408383664962;14816.185109819064;15145.545633631009;15355.846441535441;15370.69258614799;15386.153761542775;15416.614584635474;15520.5343839685;15612.82903782198;15763.684726305639;9617.519124043909;9664.226861851175;9740.512974351395;9959.950200248952;10333.070023697903;10918.18113641496;15136.924315378794;15872.60318492047;15893.682126357176;16088.67822643564 09:23:39 INFO - 2016-01-23 09:23:39,768 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1523.6876440329727;1537.6386549160952;1700.8299170083;1800.6231774058244;1836.311383231288;7377.52046117002;7717.922820771791;7758.650860711267;7786.649600767972;7988.121306656278;7876.763697089083;7889;7907.327877130437;7917.247861453153;7966.681332746683;2279.418748219206;2303.7696230376996;2308.7691230876944;2323.581755284048;2332.6501024846325;2278.396225000376;2312.895919683618;2316.5251123519724;2317.629179331307;2318.07277089164;2284.680144779732;2303.9308820735323;2322.512272422793;2330.6387509935985;2337.5208082343165;2231.665250212465;2286.4398222435525;2302.7236731592234;2315.8378913476063;2316.7104111986;2260.2089268755967;2284.554511870186;2287.0508738873345;2290.576243394961;2291.026313816638;7647.158812530617;7762.417818663623;7817;7827.6477558510005;7851;4711.175544279771;4786.832460863888;4789.976050119762;4812.422509298872;4813.735244561548;2964.6294213223346;3006.5790789289517;3057.31210477643;3067.6778938211614;3067.7699172561925;972.0910948263326;978.0806042320196;1002.1081237698454;1002.8846682631518;1012.3723291559206;10358.378497290187;10454.425006624633;10461.110805581535;10470.895291047069;10498.212634052401;4148.43996060534;4165.604267594574;4220.683448741357;4246.8725938221905;4250.681198910094;8668.349873759367;8685.39202255836;8686.52224127679;8688.78278043054;8704.434211776213;4667.276572131325;4675.345451636774;4684.484706682262;4697.530246975275;4701.412323459567;4249.277622804131;4300.61294483498;4301.032267739796;4306.2894622387585;4312.245357062501;3451.5685539307588;3457.083872773717;3463.151527875636;3469.4969229461585;3505.1762835733584;1013.4628646817199;1020.0819262663514;1024.5491983527224;1024.784795193003;1039.8492218628257;1126.1103728054745;1131.1516362727955;1174.0783484964263;1181.9763604727857;1199.8140288255333;7256;7295.270472952769;7335.77992660221;7340.302671246223;7365.594892280976;1090.9618163364403;1136.4204255829586;1172.472387425662;1178.5327267551952;1178.5757127434117;5978.342382337939;5995.760169593167;6035.577509574287;6045.72794224261;6060.696965151725;8759.036505984337;9250.167484926254;9344.159025687584;9403.153716165441;9432.575534100983;9245.399049061789;9249;9258.907410925805;9284.628614855465;9311.301652376098;6968.442524598121;7082.752103676346;7113.110861142461;7159.427245820426;7343;7342.412606991535;7442.404607631268;7480.4015678746655;7506.624668766649;7517.097948246245;8070.919290807252;8323.084460709439;8327.875081873655;8333.583320833814;8367.12145224767;8271.46235494715;8381.03618083928;8402.663893444194;8418.074011858813;8425.4944703318;7022.087128673445;7069.505134640732;7083;7097.858042839011;7100.7869763907165;7523.435742319458;7532.472726909064;7565.319121279112;7619.1999840016;7640.617969101634;6844.2129155147795;7040.0847889774;7062.964685176541;7199.640017998974;7213.963930180315;6627.403533681992;6736.259011508828;6877.518573699793;7027.9297207027275;7226;7176.067111275501;7197.388222000979;7221.988921551092;7233.276672332725;7243.674034668558;6508.707108180049;6735.057092007025;6738.966305168639;6746.9662651688395;6749.392554670103;6742.359475849787;6843.62360070181;6855.177378714586;6859.211190713132;6866.519343645897 09:23:39 INFO - 2016-01-23 09:23:39,768 DEBUG : BROWSER_OUTPUT: |4;prototype.html;363.6182008890665;364.1515269422246;367.98528058877645;369.2762186115214;370.2631762792043;6284.183056202693;6289;6353.2376114866165;6353.301136874946;6355.777547785829;6116.266048074237;6235.7505699771955;6236.937630623693;6265.279492858312;6274.749010039593;4868.659193856432;4869.537393947569;4871.951280487186;4875.609951203895;4883;4834.782434790425;4841.806327746904;4846.4911184325665;4865.24588688752;4882.2432522958825;4713.9057218855605;4788.329633851264;4807.855764327076;4818.397700287464;4821.590164835976;4803.375561177059;4818.204996175627;4830.492798256168;4843.39457567804;4844.20070688336;4106.568810274938;4196.349565817303;4268;4278.850240241577;4281.186574550857;5930.318013428468;5942.702864856783;5962.224910761616;5974;5999.310079340888;5631.2397826293745;5638.323401191842;5639.548836093103;5639.577031722596;5644.802431914904;6555.278919318871;6669.233038200572;6689.397954184147;6699.196096468406;6715.832104197385;4683.812647494096;4686.992296656235;4687.484376718558;4691.953080469186;4695.765211739399;6903.723851045952;6967.79096627102;6974.337437943438;6974.721011159548;6983.755568555127;4782.689125206851;4785.994941062347;4792.137415265286;4796.832110876103;4812.927806082912;4765.785539650724;4855.708657480563;4863.586595139382;4870.586000190024;4875.34182885313;5608.242887210256;5612.691301978431;5612.887742245132;5627.549796016309;5645.379008309083;6693.062971184038;6719.260881303053;6742.5280230383405;6743.629100399427;6749.730010799612;1695.8643308535288;1706.4283465039102;1713.7258038713746;1716.519374575121;1718.8453039226529;1125.5104029747085;1151.654503648902;1167.4046236419317;1181.3443538835857;1183.6330737471412;6454.548181627335;6522.673866306665;6525.445337146396;6529.183852018497;6535.3464653534265;6881.311868813079;6908.723651054002;6921.653917304115;6933.653317334214;6948.33990770876;6302.401271879165;6396.2964073951825;6412.967935160387;6426.389492998158;6507.7071531781185;3731.869384571527;3732.626737326246;3770.981145094312;3788.962110378916;3794.6964242860504;7041.084658994298;7119.21688614252;7224.5665260083515;7229.710811567584;7236.384907282834;7206.7117315306805;7222.386097181693;7230.276972302833;7231.7107315707835;7242.927570724225;7083.220845707071;7167.677454514559;7206.783796486114;7208.495405321577;7214.639268036683;6976.127984002;6997.860042799014;7047;7054.929450705633;7056.188538317954;6872.037914692047;6877.209120951155;6889.44987377836;6891.173059232724;6928.099347084847;7068.681909314196;7161.033260509765;7204.31559001915;7205.675744591611;7217.206107328085;4748.430188377417;4782.163121453801;4790.281457781361;4791.065742180381;4795.592374648194;7015.772239858106;7018.157821061505;7060.82347941285;7064.32888875556;7086.4685148613025;6666.766663166766;6776.627285499345;6797.25230224665;6810.523263371517;6813.2846051163915;6775.62734049632;6797.694103765243;6807.421369183675;6813.863722725617;6826.044353790573;6650.800475985535;6660.966695166493;6684.899726504009;6693.828579998578;6703.396694297537;6681.966590167018;6834.9316506836285;6843.692033858389;6865.5537390069485;6879.6216208107035;6653;6655.101561289164;6668.0331351954665;6695.631740254333;6714.865702686016 09:23:39 INFO - 2016-01-23 09:23:39,769 DEBUG : BROWSER_OUTPUT: |5;yui.html;837.330135891287;854.2013217641505;871.250724377036;904.5838914099514;924.6486335192626;13275;13453.461861525528;13459;13508.257045862474;13513.256770877599;14072.507462238824;14143.080699754535;14145.504907328246;14161.645958851033;14170.149791012547;913.4427998920653;917.0691747875911;939.0327962198946;944.1031020530489;944.4191822029437;907.5008745190152;915.199200699388;916.2852974679727;920.0293690156882;921.755734730297;965.1940629574314;965.2519297544424;965.75856035991;966.1111777165025;968.5786682792973;949.3686698345592;949.5299826585849;951.4434056077204;951.8857737071596;954.6420092465326;703.6692754405422;703.992960070403;706.3854446631464;715.3061530315586;722.342668171961;14683.63290917725;14850.628734281729;14873;14878.330475128538;14907.329170187368;12548.874511254862;12694.492220311176;12839.358032098358;13002.349882505838;13383.464661413533;11098.500567474483;11510.539578416854;11640.476178571984;12006.519739210422;12221.816672749916;3884.6892248620325;3884.8251828667494;3896.7856767877756;3902.2975864344407;3905.6094390561;47926.760366198294;47929.520704792856;48354.75822620864;48449.69132889983;48936.75531622319;9952.353097048668;10059.899401005896;10166.796664066676;10195.541200645988;10309.587616495257;18286.542836429195;18335.358262461017;19672.114754836068;19938.90030549838;20041.498962525762;7693.422993275527;7711.113221979432;7756.340711039512;7814.68741250355;7908.288254057163;4396.60430561251;4541.909161816811;4605;4662.393888794435;4719.8377087351555;3226.72572831312;3246.6753324667343;3250.203700093445;3252.4308246056844;3269.4441944869427;569.7493103034651;572.7937942340754;574.0270241939955;577.6967092276589;579.154434525589;757.4054367321626;774.7017398301695;778.7118766056482;779.0923574036298;797.0233820126119;8974.820503590023;9155.587998540082;9289.256859451227;9578.13796758295;9700.12698857092;539.9730013499309;633.1231244725996;660.6663634864362;694.9200841903145;695.5759179260274;4350.978245108818;4354.716943398732;4483.21543729846;4492.989077457546;4506.414166158378;57248.141277880866;57745;57751.711241443525;58035.41964580385;61581.07628385578;50321.24518132231;50635;51093;51259.487405126216;51542.48457515452;46961.76519117383;47909.28136077892;48173.518264817605;48216.27675584799;48929.26606100911;9483.336166468282;9540.205794584657;9541.618335266789;9715.417074975525;9839;35097.82451087728;36029.63970360263;36319.092022699646;37073.6292637081;37171.814140930204;46788.29817552808;47255.29117063178;47513.52486475229;47672.2849157256;47725.76137119292;11692.47383867745;11912.761744764883;12076.818847717115;12103.939480302543;12358;13045.673858153623;13544.86455135436;13579;14124.646883827987;14347.56957291241;11662.300261984308;11918.284902905507;11952;12034.097442691658;12061.336626485627;10919.727006824574;11114.22200445961;11288.20982531215;11362.602308919148;11725.530978760755;11728.354940478355;12467.251964882136;12484.687882803002;12614.936925315682;12858;10816.891831081588;10824.945875270574;11168.497417616065;11199.10407167441;11346.602868899548;10609.098226650822;10675;10698.518566664363;10741.301815381976;10801.135909127408 09:23:39 INFO - 2016-01-23 09:23:39,770 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:23:39 INFO - 2016-01-23 09:23:39,770 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:23:39 INFO - 2016-01-23 09:23:39,770 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,305 09:23:39 INFO - 2016-01-23 09:23:39,770 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:23:39 INFO - 2016-01-23 09:23:39,770 DEBUG : BROWSER_OUTPUT: __startTimestamp1453569819761__endTimestamp 09:23:39 INFO - 2016-01-23 09:23:39,770 DEBUG : BROWSER_OUTPUT: 09:23:39 INFO - 2016-01-23 09:23:39,770 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:23:39 INFO - 2016-01-23 09:23:39,770 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:23:39 INFO - 2016-01-23 09:23:39,770 DEBUG : BROWSER_OUTPUT: 09:23:39 INFO - 2016-01-23 09:23:39,770 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5411.23 Median:5611.80 stddev:579.31 (10.3%) stddev-sans-first:556.91 09:23:39 INFO - 2016-01-23 09:23:39,770 DEBUG : BROWSER_OUTPUT: Values: 3300.1 3344.8 3351.6 3374.1 3382.7 5289.8 5322.5 5327.6 5330.5 5354.8 5390.0 5436.4 5443.7 5445.8 5447.1 4950.4 4972.8 5032.4 5048.7 5049.8 4788.3 4927.6 4937.4 4945.1 5075.9 4946.1 5024.1 5028.1 5030.9 5046.1 4917.1 4956.8 4978.3 4991.9 5080.6 4740.8 4810.1 4816.9 4844.6 4912.5 5106.9 5180.8 5222.2 5264.2 5276.8 5815.3 5821.7 5857.0 5894.1 5900.2 5619.2 5651.2 5683.4 5841.0 5922.2 5450.3 5515.1 5517.0 5517.3 5533.7 5926.2 5966.6 5968.2 5973.7 5974.1 5690.4 5697.2 5709.4 5775.5 5829.0 5855.2 5856.3 5872.1 5874.6 5893.9 5640.0 5804.9 5819.7 5826.1 5829.7 5648.4 5740.9 5742.7 5822.7 5854.0 4472.8 4535.0 4555.9 4568.5 4594.0 3934.8 4037.5 4081.0 4103.7 4121.3 5408.7 5499.6 5504.9 5524.3 5568.6 5837.0 5854.6 5860.2 5862.6 5884.9 5364.3 5394.9 5402.9 5569.6 5601.9 5112.8 5113.6 5140.4 5140.6 5166.4 5867.6 5915.3 5927.6 5959.0 5996.4 5653.1 5771.9 5866.2 5893.3 5966.0 5991.0 5991.6 6000.8 6008.1 6012.8 5812.3 5821.3 5825.4 5834.7 5838.3 5680.7 5744.0 5755.7 5796.8 5842.2 5634.7 5761.6 5764.7 5780.1 5783.2 5695.7 5763.0 5764.7 5765.3 5768.5 5391.5 5504.7 5551.2 5564.0 5627.7 5678.2 5701.7 5728.8 5735.9 5782.1 5497.1 5605.9 5606.5 5611.8 5617.9 09:23:39 INFO - 2016-01-23 09:23:39,770 DEBUG : BROWSER_OUTPUT: 09:23:39 INFO - 2016-01-23 09:23:39,770 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:60092.26 Median:4047.82 stddev:125721.74 (3105.9%) stddev-sans-first:125995.00 09:23:39 INFO - 2016-01-23 09:23:39,772 DEBUG : BROWSER_OUTPUT: Values: 571.7 617.6 620.5 638.1 681.3 32490.2 40222.0 41040.4 41065.0 41281.0 44664.6 45283.0 45287.8 45373.5 45382.8 9083.6 9196.3 9200.7 9211.4 9216.7 9001.7 9140.6 9146.4 9154.8 9157.7 9092.8 9164.7 9187.2 9192.5 9200.4 9159.1 9180.8 9235.3 9237.7 9259.0 9076.0 9141.3 9161.4 9199.9 9200.3 42558.0 42597.4 43201.0 43207.8 43232.4 3640.8 3741.8 4022.8 4049.8 4185.8 32456.5 32655.0 32735.7 32809.2 32988.7 3867.7 3904.3 3922.4 3988.8 4045.8 280600.0 281319.0 281350.0 281494.0 469729.0 65821.3 65865.7 66196.0 66323.3 66710.7 70275.6 71088.6 71173.3 71259.3 71582.0 15663.7 15845.8 15880.3 15909.3 15931.0 12896.9 13290.7 13290.8 13294.9 13317.9 22515.4 22671.8 22788.7 22837.9 22970.8 8743.3 9014.9 9045.0 9046.7 9086.9 968.4 1022.0 1093.7 1104.0 1161.6 29566.9 29731.7 29986.3 30647.0 30652.7 1131.4 1146.4 1149.1 1198.0 1210.8 15715.0 15919.4 15997.8 16001.9 16002.0 326701.0 589088.0 765952.0 773082.0 775462.2 59070.4 59828.0 59970.0 60160.0 60295.4 1479.1 1482.6 1491.0 1515.6 1516.6 30582.4 31344.7 31397.4 31625.8 32093.4 49990.0 50395.5 50527.7 50570.2 50797.0 321304.0 321924.0 322960.0 323055.0 323940.0 34686.0 34839.5 34870.8 35090.6 35239.8 45700.8 45954.5 46387.0 46517.8 47091.0 39726.6 39737.2 40628.6 40917.8 41153.2 45276.8 46497.5 47325.3 47499.5 48014.8 37998.4 38467.2 38521.8 38591.6 38679.0 34274.0 34570.0 34723.3 34811.5 34993.7 28189.4 28799.4 30761.5 30891.0 31113.0 09:23:39 INFO - 2016-01-23 09:23:39,772 DEBUG : BROWSER_OUTPUT: 09:23:39 INFO - 2016-01-23 09:23:39,772 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32634.88 Median:19350.82 stddev:107212.94 (554.0%) stddev-sans-first:107486.34 09:23:39 INFO - 2016-01-23 09:23:39,772 DEBUG : BROWSER_OUTPUT: Values: 379.6 380.0 381.4 384.9 390.6 15978.5 17466.8 17918.0 19081.6 19158.7 17549.2 17799.1 18032.5 18177.3 18638.5 4890.1 5169.8 5177.0 5193.4 5196.2 5090.7 5275.5 5412.4 5414.2 5416.7 5387.2 5403.9 5432.3 6351.1 6369.5 6321.8 6327.7 6336.9 6368.1 6376.5 5401.2 5417.3 5425.3 5452.6 5620.7 15281.0 21517.9 21553.6 21801.5 21971.8 2248.6 2295.2 2321.4 2473.0 2483.0 9407.3 9593.6 9816.1 12725.9 14175.2 2008.0 2013.9 2022.7 2039.7 2083.1 65438.3 66006.7 66969.0 68108.0 69282.7 10795.4 10934.2 11097.4 11110.3 11135.7 14543.9 14600.5 14614.5 14663.9 14671.4 8485.6 8501.4 8513.1 8566.3 8620.1 8424.3 8504.8 8507.3 8545.4 8552.0 4636.1 4712.6 4754.7 4762.8 4837.1 1964.2 1979.8 1992.1 2018.2 2023.9 470.1 956.2 1022.7 1022.8 1128.1 10091.3 10144.8 10205.9 10268.8 10637.0 481.0 487.5 492.0 492.2 525.4 5712.2 5734.3 5796.6 5831.2 5836.4 635317.0 644061.0 650247.5 674650.0 676951.0 78488.0 79671.6 80104.0 87765.0 91009.1 1210.3 1215.7 1252.1 1260.5 1287.5 16402.3 16435.9 16596.3 16631.7 16785.8 37464.6 37875.2 38320.2 38449.6 38663.8 45247.0 47119.0 47864.5 48253.0 49020.8 9335.3 9665.7 9764.3 9808.9 9834.9 13717.1 17888.6 18148.6 18224.4 18573.9 14446.5 14586.8 15140.4 15394.8 15736.0 14790.4 14816.2 15145.5 15355.8 15370.7 15386.2 15416.6 15520.5 15612.8 15763.7 9617.5 9664.2 9740.5 9960.0 10333.1 10918.2 15136.9 15872.6 15893.7 16088.7 09:23:39 INFO - 2016-01-23 09:23:39,772 DEBUG : BROWSER_OUTPUT: 09:23:39 INFO - 2016-01-23 09:23:39,772 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5472.61 Median:6735.66 stddev:2800.84 (41.6%) stddev-sans-first:2792.97 09:23:39 INFO - 2016-01-23 09:23:39,772 DEBUG : BROWSER_OUTPUT: Values: 1523.7 1537.6 1700.8 1800.6 1836.3 7377.5 7717.9 7758.7 7786.6 7988.1 7876.8 7889.0 7907.3 7917.2 7966.7 2279.4 2303.8 2308.8 2323.6 2332.7 2278.4 2312.9 2316.5 2317.6 2318.1 2284.7 2303.9 2322.5 2330.6 2337.5 2231.7 2286.4 2302.7 2315.8 2316.7 2260.2 2284.6 2287.1 2290.6 2291.0 7647.2 7762.4 7817.0 7827.6 7851.0 4711.2 4786.8 4790.0 4812.4 4813.7 2964.6 3006.6 3057.3 3067.7 3067.8 972.1 978.1 1002.1 1002.9 1012.4 10358.4 10454.4 10461.1 10470.9 10498.2 4148.4 4165.6 4220.7 4246.9 4250.7 8668.3 8685.4 8686.5 8688.8 8704.4 4667.3 4675.3 4684.5 4697.5 4701.4 4249.3 4300.6 4301.0 4306.3 4312.2 3451.6 3457.1 3463.2 3469.5 3505.2 1013.5 1020.1 1024.5 1024.8 1039.8 1126.1 1131.2 1174.1 1182.0 1199.8 7256.0 7295.3 7335.8 7340.3 7365.6 1091.0 1136.4 1172.5 1178.5 1178.6 5978.3 5995.8 6035.6 6045.7 6060.7 8759.0 9250.2 9344.2 9403.2 9432.6 9245.4 9249.0 9258.9 9284.6 9311.3 6968.4 7082.8 7113.1 7159.4 7343.0 7342.4 7442.4 7480.4 7506.6 7517.1 8070.9 8323.1 8327.9 8333.6 8367.1 8271.5 8381.0 8402.7 8418.1 8425.5 7022.1 7069.5 7083.0 7097.9 7100.8 7523.4 7532.5 7565.3 7619.2 7640.6 6844.2 7040.1 7063.0 7199.6 7214.0 6627.4 6736.3 6877.5 7027.9 7226.0 7176.1 7197.4 7222.0 7233.3 7243.7 6508.7 6735.1 6739.0 6747.0 6749.4 6742.4 6843.6 6855.2 6859.2 6866.5 09:23:39 INFO - 2016-01-23 09:23:39,772 DEBUG : BROWSER_OUTPUT: 09:23:39 INFO - 2016-01-23 09:23:39,773 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5642.34 Median:6376.04 stddev:1700.81 (26.7%) stddev-sans-first:1658.79 09:23:39 INFO - 2016-01-23 09:23:39,774 DEBUG : BROWSER_OUTPUT: Values: 363.6 364.2 368.0 369.3 370.3 6284.2 6289.0 6353.2 6353.3 6355.8 6116.3 6235.8 6236.9 6265.3 6274.7 4868.7 4869.5 4872.0 4875.6 4883.0 4834.8 4841.8 4846.5 4865.2 4882.2 4713.9 4788.3 4807.9 4818.4 4821.6 4803.4 4818.2 4830.5 4843.4 4844.2 4106.6 4196.3 4268.0 4278.9 4281.2 5930.3 5942.7 5962.2 5974.0 5999.3 5631.2 5638.3 5639.5 5639.6 5644.8 6555.3 6669.2 6689.4 6699.2 6715.8 4683.8 4687.0 4687.5 4692.0 4695.8 6903.7 6967.8 6974.3 6974.7 6983.8 4782.7 4786.0 4792.1 4796.8 4812.9 4765.8 4855.7 4863.6 4870.6 4875.3 5608.2 5612.7 5612.9 5627.5 5645.4 6693.1 6719.3 6742.5 6743.6 6749.7 1695.9 1706.4 1713.7 1716.5 1718.8 1125.5 1151.7 1167.4 1181.3 1183.6 6454.5 6522.7 6525.4 6529.2 6535.3 6881.3 6908.7 6921.7 6933.7 6948.3 6302.4 6396.3 6413.0 6426.4 6507.7 3731.9 3732.6 3771.0 3789.0 3794.7 7041.1 7119.2 7224.6 7229.7 7236.4 7206.7 7222.4 7230.3 7231.7 7242.9 7083.2 7167.7 7206.8 7208.5 7214.6 6976.1 6997.9 7047.0 7054.9 7056.2 6872.0 6877.2 6889.4 6891.2 6928.1 7068.7 7161.0 7204.3 7205.7 7217.2 4748.4 4782.2 4790.3 4791.1 4795.6 7015.8 7018.2 7060.8 7064.3 7086.5 6666.8 6776.6 6797.3 6810.5 6813.3 6775.6 6797.7 6807.4 6813.9 6826.0 6650.8 6661.0 6684.9 6693.8 6703.4 6682.0 6834.9 6843.7 6865.6 6879.6 6653.0 6655.1 6668.0 6695.6 6714.9 09:23:39 INFO - 2016-01-23 09:23:39,774 DEBUG : BROWSER_OUTPUT: 09:23:39 INFO - 2016-01-23 09:23:39,774 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14426.64 Median:4573.45 stddev:16224.01 (354.7%) stddev-sans-first:16237.43 09:23:39 INFO - 2016-01-23 09:23:39,774 DEBUG : BROWSER_OUTPUT: Values: 837.3 854.2 871.3 904.6 924.6 13275.0 13453.5 13459.0 13508.3 13513.3 14072.5 14143.1 14145.5 14161.6 14170.1 913.4 917.1 939.0 944.1 944.4 907.5 915.2 916.3 920.0 921.8 965.2 965.3 965.8 966.1 968.6 949.4 949.5 951.4 951.9 954.6 703.7 704.0 706.4 715.3 722.3 14683.6 14850.6 14873.0 14878.3 14907.3 12548.9 12694.5 12839.4 13002.3 13383.5 11098.5 11510.5 11640.5 12006.5 12221.8 3884.7 3884.8 3896.8 3902.3 3905.6 47926.8 47929.5 48354.8 48449.7 48936.8 9952.4 10059.9 10166.8 10195.5 10309.6 18286.5 18335.4 19672.1 19938.9 20041.5 7693.4 7711.1 7756.3 7814.7 7908.3 4396.6 4541.9 4605.0 4662.4 4719.8 3226.7 3246.7 3250.2 3252.4 3269.4 569.7 572.8 574.0 577.7 579.2 757.4 774.7 778.7 779.1 797.0 8974.8 9155.6 9289.3 9578.1 9700.1 540.0 633.1 660.7 694.9 695.6 4351.0 4354.7 4483.2 4493.0 4506.4 57248.1 57745.0 57751.7 58035.4 61581.1 50321.2 50635.0 51093.0 51259.5 51542.5 46961.8 47909.3 48173.5 48216.3 48929.3 9483.3 9540.2 9541.6 9715.4 9839.0 35097.8 36029.6 36319.1 37073.6 37171.8 46788.3 47255.3 47513.5 47672.3 47725.8 11692.5 11912.8 12076.8 12103.9 12358.0 13045.7 13544.9 13579.0 14124.6 14347.6 11662.3 11918.3 11952.0 12034.1 12061.3 10919.7 11114.2 11288.2 11362.6 11725.5 11728.4 12467.3 12484.7 12614.9 12858.0 10816.9 10824.9 11168.5 11199.1 11346.6 10609.1 10675.0 10698.5 10741.3 10801.1 09:23:39 INFO - 2016-01-23 09:23:39,774 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:23:39 INFO - 2016-01-23 09:23:39,774 DEBUG : BROWSER_OUTPUT: 09:23:40 INFO - 2016-01-23 09:23:40,445 INFO : Browser exited with error code: 0 09:23:40 INFO - 2016-01-23 09:23:40,467 INFO : Completed test dromaeo_css (00:18:28) 09:23:40 INFO - 2016-01-23 09:23:40,467 INFO : Starting test kraken 09:23:40 INFO - 2016-01-23 09:23:40,467 DEBUG : operating with platform_type : linux_ 09:23:40 INFO - 2016-01-23 09:23:40,467 INFO : Initialising browser for kraken test... 09:23:40 INFO - 2016-01-23 09:23:40,473 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKVXigX/profile http://localhost:54883/getInfo.html 09:23:44 INFO - 2016-01-23 09:23:44,071 DEBUG : BROWSER_OUTPUT: 09:23:44 INFO - 2016-01-23 09:23:44,071 DEBUG : BROWSER_OUTPUT: (process:28000): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:23:44 INFO - 2016-01-23 09:23:44,894 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:23:44 INFO - 2016-01-23 09:23:44,894 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:23:44 INFO - 2016-01-23 09:23:44,894 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:23:44 INFO - 2016-01-23 09:23:44,894 DEBUG : BROWSER_OUTPUT: __metrics 09:23:45 INFO - 2016-01-23 09:23:45,841 INFO : Browser initialized. 09:23:45 INFO - 2016-01-23 09:23:45,842 INFO : Running cycle 1/1 for kraken test... 09:23:45 INFO - 2016-01-23 09:23:45,842 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKVXigX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:23:47 INFO - 2016-01-23 09:23:47,113 DEBUG : BROWSER_OUTPUT: 09:23:47 INFO - 2016-01-23 09:23:47,113 DEBUG : BROWSER_OUTPUT: (process:28116): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:23:57 INFO - 2016-01-23 09:23:57,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 135983104 09:23:57 INFO - 2016-01-23 09:23:57,620 DEBUG : BROWSER_OUTPUT: 09:24:00 INFO - 2016-01-23 09:24:00,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54883/tests/kraken/driver.html?testName=audio-beat-detection) 09:24:00 INFO - 2016-01-23 09:24:00,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 138719232 09:24:00 INFO - 2016-01-23 09:24:00,690 DEBUG : BROWSER_OUTPUT: 09:24:03 INFO - 2016-01-23 09:24:03,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54883/tests/kraken/driver.html?testName=audio-dft) 09:24:03 INFO - 2016-01-23 09:24:03,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 139440128 09:24:03 INFO - 2016-01-23 09:24:03,901 DEBUG : BROWSER_OUTPUT: 09:24:06 INFO - 2016-01-23 09:24:06,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54883/tests/kraken/driver.html?testName=audio-fft) 09:24:07 INFO - 2016-01-23 09:24:07,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 138616832 09:24:07 INFO - 2016-01-23 09:24:07,328 DEBUG : BROWSER_OUTPUT: 09:24:09 INFO - 2016-01-23 09:24:09,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54883/tests/kraken/driver.html?testName=audio-oscillator) 09:24:09 INFO - 2016-01-23 09:24:09,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 139141120 09:24:09 INFO - 2016-01-23 09:24:09,884 DEBUG : BROWSER_OUTPUT: 09:24:12 INFO - 2016-01-23 09:24:12,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54883/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:24:12 INFO - 2016-01-23 09:24:12,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 139804672 09:24:12 INFO - 2016-01-23 09:24:12,682 DEBUG : BROWSER_OUTPUT: 09:24:15 INFO - 2016-01-23 09:24:15,644 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54883/tests/kraken/driver.html?testName=imaging-darkroom) 09:24:16 INFO - 2016-01-23 09:24:16,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 138940416 09:24:16 INFO - 2016-01-23 09:24:16,231 DEBUG : BROWSER_OUTPUT: 09:24:19 INFO - 2016-01-23 09:24:19,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54883/tests/kraken/driver.html?testName=imaging-desaturate) 09:24:20 INFO - 2016-01-23 09:24:20,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 138612736 09:24:20 INFO - 2016-01-23 09:24:20,199 DEBUG : BROWSER_OUTPUT: 09:24:22 INFO - 2016-01-23 09:24:22,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54883/tests/kraken/driver.html?testName=json-parse-financial) 09:24:23 INFO - 2016-01-23 09:24:23,560 DEBUG : BROWSER_OUTPUT: RSS: Main: 138412032 09:24:23 INFO - 2016-01-23 09:24:23,560 DEBUG : BROWSER_OUTPUT: 09:24:25 INFO - 2016-01-23 09:24:25,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54883/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:24:25 INFO - 2016-01-23 09:24:25,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 138584064 09:24:25 INFO - 2016-01-23 09:24:25,699 DEBUG : BROWSER_OUTPUT: 09:24:27 INFO - 2016-01-23 09:24:27,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54883/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:24:28 INFO - 2016-01-23 09:24:28,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 138539008 09:24:28 INFO - 2016-01-23 09:24:28,079 DEBUG : BROWSER_OUTPUT: 09:24:30 INFO - 2016-01-23 09:24:30,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54883/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:24:30 INFO - 2016-01-23 09:24:30,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 139608064 09:24:30 INFO - 2016-01-23 09:24:30,706 DEBUG : BROWSER_OUTPUT: 09:24:33 INFO - 2016-01-23 09:24:33,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54883/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:24:33 INFO - 2016-01-23 09:24:33,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 138371072 09:24:33 INFO - 2016-01-23 09:24:33,711 DEBUG : BROWSER_OUTPUT: 09:24:36 INFO - 2016-01-23 09:24:36,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54883/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:24:36 INFO - 2016-01-23 09:24:36,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 138887168 09:24:36 INFO - 2016-01-23 09:24:36,798 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54883/tests/kraken/driver.html?testName=ai-astar) 09:24:38 INFO - 2016-01-23 09:24:38,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 140472320 09:24:38 INFO - 2016-01-23 09:24:38,724 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,724 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:24:38 INFO - 2016-01-23 09:24:38,724 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:24:38 INFO - 2016-01-23 09:24:38,725 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:24:38 INFO - 2016-01-23 09:24:38,725 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:24:38 INFO - 2016-01-23 09:24:38,725 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;105;112;110;112;120;110;111;112;111 09:24:38 INFO - 2016-01-23 09:24:38,725 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;164;120;154;155;124;154;147;123;162;128 09:24:38 INFO - 2016-01-23 09:24:38,725 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;160;162;164;162;164;163;165;162 09:24:38 INFO - 2016-01-23 09:24:38,725 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;71;72;154;73;71;70;72;155;71 09:24:38 INFO - 2016-01-23 09:24:38,726 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;93;141;91;94;92;142;94;96;141 09:24:38 INFO - 2016-01-23 09:24:38,726 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;114;111;110;110;111;110;110;109;110;109 09:24:38 INFO - 2016-01-23 09:24:38,726 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;146;146;146;146;147;146;147;146 09:24:38 INFO - 2016-01-23 09:24:38,726 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;101;96;96;96;97;96;98;101;95;96 09:24:38 INFO - 2016-01-23 09:24:38,726 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;60;60;59;58;60;61;59;57 09:24:38 INFO - 2016-01-23 09:24:38,726 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;69;65;68;65;65;65;65;66 09:24:38 INFO - 2016-01-23 09:24:38,726 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;83;82;83;84;82;80;83;88 09:24:38 INFO - 2016-01-23 09:24:38,727 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;120;120;120;126;113;119;113;119;117 09:24:38 INFO - 2016-01-23 09:24:38,727 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;137;144;147;146;148;135;146;142;134 09:24:38 INFO - 2016-01-23 09:24:38,727 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;65;65;64;64;66;66;66;67;64 09:24:38 INFO - 2016-01-23 09:24:38,727 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:24:38 INFO - 2016-01-23 09:24:38,727 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:24:38 INFO - 2016-01-23 09:24:38,727 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,688 09:24:38 INFO - 2016-01-23 09:24:38,727 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:24:38 INFO - 2016-01-23 09:24:38,728 DEBUG : BROWSER_OUTPUT: __startTimestamp1453569878722__endTimestamp 09:24:38 INFO - 2016-01-23 09:24:38,728 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,731 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:24:38 INFO - 2016-01-23 09:24:38,731 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:24:38 INFO - 2016-01-23 09:24:38,731 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,732 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:3.66 (3.3%) stddev-sans-first:3.88 09:24:38 INFO - 2016-01-23 09:24:38,732 DEBUG : BROWSER_OUTPUT: Values: 112.0 105.0 112.0 110.0 112.0 120.0 110.0 111.0 112.0 111.0 09:24:38 INFO - 2016-01-23 09:24:38,732 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,732 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.10 Median:154.00 stddev:17.38 (11.3%) stddev-sans-first:16.71 09:24:38 INFO - 2016-01-23 09:24:38,733 DEBUG : BROWSER_OUTPUT: Values: 164.0 120.0 154.0 155.0 124.0 154.0 147.0 123.0 162.0 128.0 09:24:38 INFO - 2016-01-23 09:24:38,734 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,734 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:1.43 (0.9%) stddev-sans-first:1.50 09:24:38 INFO - 2016-01-23 09:24:38,734 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 160.0 162.0 164.0 162.0 164.0 163.0 165.0 162.0 09:24:38 INFO - 2016-01-23 09:24:38,734 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,734 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.70 Median:71.50 stddev:34.75 (48.6%) stddev-sans-first:36.64 09:24:38 INFO - 2016-01-23 09:24:38,734 DEBUG : BROWSER_OUTPUT: Values: 78.0 71.0 72.0 154.0 73.0 71.0 70.0 72.0 155.0 71.0 09:24:38 INFO - 2016-01-23 09:24:38,734 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,734 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.50 Median:92.50 stddev:23.40 (25.3%) stddev-sans-first:24.04 09:24:38 INFO - 2016-01-23 09:24:38,734 DEBUG : BROWSER_OUTPUT: Values: 91.0 93.0 141.0 91.0 94.0 92.0 142.0 94.0 96.0 141.0 09:24:38 INFO - 2016-01-23 09:24:38,734 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,734 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.00 stddev:1.43 (1.3%) stddev-sans-first:0.71 09:24:38 INFO - 2016-01-23 09:24:38,734 DEBUG : BROWSER_OUTPUT: Values: 114.0 111.0 110.0 110.0 111.0 110.0 110.0 109.0 110.0 109.0 09:24:38 INFO - 2016-01-23 09:24:38,734 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,734 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 09:24:38 INFO - 2016-01-23 09:24:38,735 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 09:24:38 INFO - 2016-01-23 09:24:38,735 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,735 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.20 Median:96.00 stddev:2.15 (2.2%) stddev-sans-first:1.79 09:24:38 INFO - 2016-01-23 09:24:38,735 DEBUG : BROWSER_OUTPUT: Values: 101.0 96.0 96.0 96.0 97.0 96.0 98.0 101.0 95.0 96.0 09:24:38 INFO - 2016-01-23 09:24:38,735 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,735 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.20 Median:59.50 stddev:1.14 (1.9%) stddev-sans-first:1.20 09:24:38 INFO - 2016-01-23 09:24:38,735 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 60.0 60.0 59.0 58.0 60.0 61.0 59.0 57.0 09:24:38 INFO - 2016-01-23 09:24:38,735 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,735 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:65.00 stddev:1.57 (2.4%) stddev-sans-first:1.54 09:24:38 INFO - 2016-01-23 09:24:38,735 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 69.0 65.0 68.0 65.0 65.0 65.0 65.0 66.0 09:24:38 INFO - 2016-01-23 09:24:38,735 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,735 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:2.15 (2.6%) stddev-sans-first:2.18 09:24:38 INFO - 2016-01-23 09:24:38,735 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 83.0 82.0 83.0 84.0 82.0 80.0 83.0 88.0 09:24:38 INFO - 2016-01-23 09:24:38,735 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,735 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:120.00 stddev:3.77 (3.1%) stddev-sans-first:3.97 09:24:38 INFO - 2016-01-23 09:24:38,735 DEBUG : BROWSER_OUTPUT: Values: 120.0 120.0 120.0 120.0 126.0 113.0 119.0 113.0 119.0 117.0 09:24:38 INFO - 2016-01-23 09:24:38,736 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,736 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:145.00 stddev:5.14 (3.5%) stddev-sans-first:5.42 09:24:38 INFO - 2016-01-23 09:24:38,736 DEBUG : BROWSER_OUTPUT: Values: 144.0 137.0 144.0 147.0 146.0 148.0 135.0 146.0 142.0 134.0 09:24:38 INFO - 2016-01-23 09:24:38,736 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-01-23 09:24:38,736 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:1.03 (1.6%) stddev-sans-first:1.09 09:24:38 INFO - 2016-01-23 09:24:38,736 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 65.0 64.0 64.0 66.0 66.0 66.0 67.0 64.0 09:24:38 INFO - 2016-01-23 09:24:38,736 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:24:38 INFO - 2016-01-23 09:24:38,736 DEBUG : BROWSER_OUTPUT: 09:24:39 INFO - 2016-01-23 09:24:39,617 INFO : Browser exited with error code: 0 09:24:39 INFO - 2016-01-23 09:24:39,671 INFO : Completed test kraken (00:00:59) 09:24:39 INFO - 2016-01-23 09:24:39,671 INFO : Starting test v8_7 09:24:39 INFO - 2016-01-23 09:24:39,671 DEBUG : operating with platform_type : linux_ 09:24:39 INFO - 2016-01-23 09:24:39,672 INFO : Initialising browser for v8_7 test... 09:24:39 INFO - 2016-01-23 09:24:39,678 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJeC_79/profile http://localhost:54883/getInfo.html 09:24:43 INFO - 2016-01-23 09:24:43,372 DEBUG : BROWSER_OUTPUT: 09:24:43 INFO - 2016-01-23 09:24:43,372 DEBUG : BROWSER_OUTPUT: (process:28426): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:24:44 INFO - 2016-01-23 09:24:44,220 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:24:44 INFO - 2016-01-23 09:24:44,220 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:24:44 INFO - 2016-01-23 09:24:44,220 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:24:44 INFO - 2016-01-23 09:24:44,220 DEBUG : BROWSER_OUTPUT: __metrics 09:24:45 INFO - 2016-01-23 09:24:45,185 INFO : Browser initialized. 09:24:45 INFO - 2016-01-23 09:24:45,186 INFO : Running cycle 1/1 for v8_7 test... 09:24:45 INFO - 2016-01-23 09:24:45,186 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJeC_79/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:24:46 INFO - 2016-01-23 09:24:46,520 DEBUG : BROWSER_OUTPUT: 09:24:46 INFO - 2016-01-23 09:24:46,520 DEBUG : BROWSER_OUTPUT: (process:28541): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:24:57 INFO - 2016-01-23 09:24:57,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 138104832 09:24:57 INFO - 2016-01-23 09:24:57,022 DEBUG : BROWSER_OUTPUT: 09:25:18 INFO - 2016-01-23 09:25:18,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54883/tests/v8_7/run.html (next: http://localhost:54883/tests/v8_7/run.html) 09:25:18 INFO - 2016-01-23 09:25:18,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 136491008 09:25:18 INFO - 2016-01-23 09:25:18,632 DEBUG : BROWSER_OUTPUT: 09:25:18 INFO - 2016-01-23 09:25:18,632 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:25:18 INFO - 2016-01-23 09:25:18,633 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:25:18 INFO - 2016-01-23 09:25:18,633 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:25:18 INFO - 2016-01-23 09:25:18,633 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:25:18 INFO - 2016-01-23 09:25:18,633 DEBUG : BROWSER_OUTPUT: |0;Richards;165.78249336870027 09:25:18 INFO - 2016-01-23 09:25:18,633 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.55562958027983 09:25:18 INFO - 2016-01-23 09:25:18,633 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.2466836014677 09:25:18 INFO - 2016-01-23 09:25:18,633 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5218.75 09:25:18 INFO - 2016-01-23 09:25:18,633 DEBUG : BROWSER_OUTPUT: |4;RayTrace;890.4719501335708 09:25:18 INFO - 2016-01-23 09:25:18,633 DEBUG : BROWSER_OUTPUT: |5;Earley;550.357732526142 09:25:18 INFO - 2016-01-23 09:25:18,634 DEBUG : BROWSER_OUTPUT: |6;Boyer;11397.727272727272 09:25:18 INFO - 2016-01-23 09:25:18,634 DEBUG : BROWSER_OUTPUT: |7;RegExp;24190.47619047619 09:25:18 INFO - 2016-01-23 09:25:18,634 DEBUG : BROWSER_OUTPUT: |8;Splay;517.3305742369374 09:25:18 INFO - 2016-01-23 09:25:18,634 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 09:25:18 INFO - 2016-01-23 09:25:18,634 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:25:18 INFO - 2016-01-23 09:25:18,634 DEBUG : BROWSER_OUTPUT: __startTimestamp1453569918625__endTimestamp 09:25:18 INFO - 2016-01-23 09:25:18,634 DEBUG : BROWSER_OUTPUT: 09:25:18 INFO - 2016-01-23 09:25:18,634 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:25:18 INFO - 2016-01-23 09:25:18,635 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:25:18 INFO - 2016-01-23 09:25:18,635 DEBUG : BROWSER_OUTPUT: 09:25:18 INFO - 2016-01-23 09:25:18,635 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.78 Median:165.78 stddev:0.00 (0.0%) 09:25:18 INFO - 2016-01-23 09:25:18,635 DEBUG : BROWSER_OUTPUT: Values: 165.8 09:25:18 INFO - 2016-01-23 09:25:18,635 DEBUG : BROWSER_OUTPUT: 09:25:18 INFO - 2016-01-23 09:25:18,635 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.56 Median:166.56 stddev:0.00 (0.0%) 09:25:18 INFO - 2016-01-23 09:25:18,635 DEBUG : BROWSER_OUTPUT: Values: 166.6 09:25:18 INFO - 2016-01-23 09:25:18,636 DEBUG : BROWSER_OUTPUT: 09:25:18 INFO - 2016-01-23 09:25:18,636 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.25 Median:282.25 stddev:0.00 (0.0%) 09:25:18 INFO - 2016-01-23 09:25:18,636 DEBUG : BROWSER_OUTPUT: Values: 282.2 09:25:18 INFO - 2016-01-23 09:25:18,636 DEBUG : BROWSER_OUTPUT: 09:25:18 INFO - 2016-01-23 09:25:18,636 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 09:25:18 INFO - 2016-01-23 09:25:18,636 DEBUG : BROWSER_OUTPUT: Values: 5218.8 09:25:18 INFO - 2016-01-23 09:25:18,636 DEBUG : BROWSER_OUTPUT: 09:25:18 INFO - 2016-01-23 09:25:18,636 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:890.47 Median:890.47 stddev:0.00 (0.0%) 09:25:18 INFO - 2016-01-23 09:25:18,637 DEBUG : BROWSER_OUTPUT: Values: 890.5 09:25:18 INFO - 2016-01-23 09:25:18,637 DEBUG : BROWSER_OUTPUT: 09:25:18 INFO - 2016-01-23 09:25:18,637 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:550.36 Median:550.36 stddev:0.00 (0.0%) 09:25:18 INFO - 2016-01-23 09:25:18,637 DEBUG : BROWSER_OUTPUT: Values: 550.4 09:25:18 INFO - 2016-01-23 09:25:18,637 DEBUG : BROWSER_OUTPUT: 09:25:18 INFO - 2016-01-23 09:25:18,637 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11397.73 Median:11397.73 stddev:0.00 (0.0%) 09:25:18 INFO - 2016-01-23 09:25:18,637 DEBUG : BROWSER_OUTPUT: Values: 11397.7 09:25:18 INFO - 2016-01-23 09:25:18,637 DEBUG : BROWSER_OUTPUT: 09:25:18 INFO - 2016-01-23 09:25:18,637 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24190.48 Median:24190.48 stddev:0.00 (0.0%) 09:25:18 INFO - 2016-01-23 09:25:18,637 DEBUG : BROWSER_OUTPUT: Values: 24190.5 09:25:18 INFO - 2016-01-23 09:25:18,637 DEBUG : BROWSER_OUTPUT: 09:25:18 INFO - 2016-01-23 09:25:18,637 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:517.33 Median:517.33 stddev:0.00 (0.0%) 09:25:18 INFO - 2016-01-23 09:25:18,638 DEBUG : BROWSER_OUTPUT: Values: 517.3 09:25:18 INFO - 2016-01-23 09:25:18,638 DEBUG : BROWSER_OUTPUT: 09:25:18 INFO - 2016-01-23 09:25:18,638 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 09:25:18 INFO - 2016-01-23 09:25:18,638 DEBUG : BROWSER_OUTPUT: Values: 4840.6 09:25:18 INFO - 2016-01-23 09:25:18,638 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:25:18 INFO - 2016-01-23 09:25:18,638 DEBUG : BROWSER_OUTPUT: 09:25:19 INFO - 2016-01-23 09:25:19,489 INFO : Browser exited with error code: 0 09:25:19 INFO - 2016-01-23 09:25:19,504 INFO : Completed test v8_7 (00:00:39) 09:25:19 INFO - 2016-01-23 09:25:19,689 INFO : Completed test suite (00:20:07) 09:25:19 INFO - 2016-01-23 09:25:19,689 DEBUG : Working with test: dromaeo_css 09:25:19 INFO - 2016-01-23 09:25:19,689 DEBUG : Generating results file: dromaeo_css 09:25:19 INFO - 2016-01-23 09:25:19,690 DEBUG : Working with test: kraken 09:25:19 INFO - 2016-01-23 09:25:19,690 DEBUG : Generating results file: kraken 09:25:19 INFO - 2016-01-23 09:25:19,691 INFO : javascript benchmark 09:25:19 INFO - 2016-01-23 09:25:19,691 DEBUG : Working with test: v8_7 09:25:19 INFO - 2016-01-23 09:25:19,691 DEBUG : Generating results file: v8_7 09:25:19 INFO - 2016-01-23 09:25:19,691 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:25:19 INFO - 2016-01-23 09:25:19,831 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 09:25:19 INFO - 2016-01-23 09:25:19,831 DEBUG : process_Request line: dromaeo_css 7336.86 graph.html#tests=[[72,52,43]] 09:25:19 INFO - 2016-01-23 09:25:19,831 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:25:19 INFO - 2016-01-23 09:25:19,868 DEBUG : process_Request line: kraken 1501.40 graph.html#tests=[[232,52,43]] 09:25:19 INFO - 2016-01-23 09:25:19,868 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:25:19 INFO - 2016-01-23 09:25:19,901 DEBUG : process_Request line: v8_7 23204.66 graph.html#tests=[[230,52,43]] 09:25:19 INFO - 2016-01-23 09:25:19,903 INFO : javascript benchmark 09:25:19 INFO - 2016-01-23 09:25:19,905 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3300.0759787259567, 3344.816035118069, 3351.597808263009, 3374.1395944034266, 3382.7124694400973, 5289.788408463657, 5322.467753224676, 5327.627066105374, 5330.493603107703, 5354.812581559646, 5390.0, 5436.429174936634, 5443.727813609324, 5445.754941027653, 5447.12845944649, 4950.381202349698, 4972.776225069862, 5032.421271553763, 5048.747562621854, 5049.823256186034, 4788.281757736333, 4927.605791536668, 4937.358143441347, 4945.1098802215765, 5075.873103172414, 4946.134426475371, 5024.145895197825, 5028.069807085701, 5030.874228144307, 5046.09170349337, 4917.114919314522, 4956.826511072131, 4978.303037574724, 4991.850244492671, 5080.618953578478, 4740.810367585293, 4810.134175848346, 4816.927746083777, 4844.63665225106, 4912.533309335608, 5106.948930510722, 5180.818671346522, 5222.190560463135, 5264.236685680593, 5276.762545685453, 5815.331236907725, 5821.67980761058, 5857.0, 5894.115882617599, 5900.203472531196, 5619.157126431027, 5651.208830763697, 5683.403242659502, 5841.0, 5922.200502932092, 5450.264214331094, 5515.117581186991, 5517.034518959166, 5517.310336207974, 5533.6956467393875, 5926.170336152942, 5966.552508561876, 5968.1644569760265, 5973.701314934236, 5974.133750606138, 5690.374058853523, 5697.202391665171, 5709.371969083398, 5775.509081728016, 5829.038208695602, 5855.180274761537, 5856.267966504187, 5872.148538461985, 5874.618149820248, 5893.941060589425, 5639.971800141055, 5804.9419505805245, 5819.73811178498, 5826.126081087786, 5829.650220986754, 5648.406917273709, 5740.885182296331, 5742.6554406734895, 5822.650640961471, 5854.0, 4472.798724057425, 4535.0, 4555.863324100283, 4568.451785785727, 4594.035252596992, 3934.842606295716, 4037.515498140242, 4081.0, 4103.733257338264, 4121.340585506305, 5408.702521361363, 5499.615026948155, 5504.944950550524, 5524.254225679562, 5568.638038527563, 5837.036888913367, 5854.560907931922, 5860.2381690380835, 5862.648241105548, 5884.882302354014, 5364.30264065669, 5394.91907621386, 5402.864928376822, 5569.610127291132, 5601.8599535011135, 5112.795488180505, 5113.590912726973, 5140.434552199255, 5140.640155189101, 5166.43169251382, 5867.647941123546, 5915.349311575723, 5927.614705044159, 5958.970205149033, 5996.37038110992, 5653.067243904709, 5771.884562308815, 5866.178734977021, 5893.263342082154, 5966.0, 5991.0, 5991.64050156992, 6000.759969601341, 6008.098785182257, 6012.819615411545, 5812.331581868139, 5821.330546987151, 5825.446582574648, 5834.708264586839, 5838.299404071538, 5680.6591604503865, 5744.0, 5755.683437410982, 5796.82609521715, 5842.2405087338375, 5634.74643641029, 5761.56788240892, 5764.654120752768, 5780.132980053026, 5783.190353350618, 5695.686737229326, 5763.0, 5764.7405866736935, 5765.279340082489, 5768.480836724715, 5391.4608539145775, 5504.669719816824, 5551.1673249011355, 5563.970665426909, 5627.718614069362, 5678.233438485917, 5701.714914254354, 5728.828135155952, 5735.913961290667, 5782.074868021096, 5497.065498865122, 5605.887882242414, 5606.467385598362, 5611.80358687444, 5617.859553511195], "unit": "ms", "name": "dojo.html", "value": 5375.441075178606}, {"lowerIsBetter": false, "replicates": [571.702714588414, 617.6448542088299, 620.5314987184674, 638.0716058135414, 681.2506243132555, 32490.18774530638, 40222.0, 41040.38439423411, 41065.0, 41281.0, 44664.55335446653, 45283.0, 45287.77356113223, 45373.54626453735, 45382.773086134526, 9083.636654533811, 9196.310276729238, 9200.723978280663, 9211.401258918182, 9216.723498295061, 9001.684941027066, 9140.63437462504, 9146.359754817166, 9154.816903661922, 9157.725268241964, 9092.772680683003, 9164.725058248263, 9187.173154416101, 9192.494412807293, 9200.355975081748, 9159.129882661136, 9180.770480737969, 9235.307351948632, 9237.722868313927, 9259.0, 9075.954620226923, 9141.314401419853, 9161.358704890661, 9199.908000919972, 9200.263978881674, 42558.0, 42597.36103958443, 43201.0, 43207.783961080306, 43232.35151472731, 3640.8179591020344, 3741.8316175772156, 4022.8390864365683, 4049.8380064797375, 4185.832566697329, 32456.513152302734, 32655.020349389557, 32735.6726432735, 32809.17977050569, 32988.67011329904, 3867.7099217558793, 3904.3362628352966, 3922.431247469101, 3988.840446382141, 4045.7977101144825, 280600.0, 281319.0, 281350.0, 281494.0, 469728.99999999657, 65821.34178658247, 65865.67067164634, 66196.0, 66323.33676663268, 66710.66644666746, 70275.64862175759, 71088.64455677688, 71173.28826711666, 71259.28740712526, 71582.0, 15663.68672626541, 15845.762313565076, 15880.285387157606, 15909.284082216329, 15931.0, 12896.871031289755, 13290.73418531624, 13290.800637990438, 13294.933525332312, 13317.866821331663, 22515.437114071952, 22671.773282267295, 22788.658170127463, 22837.885810570842, 22970.7702922972, 8743.344249181337, 9014.906577783531, 9044.954775226082, 9046.683366082287, 9086.864586822092, 968.4189486308159, 1022.0494939706144, 1093.6937657455926, 1103.9558417663363, 1161.5760247509597, 29566.852165739034, 29731.702682973326, 29986.25034374158, 30647.0, 30652.693473064985, 1131.3607811586592, 1146.358039497884, 1149.126663735567, 1198.0415667465993, 1210.842590463234, 15715.0, 15919.363225470852, 15997.80016498744, 16001.919990399974, 16001.959872608477, 326701.0, 589088.0, 765952.0, 773082.0, 775462.245377539, 59070.40929590649, 59828.0, 59970.0, 60160.0, 60295.39704602986, 1479.0534058202759, 1482.577465422371, 1491.0382803091945, 1515.6210947263185, 1516.5829396915935, 30582.388352233276, 31344.686553134175, 31397.372052559276, 31625.8418707905, 32093.35813283768, 49990.0, 50395.49604503908, 50527.74736126296, 50570.2414463776, 50797.0, 321304.0, 321924.0, 322960.0, 323055.0, 323940.0, 34686.0, 34839.47740783941, 34870.825645871606, 35090.64909350976, 35239.82380088186, 45700.771496143636, 45954.54045459503, 46387.0, 46517.76741116273, 47091.0, 39726.60273397345, 39737.2052558953, 40628.59371406248, 40917.79541102275, 41153.176936460506, 45276.77361613171, 46497.53502464932, 47325.290120648904, 47499.52500475089, 48014.759926200146, 37998.43002354912, 38467.23065538618, 38521.807390962866, 38591.6140838588, 38679.0, 34274.0, 34570.0, 34723.30553388868, 34811.47782783311, 34993.65006349904, 28189.43621127607, 28799.42401152007, 30761.538576921812, 30891.0, 31113.0], "unit": "ms", "name": "ext.html", "value": 20656.43596198593}, {"lowerIsBetter": false, "replicates": [379.57866767887657, 380.0479798105745, 381.4012001158181, 384.90878359849825, 390.62890254258457, 15978.520644380687, 17466.825331746695, 17918.0, 19081.61836763264, 19158.71261931072, 17549.21028553715, 17799.110044497756, 18032.54918627035, 18177.272909083622, 18638.508919286458, 4890.119778439888, 5169.767360468788, 5177.0, 5193.428722840485, 5196.246544251081, 5090.694558326512, 5275.472452754713, 5412.431694672062, 5414.187871819239, 5416.729163541827, 5387.24578559002, 5403.918941215885, 5432.320959880015, 6351.110844481776, 6369.4585960193435, 6321.841953951142, 6327.683615819191, 6336.873262534747, 6368.140301059344, 6376.458001069915, 5401.243825864382, 5417.349918009864, 5425.321834770653, 5452.645578037414, 5620.690862002588, 15281.006734562217, 21517.892410538003, 21553.56892862134, 21801.454963626034, 21971.780282197135, 2248.6177349850564, 2295.1507942061376, 2321.3848330192513, 2472.950540989188, 2482.9943872731574, 9407.341486095977, 9593.568289426992, 9816.116549510578, 12725.872741272562, 14175.220362880038, 2007.979920200794, 2013.8590298679098, 2022.7067075274003, 2039.7246371739773, 2083.14591017682, 65438.3456165437, 66006.66996665034, 66969.0, 68108.0, 69282.65358673174, 10795.352278863293, 10934.234603577832, 11097.44512774358, 11110.277831941059, 11135.665930022113, 14543.85456145425, 14600.488982885548, 14614.488492902698, 14663.853361466463, 14671.413143474356, 8485.618147183392, 8501.362397820189, 8513.148685131437, 8566.27186689126, 8620.094890036582, 8424.28393586552, 8504.829903401896, 8507.319414446829, 8545.359098067669, 8551.957240213884, 4636.11913736389, 4712.552307530779, 4754.667173297905, 4762.78567464465, 4837.129316723023, 1964.184863281722, 1979.7921218272163, 1992.1135094882638, 2018.2431588154443, 2023.9089240983897, 470.1419908666697, 956.2159029595665, 1022.749426390539, 1022.8210063238903, 1128.136975213962, 10091.344062635904, 10144.797104057878, 10205.948970255102, 10268.845967310497, 10637.0, 480.9903801923942, 487.53927538476506, 491.9950800492021, 492.1706923833352, 525.4220357606679, 5712.200291959129, 5734.340550836707, 5796.594238403271, 5831.241938547962, 5836.416358364215, 635317.0, 644061.0, 650247.4975250186, 674650.0, 676951.0, 78488.0, 79671.60164199142, 80104.0, 87765.0, 91009.08990910139, 1210.3403645013489, 1215.7143071378396, 1252.1110011891658, 1260.5021016698354, 1287.5429222626021, 16402.343906243615, 16435.91782041082, 16596.309491731805, 16631.66736665284, 16785.832141678915, 37464.62535374721, 37875.24249514939, 38320.23359532738, 38449.6155038446, 38663.806680966416, 45247.0, 47119.0, 47864.521354786004, 48253.0, 49020.75489622672, 9335.253179745469, 9665.661701840401, 9764.267679923893, 9808.852867206855, 9834.901650983398, 13717.108387954751, 17888.552786179927, 18148.637027259643, 18224.36214732531, 18573.90713046426, 14446.494372696905, 14586.781198282246, 15140.394384224508, 15394.769078464056, 15736.0, 14790.408383664962, 14816.185109819064, 15145.545633631009, 15355.846441535441, 15370.69258614799, 15386.153761542775, 15416.614584635474, 15520.5343839685, 15612.82903782198, 15763.684726305639, 9617.519124043909, 9664.226861851175, 9740.512974351395, 9959.950200248952, 10333.070023697903, 10918.18113641496, 15136.924315378794, 15872.60318492047, 15893.682126357176, 16088.67822643564], "unit": "ms", "name": "jquery.html", "value": 9041.32345212304}, {"lowerIsBetter": false, "replicates": [1523.6876440329727, 1537.6386549160952, 1700.8299170083, 1800.6231774058244, 1836.311383231288, 7377.52046117002, 7717.922820771791, 7758.650860711267, 7786.649600767972, 7988.121306656278, 7876.763697089083, 7889.0, 7907.327877130437, 7917.247861453153, 7966.681332746683, 2279.418748219206, 2303.7696230376996, 2308.7691230876944, 2323.581755284048, 2332.6501024846325, 2278.396225000376, 2312.895919683618, 2316.5251123519724, 2317.629179331307, 2318.07277089164, 2284.680144779732, 2303.9308820735323, 2322.512272422793, 2330.6387509935985, 2337.5208082343165, 2231.665250212465, 2286.4398222435525, 2302.7236731592234, 2315.8378913476063, 2316.7104111986, 2260.2089268755967, 2284.554511870186, 2287.0508738873345, 2290.576243394961, 2291.026313816638, 7647.158812530617, 7762.417818663623, 7817.0, 7827.6477558510005, 7851.0, 4711.175544279771, 4786.832460863888, 4789.976050119762, 4812.422509298872, 4813.735244561548, 2964.6294213223346, 3006.5790789289517, 3057.31210477643, 3067.6778938211614, 3067.7699172561925, 972.0910948263326, 978.0806042320196, 1002.1081237698454, 1002.8846682631518, 1012.3723291559206, 10358.378497290187, 10454.425006624633, 10461.110805581535, 10470.895291047069, 10498.212634052401, 4148.43996060534, 4165.604267594574, 4220.683448741357, 4246.8725938221905, 4250.681198910094, 8668.349873759367, 8685.39202255836, 8686.52224127679, 8688.78278043054, 8704.434211776213, 4667.276572131325, 4675.345451636774, 4684.484706682262, 4697.530246975275, 4701.412323459567, 4249.277622804131, 4300.61294483498, 4301.032267739796, 4306.2894622387585, 4312.245357062501, 3451.5685539307588, 3457.083872773717, 3463.151527875636, 3469.4969229461585, 3505.1762835733584, 1013.4628646817199, 1020.0819262663514, 1024.5491983527224, 1024.784795193003, 1039.8492218628257, 1126.1103728054745, 1131.1516362727955, 1174.0783484964263, 1181.9763604727857, 1199.8140288255333, 7256.0, 7295.270472952769, 7335.77992660221, 7340.302671246223, 7365.594892280976, 1090.9618163364403, 1136.4204255829586, 1172.472387425662, 1178.5327267551952, 1178.5757127434117, 5978.342382337939, 5995.760169593167, 6035.577509574287, 6045.72794224261, 6060.696965151725, 8759.036505984337, 9250.167484926254, 9344.159025687584, 9403.153716165441, 9432.575534100983, 9245.399049061789, 9249.0, 9258.907410925805, 9284.628614855465, 9311.301652376098, 6968.442524598121, 7082.752103676346, 7113.110861142461, 7159.427245820426, 7343.0, 7342.412606991535, 7442.404607631268, 7480.4015678746655, 7506.624668766649, 7517.097948246245, 8070.919290807252, 8323.084460709439, 8327.875081873655, 8333.583320833814, 8367.12145224767, 8271.46235494715, 8381.03618083928, 8402.663893444194, 8418.074011858813, 8425.4944703318, 7022.087128673445, 7069.505134640732, 7083.0, 7097.858042839011, 7100.7869763907165, 7523.435742319458, 7532.472726909064, 7565.319121279112, 7619.1999840016, 7640.617969101634, 6844.2129155147795, 7040.0847889774, 7062.964685176541, 7199.640017998974, 7213.963930180315, 6627.403533681992, 6736.259011508828, 6877.518573699793, 7027.9297207027275, 7226.0, 7176.067111275501, 7197.388222000979, 7221.988921551092, 7233.276672332725, 7243.674034668558, 6508.707108180049, 6735.057092007025, 6738.966305168639, 6746.9662651688395, 6749.392554670103, 6742.359475849787, 6843.62360070181, 6855.177378714586, 6859.211190713132, 6866.519343645897], "unit": "ms", "name": "mootools.html", "value": 4499.999171679878}, {"lowerIsBetter": false, "replicates": [363.6182008890665, 364.1515269422246, 367.98528058877645, 369.2762186115214, 370.2631762792043, 6284.183056202693, 6289.0, 6353.2376114866165, 6353.301136874946, 6355.777547785829, 6116.266048074237, 6235.7505699771955, 6236.937630623693, 6265.279492858312, 6274.749010039593, 4868.659193856432, 4869.537393947569, 4871.951280487186, 4875.609951203895, 4883.0, 4834.782434790425, 4841.806327746904, 4846.4911184325665, 4865.24588688752, 4882.2432522958825, 4713.9057218855605, 4788.329633851264, 4807.855764327076, 4818.397700287464, 4821.590164835976, 4803.375561177059, 4818.204996175627, 4830.492798256168, 4843.39457567804, 4844.20070688336, 4106.568810274938, 4196.349565817303, 4268.0, 4278.850240241577, 4281.186574550857, 5930.318013428468, 5942.702864856783, 5962.224910761616, 5974.0, 5999.310079340888, 5631.2397826293745, 5638.323401191842, 5639.548836093103, 5639.577031722596, 5644.802431914904, 6555.278919318871, 6669.233038200572, 6689.397954184147, 6699.196096468406, 6715.832104197385, 4683.812647494096, 4686.992296656235, 4687.484376718558, 4691.953080469186, 4695.765211739399, 6903.723851045952, 6967.79096627102, 6974.337437943438, 6974.721011159548, 6983.755568555127, 4782.689125206851, 4785.994941062347, 4792.137415265286, 4796.832110876103, 4812.927806082912, 4765.785539650724, 4855.708657480563, 4863.586595139382, 4870.586000190024, 4875.34182885313, 5608.242887210256, 5612.691301978431, 5612.887742245132, 5627.549796016309, 5645.379008309083, 6693.062971184038, 6719.260881303053, 6742.5280230383405, 6743.629100399427, 6749.730010799612, 1695.8643308535288, 1706.4283465039102, 1713.7258038713746, 1716.519374575121, 1718.8453039226529, 1125.5104029747085, 1151.654503648902, 1167.4046236419317, 1181.3443538835857, 1183.6330737471412, 6454.548181627335, 6522.673866306665, 6525.445337146396, 6529.183852018497, 6535.3464653534265, 6881.311868813079, 6908.723651054002, 6921.653917304115, 6933.653317334214, 6948.33990770876, 6302.401271879165, 6396.2964073951825, 6412.967935160387, 6426.389492998158, 6507.7071531781185, 3731.869384571527, 3732.626737326246, 3770.981145094312, 3788.962110378916, 3794.6964242860504, 7041.084658994298, 7119.21688614252, 7224.5665260083515, 7229.710811567584, 7236.384907282834, 7206.7117315306805, 7222.386097181693, 7230.276972302833, 7231.7107315707835, 7242.927570724225, 7083.220845707071, 7167.677454514559, 7206.783796486114, 7208.495405321577, 7214.639268036683, 6976.127984002, 6997.860042799014, 7047.0, 7054.929450705633, 7056.188538317954, 6872.037914692047, 6877.209120951155, 6889.44987377836, 6891.173059232724, 6928.099347084847, 7068.681909314196, 7161.033260509765, 7204.31559001915, 7205.675744591611, 7217.206107328085, 4748.430188377417, 4782.163121453801, 4790.281457781361, 4791.065742180381, 4795.592374648194, 7015.772239858106, 7018.157821061505, 7060.82347941285, 7064.32888875556, 7086.4685148613025, 6666.766663166766, 6776.627285499345, 6797.25230224665, 6810.523263371517, 6813.2846051163915, 6775.62734049632, 6797.694103765243, 6807.421369183675, 6813.863722725617, 6826.044353790573, 6650.800475985535, 6660.966695166493, 6684.899726504009, 6693.828579998578, 6703.396694297537, 6681.966590167018, 6834.9316506836285, 6843.692033858389, 6865.5537390069485, 6879.6216208107035, 6653.0, 6655.101561289164, 6668.0331351954665, 6695.631740254333, 6714.865702686016], "unit": "ms", "name": "prototype.html", "value": 5093.759248698814}, {"lowerIsBetter": false, "replicates": [837.330135891287, 854.2013217641505, 871.250724377036, 904.5838914099514, 924.6486335192626, 13275.0, 13453.461861525528, 13459.0, 13508.257045862474, 13513.256770877599, 14072.507462238824, 14143.080699754535, 14145.504907328246, 14161.645958851033, 14170.149791012547, 913.4427998920653, 917.0691747875911, 939.0327962198946, 944.1031020530489, 944.4191822029437, 907.5008745190152, 915.199200699388, 916.2852974679727, 920.0293690156882, 921.755734730297, 965.1940629574314, 965.2519297544424, 965.75856035991, 966.1111777165025, 968.5786682792973, 949.3686698345592, 949.5299826585849, 951.4434056077204, 951.8857737071596, 954.6420092465326, 703.6692754405422, 703.992960070403, 706.3854446631464, 715.3061530315586, 722.342668171961, 14683.63290917725, 14850.628734281729, 14873.0, 14878.330475128538, 14907.329170187368, 12548.874511254862, 12694.492220311176, 12839.358032098358, 13002.349882505838, 13383.464661413533, 11098.500567474483, 11510.539578416854, 11640.476178571984, 12006.519739210422, 12221.816672749916, 3884.6892248620325, 3884.8251828667494, 3896.7856767877756, 3902.2975864344407, 3905.6094390561, 47926.760366198294, 47929.520704792856, 48354.75822620864, 48449.69132889983, 48936.75531622319, 9952.353097048668, 10059.899401005896, 10166.796664066676, 10195.541200645988, 10309.587616495257, 18286.542836429195, 18335.358262461017, 19672.114754836068, 19938.90030549838, 20041.498962525762, 7693.422993275527, 7711.113221979432, 7756.340711039512, 7814.68741250355, 7908.288254057163, 4396.60430561251, 4541.909161816811, 4605.0, 4662.393888794435, 4719.8377087351555, 3226.72572831312, 3246.6753324667343, 3250.203700093445, 3252.4308246056844, 3269.4441944869427, 569.7493103034651, 572.7937942340754, 574.0270241939955, 577.6967092276589, 579.154434525589, 757.4054367321626, 774.7017398301695, 778.7118766056482, 779.0923574036298, 797.0233820126119, 8974.820503590023, 9155.587998540082, 9289.256859451227, 9578.13796758295, 9700.12698857092, 539.9730013499309, 633.1231244725996, 660.6663634864362, 694.9200841903145, 695.5759179260274, 4350.978245108818, 4354.716943398732, 4483.21543729846, 4492.989077457546, 4506.414166158378, 57248.141277880866, 57745.0, 57751.711241443525, 58035.41964580385, 61581.07628385578, 50321.24518132231, 50635.0, 51093.0, 51259.487405126216, 51542.48457515452, 46961.76519117383, 47909.28136077892, 48173.518264817605, 48216.27675584799, 48929.26606100911, 9483.336166468282, 9540.205794584657, 9541.618335266789, 9715.417074975525, 9839.0, 35097.82451087728, 36029.63970360263, 36319.092022699646, 37073.6292637081, 37171.814140930204, 46788.29817552808, 47255.29117063178, 47513.52486475229, 47672.2849157256, 47725.76137119292, 11692.47383867745, 11912.761744764883, 12076.818847717115, 12103.939480302543, 12358.0, 13045.673858153623, 13544.86455135436, 13579.0, 14124.646883827987, 14347.56957291241, 11662.300261984308, 11918.284902905507, 11952.0, 12034.097442691658, 12061.336626485627, 10919.727006824574, 11114.22200445961, 11288.20982531215, 11362.602308919148, 11725.530978760755, 11728.354940478355, 12467.251964882136, 12484.687882803002, 12614.936925315682, 12858.0, 10816.891831081588, 10824.945875270574, 11168.497417616065, 11199.10407167441, 11346.602868899548, 10609.098226650822, 10675.0, 10698.518566664363, 10741.301815381976, 10801.135909127408], "unit": "ms", "name": "yui.html", "value": 6777.461131270769}], "name": "dromaeo_css", "value": 7336.855843089145}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 112.0, 110.0, 112.0, 120.0, 110.0, 111.0, 112.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [164.0, 120.0, 154.0, 155.0, 124.0, 154.0, 147.0, 123.0, 162.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 160.0, 162.0, 164.0, 162.0, 164.0, 163.0, 165.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [78.0, 71.0, 72.0, 154.0, 73.0, 71.0, 70.0, 72.0, 155.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 88.7}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 141.0, 91.0, 94.0, 92.0, 142.0, 94.0, 96.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [114.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [101.0, 96.0, 96.0, 96.0, 97.0, 96.0, 98.0, 101.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 97.2}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 60.0, 60.0, 59.0, 58.0, 60.0, 61.0, 59.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 59.2}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 69.0, 65.0, 68.0, 65.0, 65.0, 65.0, 65.0, 66.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.7}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 83.0, 82.0, 83.0, 84.0, 82.0, 80.0, 83.0, 88.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [120.0, 120.0, 120.0, 120.0, 126.0, 113.0, 119.0, 113.0, 119.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.7}, {"lowerIsBetter": true, "replicates": [144.0, 137.0, 144.0, 147.0, 146.0, 148.0, 135.0, 146.0, 142.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 64.0, 64.0, 66.0, 66.0, 66.0, 67.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.2}], "name": "kraken", "value": 1501.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.78249336870027], "unit": "score", "name": "Richards", "value": 212.94166399999992}, {"lowerIsBetter": false, "replicates": [166.55562958027983], "unit": "score", "name": "DeltaBlue", "value": 396.9724720000001}, {"lowerIsBetter": false, "replicates": [282.2466836014677], "unit": "score", "name": "Encrypt", "value": 943.0792829999996}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [890.4719501335708], "unit": "score", "name": "RayTrace", "value": 831.0076470000001}, {"lowerIsBetter": false, "replicates": [550.357732526142], "unit": "score", "name": "Earley", "value": 1210.9632709999996}, {"lowerIsBetter": false, "replicates": [11397.727272727272], "unit": "score", "name": "Boyer", "value": 58.47332402791622}, {"lowerIsBetter": false, "replicates": [24190.47619047619], "unit": "score", "name": "RegExp", "value": 37.65882874015749}, {"lowerIsBetter": false, "replicates": [517.3305742369374], "unit": "score", "name": "Splay", "value": 157.52210300000002}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23204.662333661323}]} 09:25:19 INFO - RETURN: dromaeo_css: 7336.86 09:25:19 INFO - RETURN: kraken: 1501.40 09:25:19 INFO - RETURN: v8_7: 23204.66 09:25:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23204.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1501.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7336.86"}}} 09:25:20 INFO - Return code: 0 09:25:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:25:20 INFO - # TBPL SUCCESS # 09:25:20 INFO - Running post-action listener: _resource_record_post_action 09:25:20 INFO - Running post-run listener: _resource_record_post_run 09:25:21 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 8192; Write bytes: 513187840; Read time: 12; Write time: 349684 09:25:21 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 238002176; Read time: 0; Write time: 208776 09:25:21 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 8192; Write bytes: 275185664; Read time: 12; Write time: 140908 09:25:21 INFO - Running post-run listener: _upload_blobber_files 09:25:21 INFO - Blob upload gear active. 09:25:21 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:25:21 INFO - Copying logs to upload dir... 09:25:21 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.249356 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-23 09:25:19.951157) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-23 09:25:19.954658) ========= 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=574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010068 build_url: 'https://queue.taskcluster.net/v1/task/kVETwNojQkCuPfXSpJCHmg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-23 09:25:20.006849) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 09:25:20.007201) ========= 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=574dc5aafe09851ec43d388c000001b6-1453568494.340354-1169686362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004580 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 09:25:20.057579) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 09:25:20.057981) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 09:25:20.058322) ========= ========= Total master_lag: 0.29 =========