builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1455235868.4 results: success (0) buildid: 20160211133004 builduid: 8040619d21f84049bea6b1d9f6fbb2e1 revision: 576a6dcde5b68c2ea45324ed5ce1dabb7d833d09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:08.399335) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:08.399731) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:08.400016) ========= 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=232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006357 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:08.424953) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:08.425230) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:08.444749) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:08.445007) ========= 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=232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:08.501620) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:08.501881) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:08.502220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:08.502504) ========= 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=232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-11 16:11:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.8M=0s 2016-02-11 16:11:09 (83.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168818 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:08.682788) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:08.683170) ========= 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=232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014014 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:08.731805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:08.732138) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 576a6dcde5b68c2ea45324ed5ce1dabb7d833d09 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 576a6dcde5b68c2ea45324ed5ce1dabb7d833d09 --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=232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-11 16:11:09,139 truncating revision to first 12 chars 2016-02-11 16:11:09,139 Setting DEBUG logging. 2016-02-11 16:11:09,139 attempt 1/10 2016-02-11 16:11:09,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/576a6dcde5b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-11 16:11:09,374 unpacking tar archive at: mozilla-central-576a6dcde5b6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.561127 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:09.305853) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:09.306189) ========= echo 576a6dcde5b68c2ea45324ed5ce1dabb7d833d09 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'576a6dcde5b68c2ea45324ed5ce1dabb7d833d09'] 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=232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 576a6dcde5b68c2ea45324ed5ce1dabb7d833d09 program finished with exit code 0 elapsedTime=0.003918 script_repo_revision: '576a6dcde5b68c2ea45324ed5ce1dabb7d833d09' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:09.359052) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:09.359415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 16:11:09.375650) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-02-11 16:11:09.375933) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:11:09 INFO - MultiFileLogger online at 20160211 16:11:09 in /builds/slave/test-pgo 16:11:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:11:09 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:11:09 INFO - {'append_to_log': False, 16:11:09 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:11:09 INFO - 'blob_upload_branch': 'Firefox', 16:11:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:11:09 INFO - 'branch': 'Firefox', 16:11:09 INFO - 'buildbot_json_path': 'buildprops.json', 16:11:09 INFO - 'config_files': ('talos/linux_config.py',), 16:11:09 INFO - 'default_actions': ('clobber', 16:11:09 INFO - 'read-buildbot-config', 16:11:09 INFO - 'download-and-extract', 16:11:09 INFO - 'populate-webroot', 16:11:09 INFO - 'create-virtualenv', 16:11:09 INFO - 'install', 16:11:09 INFO - 'run-tests'), 16:11:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:11:09 INFO - 'download_minidump_stackwalk': True, 16:11:09 INFO - 'download_symbols': 'ondemand', 16:11:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:11:09 INFO - 'tooltool.py': '/tools/tooltool.py', 16:11:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:11:09 INFO - '/tools/misc-python/virtualenv.py')}, 16:11:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:11:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:11:09 INFO - 'installer_path': 'installer.exe', 16:11:09 INFO - 'log_level': 'info', 16:11:09 INFO - 'log_name': 'talos', 16:11:09 INFO - 'log_to_console': True, 16:11:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:11:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:11:09 INFO - 'opt_config_files': (), 16:11:09 INFO - 'pip_index': False, 16:11:09 INFO - 'sps_profile': False, 16:11:09 INFO - 'sps_profile_interval': 0, 16:11:09 INFO - 'suite': 'dromaeojs', 16:11:09 INFO - 'system_bits': '32', 16:11:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:11:09 INFO - 'title': 'talos-linux64-ix-025', 16:11:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:11:09 INFO - 'use_talos_json': True, 16:11:09 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:11:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:11:09 INFO - 'work_dir': 'build'} 16:11:09 INFO - ##### 16:11:09 INFO - ##### Running clobber step. 16:11:09 INFO - ##### 16:11:09 INFO - Running pre-action listener: _resource_record_pre_action 16:11:09 INFO - Running main action method: clobber 16:11:09 INFO - rmtree: /builds/slave/test-pgo/build 16:11:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:11:10 INFO - Running post-action listener: _resource_record_post_action 16:11:10 INFO - ##### 16:11:10 INFO - ##### Running read-buildbot-config step. 16:11:10 INFO - ##### 16:11:10 INFO - Running pre-action listener: _resource_record_pre_action 16:11:10 INFO - Running main action method: read_buildbot_config 16:11:10 INFO - Using buildbot properties: 16:11:10 INFO - { 16:11:10 INFO - "project": "", 16:11:10 INFO - "product": "firefox", 16:11:10 INFO - "script_repo_revision": "production", 16:11:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:11:10 INFO - "repository": "", 16:11:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 16:11:10 INFO - "buildid": "20160211133004", 16:11:10 INFO - "pgo_build": "True", 16:11:10 INFO - "basedir": "/builds/slave/test-pgo", 16:11:10 INFO - "buildnumber": 668, 16:11:10 INFO - "slavename": "talos-linux64-ix-025", 16:11:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:11:10 INFO - "platform": "ubuntu64_hw", 16:11:10 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 16:11:10 INFO - "branch": "mozilla-central", 16:11:10 INFO - "repo_path": "mozilla-central", 16:11:10 INFO - "revision": "576a6dcde5b68c2ea45324ed5ce1dabb7d833d09", 16:11:10 INFO - "stage_platform": "linux64-pgo", 16:11:10 INFO - "builduid": "8040619d21f84049bea6b1d9f6fbb2e1", 16:11:10 INFO - "slavebuilddir": "test" 16:11:10 INFO - } 16:11:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 16:11:10 INFO - Running post-action listener: _resource_record_post_action 16:11:10 INFO - ##### 16:11:10 INFO - ##### Running download-and-extract step. 16:11:10 INFO - ##### 16:11:10 INFO - Running pre-action listener: _resource_record_pre_action 16:11:10 INFO - Running main action method: download_and_extract 16:11:10 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:11: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')]} 16:11:10 INFO - https://queue.taskcluster.net/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:11:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/test_packages.json 16:11:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/test_packages.json 16:11:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:11:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:11:15 INFO - Downloaded 1448 bytes. 16:11:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:11:15 INFO - Using the following test package requirements: 16:11:15 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:11:15 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:11:15 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:11:15 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:15 INFO - u'jsshell-linux-x86_64.zip'], 16:11:15 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:11:15 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:11:15 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:11:15 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:11:15 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:11:15 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:11:15 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:11:15 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:15 INFO - https://queue.taskcluster.net/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:11:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:11:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:11:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:11:18 INFO - Downloaded 23297951 bytes. 16:11:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:11:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:11:19 INFO - Return code: 0 16:11:19 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:19 INFO - https://queue.taskcluster.net/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:11:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:11:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:11:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:11:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:11:29 INFO - Downloaded 23297951 bytes. 16:11:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:11:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:11:30 INFO - Return code: 0 16:11: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')]} 16:11:30 INFO - https://queue.taskcluster.net/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:11:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:11:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:11:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:11:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:11:31 INFO - Downloaded 10706547 bytes. 16:11:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:11:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 16:11:31 INFO - Return code: 0 16:11:31 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')]} 16:11:31 INFO - https://queue.taskcluster.net/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:11:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:11:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:11:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:11:34 INFO - Downloaded 56480397 bytes. 16:11:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:11:34 INFO - mkdir: /builds/slave/test-pgo/properties 16:11:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:11:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:11:34 INFO - Contents: 16:11:34 INFO - build_url:https://queue.taskcluster.net/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:11:35 INFO - Running post-action listener: _resource_record_post_action 16:11:35 INFO - Running post-action listener: set_extra_try_arguments 16:11:35 INFO - ##### 16:11:35 INFO - ##### Running populate-webroot step. 16:11:35 INFO - ##### 16:11:35 INFO - Running pre-action listener: _resource_record_pre_action 16:11:35 INFO - Running main action method: populate_webroot 16:11:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:11:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:11:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:11:35 INFO - '--tppagecycles', 16:11:35 INFO - '7'], 16:11:35 INFO - 'tests': ['tsvgm']}}, 16:11:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:11:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:11:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:11:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:11:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:11:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:11:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:35 INFO - 'talos_options': ['--e10s'], 16:11:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:35 INFO - 'tests': ['damp', 'tps']}, 16:11:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:35 INFO - 'talos_options': ['--e10s'], 16:11:35 INFO - 'tests': ['damp', 'tps']}, 16:11:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:11:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:11:35 INFO - 'other': {'tests': ['a11yr', 16:11:35 INFO - 'ts_paint', 16:11:35 INFO - 'tpaint', 16:11:35 INFO - 'sessionrestore', 16:11:35 INFO - 'sessionrestore_no_auto_restore']}, 16:11:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:11:35 INFO - 'tests': ['a11yr', 16:11:35 INFO - 'ts_paint', 16:11:35 INFO - 'tpaint', 16:11:35 INFO - 'sessionrestore', 16:11:35 INFO - 'sessionrestore_no_auto_restore']}, 16:11:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:11:35 INFO - 'tests': ['a11yr', 16:11:35 INFO - 'ts_paint', 16:11:35 INFO - 'tpaint', 16:11:35 INFO - 'sessionrestore', 16:11:35 INFO - 'sessionrestore_no_auto_restore']}, 16:11:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:11:35 INFO - 'tests': ['a11yr', 16:11:35 INFO - 'ts_paint', 16:11:35 INFO - 'tpaint', 16:11:35 INFO - 'sessionrestore', 16:11:35 INFO - 'sessionrestore_no_auto_restore']}, 16:11:35 INFO - 'other_l64': {'tests': ['a11yr', 16:11:35 INFO - 'ts_paint', 16:11:35 INFO - 'tpaint', 16:11:35 INFO - 'sessionrestore', 16:11:35 INFO - 'sessionrestore_no_auto_restore']}, 16:11:35 INFO - 'other_nol64': {'tests': ['a11yr', 16:11:35 INFO - 'ts_paint', 16:11:35 INFO - 'tpaint', 16:11:35 INFO - 'sessionrestore', 16:11:35 INFO - 'sessionrestore_no_auto_restore']}, 16:11:35 INFO - 'svgr': {'tests': ['tsvgx', 16:11:35 INFO - 'tsvgr_opacity', 16:11:35 INFO - 'tart', 16:11:35 INFO - 'tscrollx', 16:11:35 INFO - 'cart']}, 16:11:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:11:35 INFO - 'tests': ['tsvgx', 16:11:35 INFO - 'tsvgr_opacity', 16:11:35 INFO - 'tart', 16:11:35 INFO - 'tscrollx', 16:11:35 INFO - 'cart']}, 16:11:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:35 INFO - 'tests': ['tp5o']}, 16:11:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:35 INFO - 'talos_options': ['--e10s'], 16:11:35 INFO - 'tests': ['tp5o']}, 16:11:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:35 INFO - 'talos_options': ['--xperf_path', 16:11:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:35 INFO - 'tests': ['tp5n']}, 16:11:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:35 INFO - 'talos_options': ['--e10s', 16:11:35 INFO - '--xperf_path', 16:11:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:35 INFO - 'tests': ['tp5n']}}, 16:11:35 INFO - 'talos.zip': {'path': '', 16:11:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:11:35 INFO - Running post-action listener: _resource_record_post_action 16:11:35 INFO - ##### 16:11:35 INFO - ##### Running create-virtualenv step. 16:11:35 INFO - ##### 16:11:35 INFO - Running pre-action listener: _resource_record_pre_action 16:11:35 INFO - Running main action method: create_virtualenv 16:11:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:11:35 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 16:11:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:11:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:11:35 INFO - Using real prefix '/usr' 16:11:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:11:35 INFO - Installing distribute.............................................................................................................................................................................................done. 16:11:37 INFO - Installing pip.................done. 16:11:37 INFO - Return code: 0 16:11:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:11: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')]} 16:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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')]} 16:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f14757d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418c0>, '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 0x28427c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2842c50>, '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': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', '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 16:11: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:11: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 pip>=1.5 16:11:37 INFO - Using env: {'DISPLAY': ':0', 16:11:37 INFO - 'HOME': '/home/cltbld', 16:11:37 INFO - 'LANG': 'en_US.UTF-8', 16:11:37 INFO - 'LANGUAGE': 'en_US:en', 16:11:37 INFO - 'LOGNAME': 'cltbld', 16:11:37 INFO - 'MAIL': '/var/mail/cltbld', 16:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:37 INFO - 'MOZ_NO_REMOTE': '1', 16:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:37 INFO - 'NO_EM_RESTART': '1', 16:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:11:37 INFO - 'PWD': '/builds/slave/test-pgo', 16:11:37 INFO - 'SHELL': '/bin/bash', 16:11:37 INFO - 'SHLVL': '1', 16:11:37 INFO - 'TERM': 'linux', 16:11:37 INFO - 'TMOUT': '86400', 16:11:37 INFO - 'USER': 'cltbld', 16:11:37 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', 16:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:37 INFO - '_': '/tools/buildbot/bin/python'} 16:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:37 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 16:11:37 INFO - Cleaning up... 16:11:37 INFO - Return code: 0 16:11:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:11: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')]} 16:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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')]} 16:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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', '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 0x7f14757d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418c0>, '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 0x28427c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2842c50>, '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': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', '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 16:11: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:11: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 psutil>=0.7.1 16:11:37 INFO - Using env: {'DISPLAY': ':0', 16:11:37 INFO - 'HOME': '/home/cltbld', 16:11:37 INFO - 'LANG': 'en_US.UTF-8', 16:11:37 INFO - 'LANGUAGE': 'en_US:en', 16:11:37 INFO - 'LOGNAME': 'cltbld', 16:11:37 INFO - 'MAIL': '/var/mail/cltbld', 16:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:37 INFO - 'MOZ_NO_REMOTE': '1', 16:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:37 INFO - 'NO_EM_RESTART': '1', 16:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:11:37 INFO - 'PWD': '/builds/slave/test-pgo', 16:11:37 INFO - 'SHELL': '/bin/bash', 16:11:37 INFO - 'SHLVL': '1', 16:11:37 INFO - 'TERM': 'linux', 16:11:37 INFO - 'TMOUT': '86400', 16:11:37 INFO - 'USER': 'cltbld', 16:11:37 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', 16:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:37 INFO - '_': '/tools/buildbot/bin/python'} 16:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:38 INFO - Downloading/unpacking psutil>=0.7.1 16:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:11:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:39 INFO - Installing collected packages: psutil 16:11:39 INFO - Running setup.py install for psutil 16:11:39 INFO - building 'psutil._psutil_linux' extension 16:11:39 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 16:11:40 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 16:11:40 INFO - building 'psutil._psutil_posix' extension 16:11:40 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 16:11:40 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 16:11:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:40 INFO - Successfully installed psutil 16:11:40 INFO - Cleaning up... 16:11:40 INFO - Return code: 0 16:11:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f14757d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418c0>, '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 0x28427c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2842c50>, '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': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', '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 16:11:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:11:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:11:40 INFO - Using env: {'DISPLAY': ':0', 16:11:40 INFO - 'HOME': '/home/cltbld', 16:11:40 INFO - 'LANG': 'en_US.UTF-8', 16:11:40 INFO - 'LANGUAGE': 'en_US:en', 16:11:40 INFO - 'LOGNAME': 'cltbld', 16:11:40 INFO - 'MAIL': '/var/mail/cltbld', 16:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:40 INFO - 'MOZ_NO_REMOTE': '1', 16:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:40 INFO - 'NO_EM_RESTART': '1', 16:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:11:40 INFO - 'PWD': '/builds/slave/test-pgo', 16:11:40 INFO - 'SHELL': '/bin/bash', 16:11:40 INFO - 'SHLVL': '1', 16:11:40 INFO - 'TERM': 'linux', 16:11:40 INFO - 'TMOUT': '86400', 16:11:40 INFO - 'USER': 'cltbld', 16:11:40 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', 16:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:40 INFO - '_': '/tools/buildbot/bin/python'} 16:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:11:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:11:42 INFO - Installing collected packages: mozsystemmonitor 16:11:42 INFO - Running setup.py install for mozsystemmonitor 16:11:42 INFO - Successfully installed mozsystemmonitor 16:11:42 INFO - Cleaning up... 16:11:42 INFO - Return code: 0 16:11:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:42 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 0x7f14757d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418c0>, '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 0x28427c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2842c50>, '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': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', '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 16:11:42 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 16:11:42 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 16:11:42 INFO - Using env: {'DISPLAY': ':0', 16:11:42 INFO - 'HOME': '/home/cltbld', 16:11:42 INFO - 'LANG': 'en_US.UTF-8', 16:11:42 INFO - 'LANGUAGE': 'en_US:en', 16:11:42 INFO - 'LOGNAME': 'cltbld', 16:11:42 INFO - 'MAIL': '/var/mail/cltbld', 16:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:42 INFO - 'MOZ_NO_REMOTE': '1', 16:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:42 INFO - 'NO_EM_RESTART': '1', 16:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:11:42 INFO - 'PWD': '/builds/slave/test-pgo', 16:11:42 INFO - 'SHELL': '/bin/bash', 16:11:42 INFO - 'SHLVL': '1', 16:11:42 INFO - 'TERM': 'linux', 16:11:42 INFO - 'TMOUT': '86400', 16:11:42 INFO - 'USER': 'cltbld', 16:11:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', 16:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:42 INFO - '_': '/tools/buildbot/bin/python'} 16:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:42 INFO - Downloading/unpacking blobuploader==1.2.4 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11:44 INFO - Downloading blobuploader-1.2.4.tar.gz 16:11:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:11:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:11:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:45 INFO - Downloading docopt-0.6.1.tar.gz 16:11:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:11:45 INFO - Installing collected packages: blobuploader, requests, docopt 16:11:45 INFO - Running setup.py install for blobuploader 16:11:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:11:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:11:45 INFO - Running setup.py install for requests 16:11:45 INFO - Running setup.py install for docopt 16:11:45 INFO - Successfully installed blobuploader requests docopt 16:11:45 INFO - Cleaning up... 16:11:45 INFO - Return code: 0 16:11:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:45 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 0x7f14757d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418c0>, '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 0x28427c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2842c50>, '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': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', '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 16:11:45 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 16:11:45 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 16:11:45 INFO - Using env: {'DISPLAY': ':0', 16:11:45 INFO - 'HOME': '/home/cltbld', 16:11:45 INFO - 'LANG': 'en_US.UTF-8', 16:11:45 INFO - 'LANGUAGE': 'en_US:en', 16:11:45 INFO - 'LOGNAME': 'cltbld', 16:11:45 INFO - 'MAIL': '/var/mail/cltbld', 16:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:45 INFO - 'MOZ_NO_REMOTE': '1', 16:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:45 INFO - 'NO_EM_RESTART': '1', 16:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:11:45 INFO - 'PWD': '/builds/slave/test-pgo', 16:11:45 INFO - 'SHELL': '/bin/bash', 16:11:45 INFO - 'SHLVL': '1', 16:11:45 INFO - 'TERM': 'linux', 16:11:45 INFO - 'TMOUT': '86400', 16:11:45 INFO - 'USER': 'cltbld', 16:11:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', 16:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:45 INFO - '_': '/tools/buildbot/bin/python'} 16:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:11:46 INFO - Running setup.py (path:/tmp/pip-U4PVeq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:11:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:11:46 INFO - Running setup.py (path:/tmp/pip-B8HAIN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:11:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:11:46 INFO - Running setup.py (path:/tmp/pip-81iAeb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:11:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:11:46 INFO - Running setup.py (path:/tmp/pip-E9p0yX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:11:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:11:46 INFO - Running setup.py (path:/tmp/pip-ch6yCq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:11:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:11:46 INFO - Running setup.py (path:/tmp/pip-anT9AA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:11:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:11:46 INFO - Running setup.py (path:/tmp/pip-v3D8n_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:11:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:11:46 INFO - Running setup.py (path:/tmp/pip-qpxOdA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:11:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:11:46 INFO - Running setup.py (path:/tmp/pip-r8abT4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:11:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:11:46 INFO - Running setup.py (path:/tmp/pip-F4h9Yu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:11:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:11:46 INFO - Running setup.py (path:/tmp/pip-NJBkQ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:11:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:11:46 INFO - Running setup.py (path:/tmp/pip-qitjef-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:11:47 INFO - Running setup.py (path:/tmp/pip-5vF1Q9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:11:47 INFO - Running setup.py (path:/tmp/pip-Zt939e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:11:47 INFO - Running setup.py (path:/tmp/pip-_pRvR8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:11:47 INFO - Running setup.py (path:/tmp/pip-9qmVqa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:11:47 INFO - Running setup.py (path:/tmp/pip-1XObm2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:11:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:11:47 INFO - Running setup.py install for manifestparser 16:11:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:11:47 INFO - Running setup.py install for mozcrash 16:11:47 INFO - Running setup.py install for mozdebug 16:11:47 INFO - Running setup.py install for mozdevice 16:11:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:11:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:11:47 INFO - Running setup.py install for mozfile 16:11:47 INFO - Running setup.py install for mozhttpd 16:11:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:11:48 INFO - Running setup.py install for mozinfo 16:11:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:11:48 INFO - Running setup.py install for mozInstall 16:11:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:11:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:11:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:11:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:11:48 INFO - Running setup.py install for mozleak 16:11:48 INFO - Running setup.py install for mozlog 16:11:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:11:48 INFO - Running setup.py install for moznetwork 16:11:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:11:48 INFO - Running setup.py install for mozprocess 16:11:48 INFO - Running setup.py install for mozprofile 16:11:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:11:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:11:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:11:48 INFO - Running setup.py install for mozrunner 16:11:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:11:48 INFO - Running setup.py install for mozscreenshot 16:11:49 INFO - Running setup.py install for moztest 16:11:49 INFO - Running setup.py install for mozversion 16:11:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:11:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:11:49 INFO - Cleaning up... 16:11:49 INFO - Return code: 0 16:11:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:11:49 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')]} 16:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:49 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')]} 16:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:49 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 0x7f14757d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418c0>, '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 0x28427c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2842c50>, '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': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', '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 16:11:49 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 16:11:49 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 16:11:49 INFO - Using env: {'DISPLAY': ':0', 16:11:49 INFO - 'HOME': '/home/cltbld', 16:11:49 INFO - 'LANG': 'en_US.UTF-8', 16:11:49 INFO - 'LANGUAGE': 'en_US:en', 16:11:49 INFO - 'LOGNAME': 'cltbld', 16:11:49 INFO - 'MAIL': '/var/mail/cltbld', 16:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:49 INFO - 'MOZ_NO_REMOTE': '1', 16:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:49 INFO - 'NO_EM_RESTART': '1', 16:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:11:49 INFO - 'PWD': '/builds/slave/test-pgo', 16:11:49 INFO - 'SHELL': '/bin/bash', 16:11:49 INFO - 'SHLVL': '1', 16:11:49 INFO - 'TERM': 'linux', 16:11:49 INFO - 'TMOUT': '86400', 16:11:49 INFO - 'USER': 'cltbld', 16:11:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', 16:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:49 INFO - '_': '/tools/buildbot/bin/python'} 16:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:11:49 INFO - Running setup.py (path:/tmp/pip-oNq28y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:11:49 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)) 16:11:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:11:49 INFO - Running setup.py (path:/tmp/pip-FezfZs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:11:49 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)) 16:11:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:11:49 INFO - Running setup.py (path:/tmp/pip-2phDh3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:11:49 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)) 16:11:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:11:49 INFO - Running setup.py (path:/tmp/pip-7FNgJp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:11:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:11:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:11:49 INFO - Running setup.py (path:/tmp/pip-TqG77_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:11:49 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)) 16:11:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:11:49 INFO - Running setup.py (path:/tmp/pip-PGwsvy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:11:49 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)) 16:11:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:11:49 INFO - Running setup.py (path:/tmp/pip-Wb65l3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:11:49 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)) 16:11:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:11:49 INFO - Running setup.py (path:/tmp/pip-CmDkta-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:11:50 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)) 16:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:11:50 INFO - Running setup.py (path:/tmp/pip-TZsiqJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:11:50 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)) 16:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:11:50 INFO - Running setup.py (path:/tmp/pip-d4ruwA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:11:50 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)) 16:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:11:50 INFO - Running setup.py (path:/tmp/pip-TqWYFo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:11:50 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)) 16:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:11:50 INFO - Running setup.py (path:/tmp/pip-Sg5Prr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:11:50 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)) 16:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:11:50 INFO - Running setup.py (path:/tmp/pip-Th5dMj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 16:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:11:50 INFO - Running setup.py (path:/tmp/pip-8gGDlk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:11:50 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)) 16:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:11:50 INFO - Running setup.py (path:/tmp/pip-w2fv6q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:11:50 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)) 16:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:11:50 INFO - Running setup.py (path:/tmp/pip-kNx2lF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:11:50 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)) 16:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:11:50 INFO - Running setup.py (path:/tmp/pip-0EyLeo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:11:50 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)) 16:11:50 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)) 16:11: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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:11:50 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)) 16:11: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 mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:11:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11:52 INFO - Downloading blessings-1.6.tar.gz 16:11:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:11:52 INFO - Installing collected packages: blessings 16:11:52 INFO - Running setup.py install for blessings 16:11:52 INFO - Successfully installed blessings 16:11:52 INFO - Cleaning up... 16:11:52 INFO - Return code: 0 16:11:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:11:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:11:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:11:52 INFO - Reading from file tmpfile_stdout 16:11:52 INFO - Current package versions: 16:11:52 INFO - argparse == 1.2.1 16:11:52 INFO - blessings == 1.6 16:11:52 INFO - blobuploader == 1.2.4 16:11:52 INFO - docopt == 0.6.1 16:11:52 INFO - manifestparser == 1.1 16:11:52 INFO - mozInstall == 1.12 16:11:52 INFO - mozcrash == 0.16 16:11:52 INFO - mozdebug == 0.1 16:11:52 INFO - mozdevice == 0.48 16:11:52 INFO - mozfile == 1.2 16:11:52 INFO - mozhttpd == 0.7 16:11:52 INFO - mozinfo == 0.9 16:11:52 INFO - mozleak == 0.1 16:11:52 INFO - mozlog == 3.1 16:11:52 INFO - moznetwork == 0.27 16:11:52 INFO - mozprocess == 0.22 16:11:52 INFO - mozprofile == 0.28 16:11:52 INFO - mozrunner == 6.11 16:11:52 INFO - mozscreenshot == 0.1 16:11:52 INFO - mozsystemmonitor == 0.0 16:11:52 INFO - moztest == 0.7 16:11:52 INFO - mozversion == 1.4 16:11:52 INFO - psutil == 3.1.1 16:11:52 INFO - requests == 1.2.3 16:11:52 INFO - wsgiref == 0.1.2 16:11:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:11:52 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')]} 16:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:52 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')]} 16:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:52 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 0x7f14757d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418c0>, '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 0x28427c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2842c50>, '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': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', '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 16:11:52 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 16:11:52 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 16:11:52 INFO - Using env: {'DISPLAY': ':0', 16:11:52 INFO - 'HOME': '/home/cltbld', 16:11:52 INFO - 'LANG': 'en_US.UTF-8', 16:11:52 INFO - 'LANGUAGE': 'en_US:en', 16:11:52 INFO - 'LOGNAME': 'cltbld', 16:11:52 INFO - 'MAIL': '/var/mail/cltbld', 16:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:52 INFO - 'MOZ_NO_REMOTE': '1', 16:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:52 INFO - 'NO_EM_RESTART': '1', 16:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:11:52 INFO - 'PWD': '/builds/slave/test-pgo', 16:11:52 INFO - 'SHELL': '/bin/bash', 16:11:52 INFO - 'SHLVL': '1', 16:11:52 INFO - 'TERM': 'linux', 16:11:52 INFO - 'TMOUT': '86400', 16:11:52 INFO - 'USER': 'cltbld', 16:11:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', 16:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:52 INFO - '_': '/tools/buildbot/bin/python'} 16:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 16:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 16:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 16:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 16:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 16:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 16:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 16:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:11:53 INFO - Cleaning up... 16:11:53 INFO - Return code: 0 16:11:53 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:11: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')]} 16:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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')]} 16:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f14757d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418c0>, '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 0x28427c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2842c50>, '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': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', '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 16:11: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', 'jsonschema'] in /builds/slave/test-pgo/build 16:11: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 jsonschema 16:11:53 INFO - Using env: {'DISPLAY': ':0', 16:11:53 INFO - 'HOME': '/home/cltbld', 16:11:53 INFO - 'LANG': 'en_US.UTF-8', 16:11:53 INFO - 'LANGUAGE': 'en_US:en', 16:11:53 INFO - 'LOGNAME': 'cltbld', 16:11:53 INFO - 'MAIL': '/var/mail/cltbld', 16:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:53 INFO - 'MOZ_NO_REMOTE': '1', 16:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:53 INFO - 'NO_EM_RESTART': '1', 16:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:11:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:11:53 INFO - 'SHELL': '/bin/bash', 16:11:53 INFO - 'SHLVL': '1', 16:11:53 INFO - 'TERM': 'linux', 16:11:53 INFO - 'TMOUT': '86400', 16:11:53 INFO - 'USER': 'cltbld', 16:11:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', 16:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:53 INFO - '_': '/tools/buildbot/bin/python'} 16:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:53 INFO - Downloading/unpacking jsonschema 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:11:55 INFO - Downloading/unpacking functools32 (from jsonschema) 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11:55 INFO - Downloading functools32-3.2.3-2.tar.gz 16:11:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:11:55 INFO - warning: no files found matching '*.txt' 16:11:55 INFO - no previously-included directories found matching 'build' 16:11:55 INFO - no previously-included directories found matching 'dist' 16:11:55 INFO - no previously-included directories found matching '.git*' 16:11:55 INFO - Installing collected packages: jsonschema, functools32 16:11:55 INFO - Running setup.py install for functools32 16:11:55 INFO - warning: no files found matching '*.txt' 16:11:55 INFO - no previously-included directories found matching 'build' 16:11:55 INFO - no previously-included directories found matching 'dist' 16:11:55 INFO - no previously-included directories found matching '.git*' 16:11:55 INFO - Successfully installed jsonschema functools32 16:11:55 INFO - Cleaning up... 16:11:55 INFO - Return code: 0 16:11:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:11:55 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')]} 16:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:55 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')]} 16:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:55 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 0x7f14757d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418c0>, '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 0x28427c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2842c50>, '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': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', '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 16:11:55 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 16:11:55 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 16:11:55 INFO - Using env: {'DISPLAY': ':0', 16:11:55 INFO - 'HOME': '/home/cltbld', 16:11:55 INFO - 'LANG': 'en_US.UTF-8', 16:11:55 INFO - 'LANGUAGE': 'en_US:en', 16:11:55 INFO - 'LOGNAME': 'cltbld', 16:11:55 INFO - 'MAIL': '/var/mail/cltbld', 16:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:55 INFO - 'MOZ_NO_REMOTE': '1', 16:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:55 INFO - 'NO_EM_RESTART': '1', 16:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:11:55 INFO - 'PWD': '/builds/slave/test-pgo', 16:11:55 INFO - 'SHELL': '/bin/bash', 16:11:55 INFO - 'SHLVL': '1', 16:11:55 INFO - 'TERM': 'linux', 16:11:55 INFO - 'TMOUT': '86400', 16:11:55 INFO - 'USER': 'cltbld', 16:11:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', 16:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:55 INFO - '_': '/tools/buildbot/bin/python'} 16:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:55 INFO - Downloading/unpacking flake8 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:11:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:11:57 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 16:11:57 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 16:11:57 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 16:11:57 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 16:11:57 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 16:11:57 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 16:11:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:11:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:11:57 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 16:11:57 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 16:11:57 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 16:11:57 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 16:11:57 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 16:11:57 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 16:11:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:11:58 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 16:11:58 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 16:11:58 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 16:11:58 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 16:11:58 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 16:11:58 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 16:11:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:11:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:11:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:11:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:11:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:11:58 INFO - no previously-included directories found matching 'docs/_build' 16:11:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:11:58 INFO - Running setup.py install for pep8 16:11:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:11:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:11:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:11:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:11:58 INFO - no previously-included directories found matching 'docs/_build' 16:11:58 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:11:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:11:58 INFO - Cleaning up... 16:11:58 INFO - Return code: 0 16:11:58 INFO - Running post-action listener: _resource_record_post_action 16:11:58 INFO - Running post-action listener: _start_resource_monitoring 16:11:58 INFO - Starting resource monitoring. 16:11:58 INFO - ##### 16:11:58 INFO - ##### Running install step. 16:11:58 INFO - ##### 16:11:58 INFO - Running pre-action listener: _resource_record_pre_action 16:11:58 INFO - Running main action method: install 16:11:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:11:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:11:58 INFO - Reading from file tmpfile_stdout 16:11:58 INFO - Detecting whether we're running mozinstall >=1.0... 16:11:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:11:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:11:58 INFO - Reading from file tmpfile_stdout 16:11:58 INFO - Output received: 16:11:58 INFO - Usage: mozinstall [options] installer 16:11:58 INFO - Options: 16:11:58 INFO - -h, --help show this help message and exit 16:11:58 INFO - -d DEST, --destination=DEST 16:11:58 INFO - Directory to install application into. [default: 16:11:58 INFO - "/builds/slave/test-pgo"] 16:11:58 INFO - --app=APP Application being installed. [default: firefox] 16:11:58 INFO - mkdir: /builds/slave/test-pgo/build/application 16:11:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:11:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:12:15 INFO - Reading from file tmpfile_stdout 16:12:15 INFO - Output received: 16:12:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:12:15 INFO - Running post-action listener: _resource_record_post_action 16:12:15 INFO - ##### 16:12:15 INFO - ##### Running run-tests step. 16:12:15 INFO - ##### 16:12:15 INFO - Running pre-action listener: _resource_record_pre_action 16:12:15 INFO - Running main action method: run_tests 16:12:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:12:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:12:15 INFO - Python 2.7.3 16:12:15 INFO - Return code: 0 16:12:15 INFO - grabbing minidump binary from tooltool 16:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:15 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 0x28418c0>, '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 0x28427c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2842c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:12:15 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 16:12:15 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 16:12:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:12:15 INFO - Return code: 0 16:12:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:12:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:12:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:12:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:12:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:12:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:12:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:12:16 INFO - Return code: 0 16:12:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 16:12:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 16:12:16 INFO - Using env: {'DISPLAY': ':0', 16:12:16 INFO - 'HOME': '/home/cltbld', 16:12:16 INFO - 'LANG': 'en_US.UTF-8', 16:12:16 INFO - 'LANGUAGE': 'en_US:en', 16:12:16 INFO - 'LOGNAME': 'cltbld', 16:12:16 INFO - 'MAIL': '/var/mail/cltbld', 16:12:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:12:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:16 INFO - 'MOZ_NO_REMOTE': '1', 16:12:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:16 INFO - 'NO_EM_RESTART': '1', 16:12:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:12:16 INFO - 'PWD': '/builds/slave/test-pgo', 16:12:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:12:16 INFO - 'SHELL': '/bin/bash', 16:12:16 INFO - 'SHLVL': '1', 16:12:16 INFO - 'TERM': 'linux', 16:12:16 INFO - 'TMOUT': '86400', 16:12:16 INFO - 'USER': 'cltbld', 16:12:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078', 16:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:16 INFO - '_': '/tools/buildbot/bin/python'} 16:12:16 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:12:16 INFO - mozversion application_buildid: 20160211133004 16:12:16 INFO - mozversion application_changeset: 576a6dcde5b68c2ea45324ed5ce1dabb7d833d09 16:12:16 INFO - mozversion application_display_name: Nightly 16:12:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:12:16 INFO - mozversion application_name: Firefox 16:12:16 INFO - mozversion application_remotingname: firefox 16:12:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:12:16 INFO - mozversion application_vendor: Mozilla 16:12:16 INFO - mozversion application_version: 47.0a1 16:12:16 INFO - mozversion platform_buildid: 20160211133004 16:12:16 INFO - mozversion platform_changeset: 576a6dcde5b68c2ea45324ed5ce1dabb7d833d09 16:12:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:12:16 INFO - mozversion platform_version: 47.0a1 16:12:16 INFO - using testdate: 1455235936 16:12:16 INFO - actual date: 1455235936 16:12:16 INFO - starting webserver on 'localhost:37747' 16:12:16 INFO - SUITE-START | Running 2 tests 16:12:16 INFO - TEST-START | dromaeo_css 16:12:16 INFO - operating with platform_type : linux_ 16:12:16 INFO - Initialising browser for dromaeo_css test... 16:12:16 INFO - TEST-INFO | started process 23616 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYQg40U/profile http://localhost:37747/getInfo.html) 16:12:20 INFO - PROCESS | 23616 | __metrics Screen width/height:1600/1200 16:12:20 INFO - PROCESS | 23616 | colorDepth:24 16:12:20 INFO - PROCESS | 23616 | Browser inner width/height: 1024/697 16:12:20 INFO - PROCESS | 23616 | __metrics 16:12:21 INFO - PROCESS | 23616 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:12:21 INFO - TEST-INFO | 23616: exit 0 16:12:21 INFO - Browser initialized. 16:12:21 INFO - Running cycle 1/1 for dromaeo_css test... 16:12:21 INFO - TEST-INFO | started process 23708 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYQg40U/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:33 INFO - PROCESS | 23708 | RSS: Main: 153767936 16:12:33 INFO - PROCESS | 23708 | 16:13:25 INFO - PROCESS | 23708 | 1455236005081 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] 16:15:33 INFO - PROCESS | 23708 | Cycle 1(1): loaded http://localhost:37747/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37747/tests/dromaeo/cssquery-ext.html) 16:15:34 INFO - PROCESS | 23708 | RSS: Main: 230596608 16:15:34 INFO - PROCESS | 23708 | 16:18:36 INFO - PROCESS | 23708 | Cycle 1(1): loaded http://localhost:37747/tests/dromaeo/cssquery-ext.html (next: http://localhost:37747/tests/dromaeo/cssquery-jquery.html) 16:18:37 INFO - PROCESS | 23708 | RSS: Main: 243552256 16:18:37 INFO - PROCESS | 23708 | 16:21:39 INFO - PROCESS | 23708 | Cycle 1(1): loaded http://localhost:37747/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37747/tests/dromaeo/cssquery-mootools.html) 16:21:39 INFO - PROCESS | 23708 | RSS: Main: 243535872 16:21:39 INFO - PROCESS | 23708 | 16:24:41 INFO - PROCESS | 23708 | Cycle 1(1): loaded http://localhost:37747/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37747/tests/dromaeo/cssquery-prototype.html) 16:24:42 INFO - PROCESS | 23708 | RSS: Main: 221192192 16:24:42 INFO - PROCESS | 23708 | 16:27:45 INFO - PROCESS | 23708 | Cycle 1(1): loaded http://localhost:37747/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37747/tests/dromaeo/cssquery-yui.html) 16:27:45 INFO - PROCESS | 23708 | RSS: Main: 224382976 16:27:45 INFO - PROCESS | 23708 | 16:30:48 INFO - PROCESS | 23708 | Cycle 1(1): loaded http://localhost:37747/tests/dromaeo/cssquery-yui.html (next: http://localhost:37747/tests/dromaeo/cssquery-dojo.html) 16:30:48 INFO - PROCESS | 23708 | RSS: Main: 273498112 16:30:48 INFO - PROCESS | 23708 | 16:30:48 INFO - PROCESS | 23708 | __start_tp_report 16:30:48 INFO - PROCESS | 23708 | _x_x_mozilla_page_load 16:30:48 INFO - PROCESS | 23708 | _x_x_mozilla_page_load_details 16:30:48 INFO - PROCESS | 23708 | |i|pagename|runs| 16:30:48 INFO - PROCESS | 23708 | |0;dojo.html;3073.323868748875;3112.7665425093123;3151.9527207091896;3157.842107894605;3176.1424415407832;4957.157283261845;5040;5059.3169922060515;5116.25814256933;5127.794888204472;5206.999999999991;5220.530152286294;5244.947550524494;5250.579953603703;5269.314989051428;4705.200115980275;4717.315989181567;4776.450708168571;4787.49731278216;4803.927941080887;4575.405197324343;4653.464851542065;4752.643551733617;4806.7836947337455;4818.301346304784;4688.531146885318;4751.667383283171;4755.738434386108;4761.381020467352;4771.33201351811;4784.4737078921635;4792.353032340624;4794.137055330074;4805.231163013901;4812.013537224861;4625.398698169251;4681.297805329194;4756.952430475685;4775.952240477585;4777.28340748887;4849.078675051729;4870.172070747982;4882.926756098661;4889.755512224375;4915.139850526144;5364.195370694388;5626.549876009909;5667.149927510865;5683.9715801420725;5714.342850572154;5515.365732940723;5541.584381171388;5544.722763861791;5545;5546.611737178399;5118.692878427306;5173.8189163379475;5196.376434827807;5197.870053248624;5197.974010129963;5688.431156884361;5786.566007549366;5787.797427090116;5790.247267855152;5824.417558244227;5459.890802183934;5493.972530137324;5505.6696598204235;5556.77772889088;5569.10894256917;5482.725863706799;5573.749181286852;5599.1041433370465;5611.971940140274;5631.352394474606;5519.172124181325;5528.087865502147;5528.087865502228;5540.833774986757;5585.273914391103;5528.502434780889;5531.474509921551;5537.975474537224;5544.473275038865;5544.500994910478;4231.322988321854;4303.74177549348;4325.243082460557;4380.211561918822;4410.977945110254;3874.1089549403796;3880.243352546283;3882.7864467453996;3915.197384536163;3922;5195.3246078009615;5196.32447781786;5198.454162312978;5199.870003249874;5207.453217412193;5366.248725178478;5427.945720542744;5583.916241256385;5630.8029218977135;5679.886402271932;4974.403071631427;5019.799208031638;5030.748462576857;5046.772895219724;5077.898442031213;4614.723116613014;4666.883327916829;4679.204535229019;4681;4705.7647117644665;5676.262085928803;5791.102379131242;5807.593468457168;5808.070708686674;5869.61847479921;5568.220449137205;5607.046802043744;5608.831735047955;5615.747291371817;5615.747291371817;5586.636868603528;5617.606767526234;5774.740136693775;5814.418558144152;5817.738201781015;5360.597955153301;5370.275012873212;5377.516023557899;5384.461553844584;5427.1316589345515;5579.079451890392;5621.662700237999;5630.549556035589;5631.943680563142;5651.039323314964;5285.127953887565;5354.54486368663;5366.838994830161;5498.780048798003;5532.3637781655625;5450.482204190595;5451.809186678606;5455.454454554671;5462.071447853954;5494.587905907153;5319.946800531945;5367.785288588413;5373.704446255493;5383.703896285585;5433.1035379161995;5381.596380271417;5455;5463.863403414946;5488.807891723771;5496.0107180707855;5422.349318081855;5423.918641220306;5425.511703946664;5428.104362780097;5431.185322201543 16:30:48 INFO - PROCESS | 23708 | |1;ext.html;538.5153361974222;543.6221825831047;562.9669556364076;563.0709329606151;574.2075935209413;28272.85863570682;35422.64577354226;35981;36044.279114417695;36045.279094418096;37817.43273850894;38246.617533824654;38251.61748382515;38272;38307.808460957654;8373.078961314266;8570.314374849997;8576.656933722643;8576.742697719079;8579.699710510133;8365.330773538133;8483.066862645104;8488;8488.448250863705;8711.215990560848;8681.30549556034;8728.956355218246;8746.256568191711;8746.825063498727;8755.912440875605;8624.741257762276;8667.21995020445;8681.479111253282;8683.392162548624;8696.086910874363;8595.140485951417;8723.869141962876;8738.169873861973;8739.388242823004;8747.212750852454;38768.61231387678;39321.80339098315;39325.41011884824;39433;39477.80261098705;3061.6938306169204;3261.2336101016244;3350.547676063725;3732.253549290153;3795.8991892351187;29523.852380738175;29630.70369296301;29883.10350689483;30747.538786918216;31100.066997990096;3271.1004473769667;3311.6853898879567;3352.547406100194;3408.5568876046204;3462.480627905809;191716;191806;191957.04021479943;192213;192585;52078;52995.47004529982;58899;59626.403735962085;59766.70116649389;51275.743621281654;51417;51489.742551287;51532.74233628883;51563;13153.145045572008;14062;14291.857081429052;14299.285035748171;14313.427462901367;11337.26307789991;11598;11671.066314694805;11689.824652630217;11720.531178752924;18423;18721.25114995412;18820.435386938414;18855.717164242546;18862.24551017944;6956.130483689539;7184.425245980309;7251.274872512707;7266.237045110293;7274.199838017814;960.1118964957386;970.8786401699788;973.245734555725;1107.5237647811357;1108.7616162525096;25555.61666575003;26068.217953461426;26147.73852261491;26809.731902681113;28176.8591157047;1049.192122066005;1049.197364016528;1075.709558419238;1082.7942690888706;1121.9887801122047;13527.256000920044;13877.791833122512;13909.095908765898;13985.58043258704;14013.299335033207;314959;320074;320951;320970;321186;41975.79012104981;49703;50058.24912626314;50134.239932004515;50169.498305017216;1332.9666758330925;1359.728054389126;1369.5138225929652;1370.225822410335;1371.0471222500466;28253.57619635666;28379.716202837706;28772.712272877005;28951.85524072366;29178.124656260345;40622.18755624812;40897.38653920134;40911;40957;40972;208744;209582;209980;210486;210533;31914.372416000013;32029.398530073868;32171.034868953968;32240.83879580587;32260.677393225767;41934.580654193065;42093.57906420896;42891.785541072095;43044.56955430406;43194.784026079666;34788;35648.64351356557;36318;36566.45150322694;36999.630003700695;35794.463083053255;36302;36362.27275454529;36533.45199821952;36713.81643091874;36068;37189.44215836711;37445.25109497849;37449.43825842669;37493.250134996604;28896.855515722287;32147.67852321447;32367;32601.510977335834;32630.673693263714;25374.74625253724;25865.482690346464;25873.22380328593;26023.505101381983;26116.86941565356 16:30:48 INFO - PROCESS | 23708 | |2;jquery.html;357.94451859961697;362.58302951605634;363.77082438064014;363.83445532282815;364.9616790237025;13744.725105497884;13776.793348099787;16485;17228.741568876478;17658.735118973225;15935.529992851098;15977.760333594977;16483.505494835143;16514.174291285446;16539.51144397004;5288.762005709733;5431.402545719988;5431.646942948715;5451.209574611679;5465.836024919259;4074.857379991701;5416;5456.290682211307;5883.29400471944;6162.599431036968;6020.759169633231;6072.817815465543;6111.144439778434;6112.8471788205425;6118.663473508956;5950.9107363389585;6071.574989750719;6079.027355623101;6079.270487541479;6111.388861113897;5267.710275934822;5365.382980957201;5367.221752845854;5394.460553944614;5435.2934118564335;20232.898835505875;20564.485887852923;20626;20734.48163795902;20776.27283045086;2123.5646692428013;2150.720406347165;2186.4424571734266;2197.2748992832326;2298.988505057481;12889.871101288962;12954.546590869275;13073.542426015043;13291.468341266338;13489.392977316043;1827.8903265804095;1876.6152938647544;1912.8278454938984;1928.6142771445766;1961.0194902548726;55196.72401637966;55863.72068139674;56622;56962.71518642422;57317.14024289639;9666.130048295687;9849.310548261554;9921.40471571708;10023.949880250551;10036;12884.162529435556;12973;12981.41583628739;13008.8048679268;13018.479260829461;7496.7750967471065;7517.097948246136;7553.093628764584;7704.8844267336035;7728.497647652997;7093;7123.536970096927;7141.750038748619;7162.749303774447;7191.89212161818;6012.188354572077;6015.939840601538;6051.273847138284;6062.151298818169;6066.908996365058;1643.301596821346;1727.2400143936627;1777.5644966983173;1782.5276301780038;1798.6043070524463;447.20174488537805;452.111600704617;459.370662192798;467.27572262992226;928.3594319919234;9680.854787178198;10839.945800271105;10944.39805810688;11063.72340691489;11149.498272577754;469.8144233027935;495.4846959162431;504.23859971443386;890.7327801659605;1012.1953047327393;9173.908260917438;9575.760605984768;9619.155130414112;9629.133377996013;9680.128788409076;504961;508016.45991769806;511065.89137597044;511533;516582;73201;75348.62325688337;75420;76345.23654763492;76905.61547192228;1148.0872706198593;1160.5241850841114;1162.0877611075266;1169.1465230381868;1173.7769823733463;14545.127292362493;14643;14715.484958026418;14981.40074397012;15038.248087595357;31025.379492409575;32137.196570085;32271.67728322687;32276.515852262706;33400.33199336048;45965.77017114893;48263.75868120637;48501;48589.75705121452;48663.756681216364;7696.961515192612;7879.290863822283;7938.404619653665;7966.601669916597;7967.721129760431;8330.916690833013;10620.946895265783;11042.613508527164;11646.592369267035;11885.881141188478;9762.51187440611;9829.85255221158;10440.53017614194;10543.26197166191;10583.153347732008;9917.950410248191;9971.252156088178;10087.394756314645;10275.7431064224;10560.630377936735;10215.642452514126;10314.381137131797;10349.275550711378;10582.788344232918;10722.19583531254;7438.293362130589;7460.645444654226;7750.728724494616;8031.799205019687;8036.839263214586;9621.711348659552;10245.231607629607;10315.17478601725;10485.37087774736;10504.264701470824 16:30:48 INFO - PROCESS | 23708 | |3;mootools.html;1327.7875539913616;1473.557932620214;1477.475496198849;1626.674665066986;1798.199801088516;6712.295209003051;7447;7607.315341619246;7627.466077374572;7636.236376362361;7507.512011719248;7685.231476852312;7692.961535192316;7695.846083078335;7706.961465192666;1953.082051435823;2278.4303924018996;2311.641695537194;2331.0209711920947;2345.6364263539094;2319.0839618350824;2322.651602259666;2325.1513197682893;2325.6511523271474;2334.3697201755517;2275.6472746724203;2361.9763802361927;2363.196513185517;2366.8461549999283;2367.1714899785024;2254.7745225477483;2294.827887908405;2330.5804955108074;2330.918417855367;2333.288347054148;2293.3005433342823;2297.1615360393503;2308.0190918859416;2309.9653505197434;2318;7461.925380746177;7526.774196774106;7527.548347099191;7529.585872776995;7535.472516923817;4766.928496072562;4924.06442775875;4929.630277729185;4931.901361972777;4940.2342636891335;2927.9121626351243;2973.717496837797;3003.6395632524236;3115.470370037099;3118.09575223185;985.241364149608;986.1371300112402;1009.0766948242349;1024.9590016399336;1031.9277650564463;10766.784664306748;10770.623028193975;10784.730381740519;10795.622153224678;10803.83794243087;4407.228734971367;4466.4640243171025;4528.298113792367;4533.77331133442;4534.501204867462;9309.53452327381;9317.44095354281;9324.720258392259;9326.90673093274;9334.766630834283;4874.780634871439;4908.803647854046;4938.827141050046;4955.752212389438;4962.032403681247;4470.709403888737;4473.463184417826;4523.570260825217;4525.230710779176;4536.364908912755;3351.6480769519335;3729.757565758271;3755.868544600926;3783.9243215136094;3793.9241215176094;1214.611324376191;1228.668259569929;1230.7353918907477;1233.6114124050896;1234.3643023842728;899.9415038022507;909.4361495872469;910.1490106750077;930.4835816121982;1246.426643743888;7160.212376638566;7175.067241258707;7182.928170718331;7223.747168849065;7320.011798407253;1113.8607674040745;1120.6862078618;1121.8445001648151;1143.422571601336;1146.5757669662278;5750.683712395775;5835.124731290341;5837.241158649434;5838.416158384212;5847.298324201038;8887.73336799897;8994.595243214071;9159.175674189355;9171.128742769426;9175.77060573491;8945.23965462943;9059.09409059102;9061.275097992146;9074.410163339493;9077.591508382138;7104.360607545345;7456.627168641655;7457.888131678029;7465.738699145612;7468.477206595595;7152.356287934111;7167.4982751209;7236.674349654173;7256.9274307256255;7264.418846492163;8385.58072096405;8547.102554231964;8636.17956294151;8701.129887011248;8718.65125394977;8654.697085602225;8706.129387061243;8717.564121793757;8884.200421962054;8898.154675305836;5950.553708471968;6654.434373078343;6742.224644165984;6757.155355580552;6766;6303.779367722108;6342.460890824147;7155.855063189864;7310.378617817332;7326.487145899736;6826.180858296838;7079.539829911039;7128.714851406093;7145.214026456982;7201.531900426456;7007.824804379931;7064.293570642894;7080.468964827762;7184;7188.712451501881;7060.293970602898;7105.111861017373;7127.893081603676;7136.3220494052985;7141.85716285661;6472.35276472349;6480.319566445455;6525.086487891794;6533.738650453929;6540.50946179048;6549.770758023446;6608.735650574115;6614.437772789367;6620.073189753534;6620.3710647488415 16:30:48 INFO - PROCESS | 23708 | |4;prototype.html;348.19566800690404;349.8967804497673;350.76498745840286;355.057322807945;356.20743844945;5763.452472015157;5803.274590676166;5807.535397168222;5845.824625261238;5887.676177810219;5838.562107841918;5838.766449342032;5846.532277417807;5850.151727999448;5856.6193197442135;4357.411749413836;4587;4596.678232523725;4611.262198048321;4614.861554153381;4529.207388706979;4533.093381323732;4538.910661441247;4553.089382123589;4556.2254416749065;4498.460184777831;4498.572635599613;4502.954970450302;4507.346434766957;4517.774111294439;4310.310350343945;4393.582609652078;4395.538468460798;4492.281235002384;4508.549145085498;3915.0799562102884;3932.0563064864514;3942;3943.9014024649327;3946.6250706183155;5352.91970620441;5571.804986825482;5579.163125531162;5586;5600.383957764642;5066.569341605968;5186.170212765939;5191.351081114861;5192.909489007313;5194.0910340690225;6173.197484327009;6181.536384771161;6189.16446279751;6190.597611155261;6200.534959878028;4326.459192600925;4329.0259691569145;4334.934975975363;4336.91326173478;4344.391785150082;6371.39471750183;6432.421082102634;6483.254425741053;6487.999999999953;6505.121808555832;4417.801198946056;4422.955770442254;4424.756638384855;4428.003699167662;4435.068635586563;4470.038941627566;4475.619572336388;4479.745671212066;4483.641308695296;4484.080763443486;5137.306463627438;5140.948590514047;5146.922796158061;5148.9227661584355;5153.2270159476375;6130.6628135452975;6244.094606282155;6249.812505624838;6258.906116408258;6262.279837818709;1565.436442880562;1584.0495702578592;1585.0410501646568;1585.080653221129;1586.825449200587;1056.060106505211;1057.0380953332585;1061.3950048472298;1077.439731339699;1085.2945585369416;5923.644581325134;5926.733297001645;5930.584859059911;5932.110183472428;5940.6435613863305;6375.840603984938;6376.458001069868;6380.234371875312;6381.202349706286;6393.648349340738;5911.172435858984;5936.5250779937505;5938.6139900907165;5940.316863560746;5941.584089113807;3367;3463.757536972438;3474.617792042873;3475.3396854597545;3478.2521757821683;6747.359000894907;6752.257251702309;6753.425958793558;6757.526973111933;6777.220619628806;6290.528210384239;6379.362063793584;6528.902066469007;6599.439047680905;6613;6697.196336439659;6707.490814566683;6723.394894459424;6730.9326906731285;6740.797776066628;6430.614163150226;6436.3563643637135;6447.871042579216;6461.67691615408;6464.773732919513;6287.371262873676;6358.682065896594;6363.90454143179;6372.6495042773095;6378.936210637834;6713.731450742111;6721.22705888829;6721.764738234138;6727.730890764315;6734.191896972395;4426.535213802505;4435.068635586563;4449.933251001303;4457.933131002973;4461.420015397977;6321.33625969285;6471.708773105316;6478.870422591616;6480.513961453004;6524.380183882524;6331.9366806331345;6336.651484168415;6337.081123237012;6344.365563443619;6346.619202847844;6323.691852473906;6332.905006425;6382.489400847828;6402.487800976004;6409.166808314889;6108.75564977396;6231.881160405484;6233.470155036873;6245.250569931637;6245.875082498415;6347.619142851444;6396.072569477493;6408.102865598913;6416.230052393743;6420.6147631142285;6215.906761398493;6216.533759968111;6217.316095229431;6218.502519798315;6219.284782249918 16:30:48 INFO - PROCESS | 23708 | |5;yui.html;709.6451774112943;721.4985585018412;753.9698412063518;754.7018927523625;784.8351846112316;13599.660008499792;13817.378217980202;13880.167189968597;13902.791458128137;13919;13174;13259.46962121514;13263.734725305512;13272.270025148613;13284.468621255139;661.579896765555;665.9001149827541;789.7749141494661;804.6137853830165;822.839546288474;807.9838403231961;814.9022117345927;815.0871024452591;816.049302562514;816.073756286616;700.1877821726798;832.0888626953506;834.9749507514754;835.2482765511028;836.017679226909;838.9496630202177;854.239726643288;854.5385491834402;854.8717692346136;856.3106699107216;632.1844820182006;632.276043929698;632.667849379075;632.7500637248261;632.7880160146357;13090.607281781562;13095.672608184776;13125.934370328183;13158.276294803782;13166;12228.938855305756;12676.429560669792;12700;12921.676958076123;13246.867531324757;10453.163746900305;10483.73790655232;10562.894371056345;10701.304415213064;10772.784544309148;3445.3453843769603;3544.9822750886337;3562.305350456662;3585.7848529088337;3631.963680363189;44967.55032449666;45252.773736131436;45719;46706;47099;9617.663381781604;9924.652637157666;10088.44513551747;10138.898611013796;10418.322809017389;18157.54606134831;18161.36435224787;18349.266029358943;18388.540286492676;18455.723164152547;7380.261973802684;7643.5796031218815;7663.118741344817;7714.768556943301;7906.486078404885;4115.938260926088;4198.538160802309;4247.256730072287;4252.510961239435;4278.529361770203;3131.780775345704;3141.874325026973;3154.0537838648315;3174.571432856581;3188.0276515662945;552.1000768746917;565.0845630079298;569.2429069337771;577.4254616656453;583.1573376470959;598.2581598817435;599.8410421238289;601.0983524712931;613.141601757543;620.7423919073534;8442.451240669337;8534;8563.357748168788;8577.356698247657;8777.210051095304;542.4196110162168;599.310792588518;604.5496105401504;607.419913982146;654.8297442664941;3755.7934313613014;3842.865499707497;3843.865464708722;3978.622030907059;4063.9390409143884;51541;52532;52742.73628631832;52781;52868.20697689538;46413.76793116013;48640.75679621579;48757.756211218715;49254;49286.75356623194;45211;45561;45752;45950.5404945953;46884;7961.219907510559;8369.916300836914;8442.451240669337;8452.619632116692;8553;30988.53517197289;31885.840570796998;32153;33484;33589;36457.81771091127;36940.44589331109;39205.803970981106;40362;40462;10286.331388459726;10325.896741032793;10346.637867674595;10462.68611941643;10560.841587376042;11220.66338009861;11414.086873050303;11523.250988685708;11554.768904621693;11612.825807613062;10899.56401743953;11222.438878056228;11255.606053788078;11495.712607184552;11679.708007299885;10234.141596609368;10396.756156561121;10404.47977601132;10437.39645440046;10853.34879907208;10618.681439556825;10744.73138171552;10776.838347424638;11037.896210378898;11043.573418225102;9215.907840921505;9273.953630231807;9390;9506.154382817505;9740.512974351395;8964.417312874903;9151.588178531849;9286.814263714552;9482;9605.711828645151 16:30:48 INFO - PROCESS | 23708 | __end_tp_report 16:30:48 INFO - PROCESS | 23708 | __start_cc_report 16:30:48 INFO - PROCESS | 23708 | _x_x_mozilla_cycle_collect,877 16:30:48 INFO - PROCESS | 23708 | __end_cc_report 16:30:48 INFO - PROCESS | 23708 | __startTimestamp1455237048436__endTimestamp 16:30:48 INFO - PROCESS | 23708 | 16:30:48 INFO - PROCESS | 23708 | ------- Summary: start ------- 16:30:48 INFO - PROCESS | 23708 | Number of tests: 6 16:30:48 INFO - PROCESS | 23708 | 16:30:48 INFO - PROCESS | 23708 | [#0] dojo.html Cycles:165 Average:5159.13 Median:5367.79 stddev:570.57 (10.6%) stddev-sans-first:548.36 16:30:48 INFO - PROCESS | 23708 | Values: 3073.3 3112.8 3152.0 3157.8 3176.1 4957.2 5040.0 5059.3 5116.3 5127.8 5207.0 5220.5 5244.9 5250.6 5269.3 4705.2 4717.3 4776.5 4787.5 4803.9 4575.4 4653.5 4752.6 4806.8 4818.3 4688.5 4751.7 4755.7 4761.4 4771.3 4784.5 4792.4 4794.1 4805.2 4812.0 4625.4 4681.3 4757.0 4776.0 4777.3 4849.1 4870.2 4882.9 4889.8 4915.1 5364.2 5626.5 5667.1 5684.0 5714.3 5515.4 5541.6 5544.7 5545.0 5546.6 5118.7 5173.8 5196.4 5197.9 5198.0 5688.4 5786.6 5787.8 5790.2 5824.4 5459.9 5494.0 5505.7 5556.8 5569.1 5482.7 5573.7 5599.1 5612.0 5631.4 5519.2 5528.1 5528.1 5540.8 5585.3 5528.5 5531.5 5538.0 5544.5 5544.5 4231.3 4303.7 4325.2 4380.2 4411.0 3874.1 3880.2 3882.8 3915.2 3922.0 5195.3 5196.3 5198.5 5199.9 5207.5 5366.2 5427.9 5583.9 5630.8 5679.9 4974.4 5019.8 5030.7 5046.8 5077.9 4614.7 4666.9 4679.2 4681.0 4705.8 5676.3 5791.1 5807.6 5808.1 5869.6 5568.2 5607.0 5608.8 5615.7 5615.7 5586.6 5617.6 5774.7 5814.4 5817.7 5360.6 5370.3 5377.5 5384.5 5427.1 5579.1 5621.7 5630.5 5631.9 5651.0 5285.1 5354.5 5366.8 5498.8 5532.4 5450.5 5451.8 5455.5 5462.1 5494.6 5319.9 5367.8 5373.7 5383.7 5433.1 5381.6 5455.0 5463.9 5488.8 5496.0 5422.3 5423.9 5425.5 5428.1 5431.2 16:30:48 INFO - PROCESS | 23708 | 16:30:48 INFO - PROCESS | 23708 | [#1] ext.html Cycles:180 Average:41040.14 Median:36012.64 stddev:64479.40 (179.0%) stddev-sans-first:64588.56 16:30:48 INFO - PROCESS | 23708 | Values: 538.5 543.6 563.0 563.1 574.2 28272.9 35422.6 35981.0 36044.3 36045.3 37817.4 38246.6 38251.6 38272.0 38307.8 8373.1 8570.3 8576.7 8576.7 8579.7 8365.3 8483.1 8488.0 8488.4 8711.2 8681.3 8729.0 8746.3 8746.8 8755.9 8624.7 8667.2 8681.5 8683.4 8696.1 8595.1 8723.9 8738.2 8739.4 8747.2 38768.6 39321.8 39325.4 39433.0 39477.8 3061.7 3261.2 3350.5 3732.3 3795.9 29523.9 29630.7 29883.1 30747.5 31100.1 3271.1 3311.7 3352.5 3408.6 3462.5 191716.0 191806.0 191957.0 192213.0 192585.0 52078.0 52995.5 58899.0 59626.4 59766.7 51275.7 51417.0 51489.7 51532.7 51563.0 13153.1 14062.0 14291.9 14299.3 14313.4 11337.3 11598.0 11671.1 11689.8 11720.5 18423.0 18721.3 18820.4 18855.7 18862.2 6956.1 7184.4 7251.3 7266.2 7274.2 960.1 970.9 973.2 1107.5 1108.8 25555.6 26068.2 26147.7 26809.7 28176.9 1049.2 1049.2 1075.7 1082.8 1122.0 13527.3 13877.8 13909.1 13985.6 14013.3 314959.0 320074.0 320951.0 320970.0 321186.0 41975.8 49703.0 50058.2 50134.2 50169.5 1333.0 1359.7 1369.5 1370.2 1371.0 28253.6 28379.7 28772.7 28951.9 29178.1 40622.2 40897.4 40911.0 40957.0 40972.0 208744.0 209582.0 209980.0 210486.0 210533.0 31914.4 32029.4 32171.0 32240.8 32260.7 41934.6 42093.6 42891.8 43044.6 43194.8 34788.0 35648.6 36318.0 36566.5 36999.6 35794.5 36302.0 36362.3 36533.5 36713.8 36068.0 37189.4 37445.3 37449.4 37493.3 28896.9 32147.7 32367.0 32601.5 32630.7 25374.7 25865.5 25873.2 26023.5 26116.9 16:30:48 INFO - PROCESS | 23708 | 16:30:48 INFO - PROCESS | 23708 | [#2] jquery.html Cycles:180 Average:26980.93 Median:23216.52 stddev:83457.52 (359.5%) stddev-sans-first:83667.70 16:30:48 INFO - PROCESS | 23708 | Values: 357.9 362.6 363.8 363.8 365.0 13744.7 13776.8 16485.0 17228.7 17658.7 15935.5 15977.8 16483.5 16514.2 16539.5 5288.8 5431.4 5431.6 5451.2 5465.8 4074.9 5416.0 5456.3 5883.3 6162.6 6020.8 6072.8 6111.1 6112.8 6118.7 5950.9 6071.6 6079.0 6079.3 6111.4 5267.7 5365.4 5367.2 5394.5 5435.3 20232.9 20564.5 20626.0 20734.5 20776.3 2123.6 2150.7 2186.4 2197.3 2299.0 12889.9 12954.5 13073.5 13291.5 13489.4 1827.9 1876.6 1912.8 1928.6 1961.0 55196.7 55863.7 56622.0 56962.7 57317.1 9666.1 9849.3 9921.4 10023.9 10036.0 12884.2 12973.0 12981.4 13008.8 13018.5 7496.8 7517.1 7553.1 7704.9 7728.5 7093.0 7123.5 7141.8 7162.7 7191.9 6012.2 6015.9 6051.3 6062.2 6066.9 1643.3 1727.2 1777.6 1782.5 1798.6 447.2 452.1 459.4 467.3 928.4 9680.9 10839.9 10944.4 11063.7 11149.5 469.8 495.5 504.2 890.7 1012.2 9173.9 9575.8 9619.2 9629.1 9680.1 504961.0 508016.5 511065.9 511533.0 516582.0 73201.0 75348.6 75420.0 76345.2 76905.6 1148.1 1160.5 1162.1 1169.1 1173.8 14545.1 14643.0 14715.5 14981.4 15038.2 31025.4 32137.2 32271.7 32276.5 33400.3 45965.8 48263.8 48501.0 48589.8 48663.8 7697.0 7879.3 7938.4 7966.6 7967.7 8330.9 10620.9 11042.6 11646.6 11885.9 9762.5 9829.9 10440.5 10543.3 10583.2 9918.0 9971.3 10087.4 10275.7 10560.6 10215.6 10314.4 10349.3 10582.8 10722.2 7438.3 7460.6 7750.7 8031.8 8036.8 9621.7 10245.2 10315.2 10485.4 10504.3 16:30:48 INFO - PROCESS | 23708 | 16:30:48 INFO - PROCESS | 23708 | [#3] mootools.html Cycles:180 Average:5462.28 Median:6537.12 stddev:2798.86 (42.8%) stddev-sans-first:2789.46 16:30:48 INFO - PROCESS | 23708 | Values: 1327.8 1473.6 1477.5 1626.7 1798.2 6712.3 7447.0 7607.3 7627.5 7636.2 7507.5 7685.2 7693.0 7695.8 7707.0 1953.1 2278.4 2311.6 2331.0 2345.6 2319.1 2322.7 2325.2 2325.7 2334.4 2275.6 2362.0 2363.2 2366.8 2367.2 2254.8 2294.8 2330.6 2330.9 2333.3 2293.3 2297.2 2308.0 2310.0 2318.0 7461.9 7526.8 7527.5 7529.6 7535.5 4766.9 4924.1 4929.6 4931.9 4940.2 2927.9 2973.7 3003.6 3115.5 3118.1 985.2 986.1 1009.1 1025.0 1031.9 10766.8 10770.6 10784.7 10795.6 10803.8 4407.2 4466.5 4528.3 4533.8 4534.5 9309.5 9317.4 9324.7 9326.9 9334.8 4874.8 4908.8 4938.8 4955.8 4962.0 4470.7 4473.5 4523.6 4525.2 4536.4 3351.6 3729.8 3755.9 3783.9 3793.9 1214.6 1228.7 1230.7 1233.6 1234.4 899.9 909.4 910.1 930.5 1246.4 7160.2 7175.1 7182.9 7223.7 7320.0 1113.9 1120.7 1121.8 1143.4 1146.6 5750.7 5835.1 5837.2 5838.4 5847.3 8887.7 8994.6 9159.2 9171.1 9175.8 8945.2 9059.1 9061.3 9074.4 9077.6 7104.4 7456.6 7457.9 7465.7 7468.5 7152.4 7167.5 7236.7 7256.9 7264.4 8385.6 8547.1 8636.2 8701.1 8718.7 8654.7 8706.1 8717.6 8884.2 8898.2 5950.6 6654.4 6742.2 6757.2 6766.0 6303.8 6342.5 7155.9 7310.4 7326.5 6826.2 7079.5 7128.7 7145.2 7201.5 7007.8 7064.3 7080.5 7184.0 7188.7 7060.3 7105.1 7127.9 7136.3 7141.9 6472.4 6480.3 6525.1 6533.7 6540.5 6549.8 6608.7 6614.4 6620.1 6620.4 16:30:48 INFO - PROCESS | 23708 | 16:30:48 INFO - PROCESS | 23708 | [#4] prototype.html Cycles:180 Average:5227.96 Median:5917.41 stddev:1577.37 (26.7%) stddev-sans-first:1538.68 16:30:48 INFO - PROCESS | 23708 | Values: 348.2 349.9 350.8 355.1 356.2 5763.5 5803.3 5807.5 5845.8 5887.7 5838.6 5838.8 5846.5 5850.2 5856.6 4357.4 4587.0 4596.7 4611.3 4614.9 4529.2 4533.1 4538.9 4553.1 4556.2 4498.5 4498.6 4503.0 4507.3 4517.8 4310.3 4393.6 4395.5 4492.3 4508.5 3915.1 3932.1 3942.0 3943.9 3946.6 5352.9 5571.8 5579.2 5586.0 5600.4 5066.6 5186.2 5191.4 5192.9 5194.1 6173.2 6181.5 6189.2 6190.6 6200.5 4326.5 4329.0 4334.9 4336.9 4344.4 6371.4 6432.4 6483.3 6488.0 6505.1 4417.8 4423.0 4424.8 4428.0 4435.1 4470.0 4475.6 4479.7 4483.6 4484.1 5137.3 5140.9 5146.9 5148.9 5153.2 6130.7 6244.1 6249.8 6258.9 6262.3 1565.4 1584.0 1585.0 1585.1 1586.8 1056.1 1057.0 1061.4 1077.4 1085.3 5923.6 5926.7 5930.6 5932.1 5940.6 6375.8 6376.5 6380.2 6381.2 6393.6 5911.2 5936.5 5938.6 5940.3 5941.6 3367.0 3463.8 3474.6 3475.3 3478.3 6747.4 6752.3 6753.4 6757.5 6777.2 6290.5 6379.4 6528.9 6599.4 6613.0 6697.2 6707.5 6723.4 6730.9 6740.8 6430.6 6436.4 6447.9 6461.7 6464.8 6287.4 6358.7 6363.9 6372.6 6378.9 6713.7 6721.2 6721.8 6727.7 6734.2 4426.5 4435.1 4449.9 4457.9 4461.4 6321.3 6471.7 6478.9 6480.5 6524.4 6331.9 6336.7 6337.1 6344.4 6346.6 6323.7 6332.9 6382.5 6402.5 6409.2 6108.8 6231.9 6233.5 6245.3 6245.9 6347.6 6396.1 6408.1 6416.2 6420.6 6215.9 6216.5 6217.3 6218.5 6219.3 16:30:48 INFO - PROCESS | 23708 | 16:30:48 INFO - PROCESS | 23708 | [#5] yui.html Cycles:180 Average:13188.56 Median:45406.89 stddev:14850.22 (32.7%) stddev-sans-first:14862.31 16:30:48 INFO - PROCESS | 23708 | Values: 709.6 721.5 754.0 754.7 784.8 13599.7 13817.4 13880.2 13902.8 13919.0 13174.0 13259.5 13263.7 13272.3 13284.5 661.6 665.9 789.8 804.6 822.8 808.0 814.9 815.1 816.0 816.1 700.2 832.1 835.0 835.2 836.0 838.9 854.2 854.5 854.9 856.3 632.2 632.3 632.7 632.8 632.8 13090.6 13095.7 13125.9 13158.3 13166.0 12228.9 12676.4 12700.0 12921.7 13246.9 10453.2 10483.7 10562.9 10701.3 10772.8 3445.3 3545.0 3562.3 3585.8 3632.0 44967.6 45252.8 45719.0 46706.0 47099.0 9617.7 9924.7 10088.4 10138.9 10418.3 18157.5 18161.4 18349.3 18388.5 18455.7 7380.3 7643.6 7663.1 7714.8 7906.5 4115.9 4198.5 4247.3 4252.5 4278.5 3131.8 3141.9 3154.1 3174.6 3188.0 552.1 565.1 569.2 577.4 583.2 598.3 599.8 601.1 613.1 620.7 8442.5 8534.0 8563.4 8577.4 8777.2 542.4 599.3 604.5 607.4 654.8 3755.8 3842.9 3843.9 3978.6 4063.9 51541.0 52532.0 52742.7 52781.0 52868.2 46413.8 48640.8 48757.8 49254.0 49286.8 45211.0 45561.0 45752.0 45950.5 46884.0 7961.2 8369.9 8442.5 8452.6 8553.0 30988.5 31885.8 32153.0 33484.0 33589.0 36457.8 36940.4 39205.8 40362.0 40462.0 10286.3 10325.9 10346.6 10462.7 10560.8 11220.7 11414.1 11523.3 11554.8 11612.8 10899.6 11222.4 11255.6 11495.7 11679.7 10234.1 10396.8 10404.5 10437.4 10853.3 10618.7 10744.7 10776.8 11037.9 11043.6 9215.9 9274.0 9390.0 9506.2 9740.5 8964.4 9151.6 9286.8 9482.0 9605.7 16:30:48 INFO - PROCESS | 23708 | -------- Summary: end -------- 16:30:48 INFO - PROCESS | 23708 | 16:30:49 INFO - TEST-INFO | 23708: exit 0 16:30:49 INFO - TEST-OK | dromaeo_css | took 1112742ms 16:30:49 INFO - TEST-START | kraken 16:30:49 INFO - operating with platform_type : linux_ 16:30:49 INFO - Initialising browser for kraken test... 16:30:49 INFO - TEST-INFO | started process 23897 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLyk6Nf/profile http://localhost:37747/getInfo.html) 16:30:53 INFO - PROCESS | 23897 | __metrics Screen width/height:1600/1200 16:30:53 INFO - PROCESS | 23897 | colorDepth:24 16:30:53 INFO - PROCESS | 23897 | Browser inner width/height: 1024/697 16:30:53 INFO - PROCESS | 23897 | __metrics 16:30:53 INFO - PROCESS | 23897 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:30:54 INFO - TEST-INFO | 23897: exit 0 16:30:54 INFO - Browser initialized. 16:30:54 INFO - Running cycle 1/1 for kraken test... 16:30:54 INFO - TEST-INFO | started process 23979 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLyk6Nf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:31:06 INFO - PROCESS | 23979 | RSS: Main: 153571328 16:31:06 INFO - PROCESS | 23979 | 16:31:08 INFO - PROCESS | 23979 | Cycle 1(1): loaded http://localhost:37747/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37747/tests/kraken/driver.html?testName=audio-beat-detection) 16:31:09 INFO - PROCESS | 23979 | RSS: Main: 197029888 16:31:09 INFO - PROCESS | 23979 | 16:31:12 INFO - PROCESS | 23979 | Cycle 1(1): loaded http://localhost:37747/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37747/tests/kraken/driver.html?testName=audio-dft) 16:31:12 INFO - PROCESS | 23979 | RSS: Main: 187015168 16:31:12 INFO - PROCESS | 23979 | 16:31:15 INFO - PROCESS | 23979 | Cycle 1(1): loaded http://localhost:37747/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37747/tests/kraken/driver.html?testName=audio-fft) 16:31:16 INFO - PROCESS | 23979 | RSS: Main: 170676224 16:31:16 INFO - PROCESS | 23979 | 16:31:18 INFO - PROCESS | 23979 | Cycle 1(1): loaded http://localhost:37747/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37747/tests/kraken/driver.html?testName=audio-oscillator) 16:31:18 INFO - PROCESS | 23979 | RSS: Main: 173051904 16:31:18 INFO - PROCESS | 23979 | 16:31:20 INFO - PROCESS | 23979 | Cycle 1(1): loaded http://localhost:37747/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37747/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:31:21 INFO - PROCESS | 23979 | RSS: Main: 174657536 16:31:21 INFO - PROCESS | 23979 | 16:31:24 INFO - PROCESS | 23979 | Cycle 1(1): loaded http://localhost:37747/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37747/tests/kraken/driver.html?testName=imaging-darkroom) 16:31:25 INFO - PROCESS | 23979 | RSS: Main: 173850624 16:31:25 INFO - PROCESS | 23979 | 16:31:28 INFO - PROCESS | 23979 | Cycle 1(1): loaded http://localhost:37747/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37747/tests/kraken/driver.html?testName=imaging-desaturate) 16:31:29 INFO - PROCESS | 23979 | RSS: Main: 174764032 16:31:29 INFO - PROCESS | 23979 | 16:31:31 INFO - PROCESS | 23979 | Cycle 1(1): loaded http://localhost:37747/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37747/tests/kraken/driver.html?testName=json-parse-financial) 16:31:32 INFO - PROCESS | 23979 | RSS: Main: 175345664 16:31:32 INFO - PROCESS | 23979 | 16:31:33 INFO - PROCESS | 23979 | Cycle 1(1): loaded http://localhost:37747/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37747/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:31:34 INFO - PROCESS | 23979 | RSS: Main: 187744256 16:31:34 INFO - PROCESS | 23979 | 16:31:36 INFO - PROCESS | 23979 | Cycle 1(1): loaded http://localhost:37747/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37747/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:31:36 INFO - PROCESS | 23979 | RSS: Main: 183107584 16:31:36 INFO - PROCESS | 23979 | 16:31:38 INFO - PROCESS | 23979 | Cycle 1(1): loaded http://localhost:37747/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37747/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:31:39 INFO - PROCESS | 23979 | RSS: Main: 196079616 16:31:39 INFO - PROCESS | 23979 | 16:31:42 INFO - PROCESS | 23979 | Cycle 1(1): loaded http://localhost:37747/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:31:42 INFO - PROCESS | 23979 | RSS: Main: 200105984 16:31:42 INFO - PROCESS | 23979 | 16:31:45 INFO - PROCESS | 23979 | Cycle 1(1): loaded http://localhost:37747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:31:45 INFO - PROCESS | 23979 | RSS: Main: 199733248 16:31:45 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | Cycle 1(1): loaded http://localhost:37747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37747/tests/kraken/driver.html?testName=ai-astar) 16:31:47 INFO - PROCESS | 23979 | RSS: Main: 259043328 16:31:47 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | __start_tp_report 16:31:47 INFO - PROCESS | 23979 | _x_x_mozilla_page_load 16:31:47 INFO - PROCESS | 23979 | _x_x_mozilla_page_load_details 16:31:47 INFO - PROCESS | 23979 | |i|pagename|runs| 16:31:47 INFO - PROCESS | 23979 | |0;ai-astar;110;112;105;110;111;110;101;110;111;111 16:31:47 INFO - PROCESS | 23979 | |1;audio-beat-detection;152;126;156;171;132;155;154;134;171;135 16:31:47 INFO - PROCESS | 23979 | |2;audio-dft;160;160;159;159;161;161;161;165;161;161 16:31:47 INFO - PROCESS | 23979 | |3;audio-fft;73;72;93;97;75;74;73;121;94;73 16:31:47 INFO - PROCESS | 23979 | |4;audio-oscillator;95;98;140;94;95;96;143;94;95;138 16:31:47 INFO - PROCESS | 23979 | |5;imaging-gaussian-blur;119;116;114;115;114;114;115;114;115;114 16:31:47 INFO - PROCESS | 23979 | |6;imaging-darkroom;145;145;146;145;146;145;145;146;145;145 16:31:47 INFO - PROCESS | 23979 | |7;imaging-desaturate;95;96;95;96;97;97;97;97;97;96 16:31:47 INFO - PROCESS | 23979 | |8;json-parse-financial;62;58;55;56;55;56;55;64;54;54 16:31:47 INFO - PROCESS | 23979 | |9;json-stringify-tinderbox;66;67;66;67;67;67;67;74;67;67 16:31:47 INFO - PROCESS | 23979 | |10;stanford-crypto-aes;82;81;83;83;82;82;82;82;83;84 16:31:47 INFO - PROCESS | 23979 | |11;stanford-crypto-ccm;125;122;121;114;122;117;119;117;124;118 16:31:47 INFO - PROCESS | 23979 | |12;stanford-crypto-pbkdf2;140;143;141;151;151;140;141;148;150;149 16:31:47 INFO - PROCESS | 23979 | |13;stanford-crypto-sha256-iterative;70;69;70;69;69;68;69;71;68;73 16:31:47 INFO - PROCESS | 23979 | __end_tp_report 16:31:47 INFO - PROCESS | 23979 | __start_cc_report 16:31:47 INFO - PROCESS | 23979 | _x_x_mozilla_cycle_collect,995 16:31:47 INFO - PROCESS | 23979 | __end_cc_report 16:31:47 INFO - PROCESS | 23979 | __startTimestamp1455237107738__endTimestamp 16:31:47 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | ------- Summary: start ------- 16:31:47 INFO - PROCESS | 23979 | Number of tests: 14 16:31:47 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:3.41 (3.1%) stddev-sans-first:3.61 16:31:47 INFO - PROCESS | 23979 | Values: 110.0 112.0 105.0 110.0 111.0 110.0 101.0 110.0 111.0 111.0 16:31:47 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:154.50 stddev:16.07 (10.4%) stddev-sans-first:17.00 16:31:47 INFO - PROCESS | 23979 | Values: 152.0 126.0 156.0 171.0 132.0 155.0 154.0 134.0 171.0 135.0 16:31:47 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.69 (1.0%) stddev-sans-first:1.76 16:31:47 INFO - PROCESS | 23979 | Values: 160.0 160.0 159.0 159.0 161.0 161.0 161.0 165.0 161.0 161.0 16:31:47 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | [#3] audio-fft Cycles:10 Average:84.50 Median:74.50 stddev:16.35 (21.9%) stddev-sans-first:16.80 16:31:47 INFO - PROCESS | 23979 | Values: 73.0 72.0 93.0 97.0 75.0 74.0 73.0 121.0 94.0 73.0 16:31:47 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:95.00 stddev:21.82 (23.0%) stddev-sans-first:22.57 16:31:47 INFO - PROCESS | 23979 | Values: 95.0 98.0 140.0 94.0 95.0 96.0 143.0 94.0 95.0 138.0 16:31:47 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:1.56 (1.4%) stddev-sans-first:0.73 16:31:47 INFO - PROCESS | 23979 | Values: 119.0 116.0 114.0 115.0 114.0 114.0 115.0 114.0 115.0 114.0 16:31:47 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 16:31:47 INFO - PROCESS | 23979 | Values: 145.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 16:31:47 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.73 16:31:47 INFO - PROCESS | 23979 | Values: 95.0 96.0 95.0 96.0 97.0 97.0 97.0 97.0 97.0 96.0 16:31:47 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:56.00 stddev:3.45 (6.2%) stddev-sans-first:3.12 16:31:47 INFO - PROCESS | 23979 | Values: 62.0 58.0 55.0 56.0 55.0 56.0 55.0 64.0 54.0 54.0 16:31:47 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:2.32 (3.5%) stddev-sans-first:2.40 16:31:47 INFO - PROCESS | 23979 | Values: 66.0 67.0 66.0 67.0 67.0 67.0 67.0 74.0 67.0 67.0 16:31:47 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:0.84 (1.0%) stddev-sans-first:0.88 16:31:47 INFO - PROCESS | 23979 | Values: 82.0 81.0 83.0 83.0 82.0 82.0 82.0 82.0 83.0 84.0 16:31:47 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:121.50 stddev:3.48 (2.9%) stddev-sans-first:3.16 16:31:47 INFO - PROCESS | 23979 | Values: 125.0 122.0 121.0 114.0 122.0 117.0 119.0 117.0 124.0 118.0 16:31:47 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:148.50 stddev:4.79 (3.2%) stddev-sans-first:4.66 16:31:47 INFO - PROCESS | 23979 | Values: 140.0 143.0 141.0 151.0 151.0 140.0 141.0 148.0 150.0 149.0 16:31:47 INFO - PROCESS | 23979 | 16:31:47 INFO - PROCESS | 23979 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:1.51 (2.2%) stddev-sans-first:1.59 16:31:47 INFO - PROCESS | 23979 | Values: 70.0 69.0 70.0 69.0 69.0 68.0 69.0 71.0 68.0 73.0 16:31:47 INFO - PROCESS | 23979 | -------- Summary: end -------- 16:31:47 INFO - PROCESS | 23979 | 16:31:48 INFO - TEST-INFO | 23979: exit 0 16:31:48 INFO - TEST-OK | kraken | took 59442ms 16:31:48 INFO - SUITE-END | took 1172s 16:31:48 INFO - Completed test suite (00:19:32) 16:31:48 INFO - Working with test: dromaeo_css 16:31:48 INFO - Generating results file: dromaeo_css 16:31:48 INFO - Working with test: kraken 16:31:48 INFO - Generating results file: kraken 16:31:48 INFO - javascript benchmark 16:31:48 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:31:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 16:31:48 INFO - process_Request line: dromaeo_css 6765.74 graph.html#tests=[[72,1,35]] 16:31:48 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:31:48 INFO - process_Request line: kraken 1510.10 graph.html#tests=[[232,1,35]] 16:31:48 INFO - RETURN: dromaeo_css: 6765.74 16:31:48 INFO - RETURN: kraken: 1510.10 16:31:48 INFO - javascript benchmark 16:31:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3073.323868748875, 3112.7665425093123, 3151.9527207091896, 3157.842107894605, 3176.1424415407832, 4957.157283261845, 5040.0, 5059.3169922060515, 5116.25814256933, 5127.794888204472, 5206.999999999991, 5220.530152286294, 5244.947550524494, 5250.579953603703, 5269.314989051428, 4705.200115980275, 4717.315989181567, 4776.450708168571, 4787.49731278216, 4803.927941080887, 4575.405197324343, 4653.464851542065, 4752.643551733617, 4806.7836947337455, 4818.301346304784, 4688.531146885318, 4751.667383283171, 4755.738434386108, 4761.381020467352, 4771.33201351811, 4784.4737078921635, 4792.353032340624, 4794.137055330074, 4805.231163013901, 4812.013537224861, 4625.398698169251, 4681.297805329194, 4756.952430475685, 4775.952240477585, 4777.28340748887, 4849.078675051729, 4870.172070747982, 4882.926756098661, 4889.755512224375, 4915.139850526144, 5364.195370694388, 5626.549876009909, 5667.149927510865, 5683.9715801420725, 5714.342850572154, 5515.365732940723, 5541.584381171388, 5544.722763861791, 5545.0, 5546.611737178399, 5118.692878427306, 5173.8189163379475, 5196.376434827807, 5197.870053248624, 5197.974010129963, 5688.431156884361, 5786.566007549366, 5787.797427090116, 5790.247267855152, 5824.417558244227, 5459.890802183934, 5493.972530137324, 5505.6696598204235, 5556.77772889088, 5569.10894256917, 5482.725863706799, 5573.749181286852, 5599.1041433370465, 5611.971940140274, 5631.352394474606, 5519.172124181325, 5528.087865502147, 5528.087865502228, 5540.833774986757, 5585.273914391103, 5528.502434780889, 5531.474509921551, 5537.975474537224, 5544.473275038865, 5544.500994910478, 4231.322988321854, 4303.74177549348, 4325.243082460557, 4380.211561918822, 4410.977945110254, 3874.1089549403796, 3880.243352546283, 3882.7864467453996, 3915.197384536163, 3922.0, 5195.3246078009615, 5196.32447781786, 5198.454162312978, 5199.870003249874, 5207.453217412193, 5366.248725178478, 5427.945720542744, 5583.916241256385, 5630.8029218977135, 5679.886402271932, 4974.403071631427, 5019.799208031638, 5030.748462576857, 5046.772895219724, 5077.898442031213, 4614.723116613014, 4666.883327916829, 4679.204535229019, 4681.0, 4705.7647117644665, 5676.262085928803, 5791.102379131242, 5807.593468457168, 5808.070708686674, 5869.61847479921, 5568.220449137205, 5607.046802043744, 5608.831735047955, 5615.747291371817, 5615.747291371817, 5586.636868603528, 5617.606767526234, 5774.740136693775, 5814.418558144152, 5817.738201781015, 5360.597955153301, 5370.275012873212, 5377.516023557899, 5384.461553844584, 5427.1316589345515, 5579.079451890392, 5621.662700237999, 5630.549556035589, 5631.943680563142, 5651.039323314964, 5285.127953887565, 5354.54486368663, 5366.838994830161, 5498.780048798003, 5532.3637781655625, 5450.482204190595, 5451.809186678606, 5455.454454554671, 5462.071447853954, 5494.587905907153, 5319.946800531945, 5367.785288588413, 5373.704446255493, 5383.703896285585, 5433.1035379161995, 5381.596380271417, 5455.0, 5463.863403414946, 5488.807891723771, 5496.0107180707855, 5422.349318081855, 5423.918641220306, 5425.511703946664, 5428.104362780097, 5431.185322201543], "unit": "score", "name": "dojo.html", "value": 5122.776256841819}, {"lowerIsBetter": false, "replicates": [538.5153361974222, 543.6221825831047, 562.9669556364076, 563.0709329606151, 574.2075935209413, 28272.85863570682, 35422.64577354226, 35981.0, 36044.279114417695, 36045.279094418096, 37817.43273850894, 38246.617533824654, 38251.61748382515, 38272.0, 38307.808460957654, 8373.078961314266, 8570.314374849997, 8576.656933722643, 8576.742697719079, 8579.699710510133, 8365.330773538133, 8483.066862645104, 8488.0, 8488.448250863705, 8711.215990560848, 8681.30549556034, 8728.956355218246, 8746.256568191711, 8746.825063498727, 8755.912440875605, 8624.741257762276, 8667.21995020445, 8681.479111253282, 8683.392162548624, 8696.086910874363, 8595.140485951417, 8723.869141962876, 8738.169873861973, 8739.388242823004, 8747.212750852454, 38768.61231387678, 39321.80339098315, 39325.41011884824, 39433.0, 39477.80261098705, 3061.6938306169204, 3261.2336101016244, 3350.547676063725, 3732.253549290153, 3795.8991892351187, 29523.852380738175, 29630.70369296301, 29883.10350689483, 30747.538786918216, 31100.066997990096, 3271.1004473769667, 3311.6853898879567, 3352.547406100194, 3408.5568876046204, 3462.480627905809, 191716.0, 191806.0, 191957.04021479943, 192213.0, 192585.0, 52078.0, 52995.47004529982, 58899.0, 59626.403735962085, 59766.70116649389, 51275.743621281654, 51417.0, 51489.742551287, 51532.74233628883, 51563.0, 13153.145045572008, 14062.0, 14291.857081429052, 14299.285035748171, 14313.427462901367, 11337.26307789991, 11598.0, 11671.066314694805, 11689.824652630217, 11720.531178752924, 18423.0, 18721.25114995412, 18820.435386938414, 18855.717164242546, 18862.24551017944, 6956.130483689539, 7184.425245980309, 7251.274872512707, 7266.237045110293, 7274.199838017814, 960.1118964957386, 970.8786401699788, 973.245734555725, 1107.5237647811357, 1108.7616162525096, 25555.61666575003, 26068.217953461426, 26147.73852261491, 26809.731902681113, 28176.8591157047, 1049.192122066005, 1049.197364016528, 1075.709558419238, 1082.7942690888706, 1121.9887801122047, 13527.256000920044, 13877.791833122512, 13909.095908765898, 13985.58043258704, 14013.299335033207, 314959.0, 320074.0, 320951.0, 320970.0, 321186.0, 41975.79012104981, 49703.0, 50058.24912626314, 50134.239932004515, 50169.498305017216, 1332.9666758330925, 1359.728054389126, 1369.5138225929652, 1370.225822410335, 1371.0471222500466, 28253.57619635666, 28379.716202837706, 28772.712272877005, 28951.85524072366, 29178.124656260345, 40622.18755624812, 40897.38653920134, 40911.0, 40957.0, 40972.0, 208744.0, 209582.0, 209980.0, 210486.0, 210533.0, 31914.372416000013, 32029.398530073868, 32171.034868953968, 32240.83879580587, 32260.677393225767, 41934.580654193065, 42093.57906420896, 42891.785541072095, 43044.56955430406, 43194.784026079666, 34788.0, 35648.64351356557, 36318.0, 36566.45150322694, 36999.630003700695, 35794.463083053255, 36302.0, 36362.27275454529, 36533.45199821952, 36713.81643091874, 36068.0, 37189.44215836711, 37445.25109497849, 37449.43825842669, 37493.250134996604, 28896.855515722287, 32147.67852321447, 32367.0, 32601.510977335834, 32630.673693263714, 25374.74625253724, 25865.482690346464, 25873.22380328593, 26023.505101381983, 26116.86941565356], "unit": "score", "name": "ext.html", "value": 17591.981827538708}, {"lowerIsBetter": false, "replicates": [357.94451859961697, 362.58302951605634, 363.77082438064014, 363.83445532282815, 364.9616790237025, 13744.725105497884, 13776.793348099787, 16485.0, 17228.741568876478, 17658.735118973225, 15935.529992851098, 15977.760333594977, 16483.505494835143, 16514.174291285446, 16539.51144397004, 5288.762005709733, 5431.402545719988, 5431.646942948715, 5451.209574611679, 5465.836024919259, 4074.857379991701, 5416.0, 5456.290682211307, 5883.29400471944, 6162.599431036968, 6020.759169633231, 6072.817815465543, 6111.144439778434, 6112.8471788205425, 6118.663473508956, 5950.9107363389585, 6071.574989750719, 6079.027355623101, 6079.270487541479, 6111.388861113897, 5267.710275934822, 5365.382980957201, 5367.221752845854, 5394.460553944614, 5435.2934118564335, 20232.898835505875, 20564.485887852923, 20626.0, 20734.48163795902, 20776.27283045086, 2123.5646692428013, 2150.720406347165, 2186.4424571734266, 2197.2748992832326, 2298.988505057481, 12889.871101288962, 12954.546590869275, 13073.542426015043, 13291.468341266338, 13489.392977316043, 1827.8903265804095, 1876.6152938647544, 1912.8278454938984, 1928.6142771445766, 1961.0194902548726, 55196.72401637966, 55863.72068139674, 56622.0, 56962.71518642422, 57317.14024289639, 9666.130048295687, 9849.310548261554, 9921.40471571708, 10023.949880250551, 10036.0, 12884.162529435556, 12973.0, 12981.41583628739, 13008.8048679268, 13018.479260829461, 7496.7750967471065, 7517.097948246136, 7553.093628764584, 7704.8844267336035, 7728.497647652997, 7093.0, 7123.536970096927, 7141.750038748619, 7162.749303774447, 7191.89212161818, 6012.188354572077, 6015.939840601538, 6051.273847138284, 6062.151298818169, 6066.908996365058, 1643.301596821346, 1727.2400143936627, 1777.5644966983173, 1782.5276301780038, 1798.6043070524463, 447.20174488537805, 452.111600704617, 459.370662192798, 467.27572262992226, 928.3594319919234, 9680.854787178198, 10839.945800271105, 10944.39805810688, 11063.72340691489, 11149.498272577754, 469.8144233027935, 495.4846959162431, 504.23859971443386, 890.7327801659605, 1012.1953047327393, 9173.908260917438, 9575.760605984768, 9619.155130414112, 9629.133377996013, 9680.128788409076, 504961.0, 508016.45991769806, 511065.89137597044, 511533.0, 516582.0, 73201.0, 75348.62325688337, 75420.0, 76345.23654763492, 76905.61547192228, 1148.0872706198593, 1160.5241850841114, 1162.0877611075266, 1169.1465230381868, 1173.7769823733463, 14545.127292362493, 14643.0, 14715.484958026418, 14981.40074397012, 15038.248087595357, 31025.379492409575, 32137.196570085, 32271.67728322687, 32276.515852262706, 33400.33199336048, 45965.77017114893, 48263.75868120637, 48501.0, 48589.75705121452, 48663.756681216364, 7696.961515192612, 7879.290863822283, 7938.404619653665, 7966.601669916597, 7967.721129760431, 8330.916690833013, 10620.946895265783, 11042.613508527164, 11646.592369267035, 11885.881141188478, 9762.51187440611, 9829.85255221158, 10440.53017614194, 10543.26197166191, 10583.153347732008, 9917.950410248191, 9971.252156088178, 10087.394756314645, 10275.7431064224, 10560.630377936735, 10215.642452514126, 10314.381137131797, 10349.275550711378, 10582.788344232918, 10722.19583531254, 7438.293362130589, 7460.645444654226, 7750.728724494616, 8031.799205019687, 8036.839263214586, 9621.711348659552, 10245.231607629607, 10315.17478601725, 10485.37087774736, 10504.264701470824], "unit": "score", "name": "jquery.html", "value": 8178.350310228646}, {"lowerIsBetter": false, "replicates": [1327.7875539913616, 1473.557932620214, 1477.475496198849, 1626.674665066986, 1798.199801088516, 6712.295209003051, 7447.0, 7607.315341619246, 7627.466077374572, 7636.236376362361, 7507.512011719248, 7685.231476852312, 7692.961535192316, 7695.846083078335, 7706.961465192666, 1953.082051435823, 2278.4303924018996, 2311.641695537194, 2331.0209711920947, 2345.6364263539094, 2319.0839618350824, 2322.651602259666, 2325.1513197682893, 2325.6511523271474, 2334.3697201755517, 2275.6472746724203, 2361.9763802361927, 2363.196513185517, 2366.8461549999283, 2367.1714899785024, 2254.7745225477483, 2294.827887908405, 2330.5804955108074, 2330.918417855367, 2333.288347054148, 2293.3005433342823, 2297.1615360393503, 2308.0190918859416, 2309.9653505197434, 2318.0, 7461.925380746177, 7526.774196774106, 7527.548347099191, 7529.585872776995, 7535.472516923817, 4766.928496072562, 4924.06442775875, 4929.630277729185, 4931.901361972777, 4940.2342636891335, 2927.9121626351243, 2973.717496837797, 3003.6395632524236, 3115.470370037099, 3118.09575223185, 985.241364149608, 986.1371300112402, 1009.0766948242349, 1024.9590016399336, 1031.9277650564463, 10766.784664306748, 10770.623028193975, 10784.730381740519, 10795.622153224678, 10803.83794243087, 4407.228734971367, 4466.4640243171025, 4528.298113792367, 4533.77331133442, 4534.501204867462, 9309.53452327381, 9317.44095354281, 9324.720258392259, 9326.90673093274, 9334.766630834283, 4874.780634871439, 4908.803647854046, 4938.827141050046, 4955.752212389438, 4962.032403681247, 4470.709403888737, 4473.463184417826, 4523.570260825217, 4525.230710779176, 4536.364908912755, 3351.6480769519335, 3729.757565758271, 3755.868544600926, 3783.9243215136094, 3793.9241215176094, 1214.611324376191, 1228.668259569929, 1230.7353918907477, 1233.6114124050896, 1234.3643023842728, 899.9415038022507, 909.4361495872469, 910.1490106750077, 930.4835816121982, 1246.426643743888, 7160.212376638566, 7175.067241258707, 7182.928170718331, 7223.747168849065, 7320.011798407253, 1113.8607674040745, 1120.6862078618, 1121.8445001648151, 1143.422571601336, 1146.5757669662278, 5750.683712395775, 5835.124731290341, 5837.241158649434, 5838.416158384212, 5847.298324201038, 8887.73336799897, 8994.595243214071, 9159.175674189355, 9171.128742769426, 9175.77060573491, 8945.23965462943, 9059.09409059102, 9061.275097992146, 9074.410163339493, 9077.591508382138, 7104.360607545345, 7456.627168641655, 7457.888131678029, 7465.738699145612, 7468.477206595595, 7152.356287934111, 7167.4982751209, 7236.674349654173, 7256.9274307256255, 7264.418846492163, 8385.58072096405, 8547.102554231964, 8636.17956294151, 8701.129887011248, 8718.65125394977, 8654.697085602225, 8706.129387061243, 8717.564121793757, 8884.200421962054, 8898.154675305836, 5950.553708471968, 6654.434373078343, 6742.224644165984, 6757.155355580552, 6766.0, 6303.779367722108, 6342.460890824147, 7155.855063189864, 7310.378617817332, 7326.487145899736, 6826.180858296838, 7079.539829911039, 7128.714851406093, 7145.214026456982, 7201.531900426456, 7007.824804379931, 7064.293570642894, 7080.468964827762, 7184.0, 7188.712451501881, 7060.293970602898, 7105.111861017373, 7127.893081603676, 7136.3220494052985, 7141.85716285661, 6472.35276472349, 6480.319566445455, 6525.086487891794, 6533.738650453929, 6540.50946179048, 6549.770758023446, 6608.735650574115, 6614.437772789367, 6620.073189753534, 6620.3710647488415], "unit": "score", "name": "mootools.html", "value": 4493.322739788608}, {"lowerIsBetter": false, "replicates": [348.19566800690404, 349.8967804497673, 350.76498745840286, 355.057322807945, 356.20743844945, 5763.452472015157, 5803.274590676166, 5807.535397168222, 5845.824625261238, 5887.676177810219, 5838.562107841918, 5838.766449342032, 5846.532277417807, 5850.151727999448, 5856.6193197442135, 4357.411749413836, 4587.0, 4596.678232523725, 4611.262198048321, 4614.861554153381, 4529.207388706979, 4533.093381323732, 4538.910661441247, 4553.089382123589, 4556.2254416749065, 4498.460184777831, 4498.572635599613, 4502.954970450302, 4507.346434766957, 4517.774111294439, 4310.310350343945, 4393.582609652078, 4395.538468460798, 4492.281235002384, 4508.549145085498, 3915.0799562102884, 3932.0563064864514, 3942.0, 3943.9014024649327, 3946.6250706183155, 5352.91970620441, 5571.804986825482, 5579.163125531162, 5586.0, 5600.383957764642, 5066.569341605968, 5186.170212765939, 5191.351081114861, 5192.909489007313, 5194.0910340690225, 6173.197484327009, 6181.536384771161, 6189.16446279751, 6190.597611155261, 6200.534959878028, 4326.459192600925, 4329.0259691569145, 4334.934975975363, 4336.91326173478, 4344.391785150082, 6371.39471750183, 6432.421082102634, 6483.254425741053, 6487.999999999953, 6505.121808555832, 4417.801198946056, 4422.955770442254, 4424.756638384855, 4428.003699167662, 4435.068635586563, 4470.038941627566, 4475.619572336388, 4479.745671212066, 4483.641308695296, 4484.080763443486, 5137.306463627438, 5140.948590514047, 5146.922796158061, 5148.9227661584355, 5153.2270159476375, 6130.6628135452975, 6244.094606282155, 6249.812505624838, 6258.906116408258, 6262.279837818709, 1565.436442880562, 1584.0495702578592, 1585.0410501646568, 1585.080653221129, 1586.825449200587, 1056.060106505211, 1057.0380953332585, 1061.3950048472298, 1077.439731339699, 1085.2945585369416, 5923.644581325134, 5926.733297001645, 5930.584859059911, 5932.110183472428, 5940.6435613863305, 6375.840603984938, 6376.458001069868, 6380.234371875312, 6381.202349706286, 6393.648349340738, 5911.172435858984, 5936.5250779937505, 5938.6139900907165, 5940.316863560746, 5941.584089113807, 3367.0, 3463.757536972438, 3474.617792042873, 3475.3396854597545, 3478.2521757821683, 6747.359000894907, 6752.257251702309, 6753.425958793558, 6757.526973111933, 6777.220619628806, 6290.528210384239, 6379.362063793584, 6528.902066469007, 6599.439047680905, 6613.0, 6697.196336439659, 6707.490814566683, 6723.394894459424, 6730.9326906731285, 6740.797776066628, 6430.614163150226, 6436.3563643637135, 6447.871042579216, 6461.67691615408, 6464.773732919513, 6287.371262873676, 6358.682065896594, 6363.90454143179, 6372.6495042773095, 6378.936210637834, 6713.731450742111, 6721.22705888829, 6721.764738234138, 6727.730890764315, 6734.191896972395, 4426.535213802505, 4435.068635586563, 4449.933251001303, 4457.933131002973, 4461.420015397977, 6321.33625969285, 6471.708773105316, 6478.870422591616, 6480.513961453004, 6524.380183882524, 6331.9366806331345, 6336.651484168415, 6337.081123237012, 6344.365563443619, 6346.619202847844, 6323.691852473906, 6332.905006425, 6382.489400847828, 6402.487800976004, 6409.166808314889, 6108.75564977396, 6231.881160405484, 6233.470155036873, 6245.250569931637, 6245.875082498415, 6347.619142851444, 6396.072569477493, 6408.102865598913, 6416.230052393743, 6420.6147631142285, 6215.906761398493, 6216.533759968111, 6217.316095229431, 6218.502519798315, 6219.284782249918], "unit": "score", "name": "prototype.html", "value": 4722.4544107706815}, {"lowerIsBetter": false, "replicates": [709.6451774112943, 721.4985585018412, 753.9698412063518, 754.7018927523625, 784.8351846112316, 13599.660008499792, 13817.378217980202, 13880.167189968597, 13902.791458128137, 13919.0, 13174.0, 13259.46962121514, 13263.734725305512, 13272.270025148613, 13284.468621255139, 661.579896765555, 665.9001149827541, 789.7749141494661, 804.6137853830165, 822.839546288474, 807.9838403231961, 814.9022117345927, 815.0871024452591, 816.049302562514, 816.073756286616, 700.1877821726798, 832.0888626953506, 834.9749507514754, 835.2482765511028, 836.017679226909, 838.9496630202177, 854.239726643288, 854.5385491834402, 854.8717692346136, 856.3106699107216, 632.1844820182006, 632.276043929698, 632.667849379075, 632.7500637248261, 632.7880160146357, 13090.607281781562, 13095.672608184776, 13125.934370328183, 13158.276294803782, 13166.0, 12228.938855305756, 12676.429560669792, 12700.0, 12921.676958076123, 13246.867531324757, 10453.163746900305, 10483.73790655232, 10562.894371056345, 10701.304415213064, 10772.784544309148, 3445.3453843769603, 3544.9822750886337, 3562.305350456662, 3585.7848529088337, 3631.963680363189, 44967.55032449666, 45252.773736131436, 45719.0, 46706.0, 47099.0, 9617.663381781604, 9924.652637157666, 10088.44513551747, 10138.898611013796, 10418.322809017389, 18157.54606134831, 18161.36435224787, 18349.266029358943, 18388.540286492676, 18455.723164152547, 7380.261973802684, 7643.5796031218815, 7663.118741344817, 7714.768556943301, 7906.486078404885, 4115.938260926088, 4198.538160802309, 4247.256730072287, 4252.510961239435, 4278.529361770203, 3131.780775345704, 3141.874325026973, 3154.0537838648315, 3174.571432856581, 3188.0276515662945, 552.1000768746917, 565.0845630079298, 569.2429069337771, 577.4254616656453, 583.1573376470959, 598.2581598817435, 599.8410421238289, 601.0983524712931, 613.141601757543, 620.7423919073534, 8442.451240669337, 8534.0, 8563.357748168788, 8577.356698247657, 8777.210051095304, 542.4196110162168, 599.310792588518, 604.5496105401504, 607.419913982146, 654.8297442664941, 3755.7934313613014, 3842.865499707497, 3843.865464708722, 3978.622030907059, 4063.9390409143884, 51541.0, 52532.0, 52742.73628631832, 52781.0, 52868.20697689538, 46413.76793116013, 48640.75679621579, 48757.756211218715, 49254.0, 49286.75356623194, 45211.0, 45561.0, 45752.0, 45950.5404945953, 46884.0, 7961.219907510559, 8369.916300836914, 8442.451240669337, 8452.619632116692, 8553.0, 30988.53517197289, 31885.840570796998, 32153.0, 33484.0, 33589.0, 36457.81771091127, 36940.44589331109, 39205.803970981106, 40362.0, 40462.0, 10286.331388459726, 10325.896741032793, 10346.637867674595, 10462.68611941643, 10560.841587376042, 11220.66338009861, 11414.086873050303, 11523.250988685708, 11554.768904621693, 11612.825807613062, 10899.56401743953, 11222.438878056228, 11255.606053788078, 11495.712607184552, 11679.708007299885, 10234.141596609368, 10396.756156561121, 10404.47977601132, 10437.39645440046, 10853.34879907208, 10618.681439556825, 10744.73138171552, 10776.838347424638, 11037.896210378898, 11043.573418225102, 9215.907840921505, 9273.953630231807, 9390.0, 9506.154382817505, 9740.512974351395, 8964.417312874903, 9151.588178531849, 9286.814263714552, 9482.0, 9605.711828645151], "unit": "score", "name": "yui.html", "value": 6132.429879350397}], "name": "dromaeo_css", "value": 6765.737064725529}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 110.0, 111.0, 110.0, 101.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [152.0, 126.0, 156.0, 171.0, 132.0, 155.0, 154.0, 134.0, 171.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 159.0, 159.0, 161.0, 161.0, 161.0, 165.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 93.0, 97.0, 75.0, 74.0, 73.0, 121.0, 94.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.5}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 140.0, 94.0, 95.0, 96.0, 143.0, 94.0, 95.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0, 115.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.0}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [62.0, 58.0, 55.0, 56.0, 55.0, 56.0, 55.0, 64.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 74.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 83.0, 83.0, 82.0, 82.0, 82.0, 82.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [125.0, 122.0, 121.0, 114.0, 122.0, 117.0, 119.0, 117.0, 124.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.9}, {"lowerIsBetter": true, "replicates": [140.0, 143.0, 141.0, 151.0, 151.0, 140.0, 141.0, 148.0, 150.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 70.0, 69.0, 69.0, 68.0, 69.0, 71.0, 68.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1510.1000000000001}]} 16:31:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1510.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6765.74"}}} 16:31:49 INFO - Return code: 0 16:31:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:31:49 INFO - # TBPL SUCCESS # 16:31:49 INFO - Running post-action listener: _resource_record_post_action 16:31:49 INFO - Running post-run listener: _resource_record_post_run 16:31:50 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 539492352; Read time: 0; Write time: 654816 16:31:50 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 240259072; Read time: 0; Write time: 346172 16:31:50 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 299233280; Read time: 0; Write time: 308644 16:31:50 INFO - Running post-run listener: _upload_blobber_files 16:31:50 INFO - Blob upload gear active. 16:31:50 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:31:50 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:31:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:31:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:31:50 INFO - (blobuploader) - INFO - Open directory for files ... 16:31:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 16:31:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:31:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:51 INFO - (blobuploader) - INFO - Done attempting. 16:31:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:31:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:31:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:52 INFO - (blobuploader) - INFO - Done attempting. 16:31:52 INFO - (blobuploader) - INFO - Iteration through files over. 16:31:52 INFO - Return code: 0 16:31:52 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:31:52 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:31:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e08fe092b4851c662729a88d35d2d118b4c797fae49866424f51b2884bac80f3410c4e26700531c2f8114f6e4eb57994145fd48a0f3a37acc93398587a8cdd86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5127840edb7c8836eb2a80c614ae29a26bd9ec2e9a312a8261f3144a1d793f54d57cc813864af60e58c97ac260c99268aea04d22a0aa49482020d96466b4b7b8"} 16:31:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:31:52 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:31:52 INFO - Contents: 16:31:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e08fe092b4851c662729a88d35d2d118b4c797fae49866424f51b2884bac80f3410c4e26700531c2f8114f6e4eb57994145fd48a0f3a37acc93398587a8cdd86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5127840edb7c8836eb2a80c614ae29a26bd9ec2e9a312a8261f3144a1d793f54d57cc813864af60e58c97ac260c99268aea04d22a0aa49482020d96466b4b7b8"} 16:31:52 INFO - Running post-run listener: copy_logs_to_upload_dir 16:31:52 INFO - Copying logs to upload dir... 16:31:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:31:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.624787 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-02-11 16:31:52.005751) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 16:31:52.009966) ========= 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=232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e08fe092b4851c662729a88d35d2d118b4c797fae49866424f51b2884bac80f3410c4e26700531c2f8114f6e4eb57994145fd48a0f3a37acc93398587a8cdd86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5127840edb7c8836eb2a80c614ae29a26bd9ec2e9a312a8261f3144a1d793f54d57cc813864af60e58c97ac260c99268aea04d22a0aa49482020d96466b4b7b8"} build_url:https://queue.taskcluster.net/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/NLo10tAnQBujuxawEa1IHw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e08fe092b4851c662729a88d35d2d118b4c797fae49866424f51b2884bac80f3410c4e26700531c2f8114f6e4eb57994145fd48a0f3a37acc93398587a8cdd86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5127840edb7c8836eb2a80c614ae29a26bd9ec2e9a312a8261f3144a1d793f54d57cc813864af60e58c97ac260c99268aea04d22a0aa49482020d96466b4b7b8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 16:31:52.035054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 16:31:52.035404) ========= 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=232498196343f89f466a4a9a000001c8-1455235588.565506-1389591078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 16:31:52.120286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 16:31:52.120659) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 16:31:52.120972) ========= ========= Total master_lag: 0.28 =========