builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1455638489.13 results: success (0) buildid: 20160216053003 builduid: 5b53b1ce454241878cd037cc17e0432a revision: cf16002d74e4a8ae9a8c5e7ef2de7e9876c61f3f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.128240) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.128662) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.128957) ========= 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-1455637418.694631-1118322085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006342 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.151924) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.152209) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.165521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.165870) ========= 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-1455637418.694631-1118322085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004702 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.215069) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.215347) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.215673) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.215942) ========= 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-1455637418.694631-1118322085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-16 08:01:29-- 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% 28.2M=0s 2016-02-16 08:01:29 (28.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095965 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.323699) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.323975) ========= 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-1455637418.694631-1118322085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022175 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.372692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.373023) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cf16002d74e4a8ae9a8c5e7ef2de7e9876c61f3f --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev cf16002d74e4a8ae9a8c5e7ef2de7e9876c61f3f --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-1455637418.694631-1118322085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-16 08:01:29,490 truncating revision to first 12 chars 2016-02-16 08:01:29,490 Setting DEBUG logging. 2016-02-16 08:01:29,490 attempt 1/10 2016-02-16 08:01:29,490 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cf16002d74e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-16 08:01:29,743 unpacking tar archive at: fx-team-cf16002d74e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.530921 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.917055) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.917456) ========= echo cf16002d74e4a8ae9a8c5e7ef2de7e9876c61f3f in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'cf16002d74e4a8ae9a8c5e7ef2de7e9876c61f3f'] 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-1455637418.694631-1118322085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False cf16002d74e4a8ae9a8c5e7ef2de7e9876c61f3f program finished with exit code 0 elapsedTime=0.004092 script_repo_revision: 'cf16002d74e4a8ae9a8c5e7ef2de7e9876c61f3f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.966685) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.966964) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 08:01:29.976611) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-02-16 08:01:29.976912) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1455637418.694631-1118322085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:01:30 INFO - MultiFileLogger online at 20160216 08:01:30 in /builds/slave/test-pgo 08:01:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:01:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:01:30 INFO - {'append_to_log': False, 08:01:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:01:30 INFO - 'blob_upload_branch': 'Fx-Team', 08:01:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:01:30 INFO - 'branch': 'Fx-Team', 08:01:30 INFO - 'buildbot_json_path': 'buildprops.json', 08:01:30 INFO - 'config_files': ('talos/linux_config.py',), 08:01:30 INFO - 'default_actions': ('clobber', 08:01:30 INFO - 'read-buildbot-config', 08:01:30 INFO - 'download-and-extract', 08:01:30 INFO - 'populate-webroot', 08:01:30 INFO - 'create-virtualenv', 08:01:30 INFO - 'install', 08:01:30 INFO - 'run-tests'), 08:01:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:01:30 INFO - 'download_minidump_stackwalk': True, 08:01:30 INFO - 'download_symbols': 'ondemand', 08:01:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:01:30 INFO - 'tooltool.py': '/tools/tooltool.py', 08:01:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:01:30 INFO - '/tools/misc-python/virtualenv.py')}, 08:01:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:01:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:01:30 INFO - 'installer_path': 'installer.exe', 08:01:30 INFO - 'log_level': 'info', 08:01:30 INFO - 'log_name': 'talos', 08:01:30 INFO - 'log_to_console': True, 08:01:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:01:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:01:30 INFO - 'opt_config_files': (), 08:01:30 INFO - 'pip_index': False, 08:01:30 INFO - 'sps_profile': False, 08:01:30 INFO - 'sps_profile_interval': 0, 08:01:30 INFO - 'suite': 'dromaeojs', 08:01:30 INFO - 'system_bits': '32', 08:01:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:01:30 INFO - 'title': 'talos-linux64-ix-025', 08:01:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:01:30 INFO - 'use_talos_json': True, 08:01:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:01:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:01:30 INFO - 'work_dir': 'build'} 08:01:30 INFO - ##### 08:01:30 INFO - ##### Running clobber step. 08:01:30 INFO - ##### 08:01:30 INFO - Running pre-action listener: _resource_record_pre_action 08:01:30 INFO - Running main action method: clobber 08:01:30 INFO - rmtree: /builds/slave/test-pgo/build 08:01:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:01:31 INFO - Running post-action listener: _resource_record_post_action 08:01:31 INFO - ##### 08:01:31 INFO - ##### Running read-buildbot-config step. 08:01:31 INFO - ##### 08:01:31 INFO - Running pre-action listener: _resource_record_pre_action 08:01:31 INFO - Running main action method: read_buildbot_config 08:01:31 INFO - Using buildbot properties: 08:01:31 INFO - { 08:01:31 INFO - "project": "", 08:01:31 INFO - "product": "firefox", 08:01:31 INFO - "script_repo_revision": "production", 08:01:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:01:31 INFO - "repository": "", 08:01:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:01:31 INFO - "buildid": "20160216053003", 08:01:31 INFO - "pgo_build": "True", 08:01:31 INFO - "basedir": "/builds/slave/test-pgo", 08:01:31 INFO - "buildnumber": 946, 08:01:31 INFO - "slavename": "talos-linux64-ix-025", 08:01:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:01:31 INFO - "platform": "ubuntu64_hw", 08:01:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:01:31 INFO - "branch": "fx-team", 08:01:31 INFO - "repo_path": "integration/fx-team", 08:01:31 INFO - "revision": "cf16002d74e4a8ae9a8c5e7ef2de7e9876c61f3f", 08:01:31 INFO - "stage_platform": "linux64-pgo", 08:01:31 INFO - "builduid": "5b53b1ce454241878cd037cc17e0432a", 08:01:31 INFO - "slavebuilddir": "test" 08:01:31 INFO - } 08:01:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 08:01:31 INFO - Running post-action listener: _resource_record_post_action 08:01:31 INFO - ##### 08:01:31 INFO - ##### Running download-and-extract step. 08:01:31 INFO - ##### 08:01:31 INFO - Running pre-action listener: _resource_record_pre_action 08:01:31 INFO - Running main action method: download_and_extract 08:01:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:01: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')]} 08:01:31 INFO - https://queue.taskcluster.net/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:01:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/test_packages.json 08:01:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/test_packages.json 08:01:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:01:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:01:33 INFO - Downloaded 1448 bytes. 08:01:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:01:33 INFO - Using the following test package requirements: 08:01:33 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:01:33 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:01:33 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:01:33 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:33 INFO - u'jsshell-linux-x86_64.zip'], 08:01:33 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:01:33 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:01:33 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:01:33 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:01:33 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:01:33 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:01:33 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:01:33 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:33 INFO - https://queue.taskcluster.net/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:01:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:01:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:01:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/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 08:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/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 08:01:49 INFO - Downloaded 23343345 bytes. 08:01:49 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'] 08:01:49 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 08:01:50 INFO - Return code: 0 08:01:50 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 08:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:50 INFO - https://queue.taskcluster.net/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:01:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:01:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:01:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/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 08:01:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/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 08:01:51 INFO - Downloaded 23343345 bytes. 08:01:51 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'] 08:01:51 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 08:01:53 INFO - Return code: 0 08:01: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')]} 08:01:53 INFO - https://queue.taskcluster.net/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:01:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:01:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:01:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/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 08:01:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/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 08:01:53 INFO - Downloaded 10707071 bytes. 08:01:54 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'] 08:01:54 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 08:01:54 INFO - Return code: 0 08:01:54 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')]} 08:01:54 INFO - https://queue.taskcluster.net/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:01:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:01:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:01:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/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 08:01:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXzLuuyTRJySgOiLW92_CQ/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 08:01:55 INFO - Downloaded 56558794 bytes. 08:01:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:01:55 INFO - mkdir: /builds/slave/test-pgo/properties 08:01:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:01:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:01:55 INFO - Contents: 08:01:55 INFO - build_url:https://queue.taskcluster.net/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:01:56 INFO - Running post-action listener: _resource_record_post_action 08:01:56 INFO - Running post-action listener: set_extra_try_arguments 08:01:56 INFO - ##### 08:01:56 INFO - ##### Running populate-webroot step. 08:01:56 INFO - ##### 08:01:56 INFO - Running pre-action listener: _resource_record_pre_action 08:01:56 INFO - Running main action method: populate_webroot 08:01:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:01:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:01:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:01:56 INFO - '--tppagecycles', 08:01:56 INFO - '7'], 08:01:56 INFO - 'tests': ['tsvgm']}}, 08:01:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:01:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:01:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:01:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:01:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:01:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:01:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:01:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:56 INFO - 'talos_options': ['--e10s'], 08:01:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:01:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:56 INFO - 'tests': ['damp', 'tps']}, 08:01:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:56 INFO - 'talos_options': ['--e10s'], 08:01:56 INFO - 'tests': ['damp', 'tps']}, 08:01:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:01:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:01:56 INFO - 'other': {'tests': ['a11yr', 08:01:56 INFO - 'ts_paint', 08:01:56 INFO - 'tpaint', 08:01:56 INFO - 'sessionrestore', 08:01:56 INFO - 'sessionrestore_no_auto_restore']}, 08:01:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:01:56 INFO - 'tests': ['a11yr', 08:01:56 INFO - 'ts_paint', 08:01:56 INFO - 'tpaint', 08:01:56 INFO - 'sessionrestore', 08:01:56 INFO - 'sessionrestore_no_auto_restore']}, 08:01:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:01:56 INFO - 'tests': ['a11yr', 08:01:56 INFO - 'ts_paint', 08:01:56 INFO - 'tpaint', 08:01:56 INFO - 'sessionrestore', 08:01:56 INFO - 'sessionrestore_no_auto_restore']}, 08:01:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:01:56 INFO - 'tests': ['a11yr', 08:01:56 INFO - 'ts_paint', 08:01:56 INFO - 'tpaint', 08:01:56 INFO - 'sessionrestore', 08:01:56 INFO - 'sessionrestore_no_auto_restore']}, 08:01:56 INFO - 'other_l64': {'tests': ['a11yr', 08:01:56 INFO - 'ts_paint', 08:01:56 INFO - 'tpaint', 08:01:56 INFO - 'sessionrestore', 08:01:56 INFO - 'sessionrestore_no_auto_restore']}, 08:01:56 INFO - 'other_nol64': {'tests': ['a11yr', 08:01:56 INFO - 'ts_paint', 08:01:56 INFO - 'tpaint', 08:01:56 INFO - 'sessionrestore', 08:01:56 INFO - 'sessionrestore_no_auto_restore']}, 08:01:56 INFO - 'svgr': {'tests': ['tsvgx', 08:01:56 INFO - 'tsvgr_opacity', 08:01:56 INFO - 'tart', 08:01:56 INFO - 'tscrollx', 08:01:56 INFO - 'cart']}, 08:01:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:01:56 INFO - 'tests': ['tsvgx', 08:01:56 INFO - 'tsvgr_opacity', 08:01:56 INFO - 'tart', 08:01:56 INFO - 'tscrollx', 08:01:56 INFO - 'cart']}, 08:01:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:56 INFO - 'tests': ['tp5o']}, 08:01:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:56 INFO - 'talos_options': ['--e10s'], 08:01:56 INFO - 'tests': ['tp5o']}, 08:01:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:56 INFO - 'talos_options': ['--xperf_path', 08:01:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:01:56 INFO - 'tests': ['tp5n']}, 08:01:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:56 INFO - 'talos_options': ['--e10s', 08:01:56 INFO - '--xperf_path', 08:01:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:01:56 INFO - 'tests': ['tp5n']}}, 08:01:56 INFO - 'talos.zip': {'path': '', 08:01:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:01:56 INFO - Running post-action listener: _resource_record_post_action 08:01:56 INFO - ##### 08:01:56 INFO - ##### Running create-virtualenv step. 08:01:56 INFO - ##### 08:01:56 INFO - Running pre-action listener: _resource_record_pre_action 08:01:56 INFO - Running main action method: create_virtualenv 08:01:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:01:56 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 08:01:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:01:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:01:56 INFO - Using real prefix '/usr' 08:01:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:01:56 INFO - Installing distribute.............................................................................................................................................................................................done. 08:01:58 INFO - Installing pip.................done. 08:01:58 INFO - Return code: 0 08:01:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:58 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 0x7f3720904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22288c0>, '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 0x22297c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229c50>, '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-1455637418.694631-1118322085', '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 08:01:58 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 08:01:58 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 08:01:58 INFO - Using env: {'DISPLAY': ':0', 08:01:58 INFO - 'HOME': '/home/cltbld', 08:01:58 INFO - 'LANG': 'en_US.UTF-8', 08:01:58 INFO - 'LANGUAGE': 'en_US:en', 08:01:58 INFO - 'LOGNAME': 'cltbld', 08:01:58 INFO - 'MAIL': '/var/mail/cltbld', 08:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:58 INFO - 'MOZ_NO_REMOTE': '1', 08:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:58 INFO - 'NO_EM_RESTART': '1', 08:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:01:58 INFO - 'PWD': '/builds/slave/test-pgo', 08:01:58 INFO - 'SHELL': '/bin/bash', 08:01:58 INFO - 'SHLVL': '1', 08:01:58 INFO - 'TERM': 'linux', 08:01:58 INFO - 'TMOUT': '86400', 08:01:58 INFO - 'USER': 'cltbld', 08:01:58 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455637418.694631-1118322085', 08:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:58 INFO - '_': '/tools/buildbot/bin/python'} 08:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:59 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 08:01:59 INFO - Cleaning up... 08:01:59 INFO - Return code: 0 08:01:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:01:59 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')]} 08:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:59 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')]} 08:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:59 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 0x7f3720904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22288c0>, '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 0x22297c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229c50>, '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-1455637418.694631-1118322085', '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 08:01:59 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 08:01:59 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 08:01:59 INFO - Using env: {'DISPLAY': ':0', 08:01:59 INFO - 'HOME': '/home/cltbld', 08:01:59 INFO - 'LANG': 'en_US.UTF-8', 08:01:59 INFO - 'LANGUAGE': 'en_US:en', 08:01:59 INFO - 'LOGNAME': 'cltbld', 08:01:59 INFO - 'MAIL': '/var/mail/cltbld', 08:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:59 INFO - 'MOZ_NO_REMOTE': '1', 08:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:59 INFO - 'NO_EM_RESTART': '1', 08:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:01:59 INFO - 'PWD': '/builds/slave/test-pgo', 08:01:59 INFO - 'SHELL': '/bin/bash', 08:01:59 INFO - 'SHLVL': '1', 08:01:59 INFO - 'TERM': 'linux', 08:01:59 INFO - 'TMOUT': '86400', 08:01:59 INFO - 'USER': 'cltbld', 08:01:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455637418.694631-1118322085', 08:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:59 INFO - '_': '/tools/buildbot/bin/python'} 08:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:59 INFO - Downloading/unpacking psutil>=0.7.1 08:01:59 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 08:01:59 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 08:01:59 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 08:01:59 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 08:01:59 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 08:01:59 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 08:02:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:02:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:01 INFO - Installing collected packages: psutil 08:02:01 INFO - Running setup.py install for psutil 08:02:01 INFO - building 'psutil._psutil_linux' extension 08:02:01 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 08:02:01 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 08:02:01 INFO - building 'psutil._psutil_posix' extension 08:02:01 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 08:02:01 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 08:02:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:01 INFO - Successfully installed psutil 08:02:01 INFO - Cleaning up... 08:02:01 INFO - Return code: 0 08:02:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:01 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 0x7f3720904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22288c0>, '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 0x22297c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229c50>, '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-1455637418.694631-1118322085', '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 08:02:01 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 08:02:01 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 08:02:01 INFO - Using env: {'DISPLAY': ':0', 08:02:01 INFO - 'HOME': '/home/cltbld', 08:02:01 INFO - 'LANG': 'en_US.UTF-8', 08:02:01 INFO - 'LANGUAGE': 'en_US:en', 08:02:01 INFO - 'LOGNAME': 'cltbld', 08:02:01 INFO - 'MAIL': '/var/mail/cltbld', 08:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:01 INFO - 'MOZ_NO_REMOTE': '1', 08:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:01 INFO - 'NO_EM_RESTART': '1', 08:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:02:01 INFO - 'PWD': '/builds/slave/test-pgo', 08:02:01 INFO - 'SHELL': '/bin/bash', 08:02:01 INFO - 'SHLVL': '1', 08:02:01 INFO - 'TERM': 'linux', 08:02:01 INFO - 'TMOUT': '86400', 08:02:01 INFO - 'USER': 'cltbld', 08:02:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455637418.694631-1118322085', 08:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:01 INFO - '_': '/tools/buildbot/bin/python'} 08:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:02:01 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 08:02:01 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 08:02:01 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 08:02:01 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 08:02:01 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 08:02:01 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 08:02:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:02:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:02:03 INFO - Installing collected packages: mozsystemmonitor 08:02:03 INFO - Running setup.py install for mozsystemmonitor 08:02:03 INFO - Successfully installed mozsystemmonitor 08:02:03 INFO - Cleaning up... 08:02:03 INFO - Return code: 0 08:02:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:02:03 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')]} 08:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:03 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')]} 08:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:03 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 0x7f3720904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22288c0>, '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 0x22297c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229c50>, '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-1455637418.694631-1118322085', '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 08:02:03 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 08:02:03 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 08:02:03 INFO - Using env: {'DISPLAY': ':0', 08:02:03 INFO - 'HOME': '/home/cltbld', 08:02:03 INFO - 'LANG': 'en_US.UTF-8', 08:02:03 INFO - 'LANGUAGE': 'en_US:en', 08:02:03 INFO - 'LOGNAME': 'cltbld', 08:02:03 INFO - 'MAIL': '/var/mail/cltbld', 08:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:03 INFO - 'MOZ_NO_REMOTE': '1', 08:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:03 INFO - 'NO_EM_RESTART': '1', 08:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:02:03 INFO - 'PWD': '/builds/slave/test-pgo', 08:02:03 INFO - 'SHELL': '/bin/bash', 08:02:03 INFO - 'SHLVL': '1', 08:02:03 INFO - 'TERM': 'linux', 08:02:03 INFO - 'TMOUT': '86400', 08:02:03 INFO - 'USER': 'cltbld', 08:02:03 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455637418.694631-1118322085', 08:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:03 INFO - '_': '/tools/buildbot/bin/python'} 08:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:04 INFO - Downloading/unpacking blobuploader==1.2.4 08:02:04 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 08:02:04 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 08:02:04 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 08:02:04 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 08:02:04 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 08:02:04 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 08:02:05 INFO - Downloading blobuploader-1.2.4.tar.gz 08:02:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:02:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:02:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:06 INFO - Downloading docopt-0.6.1.tar.gz 08:02:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:02:06 INFO - Installing collected packages: blobuploader, requests, docopt 08:02:06 INFO - Running setup.py install for blobuploader 08:02:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:02:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:02:06 INFO - Running setup.py install for requests 08:02:07 INFO - Running setup.py install for docopt 08:02:07 INFO - Successfully installed blobuploader requests docopt 08:02:07 INFO - Cleaning up... 08:02:07 INFO - Return code: 0 08:02:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:02:07 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')]} 08:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:07 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')]} 08:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:07 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 0x7f3720904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22288c0>, '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 0x22297c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229c50>, '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-1455637418.694631-1118322085', '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 08:02:07 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 08:02:07 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 08:02:07 INFO - Using env: {'DISPLAY': ':0', 08:02:07 INFO - 'HOME': '/home/cltbld', 08:02:07 INFO - 'LANG': 'en_US.UTF-8', 08:02:07 INFO - 'LANGUAGE': 'en_US:en', 08:02:07 INFO - 'LOGNAME': 'cltbld', 08:02:07 INFO - 'MAIL': '/var/mail/cltbld', 08:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:07 INFO - 'MOZ_NO_REMOTE': '1', 08:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:07 INFO - 'NO_EM_RESTART': '1', 08:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:02:07 INFO - 'PWD': '/builds/slave/test-pgo', 08:02:07 INFO - 'SHELL': '/bin/bash', 08:02:07 INFO - 'SHLVL': '1', 08:02:07 INFO - 'TERM': 'linux', 08:02:07 INFO - 'TMOUT': '86400', 08:02:07 INFO - 'USER': 'cltbld', 08:02:07 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455637418.694631-1118322085', 08:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:07 INFO - '_': '/tools/buildbot/bin/python'} 08:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:02:08 INFO - Running setup.py (path:/tmp/pip-py_yPU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:02:08 INFO - Running setup.py (path:/tmp/pip-QzEJ3P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:02:08 INFO - Running setup.py (path:/tmp/pip-R_puC1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:02:08 INFO - Running setup.py (path:/tmp/pip-I2GYHa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:02:08 INFO - Running setup.py (path:/tmp/pip-paMsqj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:02:08 INFO - Running setup.py (path:/tmp/pip-yMBhSr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:02:08 INFO - Running setup.py (path:/tmp/pip-DFTI0y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:02:08 INFO - Running setup.py (path:/tmp/pip-5SHV0D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:02:08 INFO - Running setup.py (path:/tmp/pip-TN_CDZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:02:08 INFO - Running setup.py (path:/tmp/pip-VOiL1Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:02:08 INFO - Running setup.py (path:/tmp/pip-1kEnvq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:02:09 INFO - Running setup.py (path:/tmp/pip-Rwts_a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:02:09 INFO - Running setup.py (path:/tmp/pip-Vw0awg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:02:09 INFO - Running setup.py (path:/tmp/pip-Oh6wQy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:02:09 INFO - Running setup.py (path:/tmp/pip-xijvsx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:02:09 INFO - Running setup.py (path:/tmp/pip-Bd9MIt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:02:09 INFO - Running setup.py (path:/tmp/pip-3Pf_9z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:02:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:02:09 INFO - Running setup.py install for manifestparser 08:02:09 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:02:09 INFO - Running setup.py install for mozcrash 08:02:09 INFO - Running setup.py install for mozdebug 08:02:09 INFO - Running setup.py install for mozdevice 08:02:09 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:02:09 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:02:09 INFO - Running setup.py install for mozfile 08:02:09 INFO - Running setup.py install for mozhttpd 08:02:10 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:02:10 INFO - Running setup.py install for mozinfo 08:02:10 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:02:10 INFO - Running setup.py install for mozInstall 08:02:10 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:02:10 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:02:10 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:02:10 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:02:10 INFO - Running setup.py install for mozleak 08:02:10 INFO - Running setup.py install for mozlog 08:02:10 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:02:10 INFO - Running setup.py install for moznetwork 08:02:10 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:02:10 INFO - Running setup.py install for mozprocess 08:02:10 INFO - Running setup.py install for mozprofile 08:02:10 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:02:10 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:02:10 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:02:10 INFO - Running setup.py install for mozrunner 08:02:10 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:02:10 INFO - Running setup.py install for mozscreenshot 08:02:11 INFO - Running setup.py install for moztest 08:02:11 INFO - Running setup.py install for mozversion 08:02:11 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:02:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:02:11 INFO - Cleaning up... 08:02:11 INFO - Return code: 0 08:02:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:11 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 0x7f3720904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22288c0>, '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 0x22297c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229c50>, '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-1455637418.694631-1118322085', '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 08:02:11 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 08:02:11 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 08:02:11 INFO - Using env: {'DISPLAY': ':0', 08:02:11 INFO - 'HOME': '/home/cltbld', 08:02:11 INFO - 'LANG': 'en_US.UTF-8', 08:02:11 INFO - 'LANGUAGE': 'en_US:en', 08:02:11 INFO - 'LOGNAME': 'cltbld', 08:02:11 INFO - 'MAIL': '/var/mail/cltbld', 08:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:11 INFO - 'MOZ_NO_REMOTE': '1', 08:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:11 INFO - 'NO_EM_RESTART': '1', 08:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:02:11 INFO - 'PWD': '/builds/slave/test-pgo', 08:02:11 INFO - 'SHELL': '/bin/bash', 08:02:11 INFO - 'SHLVL': '1', 08:02:11 INFO - 'TERM': 'linux', 08:02:11 INFO - 'TMOUT': '86400', 08:02:11 INFO - 'USER': 'cltbld', 08:02:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455637418.694631-1118322085', 08:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:11 INFO - '_': '/tools/buildbot/bin/python'} 08:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:02:11 INFO - Running setup.py (path:/tmp/pip-h0mMkq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:02:11 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)) 08:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:02:11 INFO - Running setup.py (path:/tmp/pip-MJYtQF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:02:11 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)) 08:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:02:11 INFO - Running setup.py (path:/tmp/pip-YHlwAC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:02:11 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)) 08:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:02:11 INFO - Running setup.py (path:/tmp/pip-CCXSlC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:02:11 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)) 08:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:02:11 INFO - Running setup.py (path:/tmp/pip-0TnVCS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:02:11 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)) 08:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:02:11 INFO - Running setup.py (path:/tmp/pip-3yZQoL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:02:11 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)) 08:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:02:11 INFO - Running setup.py (path:/tmp/pip-Xzwwn7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:02:11 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)) 08:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:02:11 INFO - Running setup.py (path:/tmp/pip-vbsMSy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:02:12 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)) 08:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:02:12 INFO - Running setup.py (path:/tmp/pip-qsJODN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:02:12 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)) 08:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:02:12 INFO - Running setup.py (path:/tmp/pip-a1oKR7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:02:12 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)) 08:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:02:12 INFO - Running setup.py (path:/tmp/pip-FpF1ki-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:02:12 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)) 08:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:02:12 INFO - Running setup.py (path:/tmp/pip-sEmMPs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:02:12 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)) 08:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:02:12 INFO - Running setup.py (path:/tmp/pip-qwA6ta-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:02:12 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)) 08:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:02:12 INFO - Running setup.py (path:/tmp/pip-JxVK3m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:02:12 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)) 08:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:02:12 INFO - Running setup.py (path:/tmp/pip-4MhKNJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:02:12 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)) 08:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:02:12 INFO - Running setup.py (path:/tmp/pip-7wQIJ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:02:12 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)) 08:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:02:12 INFO - Running setup.py (path:/tmp/pip-yr3qUx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:02:12 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)) 08:02:12 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)) 08:02:12 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)) 08:02:12 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)) 08:02:12 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)) 08:02:12 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)) 08:02:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:02:12 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 08:02:12 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 08:02:12 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 08:02:12 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 08:02:12 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 08:02:12 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 08:02:14 INFO - Downloading blessings-1.6.tar.gz 08:02:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:02:14 INFO - Installing collected packages: blessings 08:02:14 INFO - Running setup.py install for blessings 08:02:14 INFO - Successfully installed blessings 08:02:14 INFO - Cleaning up... 08:02:14 INFO - Return code: 0 08:02:14 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:02:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:02:14 INFO - Reading from file tmpfile_stdout 08:02:14 INFO - Current package versions: 08:02:14 INFO - argparse == 1.2.1 08:02:14 INFO - blessings == 1.6 08:02:14 INFO - blobuploader == 1.2.4 08:02:14 INFO - docopt == 0.6.1 08:02:14 INFO - manifestparser == 1.1 08:02:14 INFO - mozInstall == 1.12 08:02:14 INFO - mozcrash == 0.16 08:02:14 INFO - mozdebug == 0.1 08:02:14 INFO - mozdevice == 0.48 08:02:14 INFO - mozfile == 1.2 08:02:14 INFO - mozhttpd == 0.7 08:02:14 INFO - mozinfo == 0.9 08:02:14 INFO - mozleak == 0.1 08:02:14 INFO - mozlog == 3.1 08:02:14 INFO - moznetwork == 0.27 08:02:14 INFO - mozprocess == 0.22 08:02:14 INFO - mozprofile == 0.28 08:02:14 INFO - mozrunner == 6.11 08:02:14 INFO - mozscreenshot == 0.1 08:02:14 INFO - mozsystemmonitor == 0.0 08:02:14 INFO - moztest == 0.7 08:02:14 INFO - mozversion == 1.4 08:02:14 INFO - psutil == 3.1.1 08:02:14 INFO - requests == 1.2.3 08:02:14 INFO - wsgiref == 0.1.2 08:02:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:14 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 0x7f3720904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22288c0>, '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 0x22297c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229c50>, '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-1455637418.694631-1118322085', '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 08:02:14 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 08:02:14 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 08:02:14 INFO - Using env: {'DISPLAY': ':0', 08:02:14 INFO - 'HOME': '/home/cltbld', 08:02:14 INFO - 'LANG': 'en_US.UTF-8', 08:02:14 INFO - 'LANGUAGE': 'en_US:en', 08:02:14 INFO - 'LOGNAME': 'cltbld', 08:02:14 INFO - 'MAIL': '/var/mail/cltbld', 08:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:14 INFO - 'MOZ_NO_REMOTE': '1', 08:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:14 INFO - 'NO_EM_RESTART': '1', 08:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:02:14 INFO - 'PWD': '/builds/slave/test-pgo', 08:02:14 INFO - 'SHELL': '/bin/bash', 08:02:14 INFO - 'SHLVL': '1', 08:02:14 INFO - 'TERM': 'linux', 08:02:14 INFO - 'TMOUT': '86400', 08:02:14 INFO - 'USER': 'cltbld', 08:02:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455637418.694631-1118322085', 08:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:14 INFO - '_': '/tools/buildbot/bin/python'} 08:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:15 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)) 08:02:15 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)) 08:02:15 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)) 08:02:15 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)) 08:02:15 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)) 08:02:15 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)) 08:02:15 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)) 08:02:15 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)) 08:02:15 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)) 08:02:15 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)) 08:02:15 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)) 08:02:15 INFO - Cleaning up... 08:02:15 INFO - Return code: 0 08:02:15 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:02: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')]} 08:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:15 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 0x7f3720904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22288c0>, '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 0x22297c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229c50>, '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-1455637418.694631-1118322085', '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 08:02:15 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 08:02:15 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 08:02:15 INFO - Using env: {'DISPLAY': ':0', 08:02:15 INFO - 'HOME': '/home/cltbld', 08:02:15 INFO - 'LANG': 'en_US.UTF-8', 08:02:15 INFO - 'LANGUAGE': 'en_US:en', 08:02:15 INFO - 'LOGNAME': 'cltbld', 08:02:15 INFO - 'MAIL': '/var/mail/cltbld', 08:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:15 INFO - 'MOZ_NO_REMOTE': '1', 08:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:15 INFO - 'NO_EM_RESTART': '1', 08:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:02:15 INFO - 'PWD': '/builds/slave/test-pgo', 08:02:15 INFO - 'SHELL': '/bin/bash', 08:02:15 INFO - 'SHLVL': '1', 08:02:15 INFO - 'TERM': 'linux', 08:02:15 INFO - 'TMOUT': '86400', 08:02:15 INFO - 'USER': 'cltbld', 08:02:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455637418.694631-1118322085', 08:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:15 INFO - '_': '/tools/buildbot/bin/python'} 08:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:15 INFO - Downloading/unpacking jsonschema 08:02:15 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 08:02:15 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 08:02:15 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 08:02:15 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 08:02:15 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 08:02:15 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 08:02:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:02:17 INFO - Downloading/unpacking functools32 (from jsonschema) 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 INFO - Downloading functools32-3.2.3-2.tar.gz 08:02:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:02:17 INFO - warning: no files found matching '*.txt' 08:02:17 INFO - no previously-included directories found matching 'build' 08:02:17 INFO - no previously-included directories found matching 'dist' 08:02:17 INFO - no previously-included directories found matching '.git*' 08:02:17 INFO - Installing collected packages: jsonschema, functools32 08:02:17 INFO - Running setup.py install for functools32 08:02:17 INFO - warning: no files found matching '*.txt' 08:02:17 INFO - no previously-included directories found matching 'build' 08:02:17 INFO - no previously-included directories found matching 'dist' 08:02:17 INFO - no previously-included directories found matching '.git*' 08:02:17 INFO - Successfully installed jsonschema functools32 08:02:17 INFO - Cleaning up... 08:02:17 INFO - Return code: 0 08:02:17 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:17 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 0x7f3720904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22288c0>, '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 0x22297c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229c50>, '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-1455637418.694631-1118322085', '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 08:02:17 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 08:02:17 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 08:02:17 INFO - Using env: {'DISPLAY': ':0', 08:02:17 INFO - 'HOME': '/home/cltbld', 08:02:17 INFO - 'LANG': 'en_US.UTF-8', 08:02:17 INFO - 'LANGUAGE': 'en_US:en', 08:02:17 INFO - 'LOGNAME': 'cltbld', 08:02:17 INFO - 'MAIL': '/var/mail/cltbld', 08:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:17 INFO - 'MOZ_NO_REMOTE': '1', 08:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:17 INFO - 'NO_EM_RESTART': '1', 08:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:02:17 INFO - 'PWD': '/builds/slave/test-pgo', 08:02:17 INFO - 'SHELL': '/bin/bash', 08:02:17 INFO - 'SHLVL': '1', 08:02:17 INFO - 'TERM': 'linux', 08:02:17 INFO - 'TMOUT': '86400', 08:02:17 INFO - 'USER': 'cltbld', 08:02:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455637418.694631-1118322085', 08:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:17 INFO - '_': '/tools/buildbot/bin/python'} 08:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:17 INFO - Downloading/unpacking flake8 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 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 08:02:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:02:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:02:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:02:20 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 08:02:20 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 08:02:20 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 08:02:20 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 08:02:20 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 08:02:20 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 08:02:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:02:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:02:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:02:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:02:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:02:20 INFO - no previously-included directories found matching 'docs/_build' 08:02:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:02:20 INFO - Running setup.py install for pep8 08:02:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:02:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:02:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:02:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:02:20 INFO - no previously-included directories found matching 'docs/_build' 08:02:20 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:02:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:02:20 INFO - Cleaning up... 08:02:20 INFO - Return code: 0 08:02:20 INFO - Running post-action listener: _resource_record_post_action 08:02:20 INFO - Running post-action listener: _start_resource_monitoring 08:02:20 INFO - Starting resource monitoring. 08:02:20 INFO - ##### 08:02:20 INFO - ##### Running install step. 08:02:20 INFO - ##### 08:02:20 INFO - Running pre-action listener: _resource_record_pre_action 08:02:20 INFO - Running main action method: install 08:02:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:02:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:02:20 INFO - Reading from file tmpfile_stdout 08:02:20 INFO - Detecting whether we're running mozinstall >=1.0... 08:02:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:02:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:02:20 INFO - Reading from file tmpfile_stdout 08:02:20 INFO - Output received: 08:02:20 INFO - Usage: mozinstall [options] installer 08:02:20 INFO - Options: 08:02:20 INFO - -h, --help show this help message and exit 08:02:20 INFO - -d DEST, --destination=DEST 08:02:20 INFO - Directory to install application into. [default: 08:02:20 INFO - "/builds/slave/test-pgo"] 08:02:20 INFO - --app=APP Application being installed. [default: firefox] 08:02:20 INFO - mkdir: /builds/slave/test-pgo/build/application 08:02:20 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'] 08:02:20 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 08:02:37 INFO - Reading from file tmpfile_stdout 08:02:37 INFO - Output received: 08:02:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:02:37 INFO - Running post-action listener: _resource_record_post_action 08:02:37 INFO - ##### 08:02:37 INFO - ##### Running run-tests step. 08:02:37 INFO - ##### 08:02:37 INFO - Running pre-action listener: _resource_record_pre_action 08:02:37 INFO - Running main action method: run_tests 08:02:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:02:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:02:37 INFO - Python 2.7.3 08:02:37 INFO - Return code: 0 08:02:37 INFO - grabbing minidump binary from tooltool 08:02: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')]} 08:02:37 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 0x22288c0>, '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 0x22297c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:02:37 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 08:02:37 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 08:02:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:02:37 INFO - Return code: 0 08:02:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:02:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:02:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:02:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:02:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:02:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:02:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:02:38 INFO - Return code: 0 08:02:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fXzLuuyTRJySgOiLW92_CQ/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 08:02:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fXzLuuyTRJySgOiLW92_CQ/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 08:02:38 INFO - Using env: {'DISPLAY': ':0', 08:02:38 INFO - 'HOME': '/home/cltbld', 08:02:38 INFO - 'LANG': 'en_US.UTF-8', 08:02:38 INFO - 'LANGUAGE': 'en_US:en', 08:02:38 INFO - 'LOGNAME': 'cltbld', 08:02:38 INFO - 'MAIL': '/var/mail/cltbld', 08:02:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:02:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:38 INFO - 'MOZ_NO_REMOTE': '1', 08:02:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:38 INFO - 'NO_EM_RESTART': '1', 08:02:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:02:38 INFO - 'PWD': '/builds/slave/test-pgo', 08:02:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:02:38 INFO - 'SHELL': '/bin/bash', 08:02:38 INFO - 'SHLVL': '1', 08:02:38 INFO - 'TERM': 'linux', 08:02:38 INFO - 'TMOUT': '86400', 08:02:38 INFO - 'USER': 'cltbld', 08:02:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1455637418.694631-1118322085', 08:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:38 INFO - '_': '/tools/buildbot/bin/python'} 08:02:38 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fXzLuuyTRJySgOiLW92_CQ/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 08:02:38 INFO - mozversion application_buildid: 20160216053003 08:02:38 INFO - mozversion application_changeset: cf16002d74e4a8ae9a8c5e7ef2de7e9876c61f3f 08:02:38 INFO - mozversion application_display_name: Nightly 08:02:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:02:38 INFO - mozversion application_name: Firefox 08:02:38 INFO - mozversion application_remotingname: firefox 08:02:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:02:38 INFO - mozversion application_vendor: Mozilla 08:02:38 INFO - mozversion application_version: 47.0a1 08:02:38 INFO - mozversion platform_buildid: 20160216053003 08:02:38 INFO - mozversion platform_changeset: cf16002d74e4a8ae9a8c5e7ef2de7e9876c61f3f 08:02:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:02:38 INFO - mozversion platform_version: 47.0a1 08:02:38 INFO - using testdate: 1455638558 08:02:38 INFO - actual date: 1455638558 08:02:38 INFO - starting webserver on 'localhost:52453' 08:02:38 INFO - SUITE-START | Running 2 tests 08:02:38 INFO - TEST-START | dromaeo_css 08:02:38 INFO - operating with platform_type : linux_ 08:02:38 INFO - Initialising browser for dromaeo_css test... 08:02:38 INFO - TEST-INFO | started process 11039 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcWO1mX/profile http://localhost:52453/getInfo.html) 08:02:43 INFO - PROCESS | 11039 | __metrics Screen width/height:1600/1200 08:02:43 INFO - PROCESS | 11039 | colorDepth:24 08:02:43 INFO - PROCESS | 11039 | Browser inner width/height: 1024/697 08:02:43 INFO - PROCESS | 11039 | __metrics 08:02:44 INFO - PROCESS | 11039 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:02:44 INFO - TEST-INFO | 11039: exit 0 08:02:44 INFO - Browser initialized. 08:02:44 INFO - Running cycle 1/1 for dromaeo_css test... 08:02:44 INFO - TEST-INFO | started process 11135 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcWO1mX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:56 INFO - PROCESS | 11135 | RSS: Main: 149516288 08:02:56 INFO - PROCESS | 11135 | 08:03:48 INFO - PROCESS | 11135 | 1455638628074 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] 08:05:56 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:52453/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52453/tests/dromaeo/cssquery-ext.html) 08:05:57 INFO - PROCESS | 11135 | RSS: Main: 251346944 08:05:57 INFO - PROCESS | 11135 | 08:08:59 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:52453/tests/dromaeo/cssquery-ext.html (next: http://localhost:52453/tests/dromaeo/cssquery-jquery.html) 08:08:59 INFO - PROCESS | 11135 | RSS: Main: 233738240 08:08:59 INFO - PROCESS | 11135 | 08:12:02 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:52453/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52453/tests/dromaeo/cssquery-mootools.html) 08:12:02 INFO - PROCESS | 11135 | RSS: Main: 236158976 08:12:02 INFO - PROCESS | 11135 | 08:15:04 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:52453/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52453/tests/dromaeo/cssquery-prototype.html) 08:15:05 INFO - PROCESS | 11135 | RSS: Main: 216895488 08:15:05 INFO - PROCESS | 11135 | 08:18:07 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:52453/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52453/tests/dromaeo/cssquery-yui.html) 08:18:08 INFO - PROCESS | 11135 | RSS: Main: 218542080 08:18:08 INFO - PROCESS | 11135 | 08:21:10 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:52453/tests/dromaeo/cssquery-yui.html (next: http://localhost:52453/tests/dromaeo/cssquery-dojo.html) 08:21:10 INFO - PROCESS | 11135 | RSS: Main: 266944512 08:21:10 INFO - PROCESS | 11135 | 08:21:10 INFO - PROCESS | 11135 | __start_tp_report 08:21:10 INFO - PROCESS | 11135 | _x_x_mozilla_page_load 08:21:10 INFO - PROCESS | 11135 | _x_x_mozilla_page_load_details 08:21:10 INFO - PROCESS | 11135 | |i|pagename|runs| 08:21:10 INFO - PROCESS | 11135 | |0;dojo.html;3082.2294426393396;3092.783505154637;3132.2795756975893;3139.827309497978;3175.9841200793994;5009.298698182258;5063.645544811865;5110;5116.974415127924;5120.283160357549;5061.797528098881;5078.746062696869;5146.459621739719;5160.277561141434;5179.792808287673;4677.298405239208;4695.530446955294;4700.271457924018;4705.035467729107;4777.18787806072;4803.903921921559;4849.830255941043;4857.635677324197;4868.196747536652;4871.074495845795;4649.837255696035;4700;4705.270683044117;4786.856394308176;4834.951650483503;4786.329913812069;4787.353707249512;4790.185668436374;4797.808087676489;4831.975840120812;4760.547747963938;4764.285357196413;4767.5470830271415;4770.880727981794;4829.275608658694;4887.291342755316;4891.853244402673;4963.702177869303;4979.601631869442;5013.248012798073;5520.282363292787;5528.612997090206;5531.419200983879;5535.335759708861;5538.030844602178;5350.929814037208;5559.471850174227;5563.13771365439;5571.0807716726695;5573.359063707644;5024.899502009976;5150.562202212816;5195.402528709247;5204.297419848348;5260.526552610283;5636.436356364331;5638.2670252866865;5641.153826925994;5642.548596112301;5679.914801277984;5293.629445938825;5410.377806552218;5441.972790136024;5448.591355648342;5451.018816612968;5529.281193444907;5594.188842617879;5612.298462692163;5628.212050312959;5675.489205971482;5362.195670649356;5395.73021348931;5402.621816472809;5407.161889907071;5414.242006119146;5336.359636843604;5342.0384330820825;5396.298481197419;5424.755885985141;5462.863428414322;4238.660907127484;4239.38528913312;4245.681573881971;4284.764337961442;4291.763952982554;3804.3152232597845;3813.980930095387;3815.1988082502985;3836.4820749199057;3853.499045124116;4977.502249774993;5083.186690129562;5121.897562048738;5168.04391187624;5200.5059519345605;5467.125259958388;5468.835934921959;5512.944870551243;5519.862003449946;5534.280543529396;5076.44159142494;5144.717040562805;5163;5163.27714120016;5207.4011488678525;4660.5106463821485;4680.227762419231;4735.242361222188;4741.0754902794315;4781.187198176319;5614.045612245928;5619.297587801525;5622.156676498476;5624.55003599711;5627.184058311522;5388.865278368072;5418.133098704188;5419;5427.6472029317965;5491.341039075336;5685.516731077904;5704.172894930295;5710.885782284248;5737.053386191232;5794.101914203306;5357.678539287655;5362.785488580413;5370.167624018283;5371.221172929825;5381.085215513451;5369.1140961740875;5435.266239057677;5464.18037294409;5504.6421982571;5548.639338442988;5411.83764487066;5419.674819510842;5421.40364559906;5425.376081750492;5447.237386765935;5400.7569659364635;5406.378266499403;5409.161579955114;5409.864753381197;5454.127339625641;5257.342832145981;5336.092864213016;5339.813106541253;5376.919346209888;5419.187121931742;5425.945740542544;5458.072127738374;5461.071617825059;5467;5528.032594295902;5134.358205224347;5352.437994010573;5381.73091345439;5386.703731294817;5394.460553944574 08:21:10 INFO - PROCESS | 11135 | |1;ext.html;499.81257028614294;542.3383472163958;547.4716898193243;559.1808001278127;571.4514066496164;27851.860740696295;36034;36899.81550092246;36932.07669808253;36997.81501092498;38912.41631375532;39409.802950985206;39414.8029259854;39870.80064599673;39929.800350998274;7436.776896693108;7599.35405490534;8509.61706723199;8743.912560874405;8747.125287471266;10328.896711032869;10668.839967400496;10672.839907401396;10673.78652426951;10681.145508359352;10284.691459256233;10391.636292729756;10397.960203979617;10398.272120951537;10399.584016639325;10081.495925203748;10161.237907156992;10170.186385089175;10170.796584068277;10179.032991865835;10147.391156530557;10320.690379288633;10320.896791032068;10651.946740266327;10672.30630009047;40228.39657405141;40759.388609170885;40762.79618601918;40822.59177408247;40855.591444085774;3165.1454107391105;3204.455242608762;3310.9006729798143;3528.7177025837873;3786.110264087937;26334.20997370082;27057.86471067632;27075;27132.321691957663;27150.32124196891;3719.5722491913507;3823.9426408603895;3828.406596977473;3876.9612303877166;3888.241792850395;289800;294555;294977;294988;296769;61543.69228153831;62020.37979620236;62220.37779622236;62337.376626233156;62348.37651623516;65478.67260663666;65696.6715166421;65908.34091659117;65921;66025.40707818566;16091;16208.35166593323;16300.918495407685;16337.101459419608;16349.754753678704;11768.529258829722;11858.051355891508;11860.169788114921;11862.88137118635;11879.58421455245;19473;20574.485637858874;20742.688859667116;20831.47921301949;20853.895730521555;7933.325667318342;7962.522248665098;8018.596745569502;8065.596720163969;8102.513849169069;850.8043150075517;897.8653202019749;953.413650604873;969.1907257440116;1058.6294796821205;25728.614070788954;25757.3560660985;25834.48331033369;26377.472450551264;27272.454550909268;919.090100800203;938.1228551304416;964.8745663063897;1005.9798804024025;1046.7173863057085;13521.59435216945;13723;13890.722185556233;13986.580402587939;14230.14619122856;309960;316598;317614;317706;318752;52965.470345296824;53369.733151333996;53479;53517.46482535203;53573.196402054;1362.3596909452542;1363.631819408774;1390.721855628858;1390.8191935048378;1397.699494608664;27506.312342191606;28117.43765124727;28354.574681380207;28467.715322847336;28469.145925622266;46222.7688861567;46435.303470447296;46548.30177547272;46610.53389466062;46671.533284668076;281759;282793;283436;283638;283654;27797.722022780323;31173.064808055795;31606.841965790023;31812.522812157375;31840;37581.81209093937;38022.23955520929;38500;38602.42096368613;38821.80589097036;30352.21960282845;30862.382752345275;31157.68842311548;31269.687303126677;31365;28272.894284915597;32532;32899.835500822344;33265.83367083149;35755.28489430249;32185.67814321827;32265.51601725929;32355.838220808746;32645.836770815993;32655.673443265263;25093.623595645713;26085.608715869657;26499.735002649726;27246.86376568184;28567;24130.87934560316;24298.878505607358;24355.14756983497;24427.633585495878;24704.382390439663 08:21:10 INFO - PROCESS | 11135 | |2;jquery.html;352.06526671686674;352.5170516392542;353.77181717792024;355.21497490545875;357.3710269924931;13084.607461776162;13528;16358.427455039076;16714.916425417872;17692.646147077066;15200.239988000583;15303;16844.32622695094;16898.915505422454;16920.323187072532;5304.3634763828295;5333.706646134461;5458.61789674723;5470.042742520063;5472.097103977839;3913.8238779255003;5383.16560933056;5687.289088863892;5841.7371218295275;5873.618214816044;5666.348369937448;5805.216295800055;5848.2982042155;5850.941490585104;6011.458968692817;5971.164037034819;5981;5984.700764961734;5990.1314309425325;5991.970040149793;5022.447530771612;5093.2105523643895;5135.204043373283;5139.383274007143;5146.047981123466;19834.404967850987;20019.699704504445;20052.49868753278;20197.596048078954;20246;2058.433930669078;2207.2716003718733;2321.674965504814;2381.9281323404366;2435.9391015224583;9033.412828166149;9140.634374625008;9232.261419086457;9725.708228753148;11717.648470545897;1774.7160454327375;1808.7015642418985;1824.9006806225618;1909.76127984002;1981.5739615982488;57006.42993570053;57259;59068;59520.99999999956;59544.70227648877;9519.666811661558;9527.09492598202;9550.283728720235;9764.414135151914;10103.040211179927;12065.396730163633;12207.328596927255;12228.510859565518;12246;12249.877501225052;6958.443324534025;7056.682449289794;7178.138623365229;7202.279772022861;7242.3843973262865;7099.751508697171;7104.11198600175;7152.678129484186;7158.570485770871;7339.266073392618;3636.9272614547563;3858.6527212551005;3990.980045099814;4019.799010049486;4024.476818013698;1580.446843604729;1594.6890356380627;1607.1160861526114;1776.2273411066228;1812.6918423867974;890.6348397157135;940.6660635474445;1005.8491226316111;1024.533837104116;1045.9790804183874;15964.361425542847;16169.426338003641;16465.434661131898;16595.41916032933;16652.417165399394;782.8512582609286;866.5537248317122;870.0212261206143;971.621067783565;993.2302465589227;8492.74521764348;8745.868811967826;8750.124987501198;8798.428102173339;8879.733607991771;568833;581730;591255;597352;598638;59596.702016490504;65844;69336.30663693299;73117.6344118276;74235;1109.9223054386116;1124.1400328748514;1130.8869113088626;1139.5441823270758;1141.6175581180398;15093.54719358421;15211;15300.464483743015;15372.077675339515;15491.457798977433;32616.901394367498;33230;34171.48742768811;34525.65474345224;35056.29887402289;43209.78395108004;45279;46177.53822461867;46454.53545464502;47091.76454117707;7457.515261507984;7548.66031028616;7564.50830696003;7658.8085297868;7696.499727517694;10395.376277423378;10998.450077495932;11262.831057534308;11770.470328835394;11789.941050294694;9965.551550180115;9999.900000999896;10003.899961000297;10075.949620252146;10210.846837297595;9024;9742.220622350053;9877.604895804086;9930;10114.988501149826;9832.950835245778;10267.435291059064;10271.075603195748;10323.174146068446;10337.37975721459;7276.490645654753;7452.701891924262;7469.813254668677;7511.774646760606;7913.44605877583;9839.852402214116;9906.25703072258;10239.948800255952;10356.585736570754;10395.844062339222 08:21:10 INFO - PROCESS | 11135 | |3;mootools.html;1307.261397310519;1396.3297617143771;1402.0886423824513;1525.54233729881;1717.957051073723;6682.9331706682915;7561.886571701429;7696.653650585723;7712.845743085135;7719.035120609924;7287.5627462352295;7437.033185685853;7450.366718828906;7456.403487720982;7461.253874612536;1989.9502512437232;2030.8476864235167;2277.9088836446604;2293.793558579732;2316.664083707861;2329.3827135809024;2330.7669233076726;2332.7403202270752;2335.824813139013;2336.789688927996;2249.6175650139517;2305.6195727704994;2306.1928325086255;2309.58427483053;2309.8383113182085;2269.909203631853;2291.644795056769;2338.4270853640796;2340.8010319122895;2342.8125749939963;2263.852849564773;2294.311706488047;2309.4111001694628;2314.6528020796845;2317.4438134847514;7700.075990881131;7770;7774.105977812567;7782.766517004499;7784.3772498200005;4553.749543775091;4625.791839367203;4632.8146874125;4646.976765116153;4652.139354219446;2999.505081661523;3052.633683957917;3114.0813460029344;3121.672224416426;3123.5314702794535;955.1499165742425;963.0562049191761;982.8722266105432;1009.6769033909152;1011.4538149399316;10188.847167292497;10204.97950204981;10205.64280250195;10205.897941020643;10215.569820225175;4214.304639734471;4255.914881702411;4285.828566857291;4292.12011537634;4330.631896288788;8895.955520222358;8906.109389061172;8906.59920303588;8910.55447227636;8931.419457735226;4728.645351598644;4740.905181896343;4765.0946320199055;4767.427908650984;4769.093872164347;4333.6316413104605;4342.848000319974;4346.8043938022865;4354.542773008852;4359.956400435955;3360.277540328841;3633.0372451300427;3652.0687224757517;3661.8901432957055;3688.5020522229693;1167.64970508847;1231.96920076997;1234.6357824441811;1239.900807935363;1241.416534228911;1316.5128902306208;1324.5099313254157;1331.6071758831167;1348.9932550337185;1350.5003148834994;7213;7249.420046396275;7335.303146201102;7336.193018767931;7493.512921660074;1106.5684383090602;1120.5293776613842;1132.184826924613;1141.1726498288674;1146.656003199037;5703.230063941398;5781.132830075522;5788.797392091256;5790.739416726257;5795.884082318415;9129.77175570616;9249.167574918156;9432.858507122399;9448.102430269113;9559.952200239093;9462.243020558339;9463.621455141854;9476.95261523688;9489.240860731124;9489.66786162481;7251.4923955323675;7316.487845850739;7333.779986600411;7364.631768411558;7411.4811963162065;7079.2566780487305;7117.039199707973;7118.074650295428;7129.073220481304;7137.714491420285;8167.387445941697;8368.24685778283;8368.748937531884;8393.580320984049;8562.443441176303;8596;8676.392652514263;8693;8721.433106848035;8734.606942687467;6029.668368239789;6891.483138764513;7004.614746189009;7005.229424763374;7020.613866237406;7194.604296763729;7392.852142957218;7402.259774022555;7403.370713489414;7408.518446300973;6633.568818026813;6863.725450981905;6897.172339319314;6987;7076.469264805057;6857.657117144223;6885.793426197222;6929.930700692928;6933.965330173519;6985.266547012694;6964.721411143701;7002.824929376807;7005.964970175117;7041.859162816818;7173.282671732994;6502.382273683992;6546.116274302908;6547.050677651809;6553.737850485927;6561.606303621798;6453.257875344396;6454.709538070704;6464.773732919513;6478.1578394808375;6484.675766211765 08:21:10 INFO - PROCESS | 11135 | |4;prototype.html;339.6773065587692;344.66739596289585;346.5512161750533;347.1148571143584;349.1881375801261;5707.258056452655;5857.824265272038;5860.501857342126;5879.235699359077;5939.88120237595;5692.686902220376;5828.300603927524;5840.707964601764;5869.911951320733;5873.9118913216225;4589.862304130873;4594.287885377755;4595.632349412056;4603.838865639704;4604.700694454849;4324.481062272532;4474.149911516802;4580.221362368406;4586.1974154522995;4603.539646035387;4555.521670224628;4559.338895860098;4566.725996440207;4575.084983003396;4594.3338215958665;4543.863684089482;4544.863654090366;4552.203364411248;4561.566651168134;4582.060677561125;4036.798160092013;4038.495188101487;4043.555208927016;4048.008237981684;4050.8177132028836;5362.544183744387;5488.039593071197;5509.465645802936;5517.420670829585;5537.889242215133;5166.147585648364;5172.379314482248;5174.275601415805;5178.715170665612;5183.974080129613;5930.466258036798;6192.752289908398;6193.1020002099895;6194.225721784777;6196.225471816023;4258.08451182994;4353.477582690066;4362.738235705868;4364.388985542027;4371.256886329332;6420.486361091102;6515.250746164204;6515.674216289167;6517.902231466484;6522.184726909137;4424.380586717862;4434.246178149722;4438.356438316426;4438.489573699066;4438.7114837535455;4420.646348292129;4457.3091170868565;4462.330650402466;4473.329000649928;4505.61702255312;5195.506426889439;5202.479752024768;5205.557527610195;5209.557187639018;5210.6613070150315;6267.373262673787;6270.2789179244055;6270.717817698214;6293.402126797947;6337.6197428154455;1548.3187397545043;1552.0687587447442;1552.906825590468;1554.0132016169814;1560.5552417560941;1037.865077539915;1048.632978457549;1057.3180298707443;1067.3329169269207;1083.6099004358425;5912.674802885883;5921.141434491975;5931.584789064724;5935.228420305332;5946.970265148733;6451.29035806061;6452.741890324428;6460.580062295936;6477.028445733084;6489;5900.557458190653;5944.494717948936;5948.583599148018;5955.374685657944;5966.761329546856;3379.2903490267317;3468.0809585459874;3479.9478007829903;3480.147363895811;3481.5473988381855;6766.086578311865;6790.864182716318;6791.626460544718;6800.761973330909;6809.080774095532;6662.467002639777;6675.599464032173;6680.131582894192;6681.7327306908155;6682.665866706645;6604.636744979072;6763.864722705518;6783.18601767791;6786.423154031864;6788.728450862009;6317.684115794284;6320.4311611955145;6484.805455836333;6493.090967264492;6503.089567460654;6357.364263573606;6377.266614339224;6383.2978372378075;6387.489000879826;6401.8719625608155;6735.0570920072205;6735.6968936397;6742.224644165984;6747.190337159573;6761.93238067613;4276.2089013532595;4329.393884856059;4346.456692913386;4348.043430445297;4365.432493775789;6357.110004599267;6446.9032964506505;6457;6466.321036291121;6473;6260.655663938527;6265.749370025148;6268.655223962726;6275.780347687809;6285.371462853678;6071.908921366271;6265.49876009909;6272.18461599989;6279.152314437492;6283.8114856554375;6192.969035154795;6245.125682404376;6262.812115636538;6274.592151510137;6279.277883043508;6375.87248255023;6381.744730210925;6387.489000880011;6400.167978162809;6402;6174.629522228681;6246.469050130608;6248.343923888108;6255.46828519581;6260.154879091447 08:21:10 INFO - PROCESS | 11135 | |5;yui.html;579.597179959928;622.747787146206;635.9141515895354;652.002436272503;656.2518728649337;13025.804612930802;13315.600531984031;13337.599872003831;13344.733105337888;13357.398917048731;12116.394180290994;13167.275799831006;13301.13542619729;13305.534306299282;13306;676.526431497951;821.0557858462756;823.7075838077486;834.0116961400729;834.4993004197494;822.5023860564332;826.2150956591232;827.9006519217702;828.3869936247164;828.9544075075869;862.0560486267527;862.5471627395605;862.6808081010004;865.5499140446964;869.2437579306013;699.1016543741293;859.4198915731856;868.4919322196523;892.7187935800267;896.7758060484879;630.6972653126479;630.8706715123388;631.8136149835764;633.4520639646719;634.1629049654412;12807.93596032014;12841.743165136644;12845.807312890314;12854.87145128546;12874.613761587167;12878.935605321913;13091.428656476517;13459.057865949388;13594.252316122609;13641.317934103354;9983.351082179708;10067.496625168786;10107.747306317327;10142.89857101427;10749.032587067124;3656.9085772855624;3656.945145822815;3721.162738383869;3814.370628846237;3815.9236815263816;47745;48055.75972120152;48096.99999999965;48149.99999999965;48234.51765482371;9761.671889658515;10094.899051009543;10112;10133.391996480235;10150.086492215736;19130.617387652168;19139.330123445612;19200.519987000436;19207.80792192088;19232.903835481015;7458.366038886756;7668.616569171519;7848.058233012075;8009.279164875189;8108.432409731262;4393.467148734571;4417.911641767147;4426.579474949939;4430.667699922455;4464.933026004613;3312.5031245313394;3361.7646764726724;3371.0392538126516;3374.881879134268;3378.223008708011;576.702997956053;583.5331734612294;590.1236663554618;590.2268028882178;590.7695998560565;640.7212862404868;657.1621182991628;662.1226874391355;662.1888186970922;671.6037537852691;8272.710455134042;8478.957605212057;8578.270846977952;8764.5179515126;9350.205232555172;540.4325458268802;590.5600327755849;597.3936454498687;611.6605284067297;698.6646409723361;3762.852767446911;4279.251131052053;4303.784810759449;4314.288142456522;4357.869263922087;54887.17669234965;55474;55499.44500555024;55516;55562;45210.54789452129;45548.77225613851;46201;46272;46422.5357746425;43951;44283;44311.11377772491;44497.77751111224;45035.64893053214;8577.228049475578;8786.077461866413;8809.603567839335;8847.159519845605;8942.167988935898;32980;33094.50358244676;33605.663943360254;34396.14009649678;34430.311393772485;37190.07024824401;37409.064773379796;40274.395884061174;41107;41602.791986041084;10754.677359679223;10789.892101079202;10863.945680271549;11241.943790280997;11420.71448213768;11631.88368116308;11714.121440891797;11990.700232493908;12264.693382665504;12306.87693123093;10458.738531536772;10979.890201097887;11028.117750580095;11183.384913829817;11477.713057173638;11406.258593191416;11606.88393116058;11930.045596352098;11984.58053968107;12183.878161218274;10376;10402.55220996804;10558.472076396303;10876.129909607054;11184.72038199019;8994.100589940954;9055.283414975349;9195;9228.584713688035;9596.088371604686;8566.871496927675;8772.692955746517;8867.600957957036;9152.725418237464;9714.659986900424 08:21:10 INFO - PROCESS | 11135 | __end_tp_report 08:21:10 INFO - PROCESS | 11135 | __start_cc_report 08:21:10 INFO - PROCESS | 11135 | _x_x_mozilla_cycle_collect,791 08:21:10 INFO - PROCESS | 11135 | __end_cc_report 08:21:10 INFO - PROCESS | 11135 | __startTimestamp1455639670964__endTimestamp 08:21:10 INFO - PROCESS | 11135 | 08:21:10 INFO - PROCESS | 11135 | ------- Summary: start ------- 08:21:10 INFO - PROCESS | 11135 | Number of tests: 6 08:21:10 INFO - PROCESS | 11135 | 08:21:10 INFO - PROCESS | 11135 | [#0] dojo.html Cycles:165 Average:5120.94 Median:5350.93 stddev:546.32 (10.2%) stddev-sans-first:524.06 08:21:10 INFO - PROCESS | 11135 | Values: 3082.2 3092.8 3132.3 3139.8 3176.0 5009.3 5063.6 5110.0 5117.0 5120.3 5061.8 5078.7 5146.5 5160.3 5179.8 4677.3 4695.5 4700.3 4705.0 4777.2 4803.9 4849.8 4857.6 4868.2 4871.1 4649.8 4700.0 4705.3 4786.9 4835.0 4786.3 4787.4 4790.2 4797.8 4832.0 4760.5 4764.3 4767.5 4770.9 4829.3 4887.3 4891.9 4963.7 4979.6 5013.2 5520.3 5528.6 5531.4 5535.3 5538.0 5350.9 5559.5 5563.1 5571.1 5573.4 5024.9 5150.6 5195.4 5204.3 5260.5 5636.4 5638.3 5641.2 5642.5 5679.9 5293.6 5410.4 5442.0 5448.6 5451.0 5529.3 5594.2 5612.3 5628.2 5675.5 5362.2 5395.7 5402.6 5407.2 5414.2 5336.4 5342.0 5396.3 5424.8 5462.9 4238.7 4239.4 4245.7 4284.8 4291.8 3804.3 3814.0 3815.2 3836.5 3853.5 4977.5 5083.2 5121.9 5168.0 5200.5 5467.1 5468.8 5512.9 5519.9 5534.3 5076.4 5144.7 5163.0 5163.3 5207.4 4660.5 4680.2 4735.2 4741.1 4781.2 5614.0 5619.3 5622.2 5624.6 5627.2 5388.9 5418.1 5419.0 5427.6 5491.3 5685.5 5704.2 5710.9 5737.1 5794.1 5357.7 5362.8 5370.2 5371.2 5381.1 5369.1 5435.3 5464.2 5504.6 5548.6 5411.8 5419.7 5421.4 5425.4 5447.2 5400.8 5406.4 5409.2 5409.9 5454.1 5257.3 5336.1 5339.8 5376.9 5419.2 5425.9 5458.1 5461.1 5467.0 5528.0 5134.4 5352.4 5381.7 5386.7 5394.5 08:21:10 INFO - PROCESS | 11135 | 08:21:10 INFO - PROCESS | 11135 | [#1] ext.html Cycles:180 Average:46254.55 Median:31221.38 stddev:78014.71 (249.9%) stddev-sans-first:78157.92 08:21:10 INFO - PROCESS | 11135 | Values: 499.8 542.3 547.5 559.2 571.5 27851.9 36034.0 36899.8 36932.1 36997.8 38912.4 39409.8 39414.8 39870.8 39929.8 7436.8 7599.4 8509.6 8743.9 8747.1 10328.9 10668.8 10672.8 10673.8 10681.1 10284.7 10391.6 10398.0 10398.3 10399.6 10081.5 10161.2 10170.2 10170.8 10179.0 10147.4 10320.7 10320.9 10651.9 10672.3 40228.4 40759.4 40762.8 40822.6 40855.6 3165.1 3204.5 3310.9 3528.7 3786.1 26334.2 27057.9 27075.0 27132.3 27150.3 3719.6 3823.9 3828.4 3877.0 3888.2 289800.0 294555.0 294977.0 294988.0 296769.0 61543.7 62020.4 62220.4 62337.4 62348.4 65478.7 65696.7 65908.3 65921.0 66025.4 16091.0 16208.4 16300.9 16337.1 16349.8 11768.5 11858.1 11860.2 11862.9 11879.6 19473.0 20574.5 20742.7 20831.5 20853.9 7933.3 7962.5 8018.6 8065.6 8102.5 850.8 897.9 953.4 969.2 1058.6 25728.6 25757.4 25834.5 26377.5 27272.5 919.1 938.1 964.9 1006.0 1046.7 13521.6 13723.0 13890.7 13986.6 14230.1 309960.0 316598.0 317614.0 317706.0 318752.0 52965.5 53369.7 53479.0 53517.5 53573.2 1362.4 1363.6 1390.7 1390.8 1397.7 27506.3 28117.4 28354.6 28467.7 28469.1 46222.8 46435.3 46548.3 46610.5 46671.5 281759.0 282793.0 283436.0 283638.0 283654.0 27797.7 31173.1 31606.8 31812.5 31840.0 37581.8 38022.2 38500.0 38602.4 38821.8 30352.2 30862.4 31157.7 31269.7 31365.0 28272.9 32532.0 32899.8 33265.8 35755.3 32185.7 32265.5 32355.8 32645.8 32655.7 25093.6 26085.6 26499.7 27246.9 28567.0 24130.9 24298.9 24355.1 24427.6 24704.4 08:21:10 INFO - PROCESS | 11135 | 08:21:10 INFO - PROCESS | 11135 | [#2] jquery.html Cycles:180 Average:28872.81 Median:46773.15 stddev:95932.19 (205.1%) stddev-sans-first:96177.40 08:21:10 INFO - PROCESS | 11135 | Values: 352.1 352.5 353.8 355.2 357.4 13084.6 13528.0 16358.4 16714.9 17692.6 15200.2 15303.0 16844.3 16898.9 16920.3 5304.4 5333.7 5458.6 5470.0 5472.1 3913.8 5383.2 5687.3 5841.7 5873.6 5666.3 5805.2 5848.3 5850.9 6011.5 5971.2 5981.0 5984.7 5990.1 5992.0 5022.4 5093.2 5135.2 5139.4 5146.0 19834.4 20019.7 20052.5 20197.6 20246.0 2058.4 2207.3 2321.7 2381.9 2435.9 9033.4 9140.6 9232.3 9725.7 11717.6 1774.7 1808.7 1824.9 1909.8 1981.6 57006.4 57259.0 59068.0 59521.0 59544.7 9519.7 9527.1 9550.3 9764.4 10103.0 12065.4 12207.3 12228.5 12246.0 12249.9 6958.4 7056.7 7178.1 7202.3 7242.4 7099.8 7104.1 7152.7 7158.6 7339.3 3636.9 3858.7 3991.0 4019.8 4024.5 1580.4 1594.7 1607.1 1776.2 1812.7 890.6 940.7 1005.8 1024.5 1046.0 15964.4 16169.4 16465.4 16595.4 16652.4 782.9 866.6 870.0 971.6 993.2 8492.7 8745.9 8750.1 8798.4 8879.7 568833.0 581730.0 591255.0 597352.0 598638.0 59596.7 65844.0 69336.3 73117.6 74235.0 1109.9 1124.1 1130.9 1139.5 1141.6 15093.5 15211.0 15300.5 15372.1 15491.5 32616.9 33230.0 34171.5 34525.7 35056.3 43209.8 45279.0 46177.5 46454.5 47091.8 7457.5 7548.7 7564.5 7658.8 7696.5 10395.4 10998.5 11262.8 11770.5 11789.9 9965.6 9999.9 10003.9 10075.9 10210.8 9024.0 9742.2 9877.6 9930.0 10115.0 9833.0 10267.4 10271.1 10323.2 10337.4 7276.5 7452.7 7469.8 7511.8 7913.4 9839.9 9906.3 10239.9 10356.6 10395.8 08:21:10 INFO - PROCESS | 11135 | 08:21:10 INFO - PROCESS | 11135 | [#3] mootools.html Cycles:180 Average:5429.83 Median:6471.47 stddev:2773.55 (42.9%) stddev-sans-first:2764.01 08:21:10 INFO - PROCESS | 11135 | Values: 1307.3 1396.3 1402.1 1525.5 1718.0 6682.9 7561.9 7696.7 7712.8 7719.0 7287.6 7437.0 7450.4 7456.4 7461.3 1990.0 2030.8 2277.9 2293.8 2316.7 2329.4 2330.8 2332.7 2335.8 2336.8 2249.6 2305.6 2306.2 2309.6 2309.8 2269.9 2291.6 2338.4 2340.8 2342.8 2263.9 2294.3 2309.4 2314.7 2317.4 7700.1 7770.0 7774.1 7782.8 7784.4 4553.7 4625.8 4632.8 4647.0 4652.1 2999.5 3052.6 3114.1 3121.7 3123.5 955.1 963.1 982.9 1009.7 1011.5 10188.8 10205.0 10205.6 10205.9 10215.6 4214.3 4255.9 4285.8 4292.1 4330.6 8896.0 8906.1 8906.6 8910.6 8931.4 4728.6 4740.9 4765.1 4767.4 4769.1 4333.6 4342.8 4346.8 4354.5 4360.0 3360.3 3633.0 3652.1 3661.9 3688.5 1167.6 1232.0 1234.6 1239.9 1241.4 1316.5 1324.5 1331.6 1349.0 1350.5 7213.0 7249.4 7335.3 7336.2 7493.5 1106.6 1120.5 1132.2 1141.2 1146.7 5703.2 5781.1 5788.8 5790.7 5795.9 9129.8 9249.2 9432.9 9448.1 9560.0 9462.2 9463.6 9477.0 9489.2 9489.7 7251.5 7316.5 7333.8 7364.6 7411.5 7079.3 7117.0 7118.1 7129.1 7137.7 8167.4 8368.2 8368.7 8393.6 8562.4 8596.0 8676.4 8693.0 8721.4 8734.6 6029.7 6891.5 7004.6 7005.2 7020.6 7194.6 7392.9 7402.3 7403.4 7408.5 6633.6 6863.7 6897.2 6987.0 7076.5 6857.7 6885.8 6929.9 6934.0 6985.3 6964.7 7002.8 7006.0 7041.9 7173.3 6502.4 6546.1 6547.1 6553.7 6561.6 6453.3 6454.7 6464.8 6478.2 6484.7 08:21:10 INFO - PROCESS | 11135 | 08:21:10 INFO - PROCESS | 11135 | [#4] prototype.html Cycles:180 Average:5240.48 Median:5916.91 stddev:1583.03 (26.8%) stddev-sans-first:1544.14 08:21:10 INFO - PROCESS | 11135 | Values: 339.7 344.7 346.6 347.1 349.2 5707.3 5857.8 5860.5 5879.2 5939.9 5692.7 5828.3 5840.7 5869.9 5873.9 4589.9 4594.3 4595.6 4603.8 4604.7 4324.5 4474.1 4580.2 4586.2 4603.5 4555.5 4559.3 4566.7 4575.1 4594.3 4543.9 4544.9 4552.2 4561.6 4582.1 4036.8 4038.5 4043.6 4048.0 4050.8 5362.5 5488.0 5509.5 5517.4 5537.9 5166.1 5172.4 5174.3 5178.7 5184.0 5930.5 6192.8 6193.1 6194.2 6196.2 4258.1 4353.5 4362.7 4364.4 4371.3 6420.5 6515.3 6515.7 6517.9 6522.2 4424.4 4434.2 4438.4 4438.5 4438.7 4420.6 4457.3 4462.3 4473.3 4505.6 5195.5 5202.5 5205.6 5209.6 5210.7 6267.4 6270.3 6270.7 6293.4 6337.6 1548.3 1552.1 1552.9 1554.0 1560.6 1037.9 1048.6 1057.3 1067.3 1083.6 5912.7 5921.1 5931.6 5935.2 5947.0 6451.3 6452.7 6460.6 6477.0 6489.0 5900.6 5944.5 5948.6 5955.4 5966.8 3379.3 3468.1 3479.9 3480.1 3481.5 6766.1 6790.9 6791.6 6800.8 6809.1 6662.5 6675.6 6680.1 6681.7 6682.7 6604.6 6763.9 6783.2 6786.4 6788.7 6317.7 6320.4 6484.8 6493.1 6503.1 6357.4 6377.3 6383.3 6387.5 6401.9 6735.1 6735.7 6742.2 6747.2 6761.9 4276.2 4329.4 4346.5 4348.0 4365.4 6357.1 6446.9 6457.0 6466.3 6473.0 6260.7 6265.7 6268.7 6275.8 6285.4 6071.9 6265.5 6272.2 6279.2 6283.8 6193.0 6245.1 6262.8 6274.6 6279.3 6375.9 6381.7 6387.5 6400.2 6402.0 6174.6 6246.5 6248.3 6255.5 6260.2 08:21:10 INFO - PROCESS | 11135 | 08:21:10 INFO - PROCESS | 11135 | [#5] yui.html Cycles:180 Average:13365.75 Median:24481.36 stddev:15024.42 (61.4%) stddev-sans-first:15035.89 08:21:10 INFO - PROCESS | 11135 | Values: 579.6 622.7 635.9 652.0 656.3 13025.8 13315.6 13337.6 13344.7 13357.4 12116.4 13167.3 13301.1 13305.5 13306.0 676.5 821.1 823.7 834.0 834.5 822.5 826.2 827.9 828.4 829.0 862.1 862.5 862.7 865.5 869.2 699.1 859.4 868.5 892.7 896.8 630.7 630.9 631.8 633.5 634.2 12807.9 12841.7 12845.8 12854.9 12874.6 12878.9 13091.4 13459.1 13594.3 13641.3 9983.4 10067.5 10107.7 10142.9 10749.0 3656.9 3656.9 3721.2 3814.4 3815.9 47745.0 48055.8 48097.0 48150.0 48234.5 9761.7 10094.9 10112.0 10133.4 10150.1 19130.6 19139.3 19200.5 19207.8 19232.9 7458.4 7668.6 7848.1 8009.3 8108.4 4393.5 4417.9 4426.6 4430.7 4464.9 3312.5 3361.8 3371.0 3374.9 3378.2 576.7 583.5 590.1 590.2 590.8 640.7 657.2 662.1 662.2 671.6 8272.7 8479.0 8578.3 8764.5 9350.2 540.4 590.6 597.4 611.7 698.7 3762.9 4279.3 4303.8 4314.3 4357.9 54887.2 55474.0 55499.4 55516.0 55562.0 45210.5 45548.8 46201.0 46272.0 46422.5 43951.0 44283.0 44311.1 44497.8 45035.6 8577.2 8786.1 8809.6 8847.2 8942.2 32980.0 33094.5 33605.7 34396.1 34430.3 37190.1 37409.1 40274.4 41107.0 41602.8 10754.7 10789.9 10863.9 11241.9 11420.7 11631.9 11714.1 11990.7 12264.7 12306.9 10458.7 10979.9 11028.1 11183.4 11477.7 11406.3 11606.9 11930.0 11984.6 12183.9 10376.0 10402.6 10558.5 10876.1 11184.7 8994.1 9055.3 9195.0 9228.6 9596.1 8566.9 8772.7 8867.6 9152.7 9714.7 08:21:10 INFO - PROCESS | 11135 | -------- Summary: end -------- 08:21:10 INFO - PROCESS | 11135 | 08:21:11 INFO - TEST-INFO | 11135: exit 0 08:21:11 INFO - TEST-OK | dromaeo_css | took 1113223ms 08:21:11 INFO - TEST-START | kraken 08:21:11 INFO - operating with platform_type : linux_ 08:21:11 INFO - Initialising browser for kraken test... 08:21:11 INFO - TEST-INFO | started process 11321 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC1G2L2/profile http://localhost:52453/getInfo.html) 08:21:15 INFO - PROCESS | 11321 | __metrics Screen width/height:1600/1200 08:21:15 INFO - PROCESS | 11321 | colorDepth:24 08:21:15 INFO - PROCESS | 11321 | Browser inner width/height: 1024/697 08:21:15 INFO - PROCESS | 11321 | __metrics 08:21:16 INFO - PROCESS | 11321 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:21:17 INFO - TEST-INFO | 11321: exit 0 08:21:17 INFO - Browser initialized. 08:21:17 INFO - Running cycle 1/1 for kraken test... 08:21:17 INFO - TEST-INFO | started process 11407 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC1G2L2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:29 INFO - PROCESS | 11407 | RSS: Main: 149417984 08:21:29 INFO - PROCESS | 11407 | 08:21:31 INFO - PROCESS | 11407 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52453/tests/kraken/driver.html?testName=audio-beat-detection) 08:21:32 INFO - PROCESS | 11407 | RSS: Main: 192876544 08:21:32 INFO - PROCESS | 11407 | 08:21:35 INFO - PROCESS | 11407 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52453/tests/kraken/driver.html?testName=audio-dft) 08:21:35 INFO - PROCESS | 11407 | RSS: Main: 184594432 08:21:35 INFO - PROCESS | 11407 | 08:21:38 INFO - PROCESS | 11407 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52453/tests/kraken/driver.html?testName=audio-fft) 08:21:39 INFO - PROCESS | 11407 | RSS: Main: 167182336 08:21:39 INFO - PROCESS | 11407 | 08:21:41 INFO - PROCESS | 11407 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52453/tests/kraken/driver.html?testName=audio-oscillator) 08:21:41 INFO - PROCESS | 11407 | RSS: Main: 169193472 08:21:41 INFO - PROCESS | 11407 | 08:21:44 INFO - PROCESS | 11407 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52453/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:21:44 INFO - PROCESS | 11407 | RSS: Main: 171393024 08:21:44 INFO - PROCESS | 11407 | 08:21:47 INFO - PROCESS | 11407 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52453/tests/kraken/driver.html?testName=imaging-darkroom) 08:21:48 INFO - PROCESS | 11407 | RSS: Main: 170381312 08:21:48 INFO - PROCESS | 11407 | 08:21:51 INFO - PROCESS | 11407 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52453/tests/kraken/driver.html?testName=imaging-desaturate) 08:21:52 INFO - PROCESS | 11407 | RSS: Main: 170786816 08:21:52 INFO - PROCESS | 11407 | 08:21:55 INFO - PROCESS | 11407 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52453/tests/kraken/driver.html?testName=json-parse-financial) 08:21:55 INFO - PROCESS | 11407 | RSS: Main: 171327488 08:21:55 INFO - PROCESS | 11407 | 08:21:57 INFO - PROCESS | 11407 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52453/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:21:57 INFO - PROCESS | 11407 | RSS: Main: 184754176 08:21:57 INFO - PROCESS | 11407 | 08:21:59 INFO - PROCESS | 11407 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52453/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:22:00 INFO - PROCESS | 11407 | RSS: Main: 180895744 08:22:00 INFO - PROCESS | 11407 | 08:22:02 INFO - PROCESS | 11407 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52453/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:22:02 INFO - PROCESS | 11407 | RSS: Main: 191852544 08:22:02 INFO - PROCESS | 11407 | 08:22:05 INFO - PROCESS | 11407 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52453/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:22:05 INFO - PROCESS | 11407 | RSS: Main: 198709248 08:22:05 INFO - PROCESS | 11407 | 08:22:08 INFO - PROCESS | 11407 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52453/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:22:09 INFO - PROCESS | 11407 | RSS: Main: 198684672 08:22:09 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | Cycle 1(1): loaded http://localhost:52453/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52453/tests/kraken/driver.html?testName=ai-astar) 08:22:10 INFO - PROCESS | 11407 | RSS: Main: 258760704 08:22:10 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | __start_tp_report 08:22:10 INFO - PROCESS | 11407 | _x_x_mozilla_page_load 08:22:10 INFO - PROCESS | 11407 | _x_x_mozilla_page_load_details 08:22:10 INFO - PROCESS | 11407 | |i|pagename|runs| 08:22:10 INFO - PROCESS | 11407 | |0;ai-astar;112;112;106;110;110;112;101;111;114;111 08:22:10 INFO - PROCESS | 11407 | |1;audio-beat-detection;151;125;152;166;130;166;153;135;175;134 08:22:10 INFO - PROCESS | 11407 | |2;audio-dft;162;161;160;161;163;159;159;163;163;162 08:22:10 INFO - PROCESS | 11407 | |3;audio-fft;76;73;97;91;76;73;77;104;95;74 08:22:10 INFO - PROCESS | 11407 | |4;audio-oscillator;96;96;142;96;97;95;145;97;96;140 08:22:10 INFO - PROCESS | 11407 | |5;imaging-gaussian-blur;119;115;115;116;114;115;114;115;115;115 08:22:10 INFO - PROCESS | 11407 | |6;imaging-darkroom;145;145;145;145;146;145;145;145;146;146 08:22:10 INFO - PROCESS | 11407 | |7;imaging-desaturate;96;97;97;96;97;96;96;96;96;96 08:22:10 INFO - PROCESS | 11407 | |8;json-parse-financial;55;54;56;57;56;56;57;66;54;56 08:22:10 INFO - PROCESS | 11407 | |9;json-stringify-tinderbox;67;68;68;67;67;67;72;67;69;67 08:22:10 INFO - PROCESS | 11407 | |10;stanford-crypto-aes;83;82;84;83;91;84;85;84;85;86 08:22:10 INFO - PROCESS | 11407 | |11;stanford-crypto-ccm;118;116;120;118;123;115;121;122;128;114 08:22:10 INFO - PROCESS | 11407 | |12;stanford-crypto-pbkdf2;156;150;155;159;159;145;155;157;143;147 08:22:10 INFO - PROCESS | 11407 | |13;stanford-crypto-sha256-iterative;70;71;72;69;71;69;69;71;69;70 08:22:10 INFO - PROCESS | 11407 | __end_tp_report 08:22:10 INFO - PROCESS | 11407 | __start_cc_report 08:22:10 INFO - PROCESS | 11407 | _x_x_mozilla_cycle_collect,957 08:22:10 INFO - PROCESS | 11407 | __end_cc_report 08:22:10 INFO - PROCESS | 11407 | __startTimestamp1455639730982__endTimestamp 08:22:10 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | ------- Summary: start ------- 08:22:10 INFO - PROCESS | 11407 | Number of tests: 14 08:22:10 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:3.75 (3.4%) stddev-sans-first:3.91 08:22:10 INFO - PROCESS | 11407 | Values: 112.0 112.0 106.0 110.0 110.0 112.0 101.0 111.0 114.0 111.0 08:22:10 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:152.50 stddev:17.13 (11.2%) stddev-sans-first:18.15 08:22:10 INFO - PROCESS | 11407 | Values: 151.0 125.0 152.0 166.0 130.0 166.0 153.0 135.0 175.0 134.0 08:22:10 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.57 (1.0%) stddev-sans-first:1.64 08:22:10 INFO - PROCESS | 11407 | Values: 162.0 161.0 160.0 161.0 163.0 159.0 159.0 163.0 163.0 162.0 08:22:10 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | [#3] audio-fft Cycles:10 Average:83.60 Median:76.50 stddev:11.82 (15.4%) stddev-sans-first:12.21 08:22:10 INFO - PROCESS | 11407 | Values: 76.0 73.0 97.0 91.0 76.0 73.0 77.0 104.0 95.0 74.0 08:22:10 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.00 stddev:22.35 (23.3%) stddev-sans-first:23.13 08:22:10 INFO - PROCESS | 11407 | Values: 96.0 96.0 142.0 96.0 97.0 95.0 145.0 97.0 96.0 140.0 08:22:10 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.42 (1.2%) stddev-sans-first:0.60 08:22:10 INFO - PROCESS | 11407 | Values: 119.0 115.0 115.0 116.0 114.0 115.0 114.0 115.0 115.0 115.0 08:22:10 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 08:22:10 INFO - PROCESS | 11407 | Values: 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 146.0 08:22:10 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:22:10 INFO - PROCESS | 11407 | Values: 96.0 97.0 97.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 08:22:10 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:3.43 (6.1%) stddev-sans-first:3.59 08:22:10 INFO - PROCESS | 11407 | Values: 55.0 54.0 56.0 57.0 56.0 56.0 57.0 66.0 54.0 56.0 08:22:10 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:67.50 stddev:1.60 (2.4%) stddev-sans-first:1.66 08:22:10 INFO - PROCESS | 11407 | Values: 67.0 68.0 68.0 67.0 67.0 67.0 72.0 67.0 69.0 67.0 08:22:10 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.50 stddev:2.50 (3.0%) stddev-sans-first:2.57 08:22:10 INFO - PROCESS | 11407 | Values: 83.0 82.0 84.0 83.0 91.0 84.0 85.0 84.0 85.0 86.0 08:22:10 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:120.50 stddev:4.22 (3.5%) stddev-sans-first:4.44 08:22:10 INFO - PROCESS | 11407 | Values: 118.0 116.0 120.0 118.0 123.0 115.0 121.0 122.0 128.0 114.0 08:22:10 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:155.50 stddev:5.89 (3.8%) stddev-sans-first:6.12 08:22:10 INFO - PROCESS | 11407 | Values: 156.0 150.0 155.0 159.0 159.0 145.0 155.0 157.0 143.0 147.0 08:22:10 INFO - PROCESS | 11407 | 08:22:10 INFO - PROCESS | 11407 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:1.10 (1.6%) stddev-sans-first:1.17 08:22:10 INFO - PROCESS | 11407 | Values: 70.0 71.0 72.0 69.0 71.0 69.0 69.0 71.0 69.0 70.0 08:22:10 INFO - PROCESS | 11407 | -------- Summary: end -------- 08:22:10 INFO - PROCESS | 11407 | 08:22:11 INFO - TEST-INFO | 11407: exit 0 08:22:11 INFO - TEST-OK | kraken | took 60199ms 08:22:11 INFO - SUITE-END | took 1173s 08:22:12 INFO - Completed test suite (00:19:33) 08:22:12 INFO - Working with test: dromaeo_css 08:22:12 INFO - Generating results file: dromaeo_css 08:22:12 INFO - Working with test: kraken 08:22:12 INFO - Generating results file: kraken 08:22:12 INFO - javascript benchmark 08:22:12 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:22:12 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:22:12 INFO - process_Request line: dromaeo_css 6824.33 graph.html#tests=[[72,64,35]] 08:22:12 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:22:12 INFO - process_Request line: kraken 1521.90 graph.html#tests=[[232,64,35]] 08:22:12 INFO - RETURN: dromaeo_css: 6824.33 08:22:12 INFO - RETURN: kraken: 1521.90 08:22:12 INFO - javascript benchmark 08:22:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3082.2294426393396, 3092.783505154637, 3132.2795756975893, 3139.827309497978, 3175.9841200793994, 5009.298698182258, 5063.645544811865, 5110.0, 5116.974415127924, 5120.283160357549, 5061.797528098881, 5078.746062696869, 5146.459621739719, 5160.277561141434, 5179.792808287673, 4677.298405239208, 4695.530446955294, 4700.271457924018, 4705.035467729107, 4777.18787806072, 4803.903921921559, 4849.830255941043, 4857.635677324197, 4868.196747536652, 4871.074495845795, 4649.837255696035, 4700.0, 4705.270683044117, 4786.856394308176, 4834.951650483503, 4786.329913812069, 4787.353707249512, 4790.185668436374, 4797.808087676489, 4831.975840120812, 4760.547747963938, 4764.285357196413, 4767.5470830271415, 4770.880727981794, 4829.275608658694, 4887.291342755316, 4891.853244402673, 4963.702177869303, 4979.601631869442, 5013.248012798073, 5520.282363292787, 5528.612997090206, 5531.419200983879, 5535.335759708861, 5538.030844602178, 5350.929814037208, 5559.471850174227, 5563.13771365439, 5571.0807716726695, 5573.359063707644, 5024.899502009976, 5150.562202212816, 5195.402528709247, 5204.297419848348, 5260.526552610283, 5636.436356364331, 5638.2670252866865, 5641.153826925994, 5642.548596112301, 5679.914801277984, 5293.629445938825, 5410.377806552218, 5441.972790136024, 5448.591355648342, 5451.018816612968, 5529.281193444907, 5594.188842617879, 5612.298462692163, 5628.212050312959, 5675.489205971482, 5362.195670649356, 5395.73021348931, 5402.621816472809, 5407.161889907071, 5414.242006119146, 5336.359636843604, 5342.0384330820825, 5396.298481197419, 5424.755885985141, 5462.863428414322, 4238.660907127484, 4239.38528913312, 4245.681573881971, 4284.764337961442, 4291.763952982554, 3804.3152232597845, 3813.980930095387, 3815.1988082502985, 3836.4820749199057, 3853.499045124116, 4977.502249774993, 5083.186690129562, 5121.897562048738, 5168.04391187624, 5200.5059519345605, 5467.125259958388, 5468.835934921959, 5512.944870551243, 5519.862003449946, 5534.280543529396, 5076.44159142494, 5144.717040562805, 5163.0, 5163.27714120016, 5207.4011488678525, 4660.5106463821485, 4680.227762419231, 4735.242361222188, 4741.0754902794315, 4781.187198176319, 5614.045612245928, 5619.297587801525, 5622.156676498476, 5624.55003599711, 5627.184058311522, 5388.865278368072, 5418.133098704188, 5419.0, 5427.6472029317965, 5491.341039075336, 5685.516731077904, 5704.172894930295, 5710.885782284248, 5737.053386191232, 5794.101914203306, 5357.678539287655, 5362.785488580413, 5370.167624018283, 5371.221172929825, 5381.085215513451, 5369.1140961740875, 5435.266239057677, 5464.18037294409, 5504.6421982571, 5548.639338442988, 5411.83764487066, 5419.674819510842, 5421.40364559906, 5425.376081750492, 5447.237386765935, 5400.7569659364635, 5406.378266499403, 5409.161579955114, 5409.864753381197, 5454.127339625641, 5257.342832145981, 5336.092864213016, 5339.813106541253, 5376.919346209888, 5419.187121931742, 5425.945740542544, 5458.072127738374, 5461.071617825059, 5467.0, 5528.032594295902, 5134.358205224347, 5352.437994010573, 5381.73091345439, 5386.703731294817, 5394.460553944574], "unit": "score", "name": "dojo.html", "value": 5086.868900775802}, {"lowerIsBetter": false, "replicates": [499.81257028614294, 542.3383472163958, 547.4716898193243, 559.1808001278127, 571.4514066496164, 27851.860740696295, 36034.0, 36899.81550092246, 36932.07669808253, 36997.81501092498, 38912.41631375532, 39409.802950985206, 39414.8029259854, 39870.80064599673, 39929.800350998274, 7436.776896693108, 7599.35405490534, 8509.61706723199, 8743.912560874405, 8747.125287471266, 10328.896711032869, 10668.839967400496, 10672.839907401396, 10673.78652426951, 10681.145508359352, 10284.691459256233, 10391.636292729756, 10397.960203979617, 10398.272120951537, 10399.584016639325, 10081.495925203748, 10161.237907156992, 10170.186385089175, 10170.796584068277, 10179.032991865835, 10147.391156530557, 10320.690379288633, 10320.896791032068, 10651.946740266327, 10672.30630009047, 40228.39657405141, 40759.388609170885, 40762.79618601918, 40822.59177408247, 40855.591444085774, 3165.1454107391105, 3204.455242608762, 3310.9006729798143, 3528.7177025837873, 3786.110264087937, 26334.20997370082, 27057.86471067632, 27075.0, 27132.321691957663, 27150.32124196891, 3719.5722491913507, 3823.9426408603895, 3828.406596977473, 3876.9612303877166, 3888.241792850395, 289800.0, 294555.0, 294977.0, 294988.0, 296769.0, 61543.69228153831, 62020.37979620236, 62220.37779622236, 62337.376626233156, 62348.37651623516, 65478.67260663666, 65696.6715166421, 65908.34091659117, 65921.0, 66025.40707818566, 16091.0, 16208.35166593323, 16300.918495407685, 16337.101459419608, 16349.754753678704, 11768.529258829722, 11858.051355891508, 11860.169788114921, 11862.88137118635, 11879.58421455245, 19473.0, 20574.485637858874, 20742.688859667116, 20831.47921301949, 20853.895730521555, 7933.325667318342, 7962.522248665098, 8018.596745569502, 8065.596720163969, 8102.513849169069, 850.8043150075517, 897.8653202019749, 953.413650604873, 969.1907257440116, 1058.6294796821205, 25728.614070788954, 25757.3560660985, 25834.48331033369, 26377.472450551264, 27272.454550909268, 919.090100800203, 938.1228551304416, 964.8745663063897, 1005.9798804024025, 1046.7173863057085, 13521.59435216945, 13723.0, 13890.722185556233, 13986.580402587939, 14230.14619122856, 309960.0, 316598.0, 317614.0, 317706.0, 318752.0, 52965.470345296824, 53369.733151333996, 53479.0, 53517.46482535203, 53573.196402054, 1362.3596909452542, 1363.631819408774, 1390.721855628858, 1390.8191935048378, 1397.699494608664, 27506.312342191606, 28117.43765124727, 28354.574681380207, 28467.715322847336, 28469.145925622266, 46222.7688861567, 46435.303470447296, 46548.30177547272, 46610.53389466062, 46671.533284668076, 281759.0, 282793.0, 283436.0, 283638.0, 283654.0, 27797.722022780323, 31173.064808055795, 31606.841965790023, 31812.522812157375, 31840.0, 37581.81209093937, 38022.23955520929, 38500.0, 38602.42096368613, 38821.80589097036, 30352.21960282845, 30862.382752345275, 31157.68842311548, 31269.687303126677, 31365.0, 28272.894284915597, 32532.0, 32899.835500822344, 33265.83367083149, 35755.28489430249, 32185.67814321827, 32265.51601725929, 32355.838220808746, 32645.836770815993, 32655.673443265263, 25093.623595645713, 26085.608715869657, 26499.735002649726, 27246.86376568184, 28567.0, 24130.87934560316, 24298.878505607358, 24355.14756983497, 24427.633585495878, 24704.382390439663], "unit": "score", "name": "ext.html", "value": 18308.016352465027}, {"lowerIsBetter": false, "replicates": [352.06526671686674, 352.5170516392542, 353.77181717792024, 355.21497490545875, 357.3710269924931, 13084.607461776162, 13528.0, 16358.427455039076, 16714.916425417872, 17692.646147077066, 15200.239988000583, 15303.0, 16844.32622695094, 16898.915505422454, 16920.323187072532, 5304.3634763828295, 5333.706646134461, 5458.61789674723, 5470.042742520063, 5472.097103977839, 3913.8238779255003, 5383.16560933056, 5687.289088863892, 5841.7371218295275, 5873.618214816044, 5666.348369937448, 5805.216295800055, 5848.2982042155, 5850.941490585104, 6011.458968692817, 5971.164037034819, 5981.0, 5984.700764961734, 5990.1314309425325, 5991.970040149793, 5022.447530771612, 5093.2105523643895, 5135.204043373283, 5139.383274007143, 5146.047981123466, 19834.404967850987, 20019.699704504445, 20052.49868753278, 20197.596048078954, 20246.0, 2058.433930669078, 2207.2716003718733, 2321.674965504814, 2381.9281323404366, 2435.9391015224583, 9033.412828166149, 9140.634374625008, 9232.261419086457, 9725.708228753148, 11717.648470545897, 1774.7160454327375, 1808.7015642418985, 1824.9006806225618, 1909.76127984002, 1981.5739615982488, 57006.42993570053, 57259.0, 59068.0, 59520.99999999956, 59544.70227648877, 9519.666811661558, 9527.09492598202, 9550.283728720235, 9764.414135151914, 10103.040211179927, 12065.396730163633, 12207.328596927255, 12228.510859565518, 12246.0, 12249.877501225052, 6958.443324534025, 7056.682449289794, 7178.138623365229, 7202.279772022861, 7242.3843973262865, 7099.751508697171, 7104.11198600175, 7152.678129484186, 7158.570485770871, 7339.266073392618, 3636.9272614547563, 3858.6527212551005, 3990.980045099814, 4019.799010049486, 4024.476818013698, 1580.446843604729, 1594.6890356380627, 1607.1160861526114, 1776.2273411066228, 1812.6918423867974, 890.6348397157135, 940.6660635474445, 1005.8491226316111, 1024.533837104116, 1045.9790804183874, 15964.361425542847, 16169.426338003641, 16465.434661131898, 16595.41916032933, 16652.417165399394, 782.8512582609286, 866.5537248317122, 870.0212261206143, 971.621067783565, 993.2302465589227, 8492.74521764348, 8745.868811967826, 8750.124987501198, 8798.428102173339, 8879.733607991771, 568833.0, 581730.0, 591255.0, 597352.0, 598638.0, 59596.702016490504, 65844.0, 69336.30663693299, 73117.6344118276, 74235.0, 1109.9223054386116, 1124.1400328748514, 1130.8869113088626, 1139.5441823270758, 1141.6175581180398, 15093.54719358421, 15211.0, 15300.464483743015, 15372.077675339515, 15491.457798977433, 32616.901394367498, 33230.0, 34171.48742768811, 34525.65474345224, 35056.29887402289, 43209.78395108004, 45279.0, 46177.53822461867, 46454.53545464502, 47091.76454117707, 7457.515261507984, 7548.66031028616, 7564.50830696003, 7658.8085297868, 7696.499727517694, 10395.376277423378, 10998.450077495932, 11262.831057534308, 11770.470328835394, 11789.941050294694, 9965.551550180115, 9999.900000999896, 10003.899961000297, 10075.949620252146, 10210.846837297595, 9024.0, 9742.220622350053, 9877.604895804086, 9930.0, 10114.988501149826, 9832.950835245778, 10267.435291059064, 10271.075603195748, 10323.174146068446, 10337.37975721459, 7276.490645654753, 7452.701891924262, 7469.813254668677, 7511.774646760606, 7913.44605877583, 9839.852402214116, 9906.25703072258, 10239.948800255952, 10356.585736570754, 10395.844062339222], "unit": "score", "name": "jquery.html", "value": 8197.344816670642}, {"lowerIsBetter": false, "replicates": [1307.261397310519, 1396.3297617143771, 1402.0886423824513, 1525.54233729881, 1717.957051073723, 6682.9331706682915, 7561.886571701429, 7696.653650585723, 7712.845743085135, 7719.035120609924, 7287.5627462352295, 7437.033185685853, 7450.366718828906, 7456.403487720982, 7461.253874612536, 1989.9502512437232, 2030.8476864235167, 2277.9088836446604, 2293.793558579732, 2316.664083707861, 2329.3827135809024, 2330.7669233076726, 2332.7403202270752, 2335.824813139013, 2336.789688927996, 2249.6175650139517, 2305.6195727704994, 2306.1928325086255, 2309.58427483053, 2309.8383113182085, 2269.909203631853, 2291.644795056769, 2338.4270853640796, 2340.8010319122895, 2342.8125749939963, 2263.852849564773, 2294.311706488047, 2309.4111001694628, 2314.6528020796845, 2317.4438134847514, 7700.075990881131, 7770.0, 7774.105977812567, 7782.766517004499, 7784.3772498200005, 4553.749543775091, 4625.791839367203, 4632.8146874125, 4646.976765116153, 4652.139354219446, 2999.505081661523, 3052.633683957917, 3114.0813460029344, 3121.672224416426, 3123.5314702794535, 955.1499165742425, 963.0562049191761, 982.8722266105432, 1009.6769033909152, 1011.4538149399316, 10188.847167292497, 10204.97950204981, 10205.64280250195, 10205.897941020643, 10215.569820225175, 4214.304639734471, 4255.914881702411, 4285.828566857291, 4292.12011537634, 4330.631896288788, 8895.955520222358, 8906.109389061172, 8906.59920303588, 8910.55447227636, 8931.419457735226, 4728.645351598644, 4740.905181896343, 4765.0946320199055, 4767.427908650984, 4769.093872164347, 4333.6316413104605, 4342.848000319974, 4346.8043938022865, 4354.542773008852, 4359.956400435955, 3360.277540328841, 3633.0372451300427, 3652.0687224757517, 3661.8901432957055, 3688.5020522229693, 1167.64970508847, 1231.96920076997, 1234.6357824441811, 1239.900807935363, 1241.416534228911, 1316.5128902306208, 1324.5099313254157, 1331.6071758831167, 1348.9932550337185, 1350.5003148834994, 7213.0, 7249.420046396275, 7335.303146201102, 7336.193018767931, 7493.512921660074, 1106.5684383090602, 1120.5293776613842, 1132.184826924613, 1141.1726498288674, 1146.656003199037, 5703.230063941398, 5781.132830075522, 5788.797392091256, 5790.739416726257, 5795.884082318415, 9129.77175570616, 9249.167574918156, 9432.858507122399, 9448.102430269113, 9559.952200239093, 9462.243020558339, 9463.621455141854, 9476.95261523688, 9489.240860731124, 9489.66786162481, 7251.4923955323675, 7316.487845850739, 7333.779986600411, 7364.631768411558, 7411.4811963162065, 7079.2566780487305, 7117.039199707973, 7118.074650295428, 7129.073220481304, 7137.714491420285, 8167.387445941697, 8368.24685778283, 8368.748937531884, 8393.580320984049, 8562.443441176303, 8596.0, 8676.392652514263, 8693.0, 8721.433106848035, 8734.606942687467, 6029.668368239789, 6891.483138764513, 7004.614746189009, 7005.229424763374, 7020.613866237406, 7194.604296763729, 7392.852142957218, 7402.259774022555, 7403.370713489414, 7408.518446300973, 6633.568818026813, 6863.725450981905, 6897.172339319314, 6987.0, 7076.469264805057, 6857.657117144223, 6885.793426197222, 6929.930700692928, 6933.965330173519, 6985.266547012694, 6964.721411143701, 7002.824929376807, 7005.964970175117, 7041.859162816818, 7173.282671732994, 6502.382273683992, 6546.116274302908, 6547.050677651809, 6553.737850485927, 6561.606303621798, 6453.257875344396, 6454.709538070704, 6464.773732919513, 6478.1578394808375, 6484.675766211765], "unit": "score", "name": "mootools.html", "value": 4488.26495714059}, {"lowerIsBetter": false, "replicates": [339.6773065587692, 344.66739596289585, 346.5512161750533, 347.1148571143584, 349.1881375801261, 5707.258056452655, 5857.824265272038, 5860.501857342126, 5879.235699359077, 5939.88120237595, 5692.686902220376, 5828.300603927524, 5840.707964601764, 5869.911951320733, 5873.9118913216225, 4589.862304130873, 4594.287885377755, 4595.632349412056, 4603.838865639704, 4604.700694454849, 4324.481062272532, 4474.149911516802, 4580.221362368406, 4586.1974154522995, 4603.539646035387, 4555.521670224628, 4559.338895860098, 4566.725996440207, 4575.084983003396, 4594.3338215958665, 4543.863684089482, 4544.863654090366, 4552.203364411248, 4561.566651168134, 4582.060677561125, 4036.798160092013, 4038.495188101487, 4043.555208927016, 4048.008237981684, 4050.8177132028836, 5362.544183744387, 5488.039593071197, 5509.465645802936, 5517.420670829585, 5537.889242215133, 5166.147585648364, 5172.379314482248, 5174.275601415805, 5178.715170665612, 5183.974080129613, 5930.466258036798, 6192.752289908398, 6193.1020002099895, 6194.225721784777, 6196.225471816023, 4258.08451182994, 4353.477582690066, 4362.738235705868, 4364.388985542027, 4371.256886329332, 6420.486361091102, 6515.250746164204, 6515.674216289167, 6517.902231466484, 6522.184726909137, 4424.380586717862, 4434.246178149722, 4438.356438316426, 4438.489573699066, 4438.7114837535455, 4420.646348292129, 4457.3091170868565, 4462.330650402466, 4473.329000649928, 4505.61702255312, 5195.506426889439, 5202.479752024768, 5205.557527610195, 5209.557187639018, 5210.6613070150315, 6267.373262673787, 6270.2789179244055, 6270.717817698214, 6293.402126797947, 6337.6197428154455, 1548.3187397545043, 1552.0687587447442, 1552.906825590468, 1554.0132016169814, 1560.5552417560941, 1037.865077539915, 1048.632978457549, 1057.3180298707443, 1067.3329169269207, 1083.6099004358425, 5912.674802885883, 5921.141434491975, 5931.584789064724, 5935.228420305332, 5946.970265148733, 6451.29035806061, 6452.741890324428, 6460.580062295936, 6477.028445733084, 6489.0, 5900.557458190653, 5944.494717948936, 5948.583599148018, 5955.374685657944, 5966.761329546856, 3379.2903490267317, 3468.0809585459874, 3479.9478007829903, 3480.147363895811, 3481.5473988381855, 6766.086578311865, 6790.864182716318, 6791.626460544718, 6800.761973330909, 6809.080774095532, 6662.467002639777, 6675.599464032173, 6680.131582894192, 6681.7327306908155, 6682.665866706645, 6604.636744979072, 6763.864722705518, 6783.18601767791, 6786.423154031864, 6788.728450862009, 6317.684115794284, 6320.4311611955145, 6484.805455836333, 6493.090967264492, 6503.089567460654, 6357.364263573606, 6377.266614339224, 6383.2978372378075, 6387.489000879826, 6401.8719625608155, 6735.0570920072205, 6735.6968936397, 6742.224644165984, 6747.190337159573, 6761.93238067613, 4276.2089013532595, 4329.393884856059, 4346.456692913386, 4348.043430445297, 4365.432493775789, 6357.110004599267, 6446.9032964506505, 6457.0, 6466.321036291121, 6473.0, 6260.655663938527, 6265.749370025148, 6268.655223962726, 6275.780347687809, 6285.371462853678, 6071.908921366271, 6265.49876009909, 6272.18461599989, 6279.152314437492, 6283.8114856554375, 6192.969035154795, 6245.125682404376, 6262.812115636538, 6274.592151510137, 6279.277883043508, 6375.87248255023, 6381.744730210925, 6387.489000880011, 6400.167978162809, 6402.0, 6174.629522228681, 6246.469050130608, 6248.343923888108, 6255.46828519581, 6260.154879091447], "unit": "score", "name": "prototype.html", "value": 4728.929774766864}, {"lowerIsBetter": false, "replicates": [579.597179959928, 622.747787146206, 635.9141515895354, 652.002436272503, 656.2518728649337, 13025.804612930802, 13315.600531984031, 13337.599872003831, 13344.733105337888, 13357.398917048731, 12116.394180290994, 13167.275799831006, 13301.13542619729, 13305.534306299282, 13306.0, 676.526431497951, 821.0557858462756, 823.7075838077486, 834.0116961400729, 834.4993004197494, 822.5023860564332, 826.2150956591232, 827.9006519217702, 828.3869936247164, 828.9544075075869, 862.0560486267527, 862.5471627395605, 862.6808081010004, 865.5499140446964, 869.2437579306013, 699.1016543741293, 859.4198915731856, 868.4919322196523, 892.7187935800267, 896.7758060484879, 630.6972653126479, 630.8706715123388, 631.8136149835764, 633.4520639646719, 634.1629049654412, 12807.93596032014, 12841.743165136644, 12845.807312890314, 12854.87145128546, 12874.613761587167, 12878.935605321913, 13091.428656476517, 13459.057865949388, 13594.252316122609, 13641.317934103354, 9983.351082179708, 10067.496625168786, 10107.747306317327, 10142.89857101427, 10749.032587067124, 3656.9085772855624, 3656.945145822815, 3721.162738383869, 3814.370628846237, 3815.9236815263816, 47745.0, 48055.75972120152, 48096.99999999965, 48149.99999999965, 48234.51765482371, 9761.671889658515, 10094.899051009543, 10112.0, 10133.391996480235, 10150.086492215736, 19130.617387652168, 19139.330123445612, 19200.519987000436, 19207.80792192088, 19232.903835481015, 7458.366038886756, 7668.616569171519, 7848.058233012075, 8009.279164875189, 8108.432409731262, 4393.467148734571, 4417.911641767147, 4426.579474949939, 4430.667699922455, 4464.933026004613, 3312.5031245313394, 3361.7646764726724, 3371.0392538126516, 3374.881879134268, 3378.223008708011, 576.702997956053, 583.5331734612294, 590.1236663554618, 590.2268028882178, 590.7695998560565, 640.7212862404868, 657.1621182991628, 662.1226874391355, 662.1888186970922, 671.6037537852691, 8272.710455134042, 8478.957605212057, 8578.270846977952, 8764.5179515126, 9350.205232555172, 540.4325458268802, 590.5600327755849, 597.3936454498687, 611.6605284067297, 698.6646409723361, 3762.852767446911, 4279.251131052053, 4303.784810759449, 4314.288142456522, 4357.869263922087, 54887.17669234965, 55474.0, 55499.44500555024, 55516.0, 55562.0, 45210.54789452129, 45548.77225613851, 46201.0, 46272.0, 46422.5357746425, 43951.0, 44283.0, 44311.11377772491, 44497.77751111224, 45035.64893053214, 8577.228049475578, 8786.077461866413, 8809.603567839335, 8847.159519845605, 8942.167988935898, 32980.0, 33094.50358244676, 33605.663943360254, 34396.14009649678, 34430.311393772485, 37190.07024824401, 37409.064773379796, 40274.395884061174, 41107.0, 41602.791986041084, 10754.677359679223, 10789.892101079202, 10863.945680271549, 11241.943790280997, 11420.71448213768, 11631.88368116308, 11714.121440891797, 11990.700232493908, 12264.693382665504, 12306.87693123093, 10458.738531536772, 10979.890201097887, 11028.117750580095, 11183.384913829817, 11477.713057173638, 11406.258593191416, 11606.88393116058, 11930.045596352098, 11984.58053968107, 12183.878161218274, 10376.0, 10402.55220996804, 10558.472076396303, 10876.129909607054, 11184.72038199019, 8994.100589940954, 9055.283414975349, 9195.0, 9228.584713688035, 9596.088371604686, 8566.871496927675, 8772.692955746517, 8867.600957957036, 9152.725418237464, 9714.659986900424], "unit": "score", "name": "yui.html", "value": 6233.254724882958}], "name": "dromaeo_css", "value": 6824.329096898233}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 106.0, 110.0, 110.0, 112.0, 101.0, 111.0, 114.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [151.0, 125.0, 152.0, 166.0, 130.0, 166.0, 153.0, 135.0, 175.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 148.7}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 161.0, 163.0, 159.0, 159.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 97.0, 91.0, 76.0, 73.0, 77.0, 104.0, 95.0, 74.0], "unit": "score", "name": "audio-fft", "value": 83.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 142.0, 96.0, 97.0, 95.0, 145.0, 97.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 116.0, 114.0, 115.0, 114.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 56.0, 57.0, 56.0, 56.0, 57.0, 66.0, 54.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 67.0, 67.0, 72.0, 67.0, 69.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 84.0, 83.0, 91.0, 84.0, 85.0, 84.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [118.0, 116.0, 120.0, 118.0, 123.0, 115.0, 121.0, 122.0, 128.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.5}, {"lowerIsBetter": true, "replicates": [156.0, 150.0, 155.0, 159.0, 159.0, 145.0, 155.0, 157.0, 143.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.6}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 72.0, 69.0, 71.0, 69.0, 69.0, 71.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.1}], "name": "kraken", "value": 1521.8999999999999}]} 08:22:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1521.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6824.33"}}} 08:22:12 INFO - Return code: 0 08:22:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:22:12 INFO - # TBPL SUCCESS # 08:22:12 INFO - Running post-action listener: _resource_record_post_action 08:22:12 INFO - Running post-run listener: _resource_record_post_run 08:22:13 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298790912; Read time: 8; Write time: 273256 08:22:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1150976; Read time: 0; Write time: 48 08:22:13 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295362560; Read time: 8; Write time: 273100 08:22:13 INFO - Running post-run listener: _upload_blobber_files 08:22:13 INFO - Blob upload gear active. 08:22:13 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:22:13 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 08:22:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:22:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:22:13 INFO - (blobuploader) - INFO - Open directory for files ... 08:22:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:22:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:22:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:14 INFO - (blobuploader) - INFO - Done attempting. 08:22:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:22:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:22:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:15 INFO - (blobuploader) - INFO - Done attempting. 08:22:15 INFO - (blobuploader) - INFO - Iteration through files over. 08:22:15 INFO - Return code: 0 08:22:15 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:22:15 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:22:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/246b455415111b4b8ddc5d26a5f0d945b08030955496ee2ec66b303e4f948bd21a729863e3411107098f6e070898c5e3212f4db4c7619b2fc77e5ec5c7259793", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0a5a88c48ee057060679c0c48a0a5ea26b6b7f9e5e54b5ba44fb83174c6b791e03cb5572fa74fb7566c470f777f7fd102eb566258b6e4c8d4a8430735bdd8cf"} 08:22:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:22:15 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:22:15 INFO - Contents: 08:22:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/246b455415111b4b8ddc5d26a5f0d945b08030955496ee2ec66b303e4f948bd21a729863e3411107098f6e070898c5e3212f4db4c7619b2fc77e5ec5c7259793", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0a5a88c48ee057060679c0c48a0a5ea26b6b7f9e5e54b5ba44fb83174c6b791e03cb5572fa74fb7566c470f777f7fd102eb566258b6e4c8d4a8430735bdd8cf"} 08:22:15 INFO - Running post-run listener: copy_logs_to_upload_dir 08:22:15 INFO - Copying logs to upload dir... 08:22:15 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:22:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.612262 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-02-16 08:22:15.599281) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 08:22:15.602800) ========= 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-1455637418.694631-1118322085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/246b455415111b4b8ddc5d26a5f0d945b08030955496ee2ec66b303e4f948bd21a729863e3411107098f6e070898c5e3212f4db4c7619b2fc77e5ec5c7259793", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0a5a88c48ee057060679c0c48a0a5ea26b6b7f9e5e54b5ba44fb83174c6b791e03cb5572fa74fb7566c470f777f7fd102eb566258b6e4c8d4a8430735bdd8cf"} build_url:https://queue.taskcluster.net/v1/task/fXzLuuyTRJySgOiLW92_CQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011496 build_url: 'https://queue.taskcluster.net/v1/task/fXzLuuyTRJySgOiLW92_CQ/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/Fx-Team/sha512/246b455415111b4b8ddc5d26a5f0d945b08030955496ee2ec66b303e4f948bd21a729863e3411107098f6e070898c5e3212f4db4c7619b2fc77e5ec5c7259793", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0a5a88c48ee057060679c0c48a0a5ea26b6b7f9e5e54b5ba44fb83174c6b791e03cb5572fa74fb7566c470f777f7fd102eb566258b6e4c8d4a8430735bdd8cf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 08:22:15.630926) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 08:22:15.631279) ========= 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-1455637418.694631-1118322085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004711 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 08:22:15.713205) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 08:22:15.713567) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 08:22:15.713877) ========= ========= Total master_lag: 0.26 =========