builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1454739072.64 results: success (0) buildid: 20160205193440 builduid: 235fd22f6fd54e0dbafd6e21a591c52e revision: 0885625045f0d07ab8ce6d46d8b354939aa3b617 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.635941) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.636331) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.636620) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006494 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.671444) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.671742) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.689733) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.690005) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.740396) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.740687) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.741049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.741338) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-05 22:11:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-02-05 22:11:13 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139030 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.896928) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.897257) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014333 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.946348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-05 22:11:12.946680) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0885625045f0d07ab8ce6d46d8b354939aa3b617 --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 0885625045f0d07ab8ce6d46d8b354939aa3b617 --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=74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-05 22:11:13,281 truncating revision to first 12 chars 2016-02-05 22:11:13,281 Setting DEBUG logging. 2016-02-05 22:11:13,281 attempt 1/10 2016-02-05 22:11:13,281 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0885625045f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-05 22:11:14,029 unpacking tar archive at: mozilla-central-0885625045f0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.079713 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-05 22:11:14.039702) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:14.040179) ========= echo 0885625045f0d07ab8ce6d46d8b354939aa3b617 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0885625045f0d07ab8ce6d46d8b354939aa3b617'] 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=74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0885625045f0d07ab8ce6d46d8b354939aa3b617 program finished with exit code 0 elapsedTime=0.004373 script_repo_revision: '0885625045f0d07ab8ce6d46d8b354939aa3b617' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:14.092171) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:14.092485) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:14.102097) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-02-05 22:11:14.102417) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:11:14 INFO - MultiFileLogger online at 20160205 22:11:14 in /builds/slave/test-pgo 22:11:14 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:11:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:11:14 INFO - {'append_to_log': False, 22:11:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:11:14 INFO - 'blob_upload_branch': 'Firefox', 22:11:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:11:14 INFO - 'branch': 'Firefox', 22:11:14 INFO - 'buildbot_json_path': 'buildprops.json', 22:11:14 INFO - 'config_files': ('talos/linux_config.py',), 22:11:14 INFO - 'default_actions': ('clobber', 22:11:14 INFO - 'read-buildbot-config', 22:11:14 INFO - 'download-and-extract', 22:11:14 INFO - 'populate-webroot', 22:11:14 INFO - 'create-virtualenv', 22:11:14 INFO - 'install', 22:11:14 INFO - 'run-tests'), 22:11:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:11:14 INFO - 'download_minidump_stackwalk': True, 22:11:14 INFO - 'download_symbols': 'ondemand', 22:11:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:11:14 INFO - 'tooltool.py': '/tools/tooltool.py', 22:11:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:11:14 INFO - '/tools/misc-python/virtualenv.py')}, 22:11:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:11:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:11:14 INFO - 'installer_path': 'installer.exe', 22:11:14 INFO - 'log_level': 'info', 22:11:14 INFO - 'log_name': 'talos', 22:11:14 INFO - 'log_to_console': True, 22:11:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:11:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:11:14 INFO - 'opt_config_files': (), 22:11:14 INFO - 'pip_index': False, 22:11:14 INFO - 'sps_profile': False, 22:11:14 INFO - 'sps_profile_interval': 0, 22:11:14 INFO - 'suite': 'dromaeojs', 22:11:14 INFO - 'system_bits': '32', 22:11:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:11:14 INFO - 'title': 'talos-linux64-ix-042', 22:11:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:11:14 INFO - 'use_talos_json': True, 22:11:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:11:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:11:14 INFO - 'work_dir': 'build'} 22:11:14 INFO - ##### 22:11:14 INFO - ##### Running clobber step. 22:11:14 INFO - ##### 22:11:14 INFO - Running pre-action listener: _resource_record_pre_action 22:11:14 INFO - Running main action method: clobber 22:11:14 INFO - rmtree: /builds/slave/test-pgo/build 22:11:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:11:14 INFO - Running post-action listener: _resource_record_post_action 22:11:14 INFO - ##### 22:11:14 INFO - ##### Running read-buildbot-config step. 22:11:14 INFO - ##### 22:11:14 INFO - Running pre-action listener: _resource_record_pre_action 22:11:14 INFO - Running main action method: read_buildbot_config 22:11:14 INFO - Using buildbot properties: 22:11:14 INFO - { 22:11:14 INFO - "project": "", 22:11:14 INFO - "product": "firefox", 22:11:14 INFO - "script_repo_revision": "production", 22:11:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:11:14 INFO - "repository": "", 22:11:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 22:11:14 INFO - "buildid": "20160205193440", 22:11:14 INFO - "pgo_build": "True", 22:11:14 INFO - "basedir": "/builds/slave/test-pgo", 22:11:14 INFO - "buildnumber": 349, 22:11:14 INFO - "slavename": "talos-linux64-ix-042", 22:11:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:11:14 INFO - "platform": "ubuntu64_hw", 22:11:14 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:11:14 INFO - "branch": "mozilla-central", 22:11:14 INFO - "repo_path": "mozilla-central", 22:11:14 INFO - "revision": "0885625045f0d07ab8ce6d46d8b354939aa3b617", 22:11:14 INFO - "stage_platform": "linux64-pgo", 22:11:14 INFO - "builduid": "235fd22f6fd54e0dbafd6e21a591c52e", 22:11:14 INFO - "slavebuilddir": "test" 22:11:14 INFO - } 22:11:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:11:14 INFO - Running post-action listener: _resource_record_post_action 22:11:14 INFO - ##### 22:11:14 INFO - ##### Running download-and-extract step. 22:11:14 INFO - ##### 22:11:14 INFO - Running pre-action listener: _resource_record_pre_action 22:11:14 INFO - Running main action method: download_and_extract 22:11:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:14 INFO - https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:11:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/test_packages.json 22:11:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/test_packages.json 22:11:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:11:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:11:26 INFO - Downloaded 1448 bytes. 22:11:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:11:26 INFO - Using the following test package requirements: 22:11:26 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:11:26 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:11:26 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:11:26 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:26 INFO - u'jsshell-linux-x86_64.zip'], 22:11:26 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:11:26 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:11:26 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:11:26 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:11:26 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:11:26 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:11:26 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:11:26 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:11:26 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:11:26 INFO - https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:11:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:11:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:11:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:11:28 INFO - Downloaded 23573602 bytes. 22:11:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:11:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:11:29 INFO - Return code: 0 22:11:29 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:11:29 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:11:29 INFO - https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:11:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:11:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:11:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:11:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:11:30 INFO - Downloaded 23573602 bytes. 22:11:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:11:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:11:32 INFO - Return code: 0 22:11:32 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:11:32 INFO - https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:11:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:11:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:11:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:11:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:11:33 INFO - Downloaded 10706547 bytes. 22:11:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:11:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:11:33 INFO - Return code: 0 22:11: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:11:33 INFO - https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:11:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:11:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:11:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:11:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:11:35 INFO - Downloaded 56575815 bytes. 22:11:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:11:35 INFO - mkdir: /builds/slave/test-pgo/properties 22:11:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:11:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:11:35 INFO - Contents: 22:11:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:11:35 INFO - Running post-action listener: _resource_record_post_action 22:11:35 INFO - Running post-action listener: set_extra_try_arguments 22:11:35 INFO - ##### 22:11:35 INFO - ##### Running populate-webroot step. 22:11:35 INFO - ##### 22:11:35 INFO - Running pre-action listener: _resource_record_pre_action 22:11:35 INFO - Running main action method: populate_webroot 22:11:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:11:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:11:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:11:35 INFO - '--tppagecycles', 22:11:35 INFO - '7'], 22:11:35 INFO - 'tests': ['tsvgm']}}, 22:11:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:11:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:11:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:11:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:11:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:11:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:11:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:11:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:35 INFO - 'talos_options': ['--e10s'], 22:11:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:11:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:35 INFO - 'tests': ['damp', 'tps']}, 22:11:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:35 INFO - 'talos_options': ['--e10s'], 22:11:35 INFO - 'tests': ['damp', 'tps']}, 22:11:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:11:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:11:35 INFO - 'other': {'tests': ['a11yr', 22:11:35 INFO - 'ts_paint', 22:11:35 INFO - 'tpaint', 22:11:35 INFO - 'sessionrestore', 22:11:35 INFO - 'sessionrestore_no_auto_restore']}, 22:11:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:11:35 INFO - 'tests': ['a11yr', 22:11:35 INFO - 'ts_paint', 22:11:35 INFO - 'tpaint', 22:11:35 INFO - 'sessionrestore', 22:11:35 INFO - 'sessionrestore_no_auto_restore']}, 22:11:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:11:35 INFO - 'tests': ['a11yr', 22:11:35 INFO - 'ts_paint', 22:11:35 INFO - 'tpaint', 22:11:35 INFO - 'sessionrestore', 22:11:35 INFO - 'sessionrestore_no_auto_restore']}, 22:11:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:11:35 INFO - 'tests': ['a11yr', 22:11:35 INFO - 'ts_paint', 22:11:35 INFO - 'tpaint', 22:11:35 INFO - 'sessionrestore', 22:11:35 INFO - 'sessionrestore_no_auto_restore']}, 22:11:35 INFO - 'other_l64': {'tests': ['a11yr', 22:11:35 INFO - 'ts_paint', 22:11:35 INFO - 'tpaint', 22:11:35 INFO - 'sessionrestore', 22:11:35 INFO - 'sessionrestore_no_auto_restore']}, 22:11:35 INFO - 'other_nol64': {'tests': ['a11yr', 22:11:35 INFO - 'ts_paint', 22:11:35 INFO - 'tpaint', 22:11:35 INFO - 'sessionrestore', 22:11:35 INFO - 'sessionrestore_no_auto_restore']}, 22:11:35 INFO - 'svgr': {'tests': ['tsvgx', 22:11:35 INFO - 'tsvgr_opacity', 22:11:35 INFO - 'tart', 22:11:35 INFO - 'tscrollx', 22:11:35 INFO - 'cart']}, 22:11:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:11:35 INFO - 'tests': ['tsvgx', 22:11:35 INFO - 'tsvgr_opacity', 22:11:35 INFO - 'tart', 22:11:35 INFO - 'tscrollx', 22:11:35 INFO - 'cart']}, 22:11:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:35 INFO - 'tests': ['tp5o']}, 22:11:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:35 INFO - 'talos_options': ['--e10s'], 22:11:35 INFO - 'tests': ['tp5o']}, 22:11:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:35 INFO - 'talos_options': ['--xperf_path', 22:11:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:11:35 INFO - 'tests': ['tp5n']}, 22:11:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:35 INFO - 'talos_options': ['--e10s', 22:11:35 INFO - '--xperf_path', 22:11:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:11:35 INFO - 'tests': ['tp5n']}}, 22:11:35 INFO - 'talos.zip': {'path': '', 22:11:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:11:35 INFO - Running post-action listener: _resource_record_post_action 22:11:35 INFO - ##### 22:11:35 INFO - ##### Running create-virtualenv step. 22:11:35 INFO - ##### 22:11:35 INFO - Running pre-action listener: _resource_record_pre_action 22:11:35 INFO - Running main action method: create_virtualenv 22:11:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:11:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:11:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:11:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:11:35 INFO - Using real prefix '/usr' 22:11:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:11:36 INFO - Installing distribute.............................................................................................................................................................................................done. 22:11:38 INFO - Installing pip.................done. 22:11:38 INFO - Return code: 0 22:11:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:11:38 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:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:38 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:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:38 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 0x7fac97a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9840>, '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 0x10666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', '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:11:38 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:11:38 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:11:38 INFO - Using env: {'DISPLAY': ':0', 22:11:38 INFO - 'HOME': '/home/cltbld', 22:11:38 INFO - 'LANG': 'en_US.UTF-8', 22:11:38 INFO - 'LANGUAGE': 'en_US:en', 22:11:38 INFO - 'LOGNAME': 'cltbld', 22:11:38 INFO - 'MAIL': '/var/mail/cltbld', 22:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:38 INFO - 'MOZ_NO_REMOTE': '1', 22:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:38 INFO - 'NO_EM_RESTART': '1', 22:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:38 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:38 INFO - 'SHELL': '/bin/bash', 22:11:38 INFO - 'SHLVL': '1', 22:11:38 INFO - 'TERM': 'linux', 22:11:38 INFO - 'TMOUT': '86400', 22:11:38 INFO - 'USER': 'cltbld', 22:11:38 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', 22:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:38 INFO - '_': '/tools/buildbot/bin/python'} 22:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:38 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:11:38 INFO - Cleaning up... 22:11:38 INFO - Return code: 0 22:11:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:11:38 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:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:38 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:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:38 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 0x7fac97a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9840>, '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 0x10666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', '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:11:38 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:11:38 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:11:38 INFO - Using env: {'DISPLAY': ':0', 22:11:38 INFO - 'HOME': '/home/cltbld', 22:11:38 INFO - 'LANG': 'en_US.UTF-8', 22:11:38 INFO - 'LANGUAGE': 'en_US:en', 22:11:38 INFO - 'LOGNAME': 'cltbld', 22:11:38 INFO - 'MAIL': '/var/mail/cltbld', 22:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:38 INFO - 'MOZ_NO_REMOTE': '1', 22:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:38 INFO - 'NO_EM_RESTART': '1', 22:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:38 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:38 INFO - 'SHELL': '/bin/bash', 22:11:38 INFO - 'SHLVL': '1', 22:11:38 INFO - 'TERM': 'linux', 22:11:38 INFO - 'TMOUT': '86400', 22:11:38 INFO - 'USER': 'cltbld', 22:11:38 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', 22:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:38 INFO - '_': '/tools/buildbot/bin/python'} 22:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:38 INFO - Downloading/unpacking psutil>=0.7.1 22:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:11:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:11:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:11:40 INFO - Installing collected packages: psutil 22:11:40 INFO - Running setup.py install for psutil 22:11:40 INFO - building 'psutil._psutil_linux' extension 22:11:40 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:11:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:11:40 INFO - building 'psutil._psutil_posix' extension 22:11:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:11:41 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:11:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:11:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:11:41 INFO - Successfully installed psutil 22:11:41 INFO - Cleaning up... 22:11:41 INFO - Return code: 0 22:11:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:41 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 0x7fac97a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9840>, '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 0x10666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', '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:11:41 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:11:41 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:11:41 INFO - Using env: {'DISPLAY': ':0', 22:11:41 INFO - 'HOME': '/home/cltbld', 22:11:41 INFO - 'LANG': 'en_US.UTF-8', 22:11:41 INFO - 'LANGUAGE': 'en_US:en', 22:11:41 INFO - 'LOGNAME': 'cltbld', 22:11:41 INFO - 'MAIL': '/var/mail/cltbld', 22:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:41 INFO - 'MOZ_NO_REMOTE': '1', 22:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:41 INFO - 'NO_EM_RESTART': '1', 22:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:41 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:41 INFO - 'SHELL': '/bin/bash', 22:11:41 INFO - 'SHLVL': '1', 22:11:41 INFO - 'TERM': 'linux', 22:11:41 INFO - 'TMOUT': '86400', 22:11:41 INFO - 'USER': 'cltbld', 22:11:41 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', 22:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:41 INFO - '_': '/tools/buildbot/bin/python'} 22:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:11:41 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:11:41 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:11:41 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:11:41 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:11:41 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:11:41 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:11:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:11:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:11:43 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:11:43 INFO - Installing collected packages: mozsystemmonitor 22:11:43 INFO - Running setup.py install for mozsystemmonitor 22:11:43 INFO - Successfully installed mozsystemmonitor 22:11:43 INFO - Cleaning up... 22:11:43 INFO - Return code: 0 22:11:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:43 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 0x7fac97a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9840>, '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 0x10666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', '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:11:43 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:11:43 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:11:43 INFO - Using env: {'DISPLAY': ':0', 22:11:43 INFO - 'HOME': '/home/cltbld', 22:11:43 INFO - 'LANG': 'en_US.UTF-8', 22:11:43 INFO - 'LANGUAGE': 'en_US:en', 22:11:43 INFO - 'LOGNAME': 'cltbld', 22:11:43 INFO - 'MAIL': '/var/mail/cltbld', 22:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:43 INFO - 'MOZ_NO_REMOTE': '1', 22:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:43 INFO - 'NO_EM_RESTART': '1', 22:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:43 INFO - 'SHELL': '/bin/bash', 22:11:43 INFO - 'SHLVL': '1', 22:11:43 INFO - 'TERM': 'linux', 22:11:43 INFO - 'TMOUT': '86400', 22:11:43 INFO - 'USER': 'cltbld', 22:11:43 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', 22:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:43 INFO - '_': '/tools/buildbot/bin/python'} 22:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:43 INFO - Downloading/unpacking blobuploader==1.2.4 22:11:43 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:11:43 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:11:43 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:11:43 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:11:43 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:11:43 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:11:45 INFO - Downloading blobuploader-1.2.4.tar.gz 22:11:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:11:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:11:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:46 INFO - Downloading docopt-0.6.1.tar.gz 22:11:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:11:46 INFO - Installing collected packages: blobuploader, requests, docopt 22:11:46 INFO - Running setup.py install for blobuploader 22:11:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:11:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:11:46 INFO - Running setup.py install for requests 22:11:46 INFO - Running setup.py install for docopt 22:11:46 INFO - Successfully installed blobuploader requests docopt 22:11:46 INFO - Cleaning up... 22:11:46 INFO - Return code: 0 22:11:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:46 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 0x7fac97a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9840>, '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 0x10666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', '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:11:46 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:11:46 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:11:46 INFO - Using env: {'DISPLAY': ':0', 22:11:46 INFO - 'HOME': '/home/cltbld', 22:11:46 INFO - 'LANG': 'en_US.UTF-8', 22:11:46 INFO - 'LANGUAGE': 'en_US:en', 22:11:46 INFO - 'LOGNAME': 'cltbld', 22:11:46 INFO - 'MAIL': '/var/mail/cltbld', 22:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:46 INFO - 'MOZ_NO_REMOTE': '1', 22:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:46 INFO - 'NO_EM_RESTART': '1', 22:11:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:46 INFO - 'SHELL': '/bin/bash', 22:11:46 INFO - 'SHLVL': '1', 22:11:46 INFO - 'TERM': 'linux', 22:11:46 INFO - 'TMOUT': '86400', 22:11:46 INFO - 'USER': 'cltbld', 22:11:46 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', 22:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:46 INFO - '_': '/tools/buildbot/bin/python'} 22:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:11:46 INFO - Running setup.py (path:/tmp/pip-tMZWMw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:11:47 INFO - Running setup.py (path:/tmp/pip-DnZbsH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:11:47 INFO - Running setup.py (path:/tmp/pip-yAWc17-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:11:47 INFO - Running setup.py (path:/tmp/pip-MOJrKU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:11:47 INFO - Running setup.py (path:/tmp/pip-iofEco-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:11:47 INFO - Running setup.py (path:/tmp/pip-W3jA3G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:11:47 INFO - Running setup.py (path:/tmp/pip-w7hqlJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:11:47 INFO - Running setup.py (path:/tmp/pip-eYlRJ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:11:47 INFO - Running setup.py (path:/tmp/pip-xiWjCF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:11:47 INFO - Running setup.py (path:/tmp/pip-rKJ7ta-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:11:47 INFO - Running setup.py (path:/tmp/pip-4ZRIju-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:11:47 INFO - Running setup.py (path:/tmp/pip-2g2clh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:11:47 INFO - Running setup.py (path:/tmp/pip-nQXkLV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:11:47 INFO - Running setup.py (path:/tmp/pip-HfbEKa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:11:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:11:47 INFO - Running setup.py (path:/tmp/pip-Ch3dd8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:11:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:11:48 INFO - Running setup.py (path:/tmp/pip-gcwGRX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:11:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:11:48 INFO - Running setup.py (path:/tmp/pip-Dsr2yh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:11:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:11:48 INFO - Running setup.py install for manifestparser 22:11:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:11:48 INFO - Running setup.py install for mozcrash 22:11:48 INFO - Running setup.py install for mozdebug 22:11:48 INFO - Running setup.py install for mozdevice 22:11:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:11:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:11:48 INFO - Running setup.py install for mozfile 22:11:48 INFO - Running setup.py install for mozhttpd 22:11:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:11:48 INFO - Running setup.py install for mozinfo 22:11:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:11:48 INFO - Running setup.py install for mozInstall 22:11:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:11:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:11:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:11:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:11:48 INFO - Running setup.py install for mozleak 22:11:49 INFO - Running setup.py install for mozlog 22:11:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:11:49 INFO - Running setup.py install for moznetwork 22:11:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:11:49 INFO - Running setup.py install for mozprocess 22:11:49 INFO - Running setup.py install for mozprofile 22:11:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:11:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:11:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:11:49 INFO - Running setup.py install for mozrunner 22:11:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:11:49 INFO - Running setup.py install for mozscreenshot 22:11:49 INFO - Running setup.py install for moztest 22:11:49 INFO - Running setup.py install for mozversion 22:11:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:11:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:11:49 INFO - Cleaning up... 22:11:49 INFO - Return code: 0 22:11:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac97a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9840>, '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 0x10666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', '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:11:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:11:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:11:49 INFO - Using env: {'DISPLAY': ':0', 22:11:49 INFO - 'HOME': '/home/cltbld', 22:11:49 INFO - 'LANG': 'en_US.UTF-8', 22:11:49 INFO - 'LANGUAGE': 'en_US:en', 22:11:49 INFO - 'LOGNAME': 'cltbld', 22:11:49 INFO - 'MAIL': '/var/mail/cltbld', 22:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:49 INFO - 'MOZ_NO_REMOTE': '1', 22:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:49 INFO - 'NO_EM_RESTART': '1', 22:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:49 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:49 INFO - 'SHELL': '/bin/bash', 22:11:49 INFO - 'SHLVL': '1', 22:11:49 INFO - 'TERM': 'linux', 22:11:49 INFO - 'TMOUT': '86400', 22:11:49 INFO - 'USER': 'cltbld', 22:11:49 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', 22:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:49 INFO - '_': '/tools/buildbot/bin/python'} 22:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:11:50 INFO - Running setup.py (path:/tmp/pip-TCElAE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:11:50 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:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:11:50 INFO - Running setup.py (path:/tmp/pip-mVOVBk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:11:50 INFO - Running setup.py (path:/tmp/pip-MzpQDT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:11:50 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:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:11:50 INFO - Running setup.py (path:/tmp/pip-aRPkH2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:11:50 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:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:11:50 INFO - Running setup.py (path:/tmp/pip-3pzIxk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:11:50 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:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:11:50 INFO - Running setup.py (path:/tmp/pip-YmK_u_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:11:50 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:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:11:50 INFO - Running setup.py (path:/tmp/pip-dCSgRr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:11:50 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:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:11:50 INFO - Running setup.py (path:/tmp/pip-PkkCYh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:11:50 INFO - Running setup.py (path:/tmp/pip-T8RTMF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:11:50 INFO - Running setup.py (path:/tmp/pip-SIw2TO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:11:50 INFO - Running setup.py (path:/tmp/pip-tZvL65-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:11:50 INFO - Running setup.py (path:/tmp/pip-yfJc6F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:11:51 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:11:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:11:51 INFO - Running setup.py (path:/tmp/pip-oFnsS5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:11:51 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:11:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:11:51 INFO - Running setup.py (path:/tmp/pip-46Znza-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:11:51 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:11:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:11:51 INFO - Running setup.py (path:/tmp/pip-HyzrKl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:11:51 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:11:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:11:51 INFO - Running setup.py (path:/tmp/pip-Ajh6_w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:11:51 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:11:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:11:51 INFO - Running setup.py (path:/tmp/pip-irixZ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:11:51 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:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:11:51 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:11:51 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:11:51 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:11:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:11:51 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:11:51 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:11:51 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:11:51 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:11:51 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:11:51 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:11:53 INFO - Downloading blessings-1.6.tar.gz 22:11:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:11:53 INFO - Installing collected packages: blessings 22:11:53 INFO - Running setup.py install for blessings 22:11:53 INFO - Successfully installed blessings 22:11:53 INFO - Cleaning up... 22:11:53 INFO - Return code: 0 22:11:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:11:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:11:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:11:53 INFO - Reading from file tmpfile_stdout 22:11:53 INFO - Current package versions: 22:11:53 INFO - argparse == 1.2.1 22:11:53 INFO - blessings == 1.6 22:11:53 INFO - blobuploader == 1.2.4 22:11:53 INFO - docopt == 0.6.1 22:11:53 INFO - manifestparser == 1.1 22:11:53 INFO - mozInstall == 1.12 22:11:53 INFO - mozcrash == 0.16 22:11:53 INFO - mozdebug == 0.1 22:11:53 INFO - mozdevice == 0.48 22:11:53 INFO - mozfile == 1.2 22:11:53 INFO - mozhttpd == 0.7 22:11:53 INFO - mozinfo == 0.9 22:11:53 INFO - mozleak == 0.1 22:11:53 INFO - mozlog == 3.1 22:11:53 INFO - moznetwork == 0.27 22:11:53 INFO - mozprocess == 0.22 22:11:53 INFO - mozprofile == 0.28 22:11:53 INFO - mozrunner == 6.11 22:11:53 INFO - mozscreenshot == 0.1 22:11:53 INFO - mozsystemmonitor == 0.0 22:11:53 INFO - moztest == 0.7 22:11:53 INFO - mozversion == 1.4 22:11:53 INFO - psutil == 3.1.1 22:11:53 INFO - requests == 1.2.3 22:11:53 INFO - wsgiref == 0.1.2 22:11:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:53 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 0x7fac97a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9840>, '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 0x10666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', '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:11:53 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:11:53 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:11:53 INFO - Using env: {'DISPLAY': ':0', 22:11:53 INFO - 'HOME': '/home/cltbld', 22:11:53 INFO - 'LANG': 'en_US.UTF-8', 22:11:53 INFO - 'LANGUAGE': 'en_US:en', 22:11:53 INFO - 'LOGNAME': 'cltbld', 22:11:53 INFO - 'MAIL': '/var/mail/cltbld', 22:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:53 INFO - 'MOZ_NO_REMOTE': '1', 22:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:53 INFO - 'NO_EM_RESTART': '1', 22:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:53 INFO - 'SHELL': '/bin/bash', 22:11:53 INFO - 'SHLVL': '1', 22:11:53 INFO - 'TERM': 'linux', 22:11:53 INFO - 'TMOUT': '86400', 22:11:53 INFO - 'USER': 'cltbld', 22:11:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', 22:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:53 INFO - '_': '/tools/buildbot/bin/python'} 22:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:11:53 INFO - Cleaning up... 22:11:53 INFO - Return code: 0 22:11:53 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac97a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9840>, '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 0x10666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', '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:11:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:11:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:11:53 INFO - Using env: {'DISPLAY': ':0', 22:11:53 INFO - 'HOME': '/home/cltbld', 22:11:53 INFO - 'LANG': 'en_US.UTF-8', 22:11:53 INFO - 'LANGUAGE': 'en_US:en', 22:11:53 INFO - 'LOGNAME': 'cltbld', 22:11:53 INFO - 'MAIL': '/var/mail/cltbld', 22:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:53 INFO - 'MOZ_NO_REMOTE': '1', 22:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:53 INFO - 'NO_EM_RESTART': '1', 22:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:53 INFO - 'SHELL': '/bin/bash', 22:11:53 INFO - 'SHLVL': '1', 22:11:53 INFO - 'TERM': 'linux', 22:11:53 INFO - 'TMOUT': '86400', 22:11:53 INFO - 'USER': 'cltbld', 22:11:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', 22:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:53 INFO - '_': '/tools/buildbot/bin/python'} 22:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:54 INFO - Downloading/unpacking jsonschema 22:11:54 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:11:54 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:11:54 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:11:54 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:11:54 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:11:54 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:11:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:11:55 INFO - Downloading/unpacking functools32 (from jsonschema) 22:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:56 INFO - Downloading functools32-3.2.3-2.tar.gz 22:11:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:11:56 INFO - warning: no files found matching '*.txt' 22:11:56 INFO - no previously-included directories found matching 'build' 22:11:56 INFO - no previously-included directories found matching 'dist' 22:11:56 INFO - no previously-included directories found matching '.git*' 22:11:56 INFO - Installing collected packages: jsonschema, functools32 22:11:56 INFO - Running setup.py install for functools32 22:11:56 INFO - warning: no files found matching '*.txt' 22:11:56 INFO - no previously-included directories found matching 'build' 22:11:56 INFO - no previously-included directories found matching 'dist' 22:11:56 INFO - no previously-included directories found matching '.git*' 22:11:56 INFO - Successfully installed jsonschema functools32 22:11:56 INFO - Cleaning up... 22:11:56 INFO - Return code: 0 22:11:56 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:11:56 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:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:56 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:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:56 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 0x7fac97a25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9840>, '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 0x10666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', '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:11:56 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:11:56 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:11:56 INFO - Using env: {'DISPLAY': ':0', 22:11:56 INFO - 'HOME': '/home/cltbld', 22:11:56 INFO - 'LANG': 'en_US.UTF-8', 22:11:56 INFO - 'LANGUAGE': 'en_US:en', 22:11:56 INFO - 'LOGNAME': 'cltbld', 22:11:56 INFO - 'MAIL': '/var/mail/cltbld', 22:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:56 INFO - 'MOZ_NO_REMOTE': '1', 22:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:56 INFO - 'NO_EM_RESTART': '1', 22:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:56 INFO - 'SHELL': '/bin/bash', 22:11:56 INFO - 'SHLVL': '1', 22:11:56 INFO - 'TERM': 'linux', 22:11:56 INFO - 'TMOUT': '86400', 22:11:56 INFO - 'USER': 'cltbld', 22:11:56 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', 22:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:56 INFO - '_': '/tools/buildbot/bin/python'} 22:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:56 INFO - Downloading/unpacking flake8 22:11:56 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:11:56 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:11:56 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:11:56 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:11:56 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:11:56 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:11:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:11:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:11:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:11:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:11:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:11:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:11:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:11:59 INFO - no previously-included directories found matching 'docs/_build' 22:11:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:11:59 INFO - Running setup.py install for pep8 22:11:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:11:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:11:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:11:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:11:59 INFO - no previously-included directories found matching 'docs/_build' 22:11:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:11:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:11:59 INFO - Cleaning up... 22:11:59 INFO - Return code: 0 22:11:59 INFO - Running post-action listener: _resource_record_post_action 22:11:59 INFO - Running post-action listener: _start_resource_monitoring 22:11:59 INFO - Starting resource monitoring. 22:11:59 INFO - ##### 22:11:59 INFO - ##### Running install step. 22:11:59 INFO - ##### 22:11:59 INFO - Running pre-action listener: _resource_record_pre_action 22:11:59 INFO - Running main action method: install 22:11:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:11:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:11:59 INFO - Reading from file tmpfile_stdout 22:11:59 INFO - Detecting whether we're running mozinstall >=1.0... 22:11:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:11:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:11:59 INFO - Reading from file tmpfile_stdout 22:11:59 INFO - Output received: 22:11:59 INFO - Usage: mozinstall [options] installer 22:11:59 INFO - Options: 22:11:59 INFO - -h, --help show this help message and exit 22:11:59 INFO - -d DEST, --destination=DEST 22:11:59 INFO - Directory to install application into. [default: 22:11:59 INFO - "/builds/slave/test-pgo"] 22:11:59 INFO - --app=APP Application being installed. [default: firefox] 22:11:59 INFO - mkdir: /builds/slave/test-pgo/build/application 22:11:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:11:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:12:15 INFO - Reading from file tmpfile_stdout 22:12:15 INFO - Output received: 22:12:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:12:15 INFO - Running post-action listener: _resource_record_post_action 22:12:15 INFO - ##### 22:12:15 INFO - ##### Running run-tests 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: run_tests 22:12:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:12:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:12:15 INFO - Python 2.7.3 22:12:15 INFO - Return code: 0 22:12:15 INFO - grabbing minidump binary from tooltool 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 - 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 0x10f9840>, '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 0x10666b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:12:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:12:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:12:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:12:16 INFO - Return code: 0 22:12:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:12:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:12:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:12:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:12:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:12:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:12:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:12:17 INFO - Return code: 0 22:12:17 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/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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:12:17 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/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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:12:17 INFO - Using env: {'DISPLAY': ':0', 22:12:17 INFO - 'HOME': '/home/cltbld', 22:12:17 INFO - 'LANG': 'en_US.UTF-8', 22:12:17 INFO - 'LANGUAGE': 'en_US:en', 22:12:17 INFO - 'LOGNAME': 'cltbld', 22:12:17 INFO - 'MAIL': '/var/mail/cltbld', 22:12:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:12:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:17 INFO - 'MOZ_NO_REMOTE': '1', 22:12:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:12:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:17 INFO - 'NO_EM_RESTART': '1', 22:12:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:17 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:12:17 INFO - 'SHELL': '/bin/bash', 22:12:17 INFO - 'SHLVL': '1', 22:12:17 INFO - 'TERM': 'linux', 22:12:17 INFO - 'TMOUT': '86400', 22:12:17 INFO - 'USER': 'cltbld', 22:12:17 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951', 22:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:17 INFO - '_': '/tools/buildbot/bin/python'} 22:12:17 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/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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:12:17 INFO - mozversion application_buildid: 20160205193440 22:12:17 INFO - mozversion application_changeset: 0885625045f0d07ab8ce6d46d8b354939aa3b617 22:12:17 INFO - mozversion application_display_name: Nightly 22:12:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:12:17 INFO - mozversion application_name: Firefox 22:12:17 INFO - mozversion application_remotingname: firefox 22:12:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:12:17 INFO - mozversion application_vendor: Mozilla 22:12:17 INFO - mozversion application_version: 47.0a1 22:12:17 INFO - mozversion platform_buildid: 20160205193440 22:12:17 INFO - mozversion platform_changeset: 0885625045f0d07ab8ce6d46d8b354939aa3b617 22:12:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:12:17 INFO - mozversion platform_version: 47.0a1 22:12:17 INFO - using testdate: 1454739137 22:12:17 INFO - actual date: 1454739137 22:12:17 INFO - starting webserver on 'localhost:50238' 22:12:17 INFO - SUITE-START | Running 2 tests 22:12:17 INFO - TEST-START | dromaeo_css 22:12:17 INFO - operating with platform_type : linux_ 22:12:17 INFO - Initialising browser for dromaeo_css test... 22:12:17 INFO - TEST-INFO | started process 7739 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgpq1jO/profile http://localhost:50238/getInfo.html) 22:12:21 INFO - PROCESS | 7739 | __metrics Screen width/height:1600/1200 22:12:21 INFO - PROCESS | 7739 | colorDepth:24 22:12:21 INFO - PROCESS | 7739 | Browser inner width/height: 1024/697 22:12:21 INFO - PROCESS | 7739 | __metrics 22:12:21 INFO - PROCESS | 7739 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:12:22 INFO - TEST-INFO | 7739: exit 0 22:12:22 INFO - Browser initialized. 22:12:22 INFO - Running cycle 1/1 for dromaeo_css test... 22:12:22 INFO - TEST-INFO | started process 7831 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgpq1jO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:12:34 INFO - PROCESS | 7831 | RSS: Main: 150900736 22:12:34 INFO - PROCESS | 7831 | 22:13:25 INFO - PROCESS | 7831 | 1454739205034 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:15:34 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:50238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50238/tests/dromaeo/cssquery-ext.html) 22:15:35 INFO - PROCESS | 7831 | RSS: Main: 285298688 22:15:35 INFO - PROCESS | 7831 | 22:18:37 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:50238/tests/dromaeo/cssquery-ext.html (next: http://localhost:50238/tests/dromaeo/cssquery-jquery.html) 22:18:38 INFO - PROCESS | 7831 | RSS: Main: 243204096 22:18:38 INFO - PROCESS | 7831 | 22:21:40 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:50238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50238/tests/dromaeo/cssquery-mootools.html) 22:21:40 INFO - PROCESS | 7831 | RSS: Main: 245526528 22:21:40 INFO - PROCESS | 7831 | 22:24:42 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:50238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50238/tests/dromaeo/cssquery-prototype.html) 22:24:43 INFO - PROCESS | 7831 | RSS: Main: 217387008 22:24:43 INFO - PROCESS | 7831 | 22:27:46 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:50238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50238/tests/dromaeo/cssquery-yui.html) 22:27:46 INFO - PROCESS | 7831 | RSS: Main: 219398144 22:27:46 INFO - PROCESS | 7831 | 22:30:49 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:50238/tests/dromaeo/cssquery-yui.html (next: http://localhost:50238/tests/dromaeo/cssquery-dojo.html) 22:30:49 INFO - PROCESS | 7831 | RSS: Main: 291618816 22:30:49 INFO - PROCESS | 7831 | 22:30:49 INFO - PROCESS | 7831 | __start_tp_report 22:30:49 INFO - PROCESS | 7831 | _x_x_mozilla_page_load 22:30:49 INFO - PROCESS | 7831 | _x_x_mozilla_page_load_details 22:30:49 INFO - PROCESS | 7831 | |i|pagename|runs| 22:30:49 INFO - PROCESS | 7831 | |0;dojo.html;3176.7935084219525;3225.75806814489;3262.9510557341646;3264.2329052672603;3305.0580584533404;5192.922106168401;5304.655197412166;5309.6814191148505;5339.332583427072;5403.081476149059;5336.91994620081;5368.651037682557;5382.434844341346;5392.460753924605;5393.2719082923795;4773.546513081252;4819.987802561457;4947.727874966876;4977.701337919736;5011.1481048221885;4781.0676918001;4915.680480768757;4926.088673595378;4956.7025978441225;4995.800167993276;4829.7585120744;4839.516048395168;4928.827491037797;4931.4821943696115;4944.53026962438;4843.927341089887;4848.224284114524;4848.442429120661;4851.660383773137;4889.828855990023;4772.665913386064;4819.879503012417;4839.395075615548;4848.636352273594;4887.144749668793;5050.242463630448;5123.359580052494;5157.71632560209;5226.7909283628605;5269.920951185697;5688.60179787415;5691.6585004899425;5697.4302569742695;5701.857453563653;5702.372738998707;5622.297212848394;5724.742386592613;5733.140028995643;5733.226014488033;5733.283339582552;5308.5487733542695;5311.203319502067;5362.249285100089;5366.973165134149;5414.810481633124;5838.065909454467;5840.182374467578;5840.970795145997;5878.2358293421585;5891.617044892068;5467.5625949923915;5574.60977731563;5658.264425624642;5661.122526008476;5666;5648.85877853057;5678.261825962599;5708.286464191976;5713.800016999385;5768.134779783066;5649.971750141223;5669.829905102853;5684.516816070681;5685.857853553694;5686.061799802987;5542.695151766611;5640.576956728261;5657.12314591239;5704.344000440003;5719.227904232958;4399.23013472641;4420.226460369422;4433.645308375387;4437.5784300491405;4455.153520831096;3960.643542081169;3961.603839616015;3970.4639873616693;3990.042389826479;3998.6001399859783;5210.713410762369;5304.734763261821;5327.600429967768;5332.413434522199;5334.876781909684;5736.913946290809;5801.042827933428;5814.59297849155;5818.21454103699;5843.94156058434;5286.286351342519;5352.170413585901;5354.598405119632;5355.250264962909;5357.4106848246665;4772.7136371817805;4848.5636292733825;4850.151223535867;4912.705237685679;4944.060628480577;5985.461308482258;5985.820425387245;5990.011648078018;5992.490638295706;6011.909821352683;5783.16144159103;5785.218995435563;5788.102844059177;5789.1605717171615;5791.305043394651;5821.7089145543405;5848.53211743051;5945.256842894638;5981.043033114681;6049.51603871698;5639.097744360883;5651.039323315129;5653.773849045992;5656.321241451053;5657.773689052557;5696;5747.3103227612955;5752.1659359391815;5759.107338362561;5772.047612144117;5474.343078830566;5558;5580.888382232414;5644.153376993484;5691.345495267931;5522.502974732293;5532.529734972572;5533.667979921218;5536.833894983157;5540.141278101901;5377.865553361197;5445.455454454523;5452.482014208644;5454.972725136349;5506.91739623914;5583.944160558342;5588.748506317307;5606.103023516218;5624;5656.5757568181725;5484.451554844483;5515.145152501369;5536.557075434036;5540.058190107611;5605.831825045255 22:30:49 INFO - PROCESS | 7831 | |1;ext.html;544.0099019783992;561.8651523634329;562.620231343843;575.3699698829782;578.3666884761186;28048;28913.421731565355;36123.2775344493;36957.81521092391;36976.44535331966;40694.38958415626;41066.79466602663;41079.794601027024;41229;41243.58756412435;8524.147585241473;8698.39111262212;8738.69414570487;8743.431676940978;8743.475391476532;8620.267277281439;8751.868721969144;8758.255548278372;8763.211310982011;8767.079456657055;8998.955005224965;9076.092390760905;9087.409318394282;9096.090390960884;9104.908950910505;8734.650613975433;8814;8834.425762325429;8834.911650883474;8837.690680826172;8682.218600325938;8795.164459376349;8808.383413161082;8818.823623527494;8819.426737262122;40484.1903161938;40982.59017409848;41011.179776404606;41033.589664103274;41093.79453102745;3241.1086951088405;3257.4136655402017;3275.7215636670912;3276.885309014197;3711.1278849470355;26774.464510709873;27393.726062739315;27436.862815685992;27444.588331174848;27449;3797.1836055247977;3833.195029043904;3882.107115363454;3950.6246906543834;4030.032792129897;264632.4757266992;266108;266815;267646;269802;60926.39073609296;60992.39007609956;61349.693251533456;61426;61699.38300617026;65439.34560654333;65690.34309656842;65798.34201658018;65858.67070664711;65981.34018659848;15323.310451029507;15385;15433.382664693287;15446.304916278794;15514.767278490832;12704.42830072649;12724.618261452171;12842.871571284355;12846.421911014028;12846.935765321301;19953;20994;21097.26159584438;21143.471413214793;21152.576948461254;6879.380855722909;8133.59332033396;8320.667173312999;8441.788955276168;8458.703945361884;955.8218922084098;1037.8131936251395;1045.132539991805;1122.0014187373245;1205.1864991130951;30307.393852123274;30906.918257861318;30960.535591966138;31202.68797312043;31460;1016.6441745389054;1023.4422239879135;1121.607437396921;1129.9774004519863;1174.4127936031985;14771.187584682732;15046.473373432096;17483.912580437016;17719.379821706436;17734.556636084202;289235;290587;292424;293029;293582;50608.74695626572;51069.74465127651;51087.74456127696;57769.71115144481;58970.70514647399;1343.4223283987978;1362.0329566008047;1366.473907545602;1376.7384197002336;1500.032479051006;28923.710762892944;30480.542791857697;30522.42902050743;30822.845885770428;30960;47215.52784472111;47864.7606761964;47876;47888.760556197;47899.76050119727;299895;302294;302306;302574;303032;27785.58321625137;28343;31427.37145257036;31507.36985260328;32055;37388.6261137396;37392.065198370256;37837.43243851399;38313;38526.80736596411;31097.37805243928;34614.65385346215;35210.295794084486;35513.28973420569;35530.644693552735;34661.82669086739;34966.30067398587;35069;35381.29237415289;35570.822145889106;36140.45789313215;36551.26897462089;36800.81599592092;36828.81585592162;36901.077473063386;29655.85172074126;30814.845925770227;31422.685773141977;31749.841250793597;32226.83886580552;24281.635775463736;24308.392290192885;24429.877850610632;24733.639649819434;24782 22:30:49 INFO - PROCESS | 7831 | |2;jquery.html;368.69030014787575;370.4480324316769;371.6098096998153;374.887533739878;376.4729378869582;13201.60395188146;13710.657233569165;16276.267567959441;16385.50843474696;16959.06725130119;15847.366105355772;16621.41825036124;16644.500664980038;16759.66480670386;17309.307627694907;5873.618214816044;6080.878382432349;6087.54343424245;6089.2692876854835;6101.877962440749;4370.759608221547;4522.5025247222775;4541.296099104644;4541.863744087683;6072.271327440713;6405.807825765234;6600.405963463311;6714.093597364366;6734.663266836663;6751.831204219885;6673.332666733337;6727.192736871558;6734.966325168391;6737.023131645933;6738.292479289677;6367.522435817332;6508.967455162741;6510.9023364649565;6523.836904077389;6525.4779617630475;21271;21631;22367.552648947094;22398.32805015852;22428;2141.4111119442123;2184.7924447177493;2271.8523295985874;2321.408040949564;2325.6744055832196;13116.147450415789;13660.65848353789;13933.721325573431;13941.372638231203;14073.788893166507;1974.2497850816599;1980.603879224161;1983.9801601984084;1984.8709833860896;2029.5940811837545;65257.70670772249;66493.3350666492;68907.65546172287;69128.99999999949;69327;14965.326560304813;15390.3074361654;15415.460458883885;15431.537053888402;15449.150296733562;23818;23940.40148996289;24094.39764005914;24154.51690966171;24161;6983.406410455168;7286.8178295541975;7287.089113860768;7305.3425191732995;7309.415246780245;7011.368976792113;7057.541259818198;7074.257202993715;7117.25268846774;7235.059442272471;4182.205380977604;4314.201872653569;4328.285832837547;4497.595216430537;4607.654425918069;1759.5601099725068;1835.127160180542;1849.7687789026372;1853.7868145163209;1866.0762922353522;880.3221519430003;937.5687183895484;952.8904176019846;1057.9894201058046;1107.7950579142885;12428.37858107091;15482.922585387001;16586;16648.417305394254;17439.128043597768;953.3088510829593;979.5934687104772;1029.1287308409603;1056.9312994655322;1068.973275668099;9054.592543335566;9709.300872347452;10269.075783179549;10276.794464110675;10312.535935882903;158027;160576;167143;545676;559451;41725.37411938823;52759.208611870854;60288;71148.28851711417;73947;1196.910231732606;1201.9459124339426;1202.0563857371922;1203.6509412270518;1219.85361756588;15406.922965385102;15772.842271577138;15949;15972.361105555648;16271.105089220207;33209.66790332162;33798.82010305488;34134.14664633404;34335.313293734485;34436.82781586076;46337.84155396142;47391.763041184575;48271.758641207976;48598.75700621474;49381;7555.886661700189;7937.365010799007;7940.801479962816;7983.2415920487465;7987.760367188994;8795.296376289754;8827.646894124164;10092.949535252277;10879.510422031186;11815.468303926173;9793.314467987173;10199;10355.585776569154;10360.222983276133;10582.894171058191;9715.417074975525;10198.286119971828;10209.897901020895;10303.845442318221;10429.843552346569;3227.0641513961627;6504.764094821969;9227.261819054595;10534.736631584272;10634.149268058381;7667.271609197117;7819.804504887424;7890.289873911375;7893.921060789318;7902.4863383879865;9436.622535098519;10096.899031009596;10788.244822862323;10902.890971090188;11000.394978276272 22:30:49 INFO - PROCESS | 7831 | |3;mootools.html;1385.6397336692469;1481.7703255995318;1497.071815474406;1690.3238704518192;1845.833874951254;7084.397826184774;7815.17940616235;7978.720744773934;7980.760577182694;7991.400644951623;7721.922780772191;7921.128675845653;7921.603919804015;7930.405219608538;7934.880976785353;2021.5148364392514;2066.028966385796;2067.534804668945;2334.9649755253686;2350.5416443793465;2066.2045112631595;2325.8139348852137;2386.081358676913;2387.9761202387926;2389.175734371639;2283.474800795818;2323.0243297814873;2334.253039027512;2338.5790557699606;2340.9414764630937;2229.3869185973986;2254.8196144308417;2256.5261295128043;2258.8757618330983;2340.1926335414423;2318.698569186012;2319.7332306784597;2325.430269583946;2326.5114325991563;2347.049444974788;8137;8145.266925976691;8205.138460461625;8212.425130240885;8224.054233763074;4877.780499877514;4959.355283813117;4992.925106123411;5017.448080711119;5060.898782024339;3217.420864244435;3270.708372577202;3271.329377477611;3287.046756440653;3313.3870234006786;1006.8741407324085;1023.2785885950387;1053.1574740207802;1053.6680945502142;1104.779044191165;11377.544898204145;11383.203175777699;11383.317000979885;11387;11414.143939204592;4432.3351497275025;4524.04994951064;4559.293309536961;4567.451905771262;4582.564656357641;9644.614215431444;9650.324477286522;9652.27607929408;9685.806283874424;9691.70924872255;4955.578775804097;4985.077760614298;4998.2502624606595;5005.449400565934;5009.499050095034;4456.509783923766;4500.797464114123;4510.120526497301;4514.187446259705;4527.61515271199;3490.3193877193703;3741.4948981887096;3752.4746535485056;3803.6386543278345;3889.086064774776;1226.650404634675;1238.3374894431615;1242.863285038645;1248.6316536621719;1256.3102626966715;1318.6505576022362;1326.8540460549332;1350.1359130156707;1393.2546087842954;1394.539801865382;7476.327130558276;7638.274363935418;7641.426892983049;7641.7707468776025;7647.349975252055;1151.746615744535;1155.3010428690689;1158.3320019172365;1171.1450641032095;1178.298912147271;5966.164736936832;6004.099385092184;6028.487578555784;6037.426444487766;6057.454829065406;9399.530023498797;9958.80082398348;10068.24488163376;10070.395776253448;10073.546690398949;9817;9947.20422366209;9949.104580587782;9953.353032052893;9959.850602240827;7332.413406927433;7512.474126811071;7559.962200188964;7562.281583249583;7580.696772129163;7290.088738907637;7432.182459929295;7533.6233188339265;7548.396128309612;7551.131619863786;8290.502569845828;8379.622916968872;8389.454685445426;8392.916070839214;8504.032902092486;8690.652373905226;8728.170823771732;8785.428947118417;8874.112588741074;8880.067592902653;7102.609356485236;7172.569645821268;7224.530405523624;7225.5664660120565;7236.710531578889;6834.965825170842;6972.337627925339;7440.1071871373615;7600.733974310872;7834.569098699626;7237.601931893796;7272;7352.080989876265;7391.593462359407;7437.962810185914;7277.59973201479;7285.927140728737;7293.452991025801;7340.779776606497;7423.109226892808;7264.636768161677;7320.743773968099;7355.264473552602;7359.153697324876;7437.739679111205;6692.1969363674725;6725.12573365479;6735.898961515679;6739.393454588914;6742.08981787472;6477.967610161919;6830.556013859084;6892.517523773287;6897.689603967733;6904.827379315558 22:30:49 INFO - PROCESS | 7831 | |4;prototype.html;341.5798567761653;345.80116433050983;347.80522907171985;356.9928601427973;357.50842591436776;5792.536597072224;5903.911441328378;5914.615549989253;5969.492593129578;5977.581569290146;5762;5845.5908086433965;5863.970680146604;5897.882042359161;5919.88160236795;4599.448066232057;4611.907761844761;4616.146012987591;4628.652851036186;4632.374629425035;4364.454443194601;4483.103379324132;4617.722936623796;4618.1687296286655;4635.420572428447;4555.20283950309;4560.657950653697;4563.566461186182;4579.244424669925;4584.587387135157;4568.497465278817;4571.634269258451;4579.061292435043;4580.7938642761155;4592.196365636034;4035.59644035597;4056.452378928866;4065.1869626074904;4066.2274167908004;4067.694922880766;5622.100463925753;5639.351474580435;5684.403137670568;5687.374388817227;5696.031674615284;5344.465553444625;5348.171033489815;5351.919721204185;5356.866078348034;5358.303420555303;5930.080837470199;6202.875942481171;6230.532710046719;6234.563580549363;6242.219722534684;4338.501072376685;4407.184670835905;4415.183191109655;4418.469783625953;4434.312681534368;6502.024696295546;6512.902306465359;6532;6539.607623542555;6546.803595892131;4565.3836732040745;4565.6119229865835;4568.291914753152;4571.954280457219;4574.313852922089;4533.455985281721;4615.561521655437;4616.838410655611;4618.67669263155;4620.214563524209;5294.841154765363;5297.046531624344;5305.867353316198;5307.416184219733;5308.177232528964;6318.210223722035;6322.557420980579;6327.778527751507;6330.525210609223;6406.8718625627225;1624.2122570553272;1655.6274838161316;1656.7739872494267;1657.685039842426;1658.6516831465528;1122.5565901468874;1124.1175677093606;1125.083057308291;1131;1158.2413519144973;5975.223220981245;5980.162777211194;5987;5992.041273396236;5995.61028533144;6501.707423165969;6503.642299673469;6514.3811337922825;6515.381038801401;6518.9895566187315;5790.36306006339;5918.378570250148;5918.822435326947;5976.73104710289;5980.192673988956;3476.80877551732;3507.8950130709254;3516.8593256269464;3516.9296614067575;3517.876874309438;6743.527953043338;6762.526623136431;6762.72949082041;6764.154480689914;6767.409658730195;6447.161868957006;6576.408123268833;6580.11168492257;6581.967090164519;6589.4069533742195;6637.900431493532;6746.460283177334;6747.05541224229;6759.053732477457;6772.627505487246;6222.875542489215;6468.062130991074;6471.611703297817;6476.222853257639;6477.805665830033;6480.092787009728;6496.675166241764;6511.772087976898;6512.446442052478;6528.934710653023;6860.862782744417;6862.279460656559;6868;6871.4502839773695;6872.553284036521;4597;4670.439547254351;4678.719276843401;4680.859574212779;4682.367880336111;6583.868322633425;6621.437177839937;6649.60102393858;6654.700538475877;6655.035019922181;6416.51876109303;6418.807435776934;6428.582142160932;6429.678516074271;6430.614163150226;6253.187085678833;6405.551611387158;6409.230892292955;6409.9038514423255;6450.193725784277;6383.553151279366;6383.904241436289;6389.393007664265;6395.488360931021;6397.168368112116;6471.352864713491;6473.320301368289;6474.125992991075;6474.223093228843;6489.059086432347;6172.259328880563;6312.116303717391;6314.052892066226;6314.179156709598;6319.115323854572 22:30:49 INFO - PROCESS | 7831 | |5;yui.html;669.253782033033;679.3783687925549;764.642457934773;777.2266594738236;823.435946376732;13140.342982850867;13389.7322053559;13391.263480508567;13402.597922062341;13409.731805363886;12727.618171454847;13227.338633068332;13246.933765331183;13253.271070091141;13290.601281961532;685.595498655793;693.944484441246;696.8884978403456;805.1545876829321;823.4770920465488;685.0819901332214;812.9674813007473;830.0951962361025;830.9086000539936;833.2334252487695;849.1211595998143;852.2159613155911;858.1247127929508;859.3125499600326;860.3418384935499;703.7572037647003;841.9494830310201;848.9278411335013;849.5921957460392;851.5699571716306;642.2613993906998;643.8873197190472;644.4650939720021;644.6325594411187;644.7227692092398;13071.738565228643;13089.08376413642;13112.213267203902;13145.934270328682;13152.342382880817;13125.278109703962;13217.537386191438;13260.204387736767;13561.796573051412;13620.727585448334;10639.725285374208;10730.302530335503;10756.462176891124;10790.838137427945;10808.675739727822;3626.9198935416202;3693.8337774800198;3693.9815300923324;3694.7783133012103;3828.885133445973;47412;47558.762206189094;47711;47737.28394074057;47778;10577.100946419487;10792.676219713421;10883;10887.782244355069;11118.221724479208;19262;19283.90358048229;19308.613827723366;19351.12919918579;19396.321128760424;7434.739784107638;7518.947347371372;7519.248075192437;7539.0576177977755;7742.380609551335;4215.662746980234;4221.387898754663;4238.004069043773;4261.659067274611;4418.7127836690515;3287.8027318360973;3308.123347312964;3310.2220978070136;3323.6842499962463;3337.6495467975997;530.0379810643669;536.2385412713955;538.496505767109;545.184948501992;553.051516648949;516.187005466392;592.3706235767463;641.4387411015362;650.9576877502947;701.1446035836271;8330.875036874451;8417.17754687714;8527.275181609633;8697.565121743888;8779.29765618749;551.6607286518843;607.5139888089511;680.1328306409367;683.3474032299142;694.4513834071129;4006.7996600169877;4036.8788936331957;4096.897577560585;4097.85657501986;4125.8968525786495;51222;51240.487595124316;51407.74296128495;51450.485495145316;51510.48489515132;46354.30468542974;46960.295595566095;47250.29124563134;47515.28727069097;47652.04695906132;41841;42000;42977.999999999374;43646.12707745891;43756.78121609435;7726.961365193138;8108.554029528433;8133.552654604054;8485.321174306164;8924.152205540464;30252.84873575706;30776.23059423443;32777.83611081929;33883.32233355368;33910.83044584761;40566.39150412805;41226;41274.79362603168;42444.15111697811;42897.35653965255;10894.237403381687;11024.44877756125;11166.832497512707;11238.55045798159;11361.659150225507;11893.881061189277;12094.516219351128;12241.571544996239;12315.13794034409;12494.37528123572;11638.185327027028;11714.1800073994;12131.75736485283;12186.2078964867;12309.076819238413;11259.29623159471;11340.546378145113;11540.653780386601;12020.398980051137;12207.328596927255;8182.427230093836;11150.609728659458;11356.488957997075;11698.47356868926;12143.149979501704;9556.713298601053;9732.41605503672;9769.804603908024;9884.456354900261;9929.3545919515;9234.861477077984;9403.85894211601;9441.952790236004;9473.95263023708;9532.428054316762 22:30:49 INFO - PROCESS | 7831 | __end_tp_report 22:30:49 INFO - PROCESS | 7831 | __start_cc_report 22:30:49 INFO - PROCESS | 7831 | _x_x_mozilla_cycle_collect,1080 22:30:49 INFO - PROCESS | 7831 | __end_cc_report 22:30:49 INFO - PROCESS | 7831 | __startTimestamp1454740249742__endTimestamp 22:30:49 INFO - PROCESS | 7831 | 22:30:49 INFO - PROCESS | 7831 | ------- Summary: start ------- 22:30:49 INFO - PROCESS | 7831 | Number of tests: 6 22:30:49 INFO - PROCESS | 7831 | 22:30:49 INFO - PROCESS | 7831 | [#0] dojo.html Cycles:165 Average:5312.09 Median:5506.92 stddev:580.45 (10.5%) stddev-sans-first:557.54 22:30:49 INFO - PROCESS | 7831 | Values: 3176.8 3225.8 3263.0 3264.2 3305.1 5192.9 5304.7 5309.7 5339.3 5403.1 5336.9 5368.7 5382.4 5392.5 5393.3 4773.5 4820.0 4947.7 4977.7 5011.1 4781.1 4915.7 4926.1 4956.7 4995.8 4829.8 4839.5 4928.8 4931.5 4944.5 4843.9 4848.2 4848.4 4851.7 4889.8 4772.7 4819.9 4839.4 4848.6 4887.1 5050.2 5123.4 5157.7 5226.8 5269.9 5688.6 5691.7 5697.4 5701.9 5702.4 5622.3 5724.7 5733.1 5733.2 5733.3 5308.5 5311.2 5362.2 5367.0 5414.8 5838.1 5840.2 5841.0 5878.2 5891.6 5467.6 5574.6 5658.3 5661.1 5666.0 5648.9 5678.3 5708.3 5713.8 5768.1 5650.0 5669.8 5684.5 5685.9 5686.1 5542.7 5640.6 5657.1 5704.3 5719.2 4399.2 4420.2 4433.6 4437.6 4455.2 3960.6 3961.6 3970.5 3990.0 3998.6 5210.7 5304.7 5327.6 5332.4 5334.9 5736.9 5801.0 5814.6 5818.2 5843.9 5286.3 5352.2 5354.6 5355.3 5357.4 4772.7 4848.6 4850.2 4912.7 4944.1 5985.5 5985.8 5990.0 5992.5 6011.9 5783.2 5785.2 5788.1 5789.2 5791.3 5821.7 5848.5 5945.3 5981.0 6049.5 5639.1 5651.0 5653.8 5656.3 5657.8 5696.0 5747.3 5752.2 5759.1 5772.0 5474.3 5558.0 5580.9 5644.2 5691.3 5522.5 5532.5 5533.7 5536.8 5540.1 5377.9 5445.5 5452.5 5455.0 5506.9 5583.9 5588.7 5606.1 5624.0 5656.6 5484.5 5515.1 5536.6 5540.1 5605.8 22:30:49 INFO - PROCESS | 7831 | 22:30:49 INFO - PROCESS | 7831 | [#1] ext.html Cycles:180 Average:45904.93 Median:35295.79 stddev:75016.63 (212.5%) stddev-sans-first:75149.76 22:30:49 INFO - PROCESS | 7831 | Values: 544.0 561.9 562.6 575.4 578.4 28048.0 28913.4 36123.3 36957.8 36976.4 40694.4 41066.8 41079.8 41229.0 41243.6 8524.1 8698.4 8738.7 8743.4 8743.5 8620.3 8751.9 8758.3 8763.2 8767.1 8999.0 9076.1 9087.4 9096.1 9104.9 8734.7 8814.0 8834.4 8834.9 8837.7 8682.2 8795.2 8808.4 8818.8 8819.4 40484.2 40982.6 41011.2 41033.6 41093.8 3241.1 3257.4 3275.7 3276.9 3711.1 26774.5 27393.7 27436.9 27444.6 27449.0 3797.2 3833.2 3882.1 3950.6 4030.0 264632.5 266108.0 266815.0 267646.0 269802.0 60926.4 60992.4 61349.7 61426.0 61699.4 65439.3 65690.3 65798.3 65858.7 65981.3 15323.3 15385.0 15433.4 15446.3 15514.8 12704.4 12724.6 12842.9 12846.4 12846.9 19953.0 20994.0 21097.3 21143.5 21152.6 6879.4 8133.6 8320.7 8441.8 8458.7 955.8 1037.8 1045.1 1122.0 1205.2 30307.4 30906.9 30960.5 31202.7 31460.0 1016.6 1023.4 1121.6 1130.0 1174.4 14771.2 15046.5 17483.9 17719.4 17734.6 289235.0 290587.0 292424.0 293029.0 293582.0 50608.7 51069.7 51087.7 57769.7 58970.7 1343.4 1362.0 1366.5 1376.7 1500.0 28923.7 30480.5 30522.4 30822.8 30960.0 47215.5 47864.8 47876.0 47888.8 47899.8 299895.0 302294.0 302306.0 302574.0 303032.0 27785.6 28343.0 31427.4 31507.4 32055.0 37388.6 37392.1 37837.4 38313.0 38526.8 31097.4 34614.7 35210.3 35513.3 35530.6 34661.8 34966.3 35069.0 35381.3 35570.8 36140.5 36551.3 36800.8 36828.8 36901.1 29655.9 30814.8 31422.7 31749.8 32226.8 24281.6 24308.4 24429.9 24733.6 24782.0 22:30:49 INFO - PROCESS | 7831 | 22:30:49 INFO - PROCESS | 7831 | [#2] jquery.html Cycles:180 Average:22231.04 Median:33966.48 stddev:61509.16 (181.1%) stddev-sans-first:61659.80 22:30:49 INFO - PROCESS | 7831 | Values: 368.7 370.4 371.6 374.9 376.5 13201.6 13710.7 16276.3 16385.5 16959.1 15847.4 16621.4 16644.5 16759.7 17309.3 5873.6 6080.9 6087.5 6089.3 6101.9 4370.8 4522.5 4541.3 4541.9 6072.3 6405.8 6600.4 6714.1 6734.7 6751.8 6673.3 6727.2 6735.0 6737.0 6738.3 6367.5 6509.0 6510.9 6523.8 6525.5 21271.0 21631.0 22367.6 22398.3 22428.0 2141.4 2184.8 2271.9 2321.4 2325.7 13116.1 13660.7 13933.7 13941.4 14073.8 1974.2 1980.6 1984.0 1984.9 2029.6 65257.7 66493.3 68907.7 69129.0 69327.0 14965.3 15390.3 15415.5 15431.5 15449.2 23818.0 23940.4 24094.4 24154.5 24161.0 6983.4 7286.8 7287.1 7305.3 7309.4 7011.4 7057.5 7074.3 7117.3 7235.1 4182.2 4314.2 4328.3 4497.6 4607.7 1759.6 1835.1 1849.8 1853.8 1866.1 880.3 937.6 952.9 1058.0 1107.8 12428.4 15482.9 16586.0 16648.4 17439.1 953.3 979.6 1029.1 1056.9 1069.0 9054.6 9709.3 10269.1 10276.8 10312.5 158027.0 160576.0 167143.0 545676.0 559451.0 41725.4 52759.2 60288.0 71148.3 73947.0 1196.9 1201.9 1202.1 1203.7 1219.9 15406.9 15772.8 15949.0 15972.4 16271.1 33209.7 33798.8 34134.1 34335.3 34436.8 46337.8 47391.8 48271.8 48598.8 49381.0 7555.9 7937.4 7940.8 7983.2 7987.8 8795.3 8827.6 10092.9 10879.5 11815.5 9793.3 10199.0 10355.6 10360.2 10582.9 9715.4 10198.3 10209.9 10303.8 10429.8 3227.1 6504.8 9227.3 10534.7 10634.1 7667.3 7819.8 7890.3 7893.9 7902.5 9436.6 10096.9 10788.2 10902.9 11000.4 22:30:49 INFO - PROCESS | 7831 | 22:30:49 INFO - PROCESS | 7831 | [#3] mootools.html Cycles:180 Average:5677.68 Median:6032.96 stddev:2950.27 (48.9%) stddev-sans-first:2940.91 22:30:49 INFO - PROCESS | 7831 | Values: 1385.6 1481.8 1497.1 1690.3 1845.8 7084.4 7815.2 7978.7 7980.8 7991.4 7721.9 7921.1 7921.6 7930.4 7934.9 2021.5 2066.0 2067.5 2335.0 2350.5 2066.2 2325.8 2386.1 2388.0 2389.2 2283.5 2323.0 2334.3 2338.6 2340.9 2229.4 2254.8 2256.5 2258.9 2340.2 2318.7 2319.7 2325.4 2326.5 2347.0 8137.0 8145.3 8205.1 8212.4 8224.1 4877.8 4959.4 4992.9 5017.4 5060.9 3217.4 3270.7 3271.3 3287.0 3313.4 1006.9 1023.3 1053.2 1053.7 1104.8 11377.5 11383.2 11383.3 11387.0 11414.1 4432.3 4524.0 4559.3 4567.5 4582.6 9644.6 9650.3 9652.3 9685.8 9691.7 4955.6 4985.1 4998.3 5005.4 5009.5 4456.5 4500.8 4510.1 4514.2 4527.6 3490.3 3741.5 3752.5 3803.6 3889.1 1226.7 1238.3 1242.9 1248.6 1256.3 1318.7 1326.9 1350.1 1393.3 1394.5 7476.3 7638.3 7641.4 7641.8 7647.3 1151.7 1155.3 1158.3 1171.1 1178.3 5966.2 6004.1 6028.5 6037.4 6057.5 9399.5 9958.8 10068.2 10070.4 10073.5 9817.0 9947.2 9949.1 9953.4 9959.9 7332.4 7512.5 7560.0 7562.3 7580.7 7290.1 7432.2 7533.6 7548.4 7551.1 8290.5 8379.6 8389.5 8392.9 8504.0 8690.7 8728.2 8785.4 8874.1 8880.1 7102.6 7172.6 7224.5 7225.6 7236.7 6835.0 6972.3 7440.1 7600.7 7834.6 7237.6 7272.0 7352.1 7391.6 7438.0 7277.6 7285.9 7293.5 7340.8 7423.1 7264.6 7320.7 7355.3 7359.2 7437.7 6692.2 6725.1 6735.9 6739.4 6742.1 6478.0 6830.6 6892.5 6897.7 6904.8 22:30:49 INFO - PROCESS | 7831 | 22:30:49 INFO - PROCESS | 7831 | [#4] prototype.html Cycles:180 Average:5311.70 Median:5924.98 stddev:1581.29 (26.7%) stddev-sans-first:1541.10 22:30:49 INFO - PROCESS | 7831 | Values: 341.6 345.8 347.8 357.0 357.5 5792.5 5903.9 5914.6 5969.5 5977.6 5762.0 5845.6 5864.0 5897.9 5919.9 4599.4 4611.9 4616.1 4628.7 4632.4 4364.5 4483.1 4617.7 4618.2 4635.4 4555.2 4560.7 4563.6 4579.2 4584.6 4568.5 4571.6 4579.1 4580.8 4592.2 4035.6 4056.5 4065.2 4066.2 4067.7 5622.1 5639.4 5684.4 5687.4 5696.0 5344.5 5348.2 5351.9 5356.9 5358.3 5930.1 6202.9 6230.5 6234.6 6242.2 4338.5 4407.2 4415.2 4418.5 4434.3 6502.0 6512.9 6532.0 6539.6 6546.8 4565.4 4565.6 4568.3 4572.0 4574.3 4533.5 4615.6 4616.8 4618.7 4620.2 5294.8 5297.0 5305.9 5307.4 5308.2 6318.2 6322.6 6327.8 6330.5 6406.9 1624.2 1655.6 1656.8 1657.7 1658.7 1122.6 1124.1 1125.1 1131.0 1158.2 5975.2 5980.2 5987.0 5992.0 5995.6 6501.7 6503.6 6514.4 6515.4 6519.0 5790.4 5918.4 5918.8 5976.7 5980.2 3476.8 3507.9 3516.9 3516.9 3517.9 6743.5 6762.5 6762.7 6764.2 6767.4 6447.2 6576.4 6580.1 6582.0 6589.4 6637.9 6746.5 6747.1 6759.1 6772.6 6222.9 6468.1 6471.6 6476.2 6477.8 6480.1 6496.7 6511.8 6512.4 6528.9 6860.9 6862.3 6868.0 6871.5 6872.6 4597.0 4670.4 4678.7 4680.9 4682.4 6583.9 6621.4 6649.6 6654.7 6655.0 6416.5 6418.8 6428.6 6429.7 6430.6 6253.2 6405.6 6409.2 6409.9 6450.2 6383.6 6383.9 6389.4 6395.5 6397.2 6471.4 6473.3 6474.1 6474.2 6489.1 6172.3 6312.1 6314.1 6314.2 6319.1 22:30:49 INFO - PROCESS | 7831 | 22:30:49 INFO - PROCESS | 7831 | [#5] yui.html Cycles:180 Average:13337.32 Median:43312.06 stddev:14740.17 (34.0%) stddev-sans-first:14750.82 22:30:49 INFO - PROCESS | 7831 | Values: 669.3 679.4 764.6 777.2 823.4 13140.3 13389.7 13391.3 13402.6 13409.7 12727.6 13227.3 13246.9 13253.3 13290.6 685.6 693.9 696.9 805.2 823.5 685.1 813.0 830.1 830.9 833.2 849.1 852.2 858.1 859.3 860.3 703.8 841.9 848.9 849.6 851.6 642.3 643.9 644.5 644.6 644.7 13071.7 13089.1 13112.2 13145.9 13152.3 13125.3 13217.5 13260.2 13561.8 13620.7 10639.7 10730.3 10756.5 10790.8 10808.7 3626.9 3693.8 3694.0 3694.8 3828.9 47412.0 47558.8 47711.0 47737.3 47778.0 10577.1 10792.7 10883.0 10887.8 11118.2 19262.0 19283.9 19308.6 19351.1 19396.3 7434.7 7518.9 7519.2 7539.1 7742.4 4215.7 4221.4 4238.0 4261.7 4418.7 3287.8 3308.1 3310.2 3323.7 3337.6 530.0 536.2 538.5 545.2 553.1 516.2 592.4 641.4 651.0 701.1 8330.9 8417.2 8527.3 8697.6 8779.3 551.7 607.5 680.1 683.3 694.5 4006.8 4036.9 4096.9 4097.9 4125.9 51222.0 51240.5 51407.7 51450.5 51510.5 46354.3 46960.3 47250.3 47515.3 47652.0 41841.0 42000.0 42978.0 43646.1 43756.8 7727.0 8108.6 8133.6 8485.3 8924.2 30252.8 30776.2 32777.8 33883.3 33910.8 40566.4 41226.0 41274.8 42444.2 42897.4 10894.2 11024.4 11166.8 11238.6 11361.7 11893.9 12094.5 12241.6 12315.1 12494.4 11638.2 11714.2 12131.8 12186.2 12309.1 11259.3 11340.5 11540.7 12020.4 12207.3 8182.4 11150.6 11356.5 11698.5 12143.1 9556.7 9732.4 9769.8 9884.5 9929.4 9234.9 9403.9 9442.0 9474.0 9532.4 22:30:49 INFO - PROCESS | 7831 | -------- Summary: end -------- 22:30:49 INFO - PROCESS | 7831 | 22:30:50 INFO - TEST-INFO | 7831: exit 0 22:30:50 INFO - TEST-OK | dromaeo_css | took 1113122ms 22:30:50 INFO - TEST-START | kraken 22:30:50 INFO - operating with platform_type : linux_ 22:30:50 INFO - Initialising browser for kraken test... 22:30:50 INFO - TEST-INFO | started process 8010 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSwMcY_/profile http://localhost:50238/getInfo.html) 22:30:54 INFO - PROCESS | 8010 | __metrics Screen width/height:1600/1200 22:30:54 INFO - PROCESS | 8010 | colorDepth:24 22:30:54 INFO - PROCESS | 8010 | Browser inner width/height: 1024/697 22:30:54 INFO - PROCESS | 8010 | __metrics 22:30:54 INFO - PROCESS | 8010 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:30:55 INFO - TEST-INFO | 8010: exit 0 22:30:55 INFO - Browser initialized. 22:30:55 INFO - Running cycle 1/1 for kraken test... 22:30:55 INFO - TEST-INFO | started process 8093 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSwMcY_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:31:07 INFO - PROCESS | 8093 | RSS: Main: 151351296 22:31:07 INFO - PROCESS | 8093 | 22:31:09 INFO - PROCESS | 8093 | Cycle 1(1): loaded http://localhost:50238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50238/tests/kraken/driver.html?testName=audio-beat-detection) 22:31:10 INFO - PROCESS | 8093 | RSS: Main: 191156224 22:31:10 INFO - PROCESS | 8093 | 22:31:13 INFO - PROCESS | 8093 | Cycle 1(1): loaded http://localhost:50238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50238/tests/kraken/driver.html?testName=audio-dft) 22:31:13 INFO - PROCESS | 8093 | RSS: Main: 181518336 22:31:13 INFO - PROCESS | 8093 | 22:31:16 INFO - PROCESS | 8093 | Cycle 1(1): loaded http://localhost:50238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50238/tests/kraken/driver.html?testName=audio-fft) 22:31:17 INFO - PROCESS | 8093 | RSS: Main: 166694912 22:31:17 INFO - PROCESS | 8093 | 22:31:19 INFO - PROCESS | 8093 | Cycle 1(1): loaded http://localhost:50238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50238/tests/kraken/driver.html?testName=audio-oscillator) 22:31:19 INFO - PROCESS | 8093 | RSS: Main: 167636992 22:31:19 INFO - PROCESS | 8093 | 22:31:22 INFO - PROCESS | 8093 | Cycle 1(1): loaded http://localhost:50238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:31:22 INFO - PROCESS | 8093 | RSS: Main: 168869888 22:31:22 INFO - PROCESS | 8093 | 22:31:25 INFO - PROCESS | 8093 | Cycle 1(1): loaded http://localhost:50238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50238/tests/kraken/driver.html?testName=imaging-darkroom) 22:31:26 INFO - PROCESS | 8093 | RSS: Main: 169160704 22:31:26 INFO - PROCESS | 8093 | 22:31:29 INFO - PROCESS | 8093 | Cycle 1(1): loaded http://localhost:50238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50238/tests/kraken/driver.html?testName=imaging-desaturate) 22:31:30 INFO - PROCESS | 8093 | RSS: Main: 171208704 22:31:30 INFO - PROCESS | 8093 | 22:31:32 INFO - PROCESS | 8093 | Cycle 1(1): loaded http://localhost:50238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50238/tests/kraken/driver.html?testName=json-parse-financial) 22:31:33 INFO - PROCESS | 8093 | RSS: Main: 172359680 22:31:33 INFO - PROCESS | 8093 | 22:31:34 INFO - PROCESS | 8093 | Cycle 1(1): loaded http://localhost:50238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:31:35 INFO - PROCESS | 8093 | RSS: Main: 181559296 22:31:35 INFO - PROCESS | 8093 | 22:31:37 INFO - PROCESS | 8093 | Cycle 1(1): loaded http://localhost:50238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50238/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:31:37 INFO - PROCESS | 8093 | RSS: Main: 178114560 22:31:37 INFO - PROCESS | 8093 | 22:31:40 INFO - PROCESS | 8093 | Cycle 1(1): loaded http://localhost:50238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:31:40 INFO - PROCESS | 8093 | RSS: Main: 189251584 22:31:40 INFO - PROCESS | 8093 | 22:31:43 INFO - PROCESS | 8093 | Cycle 1(1): loaded http://localhost:50238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:31:43 INFO - PROCESS | 8093 | RSS: Main: 195252224 22:31:43 INFO - PROCESS | 8093 | 22:31:46 INFO - PROCESS | 8093 | Cycle 1(1): loaded http://localhost:50238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:31:46 INFO - PROCESS | 8093 | RSS: Main: 192090112 22:31:46 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | Cycle 1(1): loaded http://localhost:50238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50238/tests/kraken/driver.html?testName=ai-astar) 22:31:48 INFO - PROCESS | 8093 | RSS: Main: 253493248 22:31:48 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | __start_tp_report 22:31:48 INFO - PROCESS | 8093 | _x_x_mozilla_page_load 22:31:48 INFO - PROCESS | 8093 | _x_x_mozilla_page_load_details 22:31:48 INFO - PROCESS | 8093 | |i|pagename|runs| 22:31:48 INFO - PROCESS | 8093 | |0;ai-astar;108;110;105;109;110;109;99;110;110;108 22:31:48 INFO - PROCESS | 8093 | |1;audio-beat-detection;155;127;155;166;126;151;152;134;174;126 22:31:48 INFO - PROCESS | 8093 | |2;audio-dft;161;162;162;162;161;161;160;164;163;163 22:31:48 INFO - PROCESS | 8093 | |3;audio-fft;72;73;124;97;72;75;72;122;100;72 22:31:48 INFO - PROCESS | 8093 | |4;audio-oscillator;95;95;135;96;95;96;138;97;96;134 22:31:48 INFO - PROCESS | 8093 | |5;imaging-gaussian-blur;118;115;114;115;115;114;115;115;115;115 22:31:48 INFO - PROCESS | 8093 | |6;imaging-darkroom;145;144;145;144;146;145;145;146;145;145 22:31:48 INFO - PROCESS | 8093 | |7;imaging-desaturate;96;95;96;96;96;96;96;96;96;95 22:31:48 INFO - PROCESS | 8093 | |8;json-parse-financial;56;56;58;55;57;55;57;65;53;54 22:31:48 INFO - PROCESS | 8093 | |9;json-stringify-tinderbox;66;66;66;66;67;67;67;66;67;66 22:31:48 INFO - PROCESS | 8093 | |10;stanford-crypto-aes;86;86;84;93;85;93;87;86;88;94 22:31:48 INFO - PROCESS | 8093 | |11;stanford-crypto-ccm;118;115;116;122;128;123;122;115;115;117 22:31:48 INFO - PROCESS | 8093 | |12;stanford-crypto-pbkdf2;149;145;146;149;156;139;152;141;153;150 22:31:48 INFO - PROCESS | 8093 | |13;stanford-crypto-sha256-iterative;69;67;70;68;68;70;68;70;69;70 22:31:48 INFO - PROCESS | 8093 | __end_tp_report 22:31:48 INFO - PROCESS | 8093 | __start_cc_report 22:31:48 INFO - PROCESS | 8093 | _x_x_mozilla_cycle_collect,999 22:31:48 INFO - PROCESS | 8093 | __end_cc_report 22:31:48 INFO - PROCESS | 8093 | __startTimestamp1454740308747__endTimestamp 22:31:48 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | ------- Summary: start ------- 22:31:48 INFO - PROCESS | 8093 | Number of tests: 14 22:31:48 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | [#0] ai-astar Cycles:10 Average:107.80 Median:110.00 stddev:3.46 (3.1%) stddev-sans-first:3.67 22:31:48 INFO - PROCESS | 8093 | Values: 108.0 110.0 105.0 109.0 110.0 109.0 99.0 110.0 110.0 108.0 22:31:48 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:153.50 stddev:17.35 (11.3%) stddev-sans-first:18.13 22:31:48 INFO - PROCESS | 8093 | Values: 155.0 127.0 155.0 166.0 126.0 151.0 152.0 134.0 174.0 126.0 22:31:48 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 22:31:48 INFO - PROCESS | 8093 | Values: 161.0 162.0 162.0 162.0 161.0 161.0 160.0 164.0 163.0 163.0 22:31:48 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | [#3] audio-fft Cycles:10 Average:87.90 Median:72.00 stddev:21.33 (29.6%) stddev-sans-first:21.83 22:31:48 INFO - PROCESS | 8093 | Values: 72.0 73.0 124.0 97.0 72.0 75.0 72.0 122.0 100.0 72.0 22:31:48 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:95.50 stddev:19.33 (20.2%) stddev-sans-first:19.95 22:31:48 INFO - PROCESS | 8093 | Values: 95.0 95.0 135.0 96.0 95.0 96.0 138.0 97.0 96.0 134.0 22:31:48 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.10 (1.0%) stddev-sans-first:0.44 22:31:48 INFO - PROCESS | 8093 | Values: 118.0 115.0 114.0 115.0 115.0 114.0 115.0 115.0 115.0 115.0 22:31:48 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 22:31:48 INFO - PROCESS | 8093 | Values: 145.0 144.0 145.0 144.0 146.0 145.0 145.0 146.0 145.0 145.0 22:31:48 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:31:48 INFO - PROCESS | 8093 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 22:31:48 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.50 stddev:3.31 (5.9%) stddev-sans-first:3.50 22:31:48 INFO - PROCESS | 8093 | Values: 56.0 56.0 58.0 55.0 57.0 55.0 57.0 65.0 53.0 54.0 22:31:48 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 22:31:48 INFO - PROCESS | 8093 | Values: 66.0 66.0 66.0 66.0 67.0 67.0 67.0 66.0 67.0 66.0 22:31:48 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:87.50 stddev:3.71 (4.2%) stddev-sans-first:3.84 22:31:48 INFO - PROCESS | 8093 | Values: 86.0 86.0 84.0 93.0 85.0 93.0 87.0 86.0 88.0 94.0 22:31:48 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | [#11] stanford-crypto-ccm Cycles:10 Average:119.10 Median:120.00 stddev:4.43 (3.7%) stddev-sans-first:4.68 22:31:48 INFO - PROCESS | 8093 | Values: 118.0 115.0 116.0 122.0 128.0 123.0 122.0 115.0 115.0 117.0 22:31:48 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:149.50 stddev:5.31 (3.6%) stddev-sans-first:5.62 22:31:48 INFO - PROCESS | 8093 | Values: 149.0 145.0 146.0 149.0 156.0 139.0 152.0 141.0 153.0 150.0 22:31:48 INFO - PROCESS | 8093 | 22:31:48 INFO - PROCESS | 8093 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.50 stddev:1.10 (1.6%) stddev-sans-first:1.17 22:31:48 INFO - PROCESS | 8093 | Values: 69.0 67.0 70.0 68.0 68.0 70.0 68.0 70.0 69.0 70.0 22:31:48 INFO - PROCESS | 8093 | -------- Summary: end -------- 22:31:48 INFO - PROCESS | 8093 | 22:31:49 INFO - TEST-INFO | 8093: exit 0 22:31:49 INFO - TEST-OK | kraken | took 59231ms 22:31:49 INFO - SUITE-END | took 1172s 22:31:49 INFO - Completed test suite (00:19:32) 22:31:49 INFO - Working with test: dromaeo_css 22:31:49 INFO - Generating results file: dromaeo_css 22:31:49 INFO - Working with test: kraken 22:31:49 INFO - Generating results file: kraken 22:31:49 INFO - javascript benchmark 22:31:49 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:31:50 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 22:31:50 INFO - process_Request line: dromaeo_css 7012.62 graph.html#tests=[[72,1,35]] 22:31:50 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:31:50 INFO - process_Request line: kraken 1515.00 graph.html#tests=[[232,1,35]] 22:31:50 INFO - RETURN: dromaeo_css: 7012.62 22:31:50 INFO - RETURN: kraken: 1515.00 22:31:50 INFO - javascript benchmark 22:31:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3176.7935084219525, 3225.75806814489, 3262.9510557341646, 3264.2329052672603, 3305.0580584533404, 5192.922106168401, 5304.655197412166, 5309.6814191148505, 5339.332583427072, 5403.081476149059, 5336.91994620081, 5368.651037682557, 5382.434844341346, 5392.460753924605, 5393.2719082923795, 4773.546513081252, 4819.987802561457, 4947.727874966876, 4977.701337919736, 5011.1481048221885, 4781.0676918001, 4915.680480768757, 4926.088673595378, 4956.7025978441225, 4995.800167993276, 4829.7585120744, 4839.516048395168, 4928.827491037797, 4931.4821943696115, 4944.53026962438, 4843.927341089887, 4848.224284114524, 4848.442429120661, 4851.660383773137, 4889.828855990023, 4772.665913386064, 4819.879503012417, 4839.395075615548, 4848.636352273594, 4887.144749668793, 5050.242463630448, 5123.359580052494, 5157.71632560209, 5226.7909283628605, 5269.920951185697, 5688.60179787415, 5691.6585004899425, 5697.4302569742695, 5701.857453563653, 5702.372738998707, 5622.297212848394, 5724.742386592613, 5733.140028995643, 5733.226014488033, 5733.283339582552, 5308.5487733542695, 5311.203319502067, 5362.249285100089, 5366.973165134149, 5414.810481633124, 5838.065909454467, 5840.182374467578, 5840.970795145997, 5878.2358293421585, 5891.617044892068, 5467.5625949923915, 5574.60977731563, 5658.264425624642, 5661.122526008476, 5666.0, 5648.85877853057, 5678.261825962599, 5708.286464191976, 5713.800016999385, 5768.134779783066, 5649.971750141223, 5669.829905102853, 5684.516816070681, 5685.857853553694, 5686.061799802987, 5542.695151766611, 5640.576956728261, 5657.12314591239, 5704.344000440003, 5719.227904232958, 4399.23013472641, 4420.226460369422, 4433.645308375387, 4437.5784300491405, 4455.153520831096, 3960.643542081169, 3961.603839616015, 3970.4639873616693, 3990.042389826479, 3998.6001399859783, 5210.713410762369, 5304.734763261821, 5327.600429967768, 5332.413434522199, 5334.876781909684, 5736.913946290809, 5801.042827933428, 5814.59297849155, 5818.21454103699, 5843.94156058434, 5286.286351342519, 5352.170413585901, 5354.598405119632, 5355.250264962909, 5357.4106848246665, 4772.7136371817805, 4848.5636292733825, 4850.151223535867, 4912.705237685679, 4944.060628480577, 5985.461308482258, 5985.820425387245, 5990.011648078018, 5992.490638295706, 6011.909821352683, 5783.16144159103, 5785.218995435563, 5788.102844059177, 5789.1605717171615, 5791.305043394651, 5821.7089145543405, 5848.53211743051, 5945.256842894638, 5981.043033114681, 6049.51603871698, 5639.097744360883, 5651.039323315129, 5653.773849045992, 5656.321241451053, 5657.773689052557, 5696.0, 5747.3103227612955, 5752.1659359391815, 5759.107338362561, 5772.047612144117, 5474.343078830566, 5558.0, 5580.888382232414, 5644.153376993484, 5691.345495267931, 5522.502974732293, 5532.529734972572, 5533.667979921218, 5536.833894983157, 5540.141278101901, 5377.865553361197, 5445.455454454523, 5452.482014208644, 5454.972725136349, 5506.91739623914, 5583.944160558342, 5588.748506317307, 5606.103023516218, 5624.0, 5656.5757568181725, 5484.451554844483, 5515.145152501369, 5536.557075434036, 5540.058190107611, 5605.831825045255], "unit": "score", "name": "dojo.html", "value": 5275.364463798318}, {"lowerIsBetter": false, "replicates": [544.0099019783992, 561.8651523634329, 562.620231343843, 575.3699698829782, 578.3666884761186, 28048.0, 28913.421731565355, 36123.2775344493, 36957.81521092391, 36976.44535331966, 40694.38958415626, 41066.79466602663, 41079.794601027024, 41229.0, 41243.58756412435, 8524.147585241473, 8698.39111262212, 8738.69414570487, 8743.431676940978, 8743.475391476532, 8620.267277281439, 8751.868721969144, 8758.255548278372, 8763.211310982011, 8767.079456657055, 8998.955005224965, 9076.092390760905, 9087.409318394282, 9096.090390960884, 9104.908950910505, 8734.650613975433, 8814.0, 8834.425762325429, 8834.911650883474, 8837.690680826172, 8682.218600325938, 8795.164459376349, 8808.383413161082, 8818.823623527494, 8819.426737262122, 40484.1903161938, 40982.59017409848, 41011.179776404606, 41033.589664103274, 41093.79453102745, 3241.1086951088405, 3257.4136655402017, 3275.7215636670912, 3276.885309014197, 3711.1278849470355, 26774.464510709873, 27393.726062739315, 27436.862815685992, 27444.588331174848, 27449.0, 3797.1836055247977, 3833.195029043904, 3882.107115363454, 3950.6246906543834, 4030.032792129897, 264632.4757266992, 266108.0, 266815.0, 267646.0, 269802.0, 60926.39073609296, 60992.39007609956, 61349.693251533456, 61426.0, 61699.38300617026, 65439.34560654333, 65690.34309656842, 65798.34201658018, 65858.67070664711, 65981.34018659848, 15323.310451029507, 15385.0, 15433.382664693287, 15446.304916278794, 15514.767278490832, 12704.42830072649, 12724.618261452171, 12842.871571284355, 12846.421911014028, 12846.935765321301, 19953.0, 20994.0, 21097.26159584438, 21143.471413214793, 21152.576948461254, 6879.380855722909, 8133.59332033396, 8320.667173312999, 8441.788955276168, 8458.703945361884, 955.8218922084098, 1037.8131936251395, 1045.132539991805, 1122.0014187373245, 1205.1864991130951, 30307.393852123274, 30906.918257861318, 30960.535591966138, 31202.68797312043, 31460.0, 1016.6441745389054, 1023.4422239879135, 1121.607437396921, 1129.9774004519863, 1174.4127936031985, 14771.187584682732, 15046.473373432096, 17483.912580437016, 17719.379821706436, 17734.556636084202, 289235.0, 290587.0, 292424.0, 293029.0, 293582.0, 50608.74695626572, 51069.74465127651, 51087.74456127696, 57769.71115144481, 58970.70514647399, 1343.4223283987978, 1362.0329566008047, 1366.473907545602, 1376.7384197002336, 1500.032479051006, 28923.710762892944, 30480.542791857697, 30522.42902050743, 30822.845885770428, 30960.0, 47215.52784472111, 47864.7606761964, 47876.0, 47888.760556197, 47899.76050119727, 299895.0, 302294.0, 302306.0, 302574.0, 303032.0, 27785.58321625137, 28343.0, 31427.37145257036, 31507.36985260328, 32055.0, 37388.6261137396, 37392.065198370256, 37837.43243851399, 38313.0, 38526.80736596411, 31097.37805243928, 34614.65385346215, 35210.295794084486, 35513.28973420569, 35530.644693552735, 34661.82669086739, 34966.30067398587, 35069.0, 35381.29237415289, 35570.822145889106, 36140.45789313215, 36551.26897462089, 36800.81599592092, 36828.81585592162, 36901.077473063386, 29655.85172074126, 30814.845925770227, 31422.685773141977, 31749.841250793597, 32226.83886580552, 24281.635775463736, 24308.392290192885, 24429.877850610632, 24733.639649819434, 24782.0], "unit": "score", "name": "ext.html", "value": 18575.143058130714}, {"lowerIsBetter": false, "replicates": [368.69030014787575, 370.4480324316769, 371.6098096998153, 374.887533739878, 376.4729378869582, 13201.60395188146, 13710.657233569165, 16276.267567959441, 16385.50843474696, 16959.06725130119, 15847.366105355772, 16621.41825036124, 16644.500664980038, 16759.66480670386, 17309.307627694907, 5873.618214816044, 6080.878382432349, 6087.54343424245, 6089.2692876854835, 6101.877962440749, 4370.759608221547, 4522.5025247222775, 4541.296099104644, 4541.863744087683, 6072.271327440713, 6405.807825765234, 6600.405963463311, 6714.093597364366, 6734.663266836663, 6751.831204219885, 6673.332666733337, 6727.192736871558, 6734.966325168391, 6737.023131645933, 6738.292479289677, 6367.522435817332, 6508.967455162741, 6510.9023364649565, 6523.836904077389, 6525.4779617630475, 21271.0, 21631.0, 22367.552648947094, 22398.32805015852, 22428.0, 2141.4111119442123, 2184.7924447177493, 2271.8523295985874, 2321.408040949564, 2325.6744055832196, 13116.147450415789, 13660.65848353789, 13933.721325573431, 13941.372638231203, 14073.788893166507, 1974.2497850816599, 1980.603879224161, 1983.9801601984084, 1984.8709833860896, 2029.5940811837545, 65257.70670772249, 66493.3350666492, 68907.65546172287, 69128.99999999949, 69327.0, 14965.326560304813, 15390.3074361654, 15415.460458883885, 15431.537053888402, 15449.150296733562, 23818.0, 23940.40148996289, 24094.39764005914, 24154.51690966171, 24161.0, 6983.406410455168, 7286.8178295541975, 7287.089113860768, 7305.3425191732995, 7309.415246780245, 7011.368976792113, 7057.541259818198, 7074.257202993715, 7117.25268846774, 7235.059442272471, 4182.205380977604, 4314.201872653569, 4328.285832837547, 4497.595216430537, 4607.654425918069, 1759.5601099725068, 1835.127160180542, 1849.7687789026372, 1853.7868145163209, 1866.0762922353522, 880.3221519430003, 937.5687183895484, 952.8904176019846, 1057.9894201058046, 1107.7950579142885, 12428.37858107091, 15482.922585387001, 16586.0, 16648.417305394254, 17439.128043597768, 953.3088510829593, 979.5934687104772, 1029.1287308409603, 1056.9312994655322, 1068.973275668099, 9054.592543335566, 9709.300872347452, 10269.075783179549, 10276.794464110675, 10312.535935882903, 158027.0, 160576.0, 167143.0, 545676.0, 559451.0, 41725.37411938823, 52759.208611870854, 60288.0, 71148.28851711417, 73947.0, 1196.910231732606, 1201.9459124339426, 1202.0563857371922, 1203.6509412270518, 1219.85361756588, 15406.922965385102, 15772.842271577138, 15949.0, 15972.361105555648, 16271.105089220207, 33209.66790332162, 33798.82010305488, 34134.14664633404, 34335.313293734485, 34436.82781586076, 46337.84155396142, 47391.763041184575, 48271.758641207976, 48598.75700621474, 49381.0, 7555.886661700189, 7937.365010799007, 7940.801479962816, 7983.2415920487465, 7987.760367188994, 8795.296376289754, 8827.646894124164, 10092.949535252277, 10879.510422031186, 11815.468303926173, 9793.314467987173, 10199.0, 10355.585776569154, 10360.222983276133, 10582.894171058191, 9715.417074975525, 10198.286119971828, 10209.897901020895, 10303.845442318221, 10429.843552346569, 3227.0641513961627, 6504.764094821969, 9227.261819054595, 10534.736631584272, 10634.149268058381, 7667.271609197117, 7819.804504887424, 7890.289873911375, 7893.921060789318, 7902.4863383879865, 9436.622535098519, 10096.899031009596, 10788.244822862323, 10902.890971090188, 11000.394978276272], "unit": "score", "name": "jquery.html", "value": 8663.086621783788}, {"lowerIsBetter": false, "replicates": [1385.6397336692469, 1481.7703255995318, 1497.071815474406, 1690.3238704518192, 1845.833874951254, 7084.397826184774, 7815.17940616235, 7978.720744773934, 7980.760577182694, 7991.400644951623, 7721.922780772191, 7921.128675845653, 7921.603919804015, 7930.405219608538, 7934.880976785353, 2021.5148364392514, 2066.028966385796, 2067.534804668945, 2334.9649755253686, 2350.5416443793465, 2066.2045112631595, 2325.8139348852137, 2386.081358676913, 2387.9761202387926, 2389.175734371639, 2283.474800795818, 2323.0243297814873, 2334.253039027512, 2338.5790557699606, 2340.9414764630937, 2229.3869185973986, 2254.8196144308417, 2256.5261295128043, 2258.8757618330983, 2340.1926335414423, 2318.698569186012, 2319.7332306784597, 2325.430269583946, 2326.5114325991563, 2347.049444974788, 8137.0, 8145.266925976691, 8205.138460461625, 8212.425130240885, 8224.054233763074, 4877.780499877514, 4959.355283813117, 4992.925106123411, 5017.448080711119, 5060.898782024339, 3217.420864244435, 3270.708372577202, 3271.329377477611, 3287.046756440653, 3313.3870234006786, 1006.8741407324085, 1023.2785885950387, 1053.1574740207802, 1053.6680945502142, 1104.779044191165, 11377.544898204145, 11383.203175777699, 11383.317000979885, 11387.0, 11414.143939204592, 4432.3351497275025, 4524.04994951064, 4559.293309536961, 4567.451905771262, 4582.564656357641, 9644.614215431444, 9650.324477286522, 9652.27607929408, 9685.806283874424, 9691.70924872255, 4955.578775804097, 4985.077760614298, 4998.2502624606595, 5005.449400565934, 5009.499050095034, 4456.509783923766, 4500.797464114123, 4510.120526497301, 4514.187446259705, 4527.61515271199, 3490.3193877193703, 3741.4948981887096, 3752.4746535485056, 3803.6386543278345, 3889.086064774776, 1226.650404634675, 1238.3374894431615, 1242.863285038645, 1248.6316536621719, 1256.3102626966715, 1318.6505576022362, 1326.8540460549332, 1350.1359130156707, 1393.2546087842954, 1394.539801865382, 7476.327130558276, 7638.274363935418, 7641.426892983049, 7641.7707468776025, 7647.349975252055, 1151.746615744535, 1155.3010428690689, 1158.3320019172365, 1171.1450641032095, 1178.298912147271, 5966.164736936832, 6004.099385092184, 6028.487578555784, 6037.426444487766, 6057.454829065406, 9399.530023498797, 9958.80082398348, 10068.24488163376, 10070.395776253448, 10073.546690398949, 9817.0, 9947.20422366209, 9949.104580587782, 9953.353032052893, 9959.850602240827, 7332.413406927433, 7512.474126811071, 7559.962200188964, 7562.281583249583, 7580.696772129163, 7290.088738907637, 7432.182459929295, 7533.6233188339265, 7548.396128309612, 7551.131619863786, 8290.502569845828, 8379.622916968872, 8389.454685445426, 8392.916070839214, 8504.032902092486, 8690.652373905226, 8728.170823771732, 8785.428947118417, 8874.112588741074, 8880.067592902653, 7102.609356485236, 7172.569645821268, 7224.530405523624, 7225.5664660120565, 7236.710531578889, 6834.965825170842, 6972.337627925339, 7440.1071871373615, 7600.733974310872, 7834.569098699626, 7237.601931893796, 7272.0, 7352.080989876265, 7391.593462359407, 7437.962810185914, 7277.59973201479, 7285.927140728737, 7293.452991025801, 7340.779776606497, 7423.109226892808, 7264.636768161677, 7320.743773968099, 7355.264473552602, 7359.153697324876, 7437.739679111205, 6692.1969363674725, 6725.12573365479, 6735.898961515679, 6739.393454588914, 6742.08981787472, 6477.967610161919, 6830.556013859084, 6892.517523773287, 6897.689603967733, 6904.827379315558], "unit": "score", "name": "mootools.html", "value": 4667.100072815529}, {"lowerIsBetter": false, "replicates": [341.5798567761653, 345.80116433050983, 347.80522907171985, 356.9928601427973, 357.50842591436776, 5792.536597072224, 5903.911441328378, 5914.615549989253, 5969.492593129578, 5977.581569290146, 5762.0, 5845.5908086433965, 5863.970680146604, 5897.882042359161, 5919.88160236795, 4599.448066232057, 4611.907761844761, 4616.146012987591, 4628.652851036186, 4632.374629425035, 4364.454443194601, 4483.103379324132, 4617.722936623796, 4618.1687296286655, 4635.420572428447, 4555.20283950309, 4560.657950653697, 4563.566461186182, 4579.244424669925, 4584.587387135157, 4568.497465278817, 4571.634269258451, 4579.061292435043, 4580.7938642761155, 4592.196365636034, 4035.59644035597, 4056.452378928866, 4065.1869626074904, 4066.2274167908004, 4067.694922880766, 5622.100463925753, 5639.351474580435, 5684.403137670568, 5687.374388817227, 5696.031674615284, 5344.465553444625, 5348.171033489815, 5351.919721204185, 5356.866078348034, 5358.303420555303, 5930.080837470199, 6202.875942481171, 6230.532710046719, 6234.563580549363, 6242.219722534684, 4338.501072376685, 4407.184670835905, 4415.183191109655, 4418.469783625953, 4434.312681534368, 6502.024696295546, 6512.902306465359, 6532.0, 6539.607623542555, 6546.803595892131, 4565.3836732040745, 4565.6119229865835, 4568.291914753152, 4571.954280457219, 4574.313852922089, 4533.455985281721, 4615.561521655437, 4616.838410655611, 4618.67669263155, 4620.214563524209, 5294.841154765363, 5297.046531624344, 5305.867353316198, 5307.416184219733, 5308.177232528964, 6318.210223722035, 6322.557420980579, 6327.778527751507, 6330.525210609223, 6406.8718625627225, 1624.2122570553272, 1655.6274838161316, 1656.7739872494267, 1657.685039842426, 1658.6516831465528, 1122.5565901468874, 1124.1175677093606, 1125.083057308291, 1131.0, 1158.2413519144973, 5975.223220981245, 5980.162777211194, 5987.0, 5992.041273396236, 5995.61028533144, 6501.707423165969, 6503.642299673469, 6514.3811337922825, 6515.381038801401, 6518.9895566187315, 5790.36306006339, 5918.378570250148, 5918.822435326947, 5976.73104710289, 5980.192673988956, 3476.80877551732, 3507.8950130709254, 3516.8593256269464, 3516.9296614067575, 3517.876874309438, 6743.527953043338, 6762.526623136431, 6762.72949082041, 6764.154480689914, 6767.409658730195, 6447.161868957006, 6576.408123268833, 6580.11168492257, 6581.967090164519, 6589.4069533742195, 6637.900431493532, 6746.460283177334, 6747.05541224229, 6759.053732477457, 6772.627505487246, 6222.875542489215, 6468.062130991074, 6471.611703297817, 6476.222853257639, 6477.805665830033, 6480.092787009728, 6496.675166241764, 6511.772087976898, 6512.446442052478, 6528.934710653023, 6860.862782744417, 6862.279460656559, 6868.0, 6871.4502839773695, 6872.553284036521, 4597.0, 4670.439547254351, 4678.719276843401, 4680.859574212779, 4682.367880336111, 6583.868322633425, 6621.437177839937, 6649.60102393858, 6654.700538475877, 6655.035019922181, 6416.51876109303, 6418.807435776934, 6428.582142160932, 6429.678516074271, 6430.614163150226, 6253.187085678833, 6405.551611387158, 6409.230892292955, 6409.9038514423255, 6450.193725784277, 6383.553151279366, 6383.904241436289, 6389.393007664265, 6395.488360931021, 6397.168368112116, 6471.352864713491, 6473.320301368289, 6474.125992991075, 6474.223093228843, 6489.059086432347, 6172.259328880563, 6312.116303717391, 6314.052892066226, 6314.179156709598, 6319.115323854572], "unit": "score", "name": "prototype.html", "value": 4806.407112921344}, {"lowerIsBetter": false, "replicates": [669.253782033033, 679.3783687925549, 764.642457934773, 777.2266594738236, 823.435946376732, 13140.342982850867, 13389.7322053559, 13391.263480508567, 13402.597922062341, 13409.731805363886, 12727.618171454847, 13227.338633068332, 13246.933765331183, 13253.271070091141, 13290.601281961532, 685.595498655793, 693.944484441246, 696.8884978403456, 805.1545876829321, 823.4770920465488, 685.0819901332214, 812.9674813007473, 830.0951962361025, 830.9086000539936, 833.2334252487695, 849.1211595998143, 852.2159613155911, 858.1247127929508, 859.3125499600326, 860.3418384935499, 703.7572037647003, 841.9494830310201, 848.9278411335013, 849.5921957460392, 851.5699571716306, 642.2613993906998, 643.8873197190472, 644.4650939720021, 644.6325594411187, 644.7227692092398, 13071.738565228643, 13089.08376413642, 13112.213267203902, 13145.934270328682, 13152.342382880817, 13125.278109703962, 13217.537386191438, 13260.204387736767, 13561.796573051412, 13620.727585448334, 10639.725285374208, 10730.302530335503, 10756.462176891124, 10790.838137427945, 10808.675739727822, 3626.9198935416202, 3693.8337774800198, 3693.9815300923324, 3694.7783133012103, 3828.885133445973, 47412.0, 47558.762206189094, 47711.0, 47737.28394074057, 47778.0, 10577.100946419487, 10792.676219713421, 10883.0, 10887.782244355069, 11118.221724479208, 19262.0, 19283.90358048229, 19308.613827723366, 19351.12919918579, 19396.321128760424, 7434.739784107638, 7518.947347371372, 7519.248075192437, 7539.0576177977755, 7742.380609551335, 4215.662746980234, 4221.387898754663, 4238.004069043773, 4261.659067274611, 4418.7127836690515, 3287.8027318360973, 3308.123347312964, 3310.2220978070136, 3323.6842499962463, 3337.6495467975997, 530.0379810643669, 536.2385412713955, 538.496505767109, 545.184948501992, 553.051516648949, 516.187005466392, 592.3706235767463, 641.4387411015362, 650.9576877502947, 701.1446035836271, 8330.875036874451, 8417.17754687714, 8527.275181609633, 8697.565121743888, 8779.29765618749, 551.6607286518843, 607.5139888089511, 680.1328306409367, 683.3474032299142, 694.4513834071129, 4006.7996600169877, 4036.8788936331957, 4096.897577560585, 4097.85657501986, 4125.8968525786495, 51222.0, 51240.487595124316, 51407.74296128495, 51450.485495145316, 51510.48489515132, 46354.30468542974, 46960.295595566095, 47250.29124563134, 47515.28727069097, 47652.04695906132, 41841.0, 42000.0, 42977.999999999374, 43646.12707745891, 43756.78121609435, 7726.961365193138, 8108.554029528433, 8133.552654604054, 8485.321174306164, 8924.152205540464, 30252.84873575706, 30776.23059423443, 32777.83611081929, 33883.32233355368, 33910.83044584761, 40566.39150412805, 41226.0, 41274.79362603168, 42444.15111697811, 42897.35653965255, 10894.237403381687, 11024.44877756125, 11166.832497512707, 11238.55045798159, 11361.659150225507, 11893.881061189277, 12094.516219351128, 12241.571544996239, 12315.13794034409, 12494.37528123572, 11638.185327027028, 11714.1800073994, 12131.75736485283, 12186.2078964867, 12309.076819238413, 11259.29623159471, 11340.546378145113, 11540.653780386601, 12020.398980051137, 12207.328596927255, 8182.427230093836, 11150.609728659458, 11356.488957997075, 11698.47356868926, 12143.149979501704, 9556.713298601053, 9732.41605503672, 9769.804603908024, 9884.456354900261, 9929.3545919515, 9234.861477077984, 9403.85894211601, 9441.952790236004, 9473.95263023708, 9532.428054316762], "unit": "score", "name": "yui.html", "value": 6244.838269130573}], "name": "dromaeo_css", "value": 7012.624094396276}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 105.0, 109.0, 110.0, 109.0, 99.0, 110.0, 110.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [155.0, 127.0, 155.0, 166.0, 126.0, 151.0, 152.0, 134.0, 174.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.6}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 160.0, 164.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 124.0, 97.0, 72.0, 75.0, 72.0, 122.0, 100.0, 72.0], "unit": "score", "name": "audio-fft", "value": 87.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 135.0, 96.0, 95.0, 96.0, 138.0, 97.0, 96.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 114.0, 115.0, 115.0, 114.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.1}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 145.0, 144.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 58.0, 55.0, 57.0, 55.0, 57.0, 65.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.4}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 84.0, 93.0, 85.0, 93.0, 87.0, 86.0, 88.0, 94.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.2}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 116.0, 122.0, 128.0, 123.0, 122.0, 115.0, 115.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.1}, {"lowerIsBetter": true, "replicates": [149.0, 145.0, 146.0, 149.0, 156.0, 139.0, 152.0, 141.0, 153.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 70.0, 68.0, 68.0, 70.0, 68.0, 70.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1515.0}]} 22:31:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1515.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "7012.62"}}} 22:31:50 INFO - Return code: 0 22:31:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:31:50 INFO - # TBPL SUCCESS # 22:31:50 INFO - Running post-action listener: _resource_record_post_action 22:31:50 INFO - Running post-run listener: _resource_record_post_run 22:31:51 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 527147008; Read time: 0; Write time: 499500 22:31:51 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 241422336; Read time: 0; Write time: 288000 22:31:51 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 285724672; Read time: 0; Write time: 211500 22:31:51 INFO - Running post-run listener: _upload_blobber_files 22:31:51 INFO - Blob upload gear active. 22:31:51 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:31:51 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:31:51 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:31:51 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:31:51 INFO - (blobuploader) - INFO - Open directory for files ... 22:31:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:31:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:31:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:31:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:31:52 INFO - (blobuploader) - INFO - Done attempting. 22:31:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:31:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:31:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:31:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:31:53 INFO - (blobuploader) - INFO - Done attempting. 22:31:53 INFO - (blobuploader) - INFO - Iteration through files over. 22:31:53 INFO - Return code: 0 22:31:53 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:31:53 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:31:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/713254f4970029ff665a74f292bfbda311a238f991f970de524dfa0f20c2395fce181f36fdc71756a352e3e991b4f589e60121469c71cca4041b048f65a0ca69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/979a16d195e1010e8716630ebeb534bfb4f8de855218ceae8bd87c5f8ade3d6335256a1f0c502b39416709ade8300595819ccc3836d54454a63d5bacbff6f768"} 22:31:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:31:53 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:31:53 INFO - Contents: 22:31:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/713254f4970029ff665a74f292bfbda311a238f991f970de524dfa0f20c2395fce181f36fdc71756a352e3e991b4f589e60121469c71cca4041b048f65a0ca69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/979a16d195e1010e8716630ebeb534bfb4f8de855218ceae8bd87c5f8ade3d6335256a1f0c502b39416709ade8300595819ccc3836d54454a63d5bacbff6f768"} 22:31:53 INFO - Running post-run listener: copy_logs_to_upload_dir 22:31:53 INFO - Copying logs to upload dir... 22:31:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:31:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.150576 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-02-05 22:31:53.258831) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-05 22:31:53.262264) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951 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/713254f4970029ff665a74f292bfbda311a238f991f970de524dfa0f20c2395fce181f36fdc71756a352e3e991b4f589e60121469c71cca4041b048f65a0ca69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/979a16d195e1010e8716630ebeb534bfb4f8de855218ceae8bd87c5f8ade3d6335256a1f0c502b39416709ade8300595819ccc3836d54454a63d5bacbff6f768"} build_url:https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/713254f4970029ff665a74f292bfbda311a238f991f970de524dfa0f20c2395fce181f36fdc71756a352e3e991b4f589e60121469c71cca4041b048f65a0ca69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/979a16d195e1010e8716630ebeb534bfb4f8de855218ceae8bd87c5f8ade3d6335256a1f0c502b39416709ade8300595819ccc3836d54454a63d5bacbff6f768"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-05 22:31:53.286837) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:31:53.287170) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1454738983.31374-1747932951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:31:53.373356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-05 22:31:53.373836) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-05 22:31:53.374171) ========= ========= Total master_lag: 0.29 =========