builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1459746732.59 results: success (0) buildid: 20160403193209 builduid: 093e6984b8474f5b866b3c1ba77726e8 revision: cfd51e67b26e1f969fb0956efb3ea27e12216491 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:12.587073) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:12.587985) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:12.588696) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006434 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:12.638797) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:12.639104) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:12.667898) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:12.668215) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:12.722888) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:12.723187) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:12.723584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:12.723913) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-03 22:12:14-- 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% 46.6M=0s 2016-04-03 22:12:14 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100456 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:12.839724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:12.840041) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022939 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:12.894045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:12.894806) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cfd51e67b26e1f969fb0956efb3ea27e12216491 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cfd51e67b26e1f969fb0956efb3ea27e12216491 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-03 22:12:14,392 truncating revision to first 12 chars 2016-04-03 22:12:14,392 Setting DEBUG logging. 2016-04-03 22:12:14,392 attempt 1/10 2016-04-03 22:12:14,392 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cfd51e67b26e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-03 22:12:14,684 unpacking tar archive at: mozilla-central-cfd51e67b26e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.593060 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:13.504648) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:13.505272) ========= echo cfd51e67b26e1f969fb0956efb3ea27e12216491 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'cfd51e67b26e1f969fb0956efb3ea27e12216491'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False cfd51e67b26e1f969fb0956efb3ea27e12216491 program finished with exit code 0 elapsedTime=0.004744 script_repo_revision: 'cfd51e67b26e1f969fb0956efb3ea27e12216491' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:13.557056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:13.557372) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-03 22:12:13.569606) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-04-03 22:12:13.570013) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:12:15 INFO - MultiFileLogger online at 20160403 22:12:15 in /builds/slave/test-pgo 22:12:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:12:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:12:15 INFO - {'append_to_log': False, 22:12:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:12:15 INFO - 'blob_upload_branch': 'Firefox', 22:12:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:12:15 INFO - 'branch': 'Firefox', 22:12:15 INFO - 'buildbot_json_path': 'buildprops.json', 22:12:15 INFO - 'config_files': ('talos/linux_config.py',), 22:12:15 INFO - 'default_actions': ('clobber', 22:12:15 INFO - 'read-buildbot-config', 22:12:15 INFO - 'download-and-extract', 22:12:15 INFO - 'populate-webroot', 22:12:15 INFO - 'create-virtualenv', 22:12:15 INFO - 'install', 22:12:15 INFO - 'run-tests'), 22:12:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:12:15 INFO - 'download_minidump_stackwalk': True, 22:12:15 INFO - 'download_symbols': 'ondemand', 22:12:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:12:15 INFO - 'tooltool.py': '/tools/tooltool.py', 22:12:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:12:15 INFO - '/tools/misc-python/virtualenv.py')}, 22:12:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:12:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:12:15 INFO - 'installer_path': 'installer.exe', 22:12:15 INFO - 'log_level': 'info', 22:12:15 INFO - 'log_name': 'talos', 22:12:15 INFO - 'log_to_console': True, 22:12:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:12:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:12:15 INFO - 'opt_config_files': (), 22:12:15 INFO - 'pip_index': False, 22:12:15 INFO - 'sps_profile': False, 22:12:15 INFO - 'sps_profile_interval': 0, 22:12:15 INFO - 'suite': 'dromaeojs', 22:12:15 INFO - 'system_bits': '32', 22:12:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:12:15 INFO - 'title': 'talos-linux64-ix-044', 22:12:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:12:15 INFO - 'use_talos_json': True, 22:12:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:12:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:12:15 INFO - 'work_dir': 'build'} 22:12:15 INFO - ##### 22:12:15 INFO - ##### Running clobber step. 22:12:15 INFO - ##### 22:12:15 INFO - Running pre-action listener: _resource_record_pre_action 22:12:15 INFO - Running main action method: clobber 22:12:15 INFO - rmtree: /builds/slave/test-pgo/build 22:12:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:12:15 INFO - Running post-action listener: _resource_record_post_action 22:12:15 INFO - ##### 22:12:15 INFO - ##### Running read-buildbot-config step. 22:12:15 INFO - ##### 22:12:15 INFO - Running pre-action listener: _resource_record_pre_action 22:12:15 INFO - Running main action method: read_buildbot_config 22:12:15 INFO - Using buildbot properties: 22:12:15 INFO - { 22:12:15 INFO - "project": "", 22:12:15 INFO - "product": "firefox", 22:12:15 INFO - "script_repo_revision": "production", 22:12:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:12:15 INFO - "repository": "", 22:12:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 22:12:15 INFO - "buildid": "20160403193209", 22:12:15 INFO - "pgo_build": "True", 22:12:15 INFO - "basedir": "/builds/slave/test-pgo", 22:12:15 INFO - "buildnumber": 728, 22:12:15 INFO - "slavename": "talos-linux64-ix-044", 22:12:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:12:15 INFO - "platform": "ubuntu64_hw", 22:12:15 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:12:15 INFO - "branch": "mozilla-central", 22:12:15 INFO - "repo_path": "mozilla-central", 22:12:15 INFO - "revision": "cfd51e67b26e1f969fb0956efb3ea27e12216491", 22:12:15 INFO - "stage_platform": "linux64-pgo", 22:12:15 INFO - "builduid": "093e6984b8474f5b866b3c1ba77726e8", 22:12:15 INFO - "slavebuilddir": "test" 22:12:15 INFO - } 22:12:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:12:15 INFO - Running post-action listener: _resource_record_post_action 22:12:15 INFO - ##### 22:12:15 INFO - ##### Running download-and-extract step. 22:12:15 INFO - ##### 22:12:15 INFO - Running pre-action listener: _resource_record_pre_action 22:12:15 INFO - Running main action method: download_and_extract 22:12:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:15 INFO - https://queue.taskcluster.net/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:12:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:12:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:12:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:12:16 INFO - Downloaded 1361 bytes. 22:12:16 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:12:16 INFO - Using the following test package requirements: 22:12:16 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:12:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:12:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:12:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:16 INFO - u'jsshell-linux-x86_64.zip'], 22:12:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:12:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:12:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:12:16 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:12:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:12:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:12:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:16 INFO - https://queue.taskcluster.net/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:12:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:12:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:12:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:12:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:12:17 INFO - Downloaded 23696556 bytes. 22:12:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:12:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:12:19 INFO - Return code: 0 22:12:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:19 INFO - https://queue.taskcluster.net/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:12:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:12:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:12:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:12:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:12:21 INFO - Downloaded 23696556 bytes. 22:12:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:12:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:12:22 INFO - Return code: 0 22:12:22 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')]} 22:12:22 INFO - https://queue.taskcluster.net/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:12:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:12:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:12:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:12:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:12:23 INFO - Downloaded 10847584 bytes. 22:12:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:12:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:12:23 INFO - Return code: 0 22:12:23 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')]} 22:12:23 INFO - https://queue.taskcluster.net/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:12:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:12:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:12:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:12:25 INFO - Downloaded 57693792 bytes. 22:12:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:12:25 INFO - mkdir: /builds/slave/test-pgo/properties 22:12:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:12:25 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:12:25 INFO - Contents: 22:12:25 INFO - build_url:https://queue.taskcluster.net/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:12:26 INFO - Running post-action listener: _resource_record_post_action 22:12:26 INFO - Running post-action listener: set_extra_try_arguments 22:12:26 INFO - ##### 22:12:26 INFO - ##### Running populate-webroot step. 22:12:26 INFO - ##### 22:12:26 INFO - Running pre-action listener: _resource_record_pre_action 22:12:26 INFO - Running main action method: populate_webroot 22:12:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:12:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:12:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:12:26 INFO - '--tppagecycles', 22:12:26 INFO - '7'], 22:12:26 INFO - 'tests': ['tsvgm']}}, 22:12:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:12:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:12:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:12:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:12:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:12:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:12:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:12:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:26 INFO - 'talos_options': ['--e10s'], 22:12:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:12:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:26 INFO - 'tests': ['damp', 'tps']}, 22:12:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:26 INFO - 'talos_options': ['--e10s'], 22:12:26 INFO - 'tests': ['damp', 'tps']}, 22:12:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:12:26 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 22:12:26 INFO - 'tests': ['dromaeo_dom']}, 22:12:26 INFO - 'other': {'tests': ['a11yr', 22:12:26 INFO - 'ts_paint', 22:12:26 INFO - 'tpaint', 22:12:26 INFO - 'sessionrestore', 22:12:26 INFO - 'sessionrestore_no_auto_restore', 22:12:26 INFO - 'tabpaint']}, 22:12:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:12:26 INFO - 'tests': ['a11yr', 22:12:26 INFO - 'ts_paint', 22:12:26 INFO - 'tpaint', 22:12:26 INFO - 'sessionrestore', 22:12:26 INFO - 'sessionrestore_no_auto_restore', 22:12:26 INFO - 'tabpaint']}, 22:12:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:12:26 INFO - 'tests': ['a11yr', 22:12:26 INFO - 'ts_paint', 22:12:26 INFO - 'tpaint', 22:12:26 INFO - 'sessionrestore', 22:12:26 INFO - 'sessionrestore_no_auto_restore', 22:12:26 INFO - 'tabpaint']}, 22:12:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:12:26 INFO - 'tests': ['a11yr', 22:12:26 INFO - 'ts_paint', 22:12:26 INFO - 'tpaint', 22:12:26 INFO - 'sessionrestore', 22:12:26 INFO - 'sessionrestore_no_auto_restore', 22:12:26 INFO - 'tabpaint']}, 22:12:26 INFO - 'other_l64': {'tests': ['a11yr', 22:12:26 INFO - 'ts_paint', 22:12:26 INFO - 'tpaint', 22:12:26 INFO - 'sessionrestore', 22:12:26 INFO - 'sessionrestore_no_auto_restore', 22:12:26 INFO - 'tabpaint']}, 22:12:26 INFO - 'other_nol64': {'tests': ['a11yr', 22:12:26 INFO - 'ts_paint', 22:12:26 INFO - 'tpaint', 22:12:26 INFO - 'sessionrestore', 22:12:26 INFO - 'sessionrestore_no_auto_restore', 22:12:26 INFO - 'tabpaint']}, 22:12:26 INFO - 'svgr': {'tests': ['tsvgx', 22:12:26 INFO - 'tsvgr_opacity', 22:12:26 INFO - 'tart', 22:12:26 INFO - 'tscrollx', 22:12:26 INFO - 'cart']}, 22:12:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:12:26 INFO - 'tests': ['tsvgx', 22:12:26 INFO - 'tsvgr_opacity', 22:12:26 INFO - 'tart', 22:12:26 INFO - 'tscrollx', 22:12:26 INFO - 'cart']}, 22:12:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:26 INFO - 'tests': ['tp5o']}, 22:12:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:26 INFO - 'talos_options': ['--e10s'], 22:12:26 INFO - 'tests': ['tp5o']}, 22:12:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:26 INFO - 'talos_options': ['--xperf_path', 22:12:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:12:26 INFO - 'tests': ['tp5n']}, 22:12:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:26 INFO - 'talos_options': ['--e10s', 22:12:26 INFO - '--xperf_path', 22:12:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:12:26 INFO - 'tests': ['tp5n']}}, 22:12:26 INFO - 'talos.zip': {'path': '', 22:12:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:12:26 INFO - Running post-action listener: _resource_record_post_action 22:12:26 INFO - ##### 22:12:26 INFO - ##### Running create-virtualenv step. 22:12:26 INFO - ##### 22:12:26 INFO - Running pre-action listener: _resource_record_pre_action 22:12:26 INFO - Running main action method: create_virtualenv 22:12:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:12:26 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 22:12:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:12:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:12:26 INFO - Using real prefix '/usr' 22:12:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:12:26 INFO - Installing distribute.............................................................................................................................................................................................done. 22:12:28 INFO - Installing pip.................done. 22:12:28 INFO - Return code: 0 22:12:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93ded71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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 0x1da2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da2be0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', '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 22:12:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:12:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:12:28 INFO - Using env: {'DISPLAY': ':0', 22:12:28 INFO - 'HOME': '/home/cltbld', 22:12:28 INFO - 'LANG': 'en_US.UTF-8', 22:12:28 INFO - 'LANGUAGE': 'en_US:en', 22:12:28 INFO - 'LOGNAME': 'cltbld', 22:12:28 INFO - 'MAIL': '/var/mail/cltbld', 22:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:28 INFO - 'MOZ_NO_REMOTE': '1', 22:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:28 INFO - 'NO_EM_RESTART': '1', 22:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:28 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:28 INFO - 'SHELL': '/bin/bash', 22:12:28 INFO - 'SHLVL': '1', 22:12:28 INFO - 'TERM': 'linux', 22:12:28 INFO - 'TMOUT': '86400', 22:12:28 INFO - 'USER': 'cltbld', 22:12:28 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', 22:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:28 INFO - '_': '/tools/buildbot/bin/python'} 22:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:28 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 22:12:28 INFO - Cleaning up... 22:12:28 INFO - Return code: 0 22:12:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f93ded71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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 0x1da2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da2be0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', '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 22:12:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:12:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:12:28 INFO - Using env: {'DISPLAY': ':0', 22:12:28 INFO - 'HOME': '/home/cltbld', 22:12:28 INFO - 'LANG': 'en_US.UTF-8', 22:12:28 INFO - 'LANGUAGE': 'en_US:en', 22:12:28 INFO - 'LOGNAME': 'cltbld', 22:12:28 INFO - 'MAIL': '/var/mail/cltbld', 22:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:28 INFO - 'MOZ_NO_REMOTE': '1', 22:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:28 INFO - 'NO_EM_RESTART': '1', 22:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:28 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:28 INFO - 'SHELL': '/bin/bash', 22:12:28 INFO - 'SHLVL': '1', 22:12:28 INFO - 'TERM': 'linux', 22:12:28 INFO - 'TMOUT': '86400', 22:12:28 INFO - 'USER': 'cltbld', 22:12:28 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', 22:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:28 INFO - '_': '/tools/buildbot/bin/python'} 22:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:29 INFO - Downloading/unpacking psutil>=0.7.1 22:12:29 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 22:12:29 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 22:12:29 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 22:12:29 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 22:12:29 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 22:12:29 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 22:12:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:12:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:12:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:12:31 INFO - Installing collected packages: psutil 22:12:31 INFO - Running setup.py install for psutil 22:12:31 INFO - building 'psutil._psutil_linux' extension 22:12:31 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 22:12:31 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 22:12:31 INFO - building 'psutil._psutil_posix' extension 22:12:31 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 22:12:31 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 22:12:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:12:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:12:31 INFO - Successfully installed psutil 22:12:31 INFO - Cleaning up... 22:12:31 INFO - Return code: 0 22:12:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:12: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')]} 22:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12: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')]} 22:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:31 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 0x7f93ded71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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 0x1da2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da2be0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', '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 22:12:31 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 22:12:31 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 22:12:31 INFO - Using env: {'DISPLAY': ':0', 22:12:31 INFO - 'HOME': '/home/cltbld', 22:12:31 INFO - 'LANG': 'en_US.UTF-8', 22:12:31 INFO - 'LANGUAGE': 'en_US:en', 22:12:31 INFO - 'LOGNAME': 'cltbld', 22:12:31 INFO - 'MAIL': '/var/mail/cltbld', 22:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:31 INFO - 'MOZ_NO_REMOTE': '1', 22:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:31 INFO - 'NO_EM_RESTART': '1', 22:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:31 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:31 INFO - 'SHELL': '/bin/bash', 22:12:31 INFO - 'SHLVL': '1', 22:12:31 INFO - 'TERM': 'linux', 22:12:31 INFO - 'TMOUT': '86400', 22:12:31 INFO - 'USER': 'cltbld', 22:12:31 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', 22:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:31 INFO - '_': '/tools/buildbot/bin/python'} 22:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:12:31 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 22:12:31 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 22:12:31 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 22:12:31 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 22:12:31 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 22:12:31 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 22:12:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:12:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:12:33 INFO - Installing collected packages: mozsystemmonitor 22:12:33 INFO - Running setup.py install for mozsystemmonitor 22:12:33 INFO - Successfully installed mozsystemmonitor 22:12:33 INFO - Cleaning up... 22:12:33 INFO - Return code: 0 22:12:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:12: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')]} 22:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12: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')]} 22:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:33 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 0x7f93ded71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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 0x1da2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da2be0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', '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 22:12:33 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 22:12:33 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 22:12:33 INFO - Using env: {'DISPLAY': ':0', 22:12:33 INFO - 'HOME': '/home/cltbld', 22:12:33 INFO - 'LANG': 'en_US.UTF-8', 22:12:33 INFO - 'LANGUAGE': 'en_US:en', 22:12:33 INFO - 'LOGNAME': 'cltbld', 22:12:33 INFO - 'MAIL': '/var/mail/cltbld', 22:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:33 INFO - 'MOZ_NO_REMOTE': '1', 22:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:33 INFO - 'NO_EM_RESTART': '1', 22:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:33 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:33 INFO - 'SHELL': '/bin/bash', 22:12:33 INFO - 'SHLVL': '1', 22:12:33 INFO - 'TERM': 'linux', 22:12:33 INFO - 'TMOUT': '86400', 22:12:33 INFO - 'USER': 'cltbld', 22:12:33 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', 22:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:33 INFO - '_': '/tools/buildbot/bin/python'} 22:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:34 INFO - Downloading/unpacking blobuploader==1.2.4 22:12:34 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 22:12:34 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 22:12:34 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 22:12:34 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 22:12:34 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 22:12:34 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 22:12:36 INFO - Downloading blobuploader-1.2.4.tar.gz 22:12:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:12:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:12:36 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 22:12:36 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 22:12:36 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 22:12:36 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 22:12:36 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 22:12:36 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 22:12:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:12:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:12:36 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 22:12:36 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 22:12:36 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 22:12:36 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 22:12:36 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 22:12:36 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 22:12:36 INFO - Downloading docopt-0.6.1.tar.gz 22:12:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:12:36 INFO - Installing collected packages: blobuploader, requests, docopt 22:12:36 INFO - Running setup.py install for blobuploader 22:12:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:12:36 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:12:36 INFO - Running setup.py install for requests 22:12:37 INFO - Running setup.py install for docopt 22:12:37 INFO - Successfully installed blobuploader requests docopt 22:12:37 INFO - Cleaning up... 22:12:37 INFO - Return code: 0 22:12:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:12: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')]} 22:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12: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')]} 22:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:37 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 0x7f93ded71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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 0x1da2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da2be0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', '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 22:12:37 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 22:12:37 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 22:12:37 INFO - Using env: {'DISPLAY': ':0', 22:12:37 INFO - 'HOME': '/home/cltbld', 22:12:37 INFO - 'LANG': 'en_US.UTF-8', 22:12:37 INFO - 'LANGUAGE': 'en_US:en', 22:12:37 INFO - 'LOGNAME': 'cltbld', 22:12:37 INFO - 'MAIL': '/var/mail/cltbld', 22:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:37 INFO - 'MOZ_NO_REMOTE': '1', 22:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:37 INFO - 'NO_EM_RESTART': '1', 22:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:37 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:37 INFO - 'SHELL': '/bin/bash', 22:12:37 INFO - 'SHLVL': '1', 22:12:37 INFO - 'TERM': 'linux', 22:12:37 INFO - 'TMOUT': '86400', 22:12:37 INFO - 'USER': 'cltbld', 22:12:37 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', 22:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:37 INFO - '_': '/tools/buildbot/bin/python'} 22:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:12:37 INFO - Running setup.py (path:/tmp/pip-kLlFRb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:12:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:12:37 INFO - Running setup.py (path:/tmp/pip-qMHhCv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:12:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:12:37 INFO - Running setup.py (path:/tmp/pip-vKRI9q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:12:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:12:37 INFO - Running setup.py (path:/tmp/pip-IEyLex-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:12:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:12:37 INFO - Running setup.py (path:/tmp/pip-oafSE3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:12:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:12:37 INFO - Running setup.py (path:/tmp/pip-HKDY_L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:12:38 INFO - Running setup.py (path:/tmp/pip-jGX3D2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:12:38 INFO - Running setup.py (path:/tmp/pip-4jPHwr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:12:38 INFO - Running setup.py (path:/tmp/pip-pwEfaI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:12:38 INFO - Running setup.py (path:/tmp/pip-ujdl4R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:12:38 INFO - Running setup.py (path:/tmp/pip-AH1ZT5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:12:38 INFO - Running setup.py (path:/tmp/pip-OAduBA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:12:38 INFO - Running setup.py (path:/tmp/pip-s5jxs1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:12:38 INFO - Running setup.py (path:/tmp/pip-XvcXoT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:12:38 INFO - Running setup.py (path:/tmp/pip-EpxfnS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:12:38 INFO - Running setup.py (path:/tmp/pip-hPpQvj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:12:38 INFO - Running setup.py (path:/tmp/pip-nPaYQb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:12:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:12:38 INFO - Running setup.py install for manifestparser 22:12:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:12:38 INFO - Running setup.py install for mozcrash 22:12:39 INFO - Running setup.py install for mozdebug 22:12:39 INFO - Running setup.py install for mozdevice 22:12:39 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:12:39 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:12:39 INFO - Running setup.py install for mozfile 22:12:39 INFO - Running setup.py install for mozhttpd 22:12:39 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:12:39 INFO - Running setup.py install for mozinfo 22:12:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:12:39 INFO - Running setup.py install for mozInstall 22:12:39 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:12:39 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:12:39 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:12:39 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:12:39 INFO - Running setup.py install for mozleak 22:12:39 INFO - Running setup.py install for mozlog 22:12:39 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:12:39 INFO - Running setup.py install for moznetwork 22:12:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:12:39 INFO - Running setup.py install for mozprocess 22:12:40 INFO - Running setup.py install for mozprofile 22:12:40 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:12:40 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:12:40 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:12:40 INFO - Running setup.py install for mozrunner 22:12:40 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:12:40 INFO - Running setup.py install for mozscreenshot 22:12:40 INFO - Running setup.py install for moztest 22:12:40 INFO - Running setup.py install for mozversion 22:12:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:12:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:12:40 INFO - Cleaning up... 22:12:40 INFO - Return code: 0 22:12:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f93ded71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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 0x1da2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da2be0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', '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 22:12:40 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 22:12:40 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 22:12:40 INFO - Using env: {'DISPLAY': ':0', 22:12:40 INFO - 'HOME': '/home/cltbld', 22:12:40 INFO - 'LANG': 'en_US.UTF-8', 22:12:40 INFO - 'LANGUAGE': 'en_US:en', 22:12:40 INFO - 'LOGNAME': 'cltbld', 22:12:40 INFO - 'MAIL': '/var/mail/cltbld', 22:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:40 INFO - 'MOZ_NO_REMOTE': '1', 22:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:40 INFO - 'NO_EM_RESTART': '1', 22:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:40 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:40 INFO - 'SHELL': '/bin/bash', 22:12:40 INFO - 'SHLVL': '1', 22:12:40 INFO - 'TERM': 'linux', 22:12:40 INFO - 'TMOUT': '86400', 22:12:40 INFO - 'USER': 'cltbld', 22:12:40 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', 22:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:40 INFO - '_': '/tools/buildbot/bin/python'} 22:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:12:40 INFO - Running setup.py (path:/tmp/pip-qo9A7F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:12:40 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)) 22:12:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:12:40 INFO - Running setup.py (path:/tmp/pip-Vfax6I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 22:12:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:12:40 INFO - Running setup.py (path:/tmp/pip-IngXM5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:12:41 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)) 22:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:12:41 INFO - Running setup.py (path:/tmp/pip-HhJ14O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:12:41 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)) 22:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:12:41 INFO - Running setup.py (path:/tmp/pip-IqbsE5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:12:41 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)) 22:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:12:41 INFO - Running setup.py (path:/tmp/pip-LAGmSv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:12:41 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)) 22:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:12:41 INFO - Running setup.py (path:/tmp/pip-Y_avSO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:12:41 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)) 22:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:12:41 INFO - Running setup.py (path:/tmp/pip-wwl0dd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:12:41 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)) 22:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:12:41 INFO - Running setup.py (path:/tmp/pip-6Daql6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:12:41 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)) 22:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:12:41 INFO - Running setup.py (path:/tmp/pip-Jgyy8S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:12:41 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)) 22:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:12:41 INFO - Running setup.py (path:/tmp/pip-NEoLhO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:12:41 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)) 22:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:12:41 INFO - Running setup.py (path:/tmp/pip-DJ7EoP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:12:41 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)) 22:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:12:41 INFO - Running setup.py (path:/tmp/pip-dl3df2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:12:41 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)) 22:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:12:41 INFO - Running setup.py (path:/tmp/pip-EysW7R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:12:41 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)) 22:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:12:41 INFO - Running setup.py (path:/tmp/pip-ZYC04L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:12:41 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)) 22:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:12:41 INFO - Running setup.py (path:/tmp/pip-tc6oOD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:12:42 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)) 22:12:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:12:42 INFO - Running setup.py (path:/tmp/pip-yulJi8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:12:42 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)) 22:12:42 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:12:42 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:12:42 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)) 22:12:42 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)) 22:12:42 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)) 22:12:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:43 INFO - Downloading blessings-1.6.tar.gz 22:12:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:12:44 INFO - Installing collected packages: blessings 22:12:44 INFO - Running setup.py install for blessings 22:12:44 INFO - Successfully installed blessings 22:12:44 INFO - Cleaning up... 22:12:44 INFO - Return code: 0 22:12:44 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:12:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:12:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:12:44 INFO - Reading from file tmpfile_stdout 22:12:44 INFO - Current package versions: 22:12:44 INFO - argparse == 1.2.1 22:12:44 INFO - blessings == 1.6 22:12:44 INFO - blobuploader == 1.2.4 22:12:44 INFO - docopt == 0.6.1 22:12:44 INFO - manifestparser == 1.1 22:12:44 INFO - mozInstall == 1.12 22:12:44 INFO - mozcrash == 0.17 22:12:44 INFO - mozdebug == 0.1 22:12:44 INFO - mozdevice == 0.48 22:12:44 INFO - mozfile == 1.2 22:12:44 INFO - mozhttpd == 0.7 22:12:44 INFO - mozinfo == 0.9 22:12:44 INFO - mozleak == 0.1 22:12:44 INFO - mozlog == 3.1 22:12:44 INFO - moznetwork == 0.27 22:12:44 INFO - mozprocess == 0.22 22:12:44 INFO - mozprofile == 0.28 22:12:44 INFO - mozrunner == 6.11 22:12:44 INFO - mozscreenshot == 0.1 22:12:44 INFO - mozsystemmonitor == 0.0 22:12:44 INFO - moztest == 0.7 22:12:44 INFO - mozversion == 1.4 22:12:44 INFO - psutil == 3.1.1 22:12:44 INFO - requests == 1.2.3 22:12:44 INFO - wsgiref == 0.1.2 22:12:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:12:44 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')]} 22:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:44 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')]} 22:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:44 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 0x7f93ded71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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 0x1da2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da2be0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', '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 22:12:44 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 22:12:44 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 22:12:44 INFO - Using env: {'DISPLAY': ':0', 22:12:44 INFO - 'HOME': '/home/cltbld', 22:12:44 INFO - 'LANG': 'en_US.UTF-8', 22:12:44 INFO - 'LANGUAGE': 'en_US:en', 22:12:44 INFO - 'LOGNAME': 'cltbld', 22:12:44 INFO - 'MAIL': '/var/mail/cltbld', 22:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:44 INFO - 'MOZ_NO_REMOTE': '1', 22:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:44 INFO - 'NO_EM_RESTART': '1', 22:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:44 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:44 INFO - 'SHELL': '/bin/bash', 22:12:44 INFO - 'SHLVL': '1', 22:12:44 INFO - 'TERM': 'linux', 22:12:44 INFO - 'TMOUT': '86400', 22:12:44 INFO - 'USER': 'cltbld', 22:12:44 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', 22:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:44 INFO - '_': '/tools/buildbot/bin/python'} 22:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:44 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)) 22:12:44 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)) 22:12:44 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)) 22:12:44 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)) 22:12:44 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)) 22:12:44 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)) 22:12:44 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)) 22:12:44 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)) 22:12:44 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)) 22:12:44 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)) 22:12:44 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)) 22:12:44 INFO - Cleaning up... 22:12:44 INFO - Return code: 0 22:12:44 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:12:44 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')]} 22:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:44 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')]} 22:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:44 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 0x7f93ded71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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 0x1da2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da2be0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', '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 22:12:44 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 22:12:44 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 22:12:44 INFO - Using env: {'DISPLAY': ':0', 22:12:44 INFO - 'HOME': '/home/cltbld', 22:12:44 INFO - 'LANG': 'en_US.UTF-8', 22:12:44 INFO - 'LANGUAGE': 'en_US:en', 22:12:44 INFO - 'LOGNAME': 'cltbld', 22:12:44 INFO - 'MAIL': '/var/mail/cltbld', 22:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:44 INFO - 'MOZ_NO_REMOTE': '1', 22:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:44 INFO - 'NO_EM_RESTART': '1', 22:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:44 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:44 INFO - 'SHELL': '/bin/bash', 22:12:44 INFO - 'SHLVL': '1', 22:12:44 INFO - 'TERM': 'linux', 22:12:44 INFO - 'TMOUT': '86400', 22:12:44 INFO - 'USER': 'cltbld', 22:12:44 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', 22:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:44 INFO - '_': '/tools/buildbot/bin/python'} 22:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:44 INFO - Downloading/unpacking jsonschema 22:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:12:46 INFO - Downloading/unpacking functools32 (from jsonschema) 22:12:46 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 22:12:46 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 22:12:46 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 22:12:46 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 22:12:46 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 22:12:46 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 22:12:46 INFO - Downloading functools32-3.2.3-2.tar.gz 22:12:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:12:46 INFO - warning: no files found matching '*.txt' 22:12:46 INFO - no previously-included directories found matching 'build' 22:12:46 INFO - no previously-included directories found matching 'dist' 22:12:46 INFO - no previously-included directories found matching '.git*' 22:12:46 INFO - Installing collected packages: jsonschema, functools32 22:12:47 INFO - Running setup.py install for functools32 22:12:47 INFO - warning: no files found matching '*.txt' 22:12:47 INFO - no previously-included directories found matching 'build' 22:12:47 INFO - no previously-included directories found matching 'dist' 22:12:47 INFO - no previously-included directories found matching '.git*' 22:12:47 INFO - Successfully installed jsonschema functools32 22:12:47 INFO - Cleaning up... 22:12:47 INFO - Return code: 0 22:12:47 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:12:47 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')]} 22:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:47 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')]} 22:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:47 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 0x7f93ded71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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 0x1da2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da2be0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', '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 22:12:47 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 22:12:47 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 22:12:47 INFO - Using env: {'DISPLAY': ':0', 22:12:47 INFO - 'HOME': '/home/cltbld', 22:12:47 INFO - 'LANG': 'en_US.UTF-8', 22:12:47 INFO - 'LANGUAGE': 'en_US:en', 22:12:47 INFO - 'LOGNAME': 'cltbld', 22:12:47 INFO - 'MAIL': '/var/mail/cltbld', 22:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:47 INFO - 'MOZ_NO_REMOTE': '1', 22:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:47 INFO - 'NO_EM_RESTART': '1', 22:12:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:47 INFO - 'SHELL': '/bin/bash', 22:12:47 INFO - 'SHLVL': '1', 22:12:47 INFO - 'TERM': 'linux', 22:12:47 INFO - 'TMOUT': '86400', 22:12:47 INFO - 'USER': 'cltbld', 22:12:47 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', 22:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:47 INFO - '_': '/tools/buildbot/bin/python'} 22:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:47 INFO - Downloading/unpacking flake8 22:12:47 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 22:12:47 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 22:12:47 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 22:12:47 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 22:12:47 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 22:12:47 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 22:12:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:12:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:12:49 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 22:12:49 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 22:12:49 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 22:12:49 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 22:12:49 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 22:12:49 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 22:12:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:12:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:12:49 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 22:12:49 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 22:12:49 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 22:12:49 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 22:12:49 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 22:12:49 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 22:12:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:12:49 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 22:12:49 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 22:12:49 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 22:12:49 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 22:12:49 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 22:12:49 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 22:12:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:12:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:12:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:12:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:12:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:12:50 INFO - no previously-included directories found matching 'docs/_build' 22:12:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:12:50 INFO - Running setup.py install for pep8 22:12:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:12:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:12:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:12:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:12:50 INFO - no previously-included directories found matching 'docs/_build' 22:12:50 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:12:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:12:50 INFO - Cleaning up... 22:12:50 INFO - Return code: 0 22:12:50 INFO - Running post-action listener: _resource_record_post_action 22:12:50 INFO - Running post-action listener: _start_resource_monitoring 22:12:50 INFO - Starting resource monitoring. 22:12:50 INFO - ##### 22:12:50 INFO - ##### Running install step. 22:12:50 INFO - ##### 22:12:50 INFO - Running pre-action listener: _resource_record_pre_action 22:12:50 INFO - Running main action method: install 22:12:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:12:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:12:50 INFO - Reading from file tmpfile_stdout 22:12:50 INFO - Detecting whether we're running mozinstall >=1.0... 22:12:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:12:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:12:50 INFO - Reading from file tmpfile_stdout 22:12:50 INFO - Output received: 22:12:50 INFO - Usage: mozinstall [options] installer 22:12:50 INFO - Options: 22:12:50 INFO - -h, --help show this help message and exit 22:12:50 INFO - -d DEST, --destination=DEST 22:12:50 INFO - Directory to install application into. [default: 22:12:50 INFO - "/builds/slave/test-pgo"] 22:12:50 INFO - --app=APP Application being installed. [default: firefox] 22:12:50 INFO - mkdir: /builds/slave/test-pgo/build/application 22:12:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:12:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:13:07 INFO - Reading from file tmpfile_stdout 22:13:07 INFO - Output received: 22:13:07 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:13:07 INFO - Running post-action listener: _resource_record_post_action 22:13:07 INFO - ##### 22:13:07 INFO - ##### Running run-tests step. 22:13:07 INFO - ##### 22:13:07 INFO - Running pre-action listener: _resource_record_pre_action 22:13:07 INFO - Running main action method: run_tests 22:13:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:13:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:13:07 INFO - Python 2.7.3 22:13:07 INFO - Return code: 0 22:13:07 INFO - grabbing minidump binary from tooltool 22:13: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')]} 22:13:07 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 0x1d9f1d0>, '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 0x1da2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da2be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:13:07 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 22:13:07 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 22:13:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:13:07 INFO - Return code: 0 22:13:07 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:13:07 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:13:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:13:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:13:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:13:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:13:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:13:08 INFO - Return code: 0 22:13:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 22:13:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 22:13:08 INFO - Using env: {'DISPLAY': ':0', 22:13:08 INFO - 'HOME': '/home/cltbld', 22:13:08 INFO - 'LANG': 'en_US.UTF-8', 22:13:08 INFO - 'LANGUAGE': 'en_US:en', 22:13:08 INFO - 'LOGNAME': 'cltbld', 22:13:08 INFO - 'MAIL': '/var/mail/cltbld', 22:13:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:13:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:08 INFO - 'MOZ_NO_REMOTE': '1', 22:13:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:08 INFO - 'NO_EM_RESTART': '1', 22:13:08 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:13:08 INFO - 'PWD': '/builds/slave/test-pgo', 22:13:08 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:13:08 INFO - 'SHELL': '/bin/bash', 22:13:08 INFO - 'SHLVL': '1', 22:13:08 INFO - 'TERM': 'linux', 22:13:08 INFO - 'TMOUT': '86400', 22:13:08 INFO - 'USER': 'cltbld', 22:13:08 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638', 22:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:08 INFO - '_': '/tools/buildbot/bin/python'} 22:13:08 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 22:13:08 INFO - mozversion application_buildid: 20160403193209 22:13:08 INFO - mozversion application_changeset: cfd51e67b26e1f969fb0956efb3ea27e12216491 22:13:08 INFO - mozversion application_display_name: Nightly 22:13:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:13:08 INFO - mozversion application_name: Firefox 22:13:08 INFO - mozversion application_remotingname: firefox 22:13:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:13:08 INFO - mozversion application_vendor: Mozilla 22:13:08 INFO - mozversion application_version: 48.0a1 22:13:08 INFO - mozversion platform_buildid: 20160403193209 22:13:08 INFO - mozversion platform_changeset: cfd51e67b26e1f969fb0956efb3ea27e12216491 22:13:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:13:08 INFO - mozversion platform_version: 48.0a1 22:13:08 INFO - using testdate: 1459746788 22:13:08 INFO - actual date: 1459746788 22:13:08 INFO - starting webserver on 'localhost:54194' 22:13:08 INFO - SUITE-START | Running 2 tests 22:13:08 INFO - TEST-START | dromaeo_css 22:13:08 INFO - operating with platform_type : linux_ 22:13:08 INFO - Initialising browser for dromaeo_css test... 22:13:08 INFO - TEST-INFO | started process 22676 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxHBUGA/profile http://localhost:54194/getInfo.html) 22:13:12 INFO - PROCESS | 22676 | __metrics Screen width/height:1600/1200 22:13:12 INFO - PROCESS | 22676 | colorDepth:24 22:13:12 INFO - PROCESS | 22676 | Browser inner width/height: 1024/697 22:13:12 INFO - PROCESS | 22676 | __metrics 22:13:13 ERROR - PROCESS | 22676 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:13:14 INFO - TEST-INFO | 22676: exit 0 22:13:14 INFO - Browser initialized. 22:13:14 INFO - Running cycle 1/1 for dromaeo_css test... 22:13:14 INFO - TEST-INFO | started process 22758 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxHBUGA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:13:26 INFO - PROCESS | 22758 | RSS: Main: 152645632 22:13:26 INFO - PROCESS | 22758 | 22:14:17 INFO - PROCESS | 22758 | 1459746857159 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] 22:16:24 INFO - PROCESS | 22758 | Cycle 1(1): loaded http://localhost:54194/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54194/tests/dromaeo/cssquery-ext.html) 22:16:25 INFO - PROCESS | 22758 | RSS: Main: 253734912 22:16:25 INFO - PROCESS | 22758 | 22:19:27 INFO - PROCESS | 22758 | Cycle 1(1): loaded http://localhost:54194/tests/dromaeo/cssquery-ext.html (next: http://localhost:54194/tests/dromaeo/cssquery-jquery.html) 22:19:28 INFO - PROCESS | 22758 | RSS: Main: 241324032 22:19:28 INFO - PROCESS | 22758 | 22:22:30 INFO - PROCESS | 22758 | Cycle 1(1): loaded http://localhost:54194/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54194/tests/dromaeo/cssquery-mootools.html) 22:22:30 INFO - PROCESS | 22758 | RSS: Main: 232210432 22:22:30 INFO - PROCESS | 22758 | 22:25:32 INFO - PROCESS | 22758 | Cycle 1(1): loaded http://localhost:54194/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54194/tests/dromaeo/cssquery-prototype.html) 22:25:33 INFO - PROCESS | 22758 | RSS: Main: 204222464 22:25:33 INFO - PROCESS | 22758 | 22:28:35 INFO - PROCESS | 22758 | Cycle 1(1): loaded http://localhost:54194/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54194/tests/dromaeo/cssquery-yui.html) 22:28:36 INFO - PROCESS | 22758 | RSS: Main: 220737536 22:28:36 INFO - PROCESS | 22758 | 22:31:39 INFO - PROCESS | 22758 | Cycle 1(1): loaded http://localhost:54194/tests/dromaeo/cssquery-yui.html (next: http://localhost:54194/tests/dromaeo/cssquery-dojo.html) 22:31:39 INFO - PROCESS | 22758 | RSS: Main: 266960896 22:31:39 INFO - PROCESS | 22758 | 22:31:39 INFO - PROCESS | 22758 | __start_tp_report 22:31:39 INFO - PROCESS | 22758 | _x_x_mozilla_page_load 22:31:39 INFO - PROCESS | 22758 | _x_x_mozilla_page_load_details 22:31:39 INFO - PROCESS | 22758 | |i|pagename|runs| 22:31:39 INFO - PROCESS | 22758 | |0;dojo.html;3114.2058775012374;3127.655957844638;3166.8574914128862;3167.3190264093214;3186.649468558459;5257.263983042372;5259.8422047338645;5292.0209761194155;5322.308099947007;5373.919391209125;5331.173668081454;5341.1187154119525;5382.111951528003;5418.133098704208;5437.211604317372;4773.594244489223;4800.255960326155;4803.471618122004;4820.542048505386;4981.0037992401485;4902.754862256873;4919.704817710931;4945.77744001519;4947.060058588874;4958.851234462972;4754.930140718328;4808.68743531671;4854.344663470457;4882.926756098661;4898.24077268024;4816.951830481686;4842.903141937177;4848.7090774553635;4850.223964165716;4891.828785992473;4737.24204127338;4803.711777293373;4815.855524334275;4840.975795121037;4875.634327425421;5217.191335343028;5263.078961181778;5287.920681189786;5291;5294.258803767476;5646.971765141189;5667.4615911488345;5680.4319568042865;5682.54539636828;5684.34630017545;5587;5649.548036157139;5682.687452190128;5711.8000869969355;5711.8000869969355;5355.437679043722;5355.571554275649;5361.597880159004;5375.704336261504;5382.811601593926;5804.593678442553;5805.419458054245;5806.854828629233;5808.361080281165;5816.243888294579;5504.724763761796;5584.46947539983;5587.636803607753;5613.186088017296;5685.857853553694;5640.830775076754;5646.830595082154;5652.2652055233375;5654.547636189177;5680.11958146488;5637.069883469264;5637.379888212294;5637.43625637433;5638.774449022075;5639.154126881001;5458;5599.692016939026;5637.154426835926;5686.9715651421475;5715.48560629537;4288.871333859989;4303.225419424471;4304.80628371724;4310.439642846472;4333.58830911063;3857.61423857612;3860.343741563941;3900.8439662413184;3923.1172986077904;3926.155876486512;5319.9202011969855;5387.676739395649;5389.514943655012;5457.2905522282645;5460.563154947595;5607.8598035048635;5613.073842815971;5617.354004289477;5627.127795191752;5629.211910332557;5291.1798671206025;5297.8145764898045;5298.125809241432;5300.814471493479;5345.3852806926925;4807.78364973577;4873.878153046202;4886.755662216946;4927.556519913225;4940.654154209171;5854.385289544622;5855;5862.912056319158;5863.179154918314;5879.470847623735;5542.140968149944;5684.573656975744;5706;5710.8001219957105;5712.885742285214;5762.913556296575;5802.100674395476;5815.9709201453725;5831.7375718091935;5834.03738383162;5560.388357280615;5561;5562.443755624405;5564.554835613222;5569.303837020372;5543.501084902378;5640.0693885508435;5651.4348565143155;5653.180288858175;5734.827955161351;5522.861928451821;5536.584756143225;5536.806211782729;5554.000279949648;5584.664920104644;5486.31421072366;5488.780448782164;5489.780408783764;5493.395726470165;5496;5385.946140538545;5395.325584301962;5402;5435.537979271648;5505;5566.192902029102;5566.582506311962;5576.052071147996;5579.330480342385;5625.662460252398;5399.2980912481125;5432.864178395572;5436.266104075899;5437.26596909428;5482.342118945752 22:31:39 INFO - PROCESS | 22758 | |1;ext.html;543.4480715462809;557.2894559436716;570.3355590736792;578.0808514462004;592.9762809487621;29703.108906732778;30120.54819177714;30221.546676799866;30252.09243722692;38503.614963850356;40358.39462408066;40796.18407631846;41078.79460602693;41119;41175.79412102943;8459.577021148933;8645.69740059098;8663.696770613029;8666.306695464347;8669.869951950694;8589.398742088026;8710.782230444258;8723.040465548784;8724.43291186071;8724.912750872474;8651.826963460759;8693.5218562979;8723.694670686527;8740.825183496327;8872.467651940904;8896.466212027266;8977.820443591092;8982.86525702115;8987.685431009882;8990.595423205972;8729.738107856774;8873.689420870303;8886.155815197611;8914.197722205032;8926.2412694921;38156.23687526261;38403.039924001845;38443.42334864979;38577;38736.80631596852;3365.5456513370873;3481;3502.982485087584;3544.8404821782824;3893.6301051400073;29695.70304296951;30985.380292394253;31012.224694382596;31206.843965780252;31409.84295078533;4178.749275043477;4243.448351714257;4373.737575745434;4384.232759267147;4469.642428605736;331064;335707;336398;337055;338000.3099984509;56984.715076424356;62594.68702656458;62741;63686.36313636897;63737.68131159314;55390.72304638451;55526.444735552934;55747.442525574224;55778.72110639421;55788;15654.45209417665;15969.520914372588;15969.920150399174;15989.200539972955;15991.760123598155;11557.190996630155;12383.876161238271;12456.875431245753;12458.377081145907;12639.11526193176;17772.822271777375;18220.36228731988;18243;18302.450926472226;18444.538886527676;6502.707378167994;6558.672066396661;6568.244651865001;6662.500937289071;6907.204126926935;933.9019402962591;993.5330394714473;997.551102004101;1004.0812656419295;1042.9374237545771;29427.841838566692;29803.701962980525;29892.70107298899;30511.847440762653;34273;1083.7507373304184;1089.934603923767;1112.5382966069153;1133.625903451859;1165.5221359242669;16163.330108407228;16206.270717817726;16413.6717265654;16736.079515626512;16756.83243167577;446391;457058;457536;458067;458247;55431.44568554343;55502.72248638731;55726.16410753842;55957.160642590396;56019;1362.6729584899554;1379.92410417426;1406.367134789349;1413.6819215676392;1426.9571912842632;31725.36549269048;31728.682713172573;31922.6807731929;32497.675023249463;33106.66893331036;46798.76600616975;46981.295280570135;47136.52863471321;47263.52736472591;47477.76261118672;284039;285061;285101;285605;465718;35517.46723799093;35928.64071359253;36189.63810361863;36206.637933620324;36234.637653623126;41120;41247.381289281286;41250;41357.37963930603;41772.79113604534;36397.45403818892;36526.817365913;36671.266574667825;36950.44574331441;37095.44356834596;34956.65043349534;35878.461823073194;36278.63721362858;38444.807775960944;41598.168036639705;36354.45468317925;37001.25997479982;37515.81242093772;37725.81137094297;37894.431583525715;31766.52350214795;31923.89216730145;31964.6803531971;32152.839235803673;32407.51388729218;26491.7350826497;26660.333491662863;26810.731892680822;26949.191524254304;26971.279891952232 22:31:39 INFO - PROCESS | 22758 | |2;jquery.html;345.808190402584;352.117944548905;356.68611621772845;362.8439770898514;369.20068052665977;17193.828061719378;17752;17863.106844657763;18556.35052773153;19361.419157425265;17176.05531695756;17438.651226975453;17484.300627974866;17489.91255043726;17852.82147178528;5308.920366194491;5377.516023557879;5489.972550137244;5494.313210848644;5496.203050557667;5391.110466772978;5455.1544510600925;5462.0987537056335;5466;5472.753726082336;5229.686218826863;5420.403755586883;5431.972840135793;5440.510354068133;5463.262459567967;5335.1730481775385;5362.705051222181;5367.651102678353;5396.811111611094;5417.566594672437;5156.20078887773;5265.025970195487;5273.499017593323;5292.2326262691695;5430;12660.303683297416;12661.240325580402;12712;12834.35828208586;12836.871631283755;2252.3017864462067;2263.9886800566055;2292.277932451289;2294.8508346957396;2392.868392238426;9345.205657519118;9440.339176257665;9509.667161649379;9699.90300096997;9848.162906152986;1842.2907180735378;1879.512321247436;2006.8795872247713;2026.5946810637931;2096.1091536097097;65104.348956510774;67137;67455;67489.3251067488;68458;9643.758906027406;10322.12261957727;10388.896111038945;10392.428416437016;10517;13744.175349479063;13775.724485510234;13803.585892423243;13868.445262189602;13877;7644.923550764533;7798.454108212371;7876.212378762192;8023.077346105156;8029.759107226792;7594.278543538466;7661.961690191513;7737.729179478803;7756.603811314018;7782.455228133977;4358.891027724332;4417.182821178092;4475.7985890635;4491.483479399911;4590.540945905383;1792.3995461520537;1818.3090425638172;1851.685213513679;1891.5176629959547;1918.3669389101563;913.6665117232162;929.4005366538545;1014.1886490807325;1033.390299723167;1081.259337353915;17337.306507739548;17996.280148793903;18129.54676133081;18259.54351141232;18622.627547448974;929.9163075323119;961.2550273538064;964.9276304277067;1007.3754272351189;1039.2569312941284;10116.797664046826;10239.948800255952;10513.57945682164;10553.894461055292;10595.31130476532;489136;502689;506879;522186;523248;79199;82732;83644.58177709073;83846;84733.57633211794;1002.1431675916986;1010.1161483701761;1038.076112260089;1049.7533079726259;1053.1679972821385;15651.705404313201;15833.129177895325;16030.919845401166;16031.278592463133;16139.435119770751;27722.306942325795;29454.852725736233;33578.47426020331;34207;36017.63982360143;45086;46424;46616.06767864556;46702.299465508724;47345.289820652026;7901.841963160819;8122.5126492410645;8196.42625016243;8204.753857384288;8445.493270403795;10904.291221070605;11490.82763758561;11542.480588373712;11922.046236300901;12764.17032892859;11321.773564528829;11403.543858245577;11409.942950285196;11437.485313161094;11542.711432214262;10926.890731092906;11173.776524469302;11185.217034807485;11293.71765705831;11308.83036754433;11218.887811121784;11519.654410367702;11569.479373428385;11635.941820290844;11902.285862848257;7955.880661790194;8026.1171271158955;8035.357171426155;8134.267915887599;8223.876641850258;9678.806423871623;11399.373034483184;11499;11636.418179090842;11639.59261425846 22:31:39 INFO - PROCESS | 22758 | |3;mootools.html;1245.3710876007615;1335.0921373466042;1357.1721250037479;1406.3319923036559;1586.3416682076945;6767.120274364332;6938.826529336763;7049.33031362021;7051.612161331124;7054.788356349305;6857.417119544844;7027.648617569127;7031.156261248658;7036.859262814741;7037.437005039597;1908.0745838268429;2060.629086764382;2085.7288552488153;2099.4751312171957;2108.462342102762;2101.4221089200514;2112.9471763205966;2117.8941052947366;2119.7456305243313;2120.236714782677;2025.3565141715687;2086.5722526881955;2103.7896210378917;2113.2286715348864;2114.8202402795782;2063.2469148760742;2088.2330911542117;2095.9685604715864;2097.1506539851384;2101;2076.1590063100944;2105.8525903186783;2108.8207502362166;2115.3548167808813;2115.5345823918715;7439.888401673979;7473.887891681629;7487.7753667389525;7492.175860655324;7498.85002299951;4523.050159466516;4632.2819962905805;4635.559621835921;4636.582707556302;4639.095376401603;3063.5557844112477;3166.7149956503795;3187.713105820464;3202.087405089538;3209.4383482890403;1051.831706926888;1078.5847448732216;1103.2773533335678;1110.1507346879644;1165.2658824940318;10005.749856253578;10067.949660251725;10089.293749437542;10098.242631802645;10098.9495052525;3831.3103641344824;3962.821673024721;3966.504186976628;3979.3235150024566;3988.840446382112;8225.259726624632;8330.50016998982;8395.24442800151;8422.115677853859;8437.40938134337;4178.937315940263;4527.117212143667;4528.071745292207;4529.705569137996;4530.4110465639915;4002.15954649521;4132.91734165315;4136.9793151034655;4161;4173.8956526087095;3259.5599594054975;3288.967110328914;3297.571315728988;3315.6850099240532;3333.0834020644515;1004.1113614451264;1008.5461542305992;1009.1220638044948;1013.4983183324301;1033.9527735084425;1111.1555218034352;1289.6775806048488;1344.475654494748;1369.5754316162022;1375.6079517337512;7318.3047610476915;7322.780316590511;7326.194118646945;7361.263873612703;7367.5211111277595;433.6877448237327;435.96948213625376;443.6317856179363;447.7403106198397;450.13798575727117;5748.109043098327;5750.683712395775;5826.883462330815;5834.912476312774;5838.766449342063;8826.205641492168;9091.681791137411;9095.909040909506;9118.179363857285;9146.2225710814;8853.468791872509;8870.556472176366;8998.10018998108;9007.279417646572;9035.412698174598;6974.651267436608;7051.294870512907;7058.329458701415;7111.893321600181;7111.964440177766;6709.194896612243;6733.663316834237;6745.494087943326;6784.966075169593;6794.150731158606;8117.512949223065;8180;8211.79470513218;8329.083800781787;8349.123342048997;8194.83610327802;8353.039400469024;8381.539015354214;8445.493270403795;8508.914910850812;5822.70886455667;6150.876982460415;6430.48556115519;6513.250976137805;6519.706613202323;7030.929690703232;7109.28907109285;7148.892766608401;7153;7155.928440715526;6455.225372955276;6561.967190164019;6587.736490540325;6605.04226887089;6637.900431493628;6156.476699480415;6299.275583307978;6320.873582528416;6363.045543168561;6434.292227855026;6954.3393377629045;6985.650717464005;6990.09128813251;7002.964985175042;7011;6341.093042067227;6374.043893415839;6414.454771344488;6470.191226096738;6481.0926470295135;6587.176602924635;6598.67006649656;6622.503312251504;6635.2037755469655;6642.202935647753 22:31:39 INFO - PROCESS | 22758 | |4;prototype.html;322.8498748082142;323.04862180877325;328.6417804592993;330.44815158685026;331.2497193855916;6001.189839371684;6010.819675409739;6048.3649216832255;6055.122007308938;6062.575619706622;5969.432903874125;5984.13230081639;5988.2215312009375;5993.160957465958;5994.07091900756;4340.240457919867;4407.228734971367;4463.575960283784;4473.88815279619;4579.061292435051;4452.8441504547345;4461.709988850731;4469.351943968123;4478.305862591304;4515.774211289438;4451.688381813275;4461.24158892989;4473;4483.34991426243;4483.843065492709;4325.286327755916;4363.869083927471;4469.932951005738;4472.217361961643;4474.910501789946;3886.397608370707;3892.552356479013;3893.0851249956236;3894.610538946111;3896.2597106549665;5707.971460142714;5754.913676294859;5758.42415758425;5764.682942438164;5769.5672824537905;5196.090684130299;5208.5051920067535;5222.817201397971;5226.137687281594;5228;6239.500839932794;6246;6259.624422534617;6266.780662676784;6267.2165979252595;4189.224993376205;4334.696571240014;4336.674749393808;4346.261135606955;4363.061941682554;6458.321876202978;6459.612423254573;6486.156799616067;6509.28397876238;6526.608403495806;4334.284843000933;4343.761093139845;4345.9348109778375;4348.652107831366;4349.304111342233;4376.868693939187;4381.6494680425485;4387.978060109743;4388;4391.494978077498;5137.717425541557;5148.738559053056;5153.227015947563;5157.252198431282;5166.173412254097;6093.299270583851;6260.029695397221;6269.0909818076125;6282.277538083087;6283.905741413882;1545.358676149408;1560.383648458875;1564.0459319814904;1569.5997520632166;1571.6306667933027;954.9045095490395;985.6698006168014;1008.1884083313004;1025.5231317437429;1039.6465201831413;5938.673372964528;6053.697315134314;6062.211912451353;6068.150458935753;6070.575059745775;6443.420092191725;6462.709178086998;6463.321351258144;6477.093206951031;6485.643289619022;5995.340512543617;6030.577859549877;6053.697315134225;6064.818055458343;6067.787627433018;3451.3097380523996;3479.269353435807;3486.6164721880573;3489.092835862694;3492.4935884296633;6493.253275873335;6637.203535575762;6644.468442524587;6774.288699686561;6776.356246156607;6646.83382915431;6648.301928297459;6679.599224046573;6682.665866706645;6683.6658167091455;6754.054432379471;6765.898511522331;6769.086173366631;6770.999999999902;6777.423918966844;6548.8035358939305;6551.21385433751;6559.4752419807255;6570.08018877348;6571.014347847861;6249.531285153541;6455.870882582228;6460.547761656639;6460.773872914613;6487.9026814598765;6772.5936443813525;6772.7290908365085;6778.42383397397;6779;6784;4430.512643609265;4451.732896026248;4471.642268618568;4474.418325617649;4475.060237350193;6554.180727409074;6558.737650493927;6568.507361947969;6570.342965703391;6578.8355291118105;6406.167198264196;6407.455366293917;6412.551121421456;6419.646919419477;6427.068075129174;6159.860425821237;6383.042543618309;6389.8722025560155;6398.1362516059735;6402.359764023747;6241.875162496815;6246.812595622138;6264.780732674517;6267.2165979252595;6267.341929097562;6404.231492220963;6407.935920640921;6407.942689456374;6424.068510065921;6484.837879053061;5988.461038506555;6048.36492168316;6265;6305.085762564311;6322.49420046386 22:31:39 INFO - PROCESS | 22758 | |5;yui.html;752.676349169857;802.3460879383302;817.8895849060378;828.9709860154892;843.6372359885247;13526.458941642335;13713.588592342221;13796.379162937666;13845.653858653539;13848.861511384883;13078.149920255177;13618.727625447485;13619.387127579257;13627.182369057864;13644.317784110804;597.3966294043026;757.420573261454;763.6792547130191;769.7152053740097;786.8465649198408;737.1265050914657;759.6088014672448;769.9759320104276;773.8374941262342;775.5501808950795;807.7051876065224;842.4524059361403;848.8005318750089;848.8854004709347;849.3247867944967;659.1102012283403;742.3949481172881;752.920943300951;812.163471624228;817.6116344736292;521.1297133786585;521.3587287636228;528.4636094364223;528.5032069854325;528.5639347538258;13312.400941957538;13369.732605347936;13382.665433364244;13395.464181432828;13406;13051.804222936664;13366.33168341579;13434;13464.057515973886;13610.387532561059;11460.312381257152;11521.942390287995;11639.301641901428;11699.47352369137;11969.401529923469;3717.888463346104;3765.6234376562397;3798.0504873781556;3847.5190601174854;3852.036990752312;51810;51848.740756296356;52436;53199.20201196985;53607.46392536064;11001.669949901516;11027.44862756875;11029.44852757359;11231.943840280746;11429.599964001387;19591.902040489993;19778.307759228646;19788.20847166126;19794.109265083105;19802.306919257757;8091.55496447701;8236.546989915492;8299.170082991774;8487.70293039753;8541.017782954916;4448.288273876165;4576.7025143366245;4635.327877457749;4639.884002899955;4770.189067858472;3271.263965607719;3289.2105894585607;3301.3067255876535;3302.983485082559;3305.5372247885316;566.8101186102701;573.1145380387312;574.810312596842;576.8615532272224;581.383733242764;574.9655020698772;710.2364957670525;725.3906718356606;731.9963400182965;739.1573606089063;9497.715068547956;9525.761855953519;9525.761855953519;9529.047095290416;9769.462679552693;641.9390157934989;665.8468552233013;704.6476761619191;735.3675838778753;740.6481921087548;4452.48796388413;4454.955450445454;4582.427196600425;4703.529647035338;4720.645951553647;62938.37061629325;63290.36709632937;63291;63785.36214637887;63841;57775;58593;58837.117443238385;58941.70529147327;59678.70160649169;51340.486595134316;51443.7427812866;51603.483965160616;51801.7409912948;54387.45612543903;9752.317337786288;9761.511924403609;9907.702768916944;9988.750281243027;10042.397456152654;39795.80102099471;39804.60195398009;40352.39471407873;41386.79306603568;41539.7923010383;47913;47981.280280795116;49838.75080624719;51385.74307128441;51544;12520;12822.615321540368;13094.934525327313;13204.339783011003;13243.07298489135;13516.391762370913;13763.38064787067;14144.151350918977;14632.414703411745;14897;13120.60638180856;13290.47480978611;13439.932800335935;13467.022995153573;13836.792448113085;13299.26854023038;13809.792853107412;13824.930875345559;13861;14112.929435352757;13017.21896686202;13035.15271507349;13673;13676.726465470834;13760.036797424485;11010.339379637247;11156.163287753288;11602.825957610474;11608.941955290507;11657;11268.83096753533;11471.139664525028;11683.591074312359;11758.529658813894;11766.58816941403 22:31:39 INFO - PROCESS | 22758 | __end_tp_report 22:31:39 INFO - PROCESS | 22758 | __start_cc_report 22:31:39 INFO - PROCESS | 22758 | _x_x_mozilla_cycle_collect,791 22:31:39 INFO - PROCESS | 22758 | __end_cc_report 22:31:39 INFO - PROCESS | 22758 | __startTimestamp1459747899302__endTimestamp 22:31:39 INFO - PROCESS | 22758 | 22:31:39 INFO - PROCESS | 22758 | ------- Summary: start ------- 22:31:39 INFO - PROCESS | 22758 | Number of tests: 6 22:31:39 INFO - PROCESS | 22758 | 22:31:39 INFO - PROCESS | 22758 | [#0] dojo.html Cycles:165 Average:5268.39 Median:5458.00 stddev:578.04 (10.6%) stddev-sans-first:554.56 22:31:39 INFO - PROCESS | 22758 | Values: 3114.2 3127.7 3166.9 3167.3 3186.6 5257.3 5259.8 5292.0 5322.3 5373.9 5331.2 5341.1 5382.1 5418.1 5437.2 4773.6 4800.3 4803.5 4820.5 4981.0 4902.8 4919.7 4945.8 4947.1 4958.9 4754.9 4808.7 4854.3 4882.9 4898.2 4817.0 4842.9 4848.7 4850.2 4891.8 4737.2 4803.7 4815.9 4841.0 4875.6 5217.2 5263.1 5287.9 5291.0 5294.3 5647.0 5667.5 5680.4 5682.5 5684.3 5587.0 5649.5 5682.7 5711.8 5711.8 5355.4 5355.6 5361.6 5375.7 5382.8 5804.6 5805.4 5806.9 5808.4 5816.2 5504.7 5584.5 5587.6 5613.2 5685.9 5640.8 5646.8 5652.3 5654.5 5680.1 5637.1 5637.4 5637.4 5638.8 5639.2 5458.0 5599.7 5637.2 5687.0 5715.5 4288.9 4303.2 4304.8 4310.4 4333.6 3857.6 3860.3 3900.8 3923.1 3926.2 5319.9 5387.7 5389.5 5457.3 5460.6 5607.9 5613.1 5617.4 5627.1 5629.2 5291.2 5297.8 5298.1 5300.8 5345.4 4807.8 4873.9 4886.8 4927.6 4940.7 5854.4 5855.0 5862.9 5863.2 5879.5 5542.1 5684.6 5706.0 5710.8 5712.9 5762.9 5802.1 5816.0 5831.7 5834.0 5560.4 5561.0 5562.4 5564.6 5569.3 5543.5 5640.1 5651.4 5653.2 5734.8 5522.9 5536.6 5536.8 5554.0 5584.7 5486.3 5488.8 5489.8 5493.4 5496.0 5385.9 5395.3 5402.0 5435.5 5505.0 5566.2 5566.6 5576.1 5579.3 5625.7 5399.3 5432.9 5436.3 5437.3 5482.3 22:31:39 INFO - PROCESS | 22758 | 22:31:39 INFO - PROCESS | 22758 | [#1] ext.html Cycles:180 Average:53073.10 Median:37810.12 stddev:99834.00 (264.0%) stddev-sans-first:100036.16 22:31:39 INFO - PROCESS | 22758 | Values: 543.4 557.3 570.3 578.1 593.0 29703.1 30120.5 30221.5 30252.1 38503.6 40358.4 40796.2 41078.8 41119.0 41175.8 8459.6 8645.7 8663.7 8666.3 8669.9 8589.4 8710.8 8723.0 8724.4 8724.9 8651.8 8693.5 8723.7 8740.8 8872.5 8896.5 8977.8 8982.9 8987.7 8990.6 8729.7 8873.7 8886.2 8914.2 8926.2 38156.2 38403.0 38443.4 38577.0 38736.8 3365.5 3481.0 3503.0 3544.8 3893.6 29695.7 30985.4 31012.2 31206.8 31409.8 4178.7 4243.4 4373.7 4384.2 4469.6 331064.0 335707.0 336398.0 337055.0 338000.3 56984.7 62594.7 62741.0 63686.4 63737.7 55390.7 55526.4 55747.4 55778.7 55788.0 15654.5 15969.5 15969.9 15989.2 15991.8 11557.2 12383.9 12456.9 12458.4 12639.1 17772.8 18220.4 18243.0 18302.5 18444.5 6502.7 6558.7 6568.2 6662.5 6907.2 933.9 993.5 997.6 1004.1 1042.9 29427.8 29803.7 29892.7 30511.8 34273.0 1083.8 1089.9 1112.5 1133.6 1165.5 16163.3 16206.3 16413.7 16736.1 16756.8 446391.0 457058.0 457536.0 458067.0 458247.0 55431.4 55502.7 55726.2 55957.2 56019.0 1362.7 1379.9 1406.4 1413.7 1427.0 31725.4 31728.7 31922.7 32497.7 33106.7 46798.8 46981.3 47136.5 47263.5 47477.8 284039.0 285061.0 285101.0 285605.0 465718.0 35517.5 35928.6 36189.6 36206.6 36234.6 41120.0 41247.4 41250.0 41357.4 41772.8 36397.5 36526.8 36671.3 36950.4 37095.4 34956.7 35878.5 36278.6 38444.8 41598.2 36354.5 37001.3 37515.8 37725.8 37894.4 31766.5 31923.9 31964.7 32152.8 32407.5 26491.7 26660.3 26810.7 26949.2 26971.3 22:31:39 INFO - PROCESS | 22758 | 22:31:39 INFO - PROCESS | 22758 | [#2] jquery.html Cycles:180 Average:27600.76 Median:33892.74 stddev:83428.70 (246.2%) stddev-sans-first:83637.64 22:31:39 INFO - PROCESS | 22758 | Values: 345.8 352.1 356.7 362.8 369.2 17193.8 17752.0 17863.1 18556.4 19361.4 17176.1 17438.7 17484.3 17489.9 17852.8 5308.9 5377.5 5490.0 5494.3 5496.2 5391.1 5455.2 5462.1 5466.0 5472.8 5229.7 5420.4 5432.0 5440.5 5463.3 5335.2 5362.7 5367.7 5396.8 5417.6 5156.2 5265.0 5273.5 5292.2 5430.0 12660.3 12661.2 12712.0 12834.4 12836.9 2252.3 2264.0 2292.3 2294.9 2392.9 9345.2 9440.3 9509.7 9699.9 9848.2 1842.3 1879.5 2006.9 2026.6 2096.1 65104.3 67137.0 67455.0 67489.3 68458.0 9643.8 10322.1 10388.9 10392.4 10517.0 13744.2 13775.7 13803.6 13868.4 13877.0 7644.9 7798.5 7876.2 8023.1 8029.8 7594.3 7662.0 7737.7 7756.6 7782.5 4358.9 4417.2 4475.8 4491.5 4590.5 1792.4 1818.3 1851.7 1891.5 1918.4 913.7 929.4 1014.2 1033.4 1081.3 17337.3 17996.3 18129.5 18259.5 18622.6 929.9 961.3 964.9 1007.4 1039.3 10116.8 10239.9 10513.6 10553.9 10595.3 489136.0 502689.0 506879.0 522186.0 523248.0 79199.0 82732.0 83644.6 83846.0 84733.6 1002.1 1010.1 1038.1 1049.8 1053.2 15651.7 15833.1 16030.9 16031.3 16139.4 27722.3 29454.9 33578.5 34207.0 36017.6 45086.0 46424.0 46616.1 46702.3 47345.3 7901.8 8122.5 8196.4 8204.8 8445.5 10904.3 11490.8 11542.5 11922.0 12764.2 11321.8 11403.5 11409.9 11437.5 11542.7 10926.9 11173.8 11185.2 11293.7 11308.8 11218.9 11519.7 11569.5 11635.9 11902.3 7955.9 8026.1 8035.4 8134.3 8223.9 9678.8 11399.4 11499.0 11636.4 11639.6 22:31:39 INFO - PROCESS | 22758 | 22:31:39 INFO - PROCESS | 22758 | [#3] mootools.html Cycles:180 Average:5196.36 Median:5994.82 stddev:2724.59 (45.4%) stddev-sans-first:2716.04 22:31:39 INFO - PROCESS | 22758 | Values: 1245.4 1335.1 1357.2 1406.3 1586.3 6767.1 6938.8 7049.3 7051.6 7054.8 6857.4 7027.6 7031.2 7036.9 7037.4 1908.1 2060.6 2085.7 2099.5 2108.5 2101.4 2112.9 2117.9 2119.7 2120.2 2025.4 2086.6 2103.8 2113.2 2114.8 2063.2 2088.2 2096.0 2097.2 2101.0 2076.2 2105.9 2108.8 2115.4 2115.5 7439.9 7473.9 7487.8 7492.2 7498.9 4523.1 4632.3 4635.6 4636.6 4639.1 3063.6 3166.7 3187.7 3202.1 3209.4 1051.8 1078.6 1103.3 1110.2 1165.3 10005.7 10067.9 10089.3 10098.2 10098.9 3831.3 3962.8 3966.5 3979.3 3988.8 8225.3 8330.5 8395.2 8422.1 8437.4 4178.9 4527.1 4528.1 4529.7 4530.4 4002.2 4132.9 4137.0 4161.0 4173.9 3259.6 3289.0 3297.6 3315.7 3333.1 1004.1 1008.5 1009.1 1013.5 1034.0 1111.2 1289.7 1344.5 1369.6 1375.6 7318.3 7322.8 7326.2 7361.3 7367.5 433.7 436.0 443.6 447.7 450.1 5748.1 5750.7 5826.9 5834.9 5838.8 8826.2 9091.7 9095.9 9118.2 9146.2 8853.5 8870.6 8998.1 9007.3 9035.4 6974.7 7051.3 7058.3 7111.9 7112.0 6709.2 6733.7 6745.5 6785.0 6794.2 8117.5 8180.0 8211.8 8329.1 8349.1 8194.8 8353.0 8381.5 8445.5 8508.9 5822.7 6150.9 6430.5 6513.3 6519.7 7030.9 7109.3 7148.9 7153.0 7155.9 6455.2 6562.0 6587.7 6605.0 6637.9 6156.5 6299.3 6320.9 6363.0 6434.3 6954.3 6985.7 6990.1 7003.0 7011.0 6341.1 6374.0 6414.5 6470.2 6481.1 6587.2 6598.7 6622.5 6635.2 6642.2 22:31:39 INFO - PROCESS | 22758 | 22:31:39 INFO - PROCESS | 22758 | [#4] prototype.html Cycles:180 Average:5258.82 Median:6051.03 stddev:1616.04 (26.7%) stddev-sans-first:1577.53 22:31:39 INFO - PROCESS | 22758 | Values: 322.8 323.0 328.6 330.4 331.2 6001.2 6010.8 6048.4 6055.1 6062.6 5969.4 5984.1 5988.2 5993.2 5994.1 4340.2 4407.2 4463.6 4473.9 4579.1 4452.8 4461.7 4469.4 4478.3 4515.8 4451.7 4461.2 4473.0 4483.3 4483.8 4325.3 4363.9 4469.9 4472.2 4474.9 3886.4 3892.6 3893.1 3894.6 3896.3 5708.0 5754.9 5758.4 5764.7 5769.6 5196.1 5208.5 5222.8 5226.1 5228.0 6239.5 6246.0 6259.6 6266.8 6267.2 4189.2 4334.7 4336.7 4346.3 4363.1 6458.3 6459.6 6486.2 6509.3 6526.6 4334.3 4343.8 4345.9 4348.7 4349.3 4376.9 4381.6 4388.0 4388.0 4391.5 5137.7 5148.7 5153.2 5157.3 5166.2 6093.3 6260.0 6269.1 6282.3 6283.9 1545.4 1560.4 1564.0 1569.6 1571.6 954.9 985.7 1008.2 1025.5 1039.6 5938.7 6053.7 6062.2 6068.2 6070.6 6443.4 6462.7 6463.3 6477.1 6485.6 5995.3 6030.6 6053.7 6064.8 6067.8 3451.3 3479.3 3486.6 3489.1 3492.5 6493.3 6637.2 6644.5 6774.3 6776.4 6646.8 6648.3 6679.6 6682.7 6683.7 6754.1 6765.9 6769.1 6771.0 6777.4 6548.8 6551.2 6559.5 6570.1 6571.0 6249.5 6455.9 6460.5 6460.8 6487.9 6772.6 6772.7 6778.4 6779.0 6784.0 4430.5 4451.7 4471.6 4474.4 4475.1 6554.2 6558.7 6568.5 6570.3 6578.8 6406.2 6407.5 6412.6 6419.6 6427.1 6159.9 6383.0 6389.9 6398.1 6402.4 6241.9 6246.8 6264.8 6267.2 6267.3 6404.2 6407.9 6407.9 6424.1 6484.8 5988.5 6048.4 6265.0 6305.1 6322.5 22:31:39 INFO - PROCESS | 22758 | 22:31:39 INFO - PROCESS | 22758 | [#5] yui.html Cycles:180 Average:15418.32 Median:4608.88 stddev:17861.29 (387.5%) stddev-sans-first:17877.44 22:31:39 INFO - PROCESS | 22758 | Values: 752.7 802.3 817.9 829.0 843.6 13526.5 13713.6 13796.4 13845.7 13848.9 13078.1 13618.7 13619.4 13627.2 13644.3 597.4 757.4 763.7 769.7 786.8 737.1 759.6 770.0 773.8 775.6 807.7 842.5 848.8 848.9 849.3 659.1 742.4 752.9 812.2 817.6 521.1 521.4 528.5 528.5 528.6 13312.4 13369.7 13382.7 13395.5 13406.0 13051.8 13366.3 13434.0 13464.1 13610.4 11460.3 11521.9 11639.3 11699.5 11969.4 3717.9 3765.6 3798.1 3847.5 3852.0 51810.0 51848.7 52436.0 53199.2 53607.5 11001.7 11027.4 11029.4 11231.9 11429.6 19591.9 19778.3 19788.2 19794.1 19802.3 8091.6 8236.5 8299.2 8487.7 8541.0 4448.3 4576.7 4635.3 4639.9 4770.2 3271.3 3289.2 3301.3 3303.0 3305.5 566.8 573.1 574.8 576.9 581.4 575.0 710.2 725.4 732.0 739.2 9497.7 9525.8 9525.8 9529.0 9769.5 641.9 665.8 704.6 735.4 740.6 4452.5 4455.0 4582.4 4703.5 4720.6 62938.4 63290.4 63291.0 63785.4 63841.0 57775.0 58593.0 58837.1 58941.7 59678.7 51340.5 51443.7 51603.5 51801.7 54387.5 9752.3 9761.5 9907.7 9988.8 10042.4 39795.8 39804.6 40352.4 41386.8 41539.8 47913.0 47981.3 49838.8 51385.7 51544.0 12520.0 12822.6 13094.9 13204.3 13243.1 13516.4 13763.4 14144.2 14632.4 14897.0 13120.6 13290.5 13439.9 13467.0 13836.8 13299.3 13809.8 13824.9 13861.0 14112.9 13017.2 13035.2 13673.0 13676.7 13760.0 11010.3 11156.2 11602.8 11608.9 11657.0 11268.8 11471.1 11683.6 11758.5 11766.6 22:31:39 INFO - PROCESS | 22758 | -------- Summary: end -------- 22:31:39 INFO - PROCESS | 22758 | 22:31:39 INFO - TEST-INFO | 22758: exit 0 22:31:39 INFO - TEST-OK | dromaeo_css | took 1111592ms 22:31:39 INFO - TEST-START | kraken 22:31:39 INFO - operating with platform_type : linux_ 22:31:39 INFO - Initialising browser for kraken test... 22:31:39 INFO - TEST-INFO | started process 22941 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiaQwAU/profile http://localhost:54194/getInfo.html) 22:31:44 INFO - PROCESS | 22941 | __metrics Screen width/height:1600/1200 22:31:44 INFO - PROCESS | 22941 | colorDepth:24 22:31:44 INFO - PROCESS | 22941 | Browser inner width/height: 1024/697 22:31:44 INFO - PROCESS | 22941 | __metrics 22:31:45 ERROR - PROCESS | 22941 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:31:46 INFO - TEST-INFO | 22941: exit 0 22:31:46 INFO - Browser initialized. 22:31:46 INFO - Running cycle 1/1 for kraken test... 22:31:46 INFO - TEST-INFO | started process 23025 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiaQwAU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:31:57 INFO - PROCESS | 23025 | RSS: Main: 152952832 22:31:57 INFO - PROCESS | 23025 | 22:32:00 INFO - PROCESS | 23025 | Cycle 1(1): loaded http://localhost:54194/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54194/tests/kraken/driver.html?testName=audio-beat-detection) 22:32:00 INFO - PROCESS | 23025 | RSS: Main: 194269184 22:32:00 INFO - PROCESS | 23025 | 22:32:03 INFO - PROCESS | 23025 | Cycle 1(1): loaded http://localhost:54194/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54194/tests/kraken/driver.html?testName=audio-dft) 22:32:04 INFO - PROCESS | 23025 | RSS: Main: 184053760 22:32:04 INFO - PROCESS | 23025 | 22:32:07 INFO - PROCESS | 23025 | Cycle 1(1): loaded http://localhost:54194/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54194/tests/kraken/driver.html?testName=audio-fft) 22:32:07 INFO - PROCESS | 23025 | RSS: Main: 169254912 22:32:07 INFO - PROCESS | 23025 | 22:32:09 INFO - PROCESS | 23025 | Cycle 1(1): loaded http://localhost:54194/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54194/tests/kraken/driver.html?testName=audio-oscillator) 22:32:10 INFO - PROCESS | 23025 | RSS: Main: 170676224 22:32:10 INFO - PROCESS | 23025 | 22:32:12 INFO - PROCESS | 23025 | Cycle 1(1): loaded http://localhost:54194/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54194/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:32:13 INFO - PROCESS | 23025 | RSS: Main: 172875776 22:32:13 INFO - PROCESS | 23025 | 22:32:15 INFO - PROCESS | 23025 | Cycle 1(1): loaded http://localhost:54194/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54194/tests/kraken/driver.html?testName=imaging-darkroom) 22:32:16 INFO - PROCESS | 23025 | RSS: Main: 172847104 22:32:16 INFO - PROCESS | 23025 | 22:32:19 INFO - PROCESS | 23025 | Cycle 1(1): loaded http://localhost:54194/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54194/tests/kraken/driver.html?testName=imaging-desaturate) 22:32:20 INFO - PROCESS | 23025 | RSS: Main: 173191168 22:32:20 INFO - PROCESS | 23025 | 22:32:23 INFO - PROCESS | 23025 | Cycle 1(1): loaded http://localhost:54194/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54194/tests/kraken/driver.html?testName=json-parse-financial) 22:32:23 INFO - PROCESS | 23025 | RSS: Main: 173572096 22:32:23 INFO - PROCESS | 23025 | 22:32:25 INFO - PROCESS | 23025 | Cycle 1(1): loaded http://localhost:54194/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54194/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:32:25 INFO - PROCESS | 23025 | RSS: Main: 183209984 22:32:25 INFO - PROCESS | 23025 | 22:32:27 INFO - PROCESS | 23025 | Cycle 1(1): loaded http://localhost:54194/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54194/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:32:28 INFO - PROCESS | 23025 | RSS: Main: 182231040 22:32:28 INFO - PROCESS | 23025 | 22:32:30 INFO - PROCESS | 23025 | Cycle 1(1): loaded http://localhost:54194/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54194/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:32:30 INFO - PROCESS | 23025 | RSS: Main: 194031616 22:32:30 INFO - PROCESS | 23025 | 22:32:33 INFO - PROCESS | 23025 | Cycle 1(1): loaded http://localhost:54194/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:32:33 INFO - PROCESS | 23025 | RSS: Main: 198848512 22:32:33 INFO - PROCESS | 23025 | 22:32:36 INFO - PROCESS | 23025 | Cycle 1(1): loaded http://localhost:54194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:32:36 INFO - PROCESS | 23025 | RSS: Main: 196612096 22:32:36 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | Cycle 1(1): loaded http://localhost:54194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54194/tests/kraken/driver.html?testName=ai-astar) 22:32:38 INFO - PROCESS | 23025 | RSS: Main: 257646592 22:32:38 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | __start_tp_report 22:32:38 INFO - PROCESS | 23025 | _x_x_mozilla_page_load 22:32:38 INFO - PROCESS | 23025 | _x_x_mozilla_page_load_details 22:32:38 INFO - PROCESS | 23025 | |i|pagename|runs| 22:32:38 INFO - PROCESS | 23025 | |0;ai-astar;110;111;107;109;111;111;99;109;110;110 22:32:38 INFO - PROCESS | 23025 | |1;audio-beat-detection;163;127;151;176;128;169;157;136;171;133 22:32:38 INFO - PROCESS | 23025 | |2;audio-dft;161;161;161;162;161;162;159;168;169;161 22:32:38 INFO - PROCESS | 23025 | |3;audio-fft;73;77;112;97;75;73;72;122;95;76 22:32:38 INFO - PROCESS | 23025 | |4;audio-oscillator;93;92;140;92;94;92;140;92;93;148 22:32:38 INFO - PROCESS | 23025 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;116;117;117 22:32:38 INFO - PROCESS | 23025 | |6;imaging-darkroom;145;145;146;145;145;146;146;145;145;145 22:32:38 INFO - PROCESS | 23025 | |7;imaging-desaturate;96;95;95;95;95;96;95;95;95;96 22:32:38 INFO - PROCESS | 23025 | |8;json-parse-financial;55;57;56;57;57;56;56;65;54;53 22:32:38 INFO - PROCESS | 23025 | |9;json-stringify-tinderbox;61;62;61;61;61;62;62;63;63;62 22:32:38 INFO - PROCESS | 23025 | |10;stanford-crypto-aes;78;80;79;78;79;86;80;84;81;79 22:32:38 INFO - PROCESS | 23025 | |11;stanford-crypto-ccm;112;110;110;109;109;122;115;108;110;117 22:32:38 INFO - PROCESS | 23025 | |12;stanford-crypto-pbkdf2;149;144;144;149;146;137;146;144;143;145 22:32:38 INFO - PROCESS | 23025 | |13;stanford-crypto-sha256-iterative;64;71;65;64;65;64;64;64;69;62 22:32:38 INFO - PROCESS | 23025 | __end_tp_report 22:32:38 INFO - PROCESS | 23025 | __start_cc_report 22:32:38 INFO - PROCESS | 23025 | _x_x_mozilla_cycle_collect,1064 22:32:38 INFO - PROCESS | 23025 | __end_cc_report 22:32:38 INFO - PROCESS | 23025 | __startTimestamp1459747958808__endTimestamp 22:32:38 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | ------- Summary: start ------- 22:32:38 INFO - PROCESS | 23025 | Number of tests: 14 22:32:38 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.50 stddev:3.62 (3.3%) stddev-sans-first:3.81 22:32:38 INFO - PROCESS | 23025 | Values: 110.0 111.0 107.0 109.0 111.0 111.0 99.0 109.0 110.0 110.0 22:32:38 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:160.00 stddev:18.81 (11.8%) stddev-sans-first:19.45 22:32:38 INFO - PROCESS | 23025 | Values: 163.0 127.0 151.0 176.0 128.0 169.0 157.0 136.0 171.0 133.0 22:32:38 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | [#2] audio-dft Cycles:10 Average:162.50 Median:161.50 stddev:3.27 (2.0%) stddev-sans-first:3.43 22:32:38 INFO - PROCESS | 23025 | Values: 161.0 161.0 161.0 162.0 161.0 162.0 159.0 168.0 169.0 161.0 22:32:38 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | [#3] audio-fft Cycles:10 Average:87.20 Median:75.50 stddev:18.24 (24.2%) stddev-sans-first:18.61 22:32:38 INFO - PROCESS | 23025 | Values: 73.0 77.0 112.0 97.0 75.0 73.0 72.0 122.0 95.0 76.0 22:32:38 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:92.00 stddev:24.30 (26.4%) stddev-sans-first:25.20 22:32:38 INFO - PROCESS | 23025 | Values: 93.0 92.0 140.0 92.0 94.0 92.0 140.0 92.0 93.0 148.0 22:32:38 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 22:32:38 INFO - PROCESS | 23025 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 22:32:38 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 22:32:38 INFO - PROCESS | 23025 | Values: 145.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 22:32:38 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 22:32:38 INFO - PROCESS | 23025 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 22:32:38 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.50 stddev:3.24 (5.7%) stddev-sans-first:3.38 22:32:38 INFO - PROCESS | 23025 | Values: 55.0 57.0 56.0 57.0 57.0 56.0 56.0 65.0 54.0 53.0 22:32:38 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 22:32:38 INFO - PROCESS | 23025 | Values: 61.0 62.0 61.0 61.0 61.0 62.0 62.0 63.0 63.0 62.0 22:32:38 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:2.63 (3.3%) stddev-sans-first:2.65 22:32:38 INFO - PROCESS | 23025 | Values: 78.0 80.0 79.0 78.0 79.0 86.0 80.0 84.0 81.0 79.0 22:32:38 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | [#11] stanford-crypto-ccm Cycles:10 Average:112.20 Median:111.00 stddev:4.47 (4.0%) stddev-sans-first:4.74 22:32:38 INFO - PROCESS | 23025 | Values: 112.0 110.0 110.0 109.0 109.0 122.0 115.0 108.0 110.0 117.0 22:32:38 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.70 Median:145.50 stddev:3.40 (2.3%) stddev-sans-first:3.23 22:32:38 INFO - PROCESS | 23025 | Values: 149.0 144.0 144.0 149.0 146.0 137.0 146.0 144.0 143.0 145.0 22:32:38 INFO - PROCESS | 23025 | 22:32:38 INFO - PROCESS | 23025 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:64.50 stddev:2.70 (4.2%) stddev-sans-first:2.83 22:32:38 INFO - PROCESS | 23025 | Values: 64.0 71.0 65.0 64.0 65.0 64.0 64.0 64.0 69.0 62.0 22:32:38 INFO - PROCESS | 23025 | -------- Summary: end -------- 22:32:38 INFO - PROCESS | 23025 | 22:32:39 INFO - TEST-INFO | 23025: exit 0 22:32:39 INFO - TEST-OK | kraken | took 59873ms 22:32:39 INFO - SUITE-END | took 1171s 22:32:39 INFO - Completed test suite (00:19:31) 22:32:39 INFO - javascript benchmark 22:32:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3114.2058775012374, 3127.655957844638, 3166.8574914128862, 3167.3190264093214, 3186.649468558459, 5257.263983042372, 5259.8422047338645, 5292.0209761194155, 5322.308099947007, 5373.919391209125, 5331.173668081454, 5341.1187154119525, 5382.111951528003, 5418.133098704208, 5437.211604317372, 4773.594244489223, 4800.255960326155, 4803.471618122004, 4820.542048505386, 4981.0037992401485, 4902.754862256873, 4919.704817710931, 4945.77744001519, 4947.060058588874, 4958.851234462972, 4754.930140718328, 4808.68743531671, 4854.344663470457, 4882.926756098661, 4898.24077268024, 4816.951830481686, 4842.903141937177, 4848.7090774553635, 4850.223964165716, 4891.828785992473, 4737.24204127338, 4803.711777293373, 4815.855524334275, 4840.975795121037, 4875.634327425421, 5217.191335343028, 5263.078961181778, 5287.920681189786, 5291.0, 5294.258803767476, 5646.971765141189, 5667.4615911488345, 5680.4319568042865, 5682.54539636828, 5684.34630017545, 5587.0, 5649.548036157139, 5682.687452190128, 5711.8000869969355, 5711.8000869969355, 5355.437679043722, 5355.571554275649, 5361.597880159004, 5375.704336261504, 5382.811601593926, 5804.593678442553, 5805.419458054245, 5806.854828629233, 5808.361080281165, 5816.243888294579, 5504.724763761796, 5584.46947539983, 5587.636803607753, 5613.186088017296, 5685.857853553694, 5640.830775076754, 5646.830595082154, 5652.2652055233375, 5654.547636189177, 5680.11958146488, 5637.069883469264, 5637.379888212294, 5637.43625637433, 5638.774449022075, 5639.154126881001, 5458.0, 5599.692016939026, 5637.154426835926, 5686.9715651421475, 5715.48560629537, 4288.871333859989, 4303.225419424471, 4304.80628371724, 4310.439642846472, 4333.58830911063, 3857.61423857612, 3860.343741563941, 3900.8439662413184, 3923.1172986077904, 3926.155876486512, 5319.9202011969855, 5387.676739395649, 5389.514943655012, 5457.2905522282645, 5460.563154947595, 5607.8598035048635, 5613.073842815971, 5617.354004289477, 5627.127795191752, 5629.211910332557, 5291.1798671206025, 5297.8145764898045, 5298.125809241432, 5300.814471493479, 5345.3852806926925, 4807.78364973577, 4873.878153046202, 4886.755662216946, 4927.556519913225, 4940.654154209171, 5854.385289544622, 5855.0, 5862.912056319158, 5863.179154918314, 5879.470847623735, 5542.140968149944, 5684.573656975744, 5706.0, 5710.8001219957105, 5712.885742285214, 5762.913556296575, 5802.100674395476, 5815.9709201453725, 5831.7375718091935, 5834.03738383162, 5560.388357280615, 5561.0, 5562.443755624405, 5564.554835613222, 5569.303837020372, 5543.501084902378, 5640.0693885508435, 5651.4348565143155, 5653.180288858175, 5734.827955161351, 5522.861928451821, 5536.584756143225, 5536.806211782729, 5554.000279949648, 5584.664920104644, 5486.31421072366, 5488.780448782164, 5489.780408783764, 5493.395726470165, 5496.0, 5385.946140538545, 5395.325584301962, 5402.0, 5435.537979271648, 5505.0, 5566.192902029102, 5566.582506311962, 5576.052071147996, 5579.330480342385, 5625.662460252398, 5399.2980912481125, 5432.864178395572, 5436.266104075899, 5437.26596909428, 5482.342118945752], "unit": "score", "name": "dojo.html", "value": 5230.829733236084}, {"lowerIsBetter": false, "replicates": [543.4480715462809, 557.2894559436716, 570.3355590736792, 578.0808514462004, 592.9762809487621, 29703.108906732778, 30120.54819177714, 30221.546676799866, 30252.09243722692, 38503.614963850356, 40358.39462408066, 40796.18407631846, 41078.79460602693, 41119.0, 41175.79412102943, 8459.577021148933, 8645.69740059098, 8663.696770613029, 8666.306695464347, 8669.869951950694, 8589.398742088026, 8710.782230444258, 8723.040465548784, 8724.43291186071, 8724.912750872474, 8651.826963460759, 8693.5218562979, 8723.694670686527, 8740.825183496327, 8872.467651940904, 8896.466212027266, 8977.820443591092, 8982.86525702115, 8987.685431009882, 8990.595423205972, 8729.738107856774, 8873.689420870303, 8886.155815197611, 8914.197722205032, 8926.2412694921, 38156.23687526261, 38403.039924001845, 38443.42334864979, 38577.0, 38736.80631596852, 3365.5456513370873, 3481.0, 3502.982485087584, 3544.8404821782824, 3893.6301051400073, 29695.70304296951, 30985.380292394253, 31012.224694382596, 31206.843965780252, 31409.84295078533, 4178.749275043477, 4243.448351714257, 4373.737575745434, 4384.232759267147, 4469.642428605736, 331064.0, 335707.0, 336398.0, 337055.0, 338000.3099984509, 56984.715076424356, 62594.68702656458, 62741.0, 63686.36313636897, 63737.68131159314, 55390.72304638451, 55526.444735552934, 55747.442525574224, 55778.72110639421, 55788.0, 15654.45209417665, 15969.520914372588, 15969.920150399174, 15989.200539972955, 15991.760123598155, 11557.190996630155, 12383.876161238271, 12456.875431245753, 12458.377081145907, 12639.11526193176, 17772.822271777375, 18220.36228731988, 18243.0, 18302.450926472226, 18444.538886527676, 6502.707378167994, 6558.672066396661, 6568.244651865001, 6662.500937289071, 6907.204126926935, 933.9019402962591, 993.5330394714473, 997.551102004101, 1004.0812656419295, 1042.9374237545771, 29427.841838566692, 29803.701962980525, 29892.70107298899, 30511.847440762653, 34273.0, 1083.7507373304184, 1089.934603923767, 1112.5382966069153, 1133.625903451859, 1165.5221359242669, 16163.330108407228, 16206.270717817726, 16413.6717265654, 16736.079515626512, 16756.83243167577, 446391.0, 457058.0, 457536.0, 458067.0, 458247.0, 55431.44568554343, 55502.72248638731, 55726.16410753842, 55957.160642590396, 56019.0, 1362.6729584899554, 1379.92410417426, 1406.367134789349, 1413.6819215676392, 1426.9571912842632, 31725.36549269048, 31728.682713172573, 31922.6807731929, 32497.675023249463, 33106.66893331036, 46798.76600616975, 46981.295280570135, 47136.52863471321, 47263.52736472591, 47477.76261118672, 284039.0, 285061.0, 285101.0, 285605.0, 465718.0, 35517.46723799093, 35928.64071359253, 36189.63810361863, 36206.637933620324, 36234.637653623126, 41120.0, 41247.381289281286, 41250.0, 41357.37963930603, 41772.79113604534, 36397.45403818892, 36526.817365913, 36671.266574667825, 36950.44574331441, 37095.44356834596, 34956.65043349534, 35878.461823073194, 36278.63721362858, 38444.807775960944, 41598.168036639705, 36354.45468317925, 37001.25997479982, 37515.81242093772, 37725.81137094297, 37894.431583525715, 31766.52350214795, 31923.89216730145, 31964.6803531971, 32152.839235803673, 32407.51388729218, 26491.7350826497, 26660.333491662863, 26810.731892680822, 26949.191524254304, 26971.279891952232], "unit": "score", "name": "ext.html", "value": 19067.35782070944}, {"lowerIsBetter": false, "replicates": [345.808190402584, 352.117944548905, 356.68611621772845, 362.8439770898514, 369.20068052665977, 17193.828061719378, 17752.0, 17863.106844657763, 18556.35052773153, 19361.419157425265, 17176.05531695756, 17438.651226975453, 17484.300627974866, 17489.91255043726, 17852.82147178528, 5308.920366194491, 5377.516023557879, 5489.972550137244, 5494.313210848644, 5496.203050557667, 5391.110466772978, 5455.1544510600925, 5462.0987537056335, 5466.0, 5472.753726082336, 5229.686218826863, 5420.403755586883, 5431.972840135793, 5440.510354068133, 5463.262459567967, 5335.1730481775385, 5362.705051222181, 5367.651102678353, 5396.811111611094, 5417.566594672437, 5156.20078887773, 5265.025970195487, 5273.499017593323, 5292.2326262691695, 5430.0, 12660.303683297416, 12661.240325580402, 12712.0, 12834.35828208586, 12836.871631283755, 2252.3017864462067, 2263.9886800566055, 2292.277932451289, 2294.8508346957396, 2392.868392238426, 9345.205657519118, 9440.339176257665, 9509.667161649379, 9699.90300096997, 9848.162906152986, 1842.2907180735378, 1879.512321247436, 2006.8795872247713, 2026.5946810637931, 2096.1091536097097, 65104.348956510774, 67137.0, 67455.0, 67489.3251067488, 68458.0, 9643.758906027406, 10322.12261957727, 10388.896111038945, 10392.428416437016, 10517.0, 13744.175349479063, 13775.724485510234, 13803.585892423243, 13868.445262189602, 13877.0, 7644.923550764533, 7798.454108212371, 7876.212378762192, 8023.077346105156, 8029.759107226792, 7594.278543538466, 7661.961690191513, 7737.729179478803, 7756.603811314018, 7782.455228133977, 4358.891027724332, 4417.182821178092, 4475.7985890635, 4491.483479399911, 4590.540945905383, 1792.3995461520537, 1818.3090425638172, 1851.685213513679, 1891.5176629959547, 1918.3669389101563, 913.6665117232162, 929.4005366538545, 1014.1886490807325, 1033.390299723167, 1081.259337353915, 17337.306507739548, 17996.280148793903, 18129.54676133081, 18259.54351141232, 18622.627547448974, 929.9163075323119, 961.2550273538064, 964.9276304277067, 1007.3754272351189, 1039.2569312941284, 10116.797664046826, 10239.948800255952, 10513.57945682164, 10553.894461055292, 10595.31130476532, 489136.0, 502689.0, 506879.0, 522186.0, 523248.0, 79199.0, 82732.0, 83644.58177709073, 83846.0, 84733.57633211794, 1002.1431675916986, 1010.1161483701761, 1038.076112260089, 1049.7533079726259, 1053.1679972821385, 15651.705404313201, 15833.129177895325, 16030.919845401166, 16031.278592463133, 16139.435119770751, 27722.306942325795, 29454.852725736233, 33578.47426020331, 34207.0, 36017.63982360143, 45086.0, 46424.0, 46616.06767864556, 46702.299465508724, 47345.289820652026, 7901.841963160819, 8122.5126492410645, 8196.42625016243, 8204.753857384288, 8445.493270403795, 10904.291221070605, 11490.82763758561, 11542.480588373712, 11922.046236300901, 12764.17032892859, 11321.773564528829, 11403.543858245577, 11409.942950285196, 11437.485313161094, 11542.711432214262, 10926.890731092906, 11173.776524469302, 11185.217034807485, 11293.71765705831, 11308.83036754433, 11218.887811121784, 11519.654410367702, 11569.479373428385, 11635.941820290844, 11902.285862848257, 7955.880661790194, 8026.1171271158955, 8035.357171426155, 8134.267915887599, 8223.876641850258, 9678.806423871623, 11399.373034483184, 11499.0, 11636.418179090842, 11639.59261425846], "unit": "score", "name": "jquery.html", "value": 8533.152244691431}, {"lowerIsBetter": false, "replicates": [1245.3710876007615, 1335.0921373466042, 1357.1721250037479, 1406.3319923036559, 1586.3416682076945, 6767.120274364332, 6938.826529336763, 7049.33031362021, 7051.612161331124, 7054.788356349305, 6857.417119544844, 7027.648617569127, 7031.156261248658, 7036.859262814741, 7037.437005039597, 1908.0745838268429, 2060.629086764382, 2085.7288552488153, 2099.4751312171957, 2108.462342102762, 2101.4221089200514, 2112.9471763205966, 2117.8941052947366, 2119.7456305243313, 2120.236714782677, 2025.3565141715687, 2086.5722526881955, 2103.7896210378917, 2113.2286715348864, 2114.8202402795782, 2063.2469148760742, 2088.2330911542117, 2095.9685604715864, 2097.1506539851384, 2101.0, 2076.1590063100944, 2105.8525903186783, 2108.8207502362166, 2115.3548167808813, 2115.5345823918715, 7439.888401673979, 7473.887891681629, 7487.7753667389525, 7492.175860655324, 7498.85002299951, 4523.050159466516, 4632.2819962905805, 4635.559621835921, 4636.582707556302, 4639.095376401603, 3063.5557844112477, 3166.7149956503795, 3187.713105820464, 3202.087405089538, 3209.4383482890403, 1051.831706926888, 1078.5847448732216, 1103.2773533335678, 1110.1507346879644, 1165.2658824940318, 10005.749856253578, 10067.949660251725, 10089.293749437542, 10098.242631802645, 10098.9495052525, 3831.3103641344824, 3962.821673024721, 3966.504186976628, 3979.3235150024566, 3988.840446382112, 8225.259726624632, 8330.50016998982, 8395.24442800151, 8422.115677853859, 8437.40938134337, 4178.937315940263, 4527.117212143667, 4528.071745292207, 4529.705569137996, 4530.4110465639915, 4002.15954649521, 4132.91734165315, 4136.9793151034655, 4161.0, 4173.8956526087095, 3259.5599594054975, 3288.967110328914, 3297.571315728988, 3315.6850099240532, 3333.0834020644515, 1004.1113614451264, 1008.5461542305992, 1009.1220638044948, 1013.4983183324301, 1033.9527735084425, 1111.1555218034352, 1289.6775806048488, 1344.475654494748, 1369.5754316162022, 1375.6079517337512, 7318.3047610476915, 7322.780316590511, 7326.194118646945, 7361.263873612703, 7367.5211111277595, 433.6877448237327, 435.96948213625376, 443.6317856179363, 447.7403106198397, 450.13798575727117, 5748.109043098327, 5750.683712395775, 5826.883462330815, 5834.912476312774, 5838.766449342063, 8826.205641492168, 9091.681791137411, 9095.909040909506, 9118.179363857285, 9146.2225710814, 8853.468791872509, 8870.556472176366, 8998.10018998108, 9007.279417646572, 9035.412698174598, 6974.651267436608, 7051.294870512907, 7058.329458701415, 7111.893321600181, 7111.964440177766, 6709.194896612243, 6733.663316834237, 6745.494087943326, 6784.966075169593, 6794.150731158606, 8117.512949223065, 8180.0, 8211.79470513218, 8329.083800781787, 8349.123342048997, 8194.83610327802, 8353.039400469024, 8381.539015354214, 8445.493270403795, 8508.914910850812, 5822.70886455667, 6150.876982460415, 6430.48556115519, 6513.250976137805, 6519.706613202323, 7030.929690703232, 7109.28907109285, 7148.892766608401, 7153.0, 7155.928440715526, 6455.225372955276, 6561.967190164019, 6587.736490540325, 6605.04226887089, 6637.900431493628, 6156.476699480415, 6299.275583307978, 6320.873582528416, 6363.045543168561, 6434.292227855026, 6954.3393377629045, 6985.650717464005, 6990.09128813251, 7002.964985175042, 7011.0, 6341.093042067227, 6374.043893415839, 6414.454771344488, 6470.191226096738, 6481.0926470295135, 6587.176602924635, 6598.67006649656, 6622.503312251504, 6635.2037755469655, 6642.202935647753], "unit": "score", "name": "mootools.html", "value": 4184.246739077874}, {"lowerIsBetter": false, "replicates": [322.8498748082142, 323.04862180877325, 328.6417804592993, 330.44815158685026, 331.2497193855916, 6001.189839371684, 6010.819675409739, 6048.3649216832255, 6055.122007308938, 6062.575619706622, 5969.432903874125, 5984.13230081639, 5988.2215312009375, 5993.160957465958, 5994.07091900756, 4340.240457919867, 4407.228734971367, 4463.575960283784, 4473.88815279619, 4579.061292435051, 4452.8441504547345, 4461.709988850731, 4469.351943968123, 4478.305862591304, 4515.774211289438, 4451.688381813275, 4461.24158892989, 4473.0, 4483.34991426243, 4483.843065492709, 4325.286327755916, 4363.869083927471, 4469.932951005738, 4472.217361961643, 4474.910501789946, 3886.397608370707, 3892.552356479013, 3893.0851249956236, 3894.610538946111, 3896.2597106549665, 5707.971460142714, 5754.913676294859, 5758.42415758425, 5764.682942438164, 5769.5672824537905, 5196.090684130299, 5208.5051920067535, 5222.817201397971, 5226.137687281594, 5228.0, 6239.500839932794, 6246.0, 6259.624422534617, 6266.780662676784, 6267.2165979252595, 4189.224993376205, 4334.696571240014, 4336.674749393808, 4346.261135606955, 4363.061941682554, 6458.321876202978, 6459.612423254573, 6486.156799616067, 6509.28397876238, 6526.608403495806, 4334.284843000933, 4343.761093139845, 4345.9348109778375, 4348.652107831366, 4349.304111342233, 4376.868693939187, 4381.6494680425485, 4387.978060109743, 4388.0, 4391.494978077498, 5137.717425541557, 5148.738559053056, 5153.227015947563, 5157.252198431282, 5166.173412254097, 6093.299270583851, 6260.029695397221, 6269.0909818076125, 6282.277538083087, 6283.905741413882, 1545.358676149408, 1560.383648458875, 1564.0459319814904, 1569.5997520632166, 1571.6306667933027, 954.9045095490395, 985.6698006168014, 1008.1884083313004, 1025.5231317437429, 1039.6465201831413, 5938.673372964528, 6053.697315134314, 6062.211912451353, 6068.150458935753, 6070.575059745775, 6443.420092191725, 6462.709178086998, 6463.321351258144, 6477.093206951031, 6485.643289619022, 5995.340512543617, 6030.577859549877, 6053.697315134225, 6064.818055458343, 6067.787627433018, 3451.3097380523996, 3479.269353435807, 3486.6164721880573, 3489.092835862694, 3492.4935884296633, 6493.253275873335, 6637.203535575762, 6644.468442524587, 6774.288699686561, 6776.356246156607, 6646.83382915431, 6648.301928297459, 6679.599224046573, 6682.665866706645, 6683.6658167091455, 6754.054432379471, 6765.898511522331, 6769.086173366631, 6770.999999999902, 6777.423918966844, 6548.8035358939305, 6551.21385433751, 6559.4752419807255, 6570.08018877348, 6571.014347847861, 6249.531285153541, 6455.870882582228, 6460.547761656639, 6460.773872914613, 6487.9026814598765, 6772.5936443813525, 6772.7290908365085, 6778.42383397397, 6779.0, 6784.0, 4430.512643609265, 4451.732896026248, 4471.642268618568, 4474.418325617649, 4475.060237350193, 6554.180727409074, 6558.737650493927, 6568.507361947969, 6570.342965703391, 6578.8355291118105, 6406.167198264196, 6407.455366293917, 6412.551121421456, 6419.646919419477, 6427.068075129174, 6159.860425821237, 6383.042543618309, 6389.8722025560155, 6398.1362516059735, 6402.359764023747, 6241.875162496815, 6246.812595622138, 6264.780732674517, 6267.2165979252595, 6267.341929097562, 6404.231492220963, 6407.935920640921, 6407.942689456374, 6424.068510065921, 6484.837879053061, 5988.461038506555, 6048.36492168316, 6265.0, 6305.085762564311, 6322.49420046386], "unit": "score", "name": "prototype.html", "value": 4726.218093100101}, {"lowerIsBetter": false, "replicates": [752.676349169857, 802.3460879383302, 817.8895849060378, 828.9709860154892, 843.6372359885247, 13526.458941642335, 13713.588592342221, 13796.379162937666, 13845.653858653539, 13848.861511384883, 13078.149920255177, 13618.727625447485, 13619.387127579257, 13627.182369057864, 13644.317784110804, 597.3966294043026, 757.420573261454, 763.6792547130191, 769.7152053740097, 786.8465649198408, 737.1265050914657, 759.6088014672448, 769.9759320104276, 773.8374941262342, 775.5501808950795, 807.7051876065224, 842.4524059361403, 848.8005318750089, 848.8854004709347, 849.3247867944967, 659.1102012283403, 742.3949481172881, 752.920943300951, 812.163471624228, 817.6116344736292, 521.1297133786585, 521.3587287636228, 528.4636094364223, 528.5032069854325, 528.5639347538258, 13312.400941957538, 13369.732605347936, 13382.665433364244, 13395.464181432828, 13406.0, 13051.804222936664, 13366.33168341579, 13434.0, 13464.057515973886, 13610.387532561059, 11460.312381257152, 11521.942390287995, 11639.301641901428, 11699.47352369137, 11969.401529923469, 3717.888463346104, 3765.6234376562397, 3798.0504873781556, 3847.5190601174854, 3852.036990752312, 51810.0, 51848.740756296356, 52436.0, 53199.20201196985, 53607.46392536064, 11001.669949901516, 11027.44862756875, 11029.44852757359, 11231.943840280746, 11429.599964001387, 19591.902040489993, 19778.307759228646, 19788.20847166126, 19794.109265083105, 19802.306919257757, 8091.55496447701, 8236.546989915492, 8299.170082991774, 8487.70293039753, 8541.017782954916, 4448.288273876165, 4576.7025143366245, 4635.327877457749, 4639.884002899955, 4770.189067858472, 3271.263965607719, 3289.2105894585607, 3301.3067255876535, 3302.983485082559, 3305.5372247885316, 566.8101186102701, 573.1145380387312, 574.810312596842, 576.8615532272224, 581.383733242764, 574.9655020698772, 710.2364957670525, 725.3906718356606, 731.9963400182965, 739.1573606089063, 9497.715068547956, 9525.761855953519, 9525.761855953519, 9529.047095290416, 9769.462679552693, 641.9390157934989, 665.8468552233013, 704.6476761619191, 735.3675838778753, 740.6481921087548, 4452.48796388413, 4454.955450445454, 4582.427196600425, 4703.529647035338, 4720.645951553647, 62938.37061629325, 63290.36709632937, 63291.0, 63785.36214637887, 63841.0, 57775.0, 58593.0, 58837.117443238385, 58941.70529147327, 59678.70160649169, 51340.486595134316, 51443.7427812866, 51603.483965160616, 51801.7409912948, 54387.45612543903, 9752.317337786288, 9761.511924403609, 9907.702768916944, 9988.750281243027, 10042.397456152654, 39795.80102099471, 39804.60195398009, 40352.39471407873, 41386.79306603568, 41539.7923010383, 47913.0, 47981.280280795116, 49838.75080624719, 51385.74307128441, 51544.0, 12520.0, 12822.615321540368, 13094.934525327313, 13204.339783011003, 13243.07298489135, 13516.391762370913, 13763.38064787067, 14144.151350918977, 14632.414703411745, 14897.0, 13120.60638180856, 13290.47480978611, 13439.932800335935, 13467.022995153573, 13836.792448113085, 13299.26854023038, 13809.792853107412, 13824.930875345559, 13861.0, 14112.929435352757, 13017.21896686202, 13035.15271507349, 13673.0, 13676.726465470834, 13760.036797424485, 11010.339379637247, 11156.163287753288, 11602.825957610474, 11608.941955290507, 11657.0, 11268.83096753533, 11471.139664525028, 11683.591074312359, 11758.529658813894, 11766.58816941403], "unit": "score", "name": "yui.html", "value": 6803.021615211942}], "name": "dromaeo_css", "value": 6968.526577357576}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 107.0, 109.0, 111.0, 111.0, 99.0, 109.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [163.0, 127.0, 151.0, 176.0, 128.0, 169.0, 157.0, 136.0, 171.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 151.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 159.0, 168.0, 169.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 112.0, 97.0, 75.0, 73.0, 72.0, 122.0, 95.0, 76.0], "unit": "score", "name": "audio-fft", "value": 87.2}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 140.0, 92.0, 94.0, 92.0, 140.0, 92.0, 93.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 56.0, 57.0, 57.0, 56.0, 56.0, 65.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 62.0, 63.0, 63.0, 62.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 61.8}, {"lowerIsBetter": true, "replicates": [78.0, 80.0, 79.0, 78.0, 79.0, 86.0, 80.0, 84.0, 81.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.4}, {"lowerIsBetter": true, "replicates": [112.0, 110.0, 110.0, 109.0, 109.0, 122.0, 115.0, 108.0, 110.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.2}, {"lowerIsBetter": true, "replicates": [149.0, 144.0, 144.0, 149.0, 146.0, 137.0, 146.0, 144.0, 143.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.7}, {"lowerIsBetter": true, "replicates": [64.0, 71.0, 65.0, 64.0, 65.0, 64.0, 64.0, 64.0, 69.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.2}], "name": "kraken", "value": 1495.3000000000002}]} 22:32:40 INFO - Return code: 0 22:32:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:32:40 ERROR - # TBPL SUCCESS # 22:32:40 INFO - Running post-action listener: _resource_record_post_action 22:32:40 INFO - Running post-run listener: _resource_record_post_run 22:32:41 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 546496512; Read time: 160; Write time: 594408 22:32:41 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 252739584; Read time: 0; Write time: 376020 22:32:41 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293658624; Read time: 160; Write time: 218388 22:32:41 INFO - Running post-run listener: _upload_blobber_files 22:32:41 INFO - Blob upload gear active. 22:32:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:32:41 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 22:32:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:32:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:32:41 INFO - (blobuploader) - INFO - Open directory for files ... 22:32:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:32:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:32:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:32:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:32:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:32:42 INFO - (blobuploader) - INFO - Done attempting. 22:32:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:32:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:32:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:32:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:32:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:32:43 INFO - (blobuploader) - INFO - Done attempting. 22:32:43 INFO - (blobuploader) - INFO - Iteration through files over. 22:32:43 INFO - Return code: 0 22:32:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:32:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:32:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72d0bf98296e354c3e370ab6e4df8c21200ef3a99ab2f074d1105f12fad5b69ca4d3297f2380091b3adc89e7de12a8e4ea6480f4179613e4679e69a1ae910b15", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60e0a87bddda3402d165e18c5d5ad3ad2b8c85e2bab502f6d203fb1423cd529841eb6f4a8ca5cff1fd26aa1071abfa0a4b47e3a4b5958a499793d32c6dc1044c"} 22:32:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:32:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:32:43 INFO - Contents: 22:32:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72d0bf98296e354c3e370ab6e4df8c21200ef3a99ab2f074d1105f12fad5b69ca4d3297f2380091b3adc89e7de12a8e4ea6480f4179613e4679e69a1ae910b15", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60e0a87bddda3402d165e18c5d5ad3ad2b8c85e2bab502f6d203fb1423cd529841eb6f4a8ca5cff1fd26aa1071abfa0a4b47e3a4b5958a499793d32c6dc1044c"} 22:32:43 INFO - Running post-run listener: copy_logs_to_upload_dir 22:32:43 INFO - Copying logs to upload dir... 22:32:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:32:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.191391 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-04-03 22:32:41.768162) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-03 22:32:41.772124) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72d0bf98296e354c3e370ab6e4df8c21200ef3a99ab2f074d1105f12fad5b69ca4d3297f2380091b3adc89e7de12a8e4ea6480f4179613e4679e69a1ae910b15", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60e0a87bddda3402d165e18c5d5ad3ad2b8c85e2bab502f6d203fb1423cd529841eb6f4a8ca5cff1fd26aa1071abfa0a4b47e3a4b5958a499793d32c6dc1044c"} build_url:https://queue.taskcluster.net/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/K4ZeQeoZQweDGquOyvViLw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72d0bf98296e354c3e370ab6e4df8c21200ef3a99ab2f074d1105f12fad5b69ca4d3297f2380091b3adc89e7de12a8e4ea6480f4179613e4679e69a1ae910b15", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60e0a87bddda3402d165e18c5d5ad3ad2b8c85e2bab502f6d203fb1423cd529841eb6f4a8ca5cff1fd26aa1071abfa0a4b47e3a4b5958a499793d32c6dc1044c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-03 22:32:41.797109) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 22:32:41.797431) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1459746071.561266-1713939638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 22:32:41.881215) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-03 22:32:41.881524) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-03 22:32:41.881855) ========= ========= Total master_lag: 0.30 =========